builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1501870151.84 results: success (0) revision: 357ef8a67e8893d91ec6716fb66f42031c34a14c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:11.836248) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:11.836721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:11.837038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:11.853378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:11.853770) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 11:09:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.1M=0s 2017-08-04 11:09:12 (32.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.008511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.008920) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.059216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.059663) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 357ef8a67e8893d91ec6716fb66f42031c34a14c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 357ef8a67e8893d91ec6716fb66f42031c34a14c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 11:09:12,730 truncating revision to first 12 chars 2017-08-04 11:09:12,730 Setting DEBUG logging. 2017-08-04 11:09:12,730 attempt 1/10 2017-08-04 11:09:12,730 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/357ef8a67e88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 11:09:13,044 unpacking tar archive at: mozilla-central-357ef8a67e88/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.706735) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.707092) ========= script_repo_revision: 357ef8a67e8893d91ec6716fb66f42031c34a14c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.707509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.707785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:09:12.716831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-04 11:09:12.717171) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:09:13 INFO - MultiFileLogger online at 20170804 11:09:13 in /builds/slave/test 11:09:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:09:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:13 INFO - {'append_to_log': False, 11:09:13 INFO - 'base_work_dir': '/builds/slave/test', 11:09:13 INFO - 'blob_upload_branch': 'Firefox', 11:09:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:13 INFO - 'branch': 'Firefox', 11:09:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:13 INFO - 'code_coverage': False, 11:09:13 INFO - 'config_files': ('talos/linux_config.py',), 11:09:13 INFO - 'default_actions': ('clobber', 11:09:13 INFO - 'read-buildbot-config', 11:09:13 INFO - 'download-and-extract', 11:09:13 INFO - 'populate-webroot', 11:09:13 INFO - 'create-virtualenv', 11:09:13 INFO - 'install', 11:09:13 INFO - 'setup-mitmproxy', 11:09:13 INFO - 'run-tests'), 11:09:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:13 INFO - 'disable_ccov_upload': False, 11:09:13 INFO - 'download_minidump_stackwalk': True, 11:09:13 INFO - 'download_symbols': 'ondemand', 11:09:13 INFO - 'enable_stylo': False, 11:09:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:13 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:13 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:13 INFO - 'gecko_profile': False, 11:09:13 INFO - 'gecko_profile_interval': 0, 11:09:13 INFO - 'installer_path': 'installer.exe', 11:09:13 INFO - 'log_level': 'info', 11:09:13 INFO - 'log_name': 'talos', 11:09:13 INFO - 'log_to_console': True, 11:09:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:09:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:09:13 INFO - 'opt_config_files': (), 11:09:13 INFO - 'pip_index': False, 11:09:13 INFO - 'suite': 'dromaeojs-e10s', 11:09:13 INFO - 'system_bits': '32', 11:09:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:13 INFO - 'title': 'talos-linux64-ix-063', 11:09:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:13 INFO - 'use_talos_json': True, 11:09:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:13 INFO - 'work_dir': 'build'} 11:09:13 INFO - [mozharness: 2017-08-04 18:09:13.491048Z] Running clobber step. 11:09:13 INFO - Running pre-action listener: _resource_record_pre_action 11:09:13 INFO - Running main action method: clobber 11:09:13 INFO - rmtree: /builds/slave/test/build 11:09:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:14 INFO - Running post-action listener: _resource_record_post_action 11:09:14 INFO - [mozharness: 2017-08-04 18:09:14.611556Z] Finished clobber step (success) 11:09:14 INFO - [mozharness: 2017-08-04 18:09:14.611659Z] Running read-buildbot-config step. 11:09:14 INFO - Running pre-action listener: _resource_record_pre_action 11:09:14 INFO - Running main action method: read_buildbot_config 11:09:14 INFO - Using buildbot properties: 11:09:14 INFO - { 11:09:14 INFO - "project": "", 11:09:14 INFO - "product": "firefox", 11:09:14 INFO - "who": "archaeopteryx@coole-files.de", 11:09:14 INFO - "installer_path": "public/build/target.tar.bz2", 11:09:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:09:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:09:14 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:09:14 INFO - "stage_platform": "linux64-stylo", 11:09:14 INFO - "basedir": "/builds/slave/test", 11:09:14 INFO - "buildnumber": 255, 11:09:14 INFO - "platform": "ubuntu64_hw_stylo", 11:09:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:09:14 INFO - "slavebuilddir": "test", 11:09:14 INFO - "taskId": "AmELiMekTiS2CLcj17_pXQ", 11:09:14 INFO - "branch": "mozilla-central", 11:09:14 INFO - "script_repo_revision": "production", 11:09:14 INFO - "revision": "357ef8a67e8893d91ec6716fb66f42031c34a14c", 11:09:14 INFO - "slavename": "talos-linux64-ix-063", 11:09:14 INFO - "repo_path": "mozilla-central" 11:09:14 INFO - } 11:09:14 INFO - Finding installer, test and symbols from parent task. 11:09:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmELiMekTiS2CLcj17_pXQ'}, attempt #1 11:09:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AmELiMekTiS2CLcj17_pXQ'}, attempt #1 11:09:15 INFO - Task dependencies: YhryPzAGTxmLADsZTzVodg 11:09:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg'}, attempt #1 11:09:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 11:09:15 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.test_packages.json 11:09:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.crashreporter-symbols.zip 11:09:15 INFO - Running post-action listener: _resource_record_post_action 11:09:15 INFO - [mozharness: 2017-08-04 18:09:15.938688Z] Finished read-buildbot-config step (success) 11:09:15 INFO - [mozharness: 2017-08-04 18:09:15.938907Z] Running download-and-extract step. 11:09:15 INFO - Running pre-action listener: _resource_record_pre_action 11:09:15 INFO - Running main action method: download_and_extract 11:09:15 INFO - mkdir: /builds/slave/test/build/tests 11:09:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:15 INFO - trying https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.test_packages.json 11:09:15 INFO - Downloading https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:09:16 INFO - Downloaded 989 bytes. 11:09:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:09:16 INFO - Using the following test package requirements: 11:09:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:09:16 INFO - u'common': [u'target.common.tests.zip'], 11:09:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:09:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:09:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:09:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:09:16 INFO - u'mozbase': [u'target.common.tests.zip'], 11:09:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:09:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:09:16 INFO - u'web-platform': [u'target.common.tests.zip', 11:09:16 INFO - u'target.web-platform.tests.tar.gz'], 11:09:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:09:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:09:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip 11:09:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:09:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip into memory 11:09:17 INFO - Content-Length response header: 54276714 11:09:17 INFO - Bytes received: 54276714 11:09:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:09:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip 11:09:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:09:28 INFO - Fetch https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.common.tests.zip into memory 11:09:29 INFO - Content-Length response header: 54276714 11:09:29 INFO - Bytes received: 54276714 11:09:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.talos.tests.zip 11:09:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:09:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.talos.tests.zip into memory 11:09:41 INFO - Content-Length response header: 14496008 11:09:41 INFO - Bytes received: 14496008 11:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:42 INFO - trying https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 11:09:42 INFO - Downloading https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:09:43 INFO - Downloaded 62328036 bytes. 11:09:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 11:09:43 INFO - mkdir: /builds/slave/test/properties 11:09:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:43 INFO - Contents: 11:09:43 INFO - build_url:https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 11:09:43 INFO - Running post-action listener: _resource_record_post_action 11:09:43 INFO - Running post-action listener: set_extra_try_arguments 11:09:43 INFO - [mozharness: 2017-08-04 18:09:43.368423Z] Finished download-and-extract step (success) 11:09:43 INFO - [mozharness: 2017-08-04 18:09:43.368520Z] Running populate-webroot step. 11:09:43 INFO - Running pre-action listener: _resource_record_pre_action 11:09:43 INFO - Running main action method: populate_webroot 11:09:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'tests': ['damp', 'tps']}, 11:09:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:09:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:09:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_many_windows', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:09:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:09:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:43 INFO - 'tsvgr_opacity', 11:09:43 INFO - 'tart', 11:09:43 INFO - 'tscrollx', 11:09:43 INFO - 'tsvg_static']}, 11:09:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:09:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:09:43 INFO - 'talos_options': ['--mitmproxy', 11:09:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:09:43 INFO - '--firstNonBlankPaint'], 11:09:43 INFO - 'tests': ['tp6_google', 11:09:43 INFO - 'tp6_youtube', 11:09:43 INFO - 'tp6_amazon', 11:09:43 INFO - 'tp6_facebook']}, 11:09:43 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:09:43 INFO - 'talos_options': ['--stylo', 11:09:43 INFO - '--mitmproxy', 11:09:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:09:43 INFO - '--firstNonBlankPaint'], 11:09:43 INFO - 'tests': ['tp6_google', 11:09:43 INFO - 'tp6_youtube', 11:09:43 INFO - 'tp6_amazon', 11:09:43 INFO - 'tp6_facebook']}, 11:09:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:09:43 INFO - 'talos_options': ['--stylo', 11:09:43 INFO - '--stylo-threads=1', 11:09:43 INFO - '--mitmproxy', 11:09:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:09:43 INFO - '--firstNonBlankPaint'], 11:09:43 INFO - 'tests': ['tp6_google', 11:09:43 INFO - 'tp6_youtube', 11:09:43 INFO - 'tp6_amazon', 11:09:43 INFO - 'tp6_facebook']}, 11:09:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--xperf_path', 11:09:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:43 INFO - 'tests': ['tp5n']}}} 11:09:43 INFO - Running post-action listener: _resource_record_post_action 11:09:43 INFO - [mozharness: 2017-08-04 18:09:43.376940Z] Finished populate-webroot step (success) 11:09:43 INFO - [mozharness: 2017-08-04 18:09:43.377030Z] Running create-virtualenv step. 11:09:43 INFO - Running pre-action listener: _resource_record_pre_action 11:09:43 INFO - Running main action method: create_virtualenv 11:09:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:43 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 11:09:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:09:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:43 INFO - Using real prefix '/usr' 11:09:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:45 INFO - Installing pip.................done. 11:09:45 INFO - Return code: 0 11:09:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:09:46 INFO - Reading from file tmpfile_stdout 11:09:46 INFO - Output received: 11:09:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:09:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:46 INFO - Using env: {'DISPLAY': ':0', 11:09:46 INFO - 'HOME': '/home/cltbld', 11:09:46 INFO - 'LANG': 'en_US.UTF-8', 11:09:46 INFO - 'LANGUAGE': 'en_US:en', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MAIL': '/var/mail/cltbld', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SHLVL': '1', 11:09:46 INFO - 'TERM': 'linux', 11:09:46 INFO - 'TMOUT': '86400', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - '_': '/tools/buildbot/bin/python'} 11:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:46 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 11:09:46 INFO - Cleaning up... 11:09:46 INFO - Return code: 0 11:09:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:09:46 INFO - Using env: {'DISPLAY': ':0', 11:09:46 INFO - 'HOME': '/home/cltbld', 11:09:46 INFO - 'LANG': 'en_US.UTF-8', 11:09:46 INFO - 'LANGUAGE': 'en_US:en', 11:09:46 INFO - 'LOGNAME': 'cltbld', 11:09:46 INFO - 'MAIL': '/var/mail/cltbld', 11:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:46 INFO - 'MOZ_NO_REMOTE': '1', 11:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:46 INFO - 'NO_EM_RESTART': '1', 11:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:46 INFO - 'PWD': '/builds/slave/test', 11:09:46 INFO - 'SHELL': '/bin/bash', 11:09:46 INFO - 'SHLVL': '1', 11:09:46 INFO - 'TERM': 'linux', 11:09:46 INFO - 'TMOUT': '86400', 11:09:46 INFO - 'USER': 'cltbld', 11:09:46 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:46 INFO - '_': '/tools/buildbot/bin/python'} 11:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:46 INFO - Downloading/unpacking psutil>=3.1.1 11:09:46 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 11:09:46 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 11:09:46 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 11:09:46 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 11:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:47 INFO - Installing collected packages: psutil 11:09:47 INFO - Running setup.py install for psutil 11:09:47 INFO - building 'psutil._psutil_linux' extension 11:09:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:09:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:09:48 INFO - building 'psutil._psutil_posix' extension 11:09:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:09:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:09:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:48 INFO - Successfully installed psutil 11:09:48 INFO - Cleaning up... 11:09:48 INFO - Return code: 0 11:09:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:48 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:09:48 INFO - Using env: {'DISPLAY': ':0', 11:09:48 INFO - 'HOME': '/home/cltbld', 11:09:48 INFO - 'LANG': 'en_US.UTF-8', 11:09:48 INFO - 'LANGUAGE': 'en_US:en', 11:09:48 INFO - 'LOGNAME': 'cltbld', 11:09:48 INFO - 'MAIL': '/var/mail/cltbld', 11:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:48 INFO - 'MOZ_NO_REMOTE': '1', 11:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:48 INFO - 'NO_EM_RESTART': '1', 11:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:48 INFO - 'PWD': '/builds/slave/test', 11:09:48 INFO - 'SHELL': '/bin/bash', 11:09:48 INFO - 'SHLVL': '1', 11:09:48 INFO - 'TERM': 'linux', 11:09:48 INFO - 'TMOUT': '86400', 11:09:48 INFO - 'USER': 'cltbld', 11:09:48 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:48 INFO - '_': '/tools/buildbot/bin/python'} 11:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:48 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 11:09:48 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 11:09:48 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 11:09:48 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 11:09:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:49 INFO - Installing collected packages: mozsystemmonitor 11:09:49 INFO - Running setup.py install for mozsystemmonitor 11:09:49 INFO - Successfully installed mozsystemmonitor 11:09:49 INFO - Cleaning up... 11:09:49 INFO - Return code: 0 11:09:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:49 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:09:49 INFO - Using env: {'DISPLAY': ':0', 11:09:49 INFO - 'HOME': '/home/cltbld', 11:09:49 INFO - 'LANG': 'en_US.UTF-8', 11:09:49 INFO - 'LANGUAGE': 'en_US:en', 11:09:49 INFO - 'LOGNAME': 'cltbld', 11:09:49 INFO - 'MAIL': '/var/mail/cltbld', 11:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:49 INFO - 'MOZ_NO_REMOTE': '1', 11:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:49 INFO - 'NO_EM_RESTART': '1', 11:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:49 INFO - 'PWD': '/builds/slave/test', 11:09:49 INFO - 'SHELL': '/bin/bash', 11:09:49 INFO - 'SHLVL': '1', 11:09:49 INFO - 'TERM': 'linux', 11:09:49 INFO - 'TMOUT': '86400', 11:09:49 INFO - 'USER': 'cltbld', 11:09:49 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:49 INFO - '_': '/tools/buildbot/bin/python'} 11:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:51 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 11:09:51 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 11:09:51 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 11:09:51 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 11:09:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:51 INFO - warning: no files found matching '*.txt' 11:09:51 INFO - no previously-included directories found matching 'build' 11:09:51 INFO - no previously-included directories found matching 'dist' 11:09:51 INFO - no previously-included directories found matching '.git*' 11:09:51 INFO - Installing collected packages: jsonschema, functools32 11:09:51 INFO - Running setup.py install for functools32 11:09:51 INFO - warning: no files found matching '*.txt' 11:09:51 INFO - no previously-included directories found matching 'build' 11:09:51 INFO - no previously-included directories found matching 'dist' 11:09:51 INFO - no previously-included directories found matching '.git*' 11:09:51 INFO - Successfully installed jsonschema functools32 11:09:51 INFO - Cleaning up... 11:09:51 INFO - Return code: 0 11:09:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:51 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:09:51 INFO - Using env: {'DISPLAY': ':0', 11:09:51 INFO - 'HOME': '/home/cltbld', 11:09:51 INFO - 'LANG': 'en_US.UTF-8', 11:09:51 INFO - 'LANGUAGE': 'en_US:en', 11:09:51 INFO - 'LOGNAME': 'cltbld', 11:09:51 INFO - 'MAIL': '/var/mail/cltbld', 11:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:51 INFO - 'MOZ_NO_REMOTE': '1', 11:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:51 INFO - 'NO_EM_RESTART': '1', 11:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:51 INFO - 'PWD': '/builds/slave/test', 11:09:51 INFO - 'SHELL': '/bin/bash', 11:09:51 INFO - 'SHLVL': '1', 11:09:51 INFO - 'TERM': 'linux', 11:09:51 INFO - 'TMOUT': '86400', 11:09:51 INFO - 'USER': 'cltbld', 11:09:51 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:51 INFO - '_': '/tools/buildbot/bin/python'} 11:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:51 INFO - Cleaning up... 11:09:51 INFO - Return code: 0 11:09:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:51 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:09:51 INFO - Using env: {'DISPLAY': ':0', 11:09:51 INFO - 'HOME': '/home/cltbld', 11:09:51 INFO - 'LANG': 'en_US.UTF-8', 11:09:51 INFO - 'LANGUAGE': 'en_US:en', 11:09:51 INFO - 'LOGNAME': 'cltbld', 11:09:51 INFO - 'MAIL': '/var/mail/cltbld', 11:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:51 INFO - 'MOZ_NO_REMOTE': '1', 11:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:51 INFO - 'NO_EM_RESTART': '1', 11:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:51 INFO - 'PWD': '/builds/slave/test', 11:09:51 INFO - 'SHELL': '/bin/bash', 11:09:51 INFO - 'SHLVL': '1', 11:09:51 INFO - 'TERM': 'linux', 11:09:51 INFO - 'TMOUT': '86400', 11:09:51 INFO - 'USER': 'cltbld', 11:09:51 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:51 INFO - '_': '/tools/buildbot/bin/python'} 11:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:51 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:51 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 11:09:51 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 11:09:51 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 11:09:51 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 11:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:53 INFO - Downloading docopt-0.6.1.tar.gz 11:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:53 INFO - Running setup.py install for blobuploader 11:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:53 INFO - Running setup.py install for requests 11:09:54 INFO - Running setup.py install for docopt 11:09:54 INFO - Successfully installed blobuploader requests docopt 11:09:54 INFO - Cleaning up... 11:09:54 INFO - Return code: 0 11:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:54 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:54 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:09:54 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:54 INFO - Using env: {'DISPLAY': ':0', 11:09:54 INFO - 'HOME': '/home/cltbld', 11:09:54 INFO - 'LANG': 'en_US.UTF-8', 11:09:54 INFO - 'LANGUAGE': 'en_US:en', 11:09:54 INFO - 'LOGNAME': 'cltbld', 11:09:54 INFO - 'MAIL': '/var/mail/cltbld', 11:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:54 INFO - 'MOZ_NO_REMOTE': '1', 11:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:54 INFO - 'NO_EM_RESTART': '1', 11:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:54 INFO - 'PWD': '/builds/slave/test', 11:09:54 INFO - 'SHELL': '/bin/bash', 11:09:54 INFO - 'SHLVL': '1', 11:09:54 INFO - 'TERM': 'linux', 11:09:54 INFO - 'TMOUT': '86400', 11:09:54 INFO - 'USER': 'cltbld', 11:09:54 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:54 INFO - '_': '/tools/buildbot/bin/python'} 11:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:54 INFO - Running setup.py (path:/tmp/pip-VcwEUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:54 INFO - Running setup.py (path:/tmp/pip-thC1IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:54 INFO - Running setup.py (path:/tmp/pip-tL9naG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:54 INFO - Running setup.py (path:/tmp/pip-eGaguI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:54 INFO - Running setup.py (path:/tmp/pip-I9Ew9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:54 INFO - Running setup.py (path:/tmp/pip-P9bgsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:54 INFO - Running setup.py (path:/tmp/pip-NZz2Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:54 INFO - Running setup.py (path:/tmp/pip-usouHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:55 INFO - Running setup.py (path:/tmp/pip-hEB3rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:55 INFO - Running setup.py (path:/tmp/pip-TboaJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:55 INFO - Running setup.py (path:/tmp/pip-UPqkHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:55 INFO - Running setup.py (path:/tmp/pip-GnbjQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:55 INFO - Running setup.py (path:/tmp/pip-mwyy2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:55 INFO - Running setup.py (path:/tmp/pip-JPi162-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:55 INFO - Running setup.py (path:/tmp/pip-3TmtZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:55 INFO - Running setup.py (path:/tmp/pip-8ZeI80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:55 INFO - Running setup.py (path:/tmp/pip-JLT6EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:55 INFO - Running setup.py install for manifestparser 11:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:55 INFO - Running setup.py install for mozcrash 11:09:55 INFO - Running setup.py install for mozdebug 11:09:56 INFO - Running setup.py install for mozdevice 11:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozfile 11:09:56 INFO - Running setup.py install for mozhttpd 11:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozinfo 11:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozInstall 11:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozleak 11:09:56 INFO - Running setup.py install for mozlog 11:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for moznetwork 11:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:56 INFO - Running setup.py install for mozprocess 11:09:56 INFO - Running setup.py install for mozprofile 11:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozrunner 11:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Running setup.py install for mozscreenshot 11:09:57 INFO - Running setup.py install for moztest 11:09:57 INFO - Running setup.py install for mozversion 11:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:57 INFO - Cleaning up... 11:09:57 INFO - Return code: 0 11:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:57 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:09:57 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:09:57 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:57 INFO - Using env: {'DISPLAY': ':0', 11:09:57 INFO - 'HOME': '/home/cltbld', 11:09:57 INFO - 'LANG': 'en_US.UTF-8', 11:09:57 INFO - 'LANGUAGE': 'en_US:en', 11:09:57 INFO - 'LOGNAME': 'cltbld', 11:09:57 INFO - 'MAIL': '/var/mail/cltbld', 11:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:57 INFO - 'MOZ_NO_REMOTE': '1', 11:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:57 INFO - 'NO_EM_RESTART': '1', 11:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:57 INFO - 'PWD': '/builds/slave/test', 11:09:57 INFO - 'SHELL': '/bin/bash', 11:09:57 INFO - 'SHLVL': '1', 11:09:57 INFO - 'TERM': 'linux', 11:09:57 INFO - 'TMOUT': '86400', 11:09:57 INFO - 'USER': 'cltbld', 11:09:57 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:57 INFO - '_': '/tools/buildbot/bin/python'} 11:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:57 INFO - Running setup.py (path:/tmp/pip-h_mrrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:57 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)) 11:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:57 INFO - Running setup.py (path:/tmp/pip-e8xuV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:57 INFO - Running setup.py (path:/tmp/pip-TJnHVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:57 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)) 11:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:57 INFO - Running setup.py (path:/tmp/pip-7h4FHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:58 INFO - Running setup.py (path:/tmp/pip-5RKzwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:58 INFO - Running setup.py (path:/tmp/pip-MUyEpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:58 INFO - Running setup.py (path:/tmp/pip-VDRr_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:58 INFO - Running setup.py (path:/tmp/pip-z5O43E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:58 INFO - Running setup.py (path:/tmp/pip-45H7wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:58 INFO - Running setup.py (path:/tmp/pip-5sFwsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:58 INFO - Running setup.py (path:/tmp/pip-hl6HIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:58 INFO - Running setup.py (path:/tmp/pip-nSnhzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:58 INFO - Running setup.py (path:/tmp/pip-fWT3CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:58 INFO - Running setup.py (path:/tmp/pip-6DEoF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:58 INFO - Running setup.py (path:/tmp/pip-vFUQhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:58 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:58 INFO - Running setup.py (path:/tmp/pip-4aQMgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:58 INFO - Running setup.py (path:/tmp/pip-cUVHIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:58 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)) 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:09:58 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)) 11:09:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:09:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09: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 11:09: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 11:09: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 11:09: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 11:10:00 INFO - Downloading blessings-1.6.tar.gz 11:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:10:00 INFO - Installing collected packages: blessings 11:10:00 INFO - Running setup.py install for blessings 11:10:00 INFO - Successfully installed blessings 11:10:00 INFO - Cleaning up... 11:10:00 INFO - Return code: 0 11:10:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:00 INFO - Reading from file tmpfile_stdout 11:10:00 INFO - Current package versions: 11:10:00 INFO - argparse == 1.2.1 11:10:00 INFO - blessings == 1.6 11:10:00 INFO - blobuploader == 1.2.4 11:10:00 INFO - docopt == 0.6.1 11:10:00 INFO - functools32 == 3.2.3-2 11:10:00 INFO - jsonschema == 2.5.1 11:10:00 INFO - manifestparser == 1.1 11:10:00 INFO - mozInstall == 1.13 11:10:00 INFO - mozcrash == 1.0 11:10:00 INFO - mozdebug == 0.1 11:10:00 INFO - mozdevice == 0.51 11:10:00 INFO - mozfile == 1.2 11:10:00 INFO - mozhttpd == 0.7 11:10:00 INFO - mozinfo == 0.10 11:10:00 INFO - mozleak == 0.1 11:10:00 INFO - mozlog == 3.5 11:10:00 INFO - moznetwork == 0.27 11:10:00 INFO - mozprocess == 0.25 11:10:00 INFO - mozprofile == 0.28 11:10:00 INFO - mozrunner == 6.13 11:10:00 INFO - mozscreenshot == 0.1 11:10:00 INFO - mozsystemmonitor == 0.3 11:10:00 INFO - moztest == 0.8 11:10:00 INFO - mozversion == 1.4 11:10:00 INFO - psutil == 3.1.1 11:10:00 INFO - requests == 1.2.3 11:10:00 INFO - wsgiref == 0.1.2 11:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:00 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:00 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:10:00 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:10:00 INFO - Using env: {'DISPLAY': ':0', 11:10:00 INFO - 'HOME': '/home/cltbld', 11:10:00 INFO - 'LANG': 'en_US.UTF-8', 11:10:00 INFO - 'LANGUAGE': 'en_US:en', 11:10:00 INFO - 'LOGNAME': 'cltbld', 11:10:00 INFO - 'MAIL': '/var/mail/cltbld', 11:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:00 INFO - 'MOZ_NO_REMOTE': '1', 11:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:00 INFO - 'NO_EM_RESTART': '1', 11:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:00 INFO - 'PWD': '/builds/slave/test', 11:10:00 INFO - 'SHELL': '/bin/bash', 11:10:00 INFO - 'SHLVL': '1', 11:10:00 INFO - 'TERM': 'linux', 11:10:00 INFO - 'TMOUT': '86400', 11:10:00 INFO - 'USER': 'cltbld', 11:10:00 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:00 INFO - '_': '/tools/buildbot/bin/python'} 11:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 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)) 11:10:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:10:00 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 11:10:00 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 11:10:00 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 11:10:00 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 11:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:10:01 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)) 11:10:01 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)) 11:10:01 INFO - Installing collected packages: simplejson 11:10:01 INFO - Running setup.py install for simplejson 11:10:01 INFO - building 'simplejson._speedups' extension 11:10:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:10:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:10:02 INFO - Successfully installed simplejson 11:10:02 INFO - Cleaning up... 11:10:02 INFO - Return code: 0 11:10:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:02 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/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 0x28381f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a04a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:10:02 INFO - Using env: {'DISPLAY': ':0', 11:10:02 INFO - 'HOME': '/home/cltbld', 11:10:02 INFO - 'LANG': 'en_US.UTF-8', 11:10:02 INFO - 'LANGUAGE': 'en_US:en', 11:10:02 INFO - 'LOGNAME': 'cltbld', 11:10:02 INFO - 'MAIL': '/var/mail/cltbld', 11:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:02 INFO - 'MOZ_NO_REMOTE': '1', 11:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:02 INFO - 'NO_EM_RESTART': '1', 11:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:02 INFO - 'PWD': '/builds/slave/test', 11:10:02 INFO - 'SHELL': '/bin/bash', 11:10:02 INFO - 'SHLVL': '1', 11:10:02 INFO - 'TERM': 'linux', 11:10:02 INFO - 'TMOUT': '86400', 11:10:02 INFO - 'USER': 'cltbld', 11:10:02 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:02 INFO - '_': '/tools/buildbot/bin/python'} 11:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:10:03 INFO - Cleaning up... 11:10:03 INFO - Return code: 0 11:10:03 INFO - Running post-action listener: _resource_record_post_action 11:10:03 INFO - Running post-action listener: _start_resource_monitoring 11:10:03 INFO - Starting resource monitoring. 11:10:03 INFO - [mozharness: 2017-08-04 18:10:03.195366Z] Finished create-virtualenv step (success) 11:10:03 INFO - [mozharness: 2017-08-04 18:10:03.195882Z] Running install step. 11:10:03 INFO - Running pre-action listener: _resource_record_pre_action 11:10:03 INFO - Running main action method: install 11:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:03 INFO - Reading from file tmpfile_stdout 11:10:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:03 INFO - Reading from file tmpfile_stdout 11:10:03 INFO - Output received: 11:10:03 INFO - Usage: mozinstall [options] installer 11:10:03 INFO - Options: 11:10:03 INFO - -h, --help show this help message and exit 11:10:03 INFO - -d DEST, --destination=DEST 11:10:03 INFO - Directory to install application into. [default: 11:10:03 INFO - "/builds/slave/test"] 11:10:03 INFO - --app=APP Application being installed. [default: firefox] 11:10:03 INFO - mkdir: /builds/slave/test/build/application 11:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:10:21 INFO - Reading from file tmpfile_stdout 11:10:21 INFO - Output received: 11:10:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:10:21 INFO - Running post-action listener: _resource_record_post_action 11:10:21 INFO - [mozharness: 2017-08-04 18:10:21.615487Z] Finished install step (success) 11:10:21 INFO - [mozharness: 2017-08-04 18:10:21.615767Z] Running setup-mitmproxy step. 11:10:21 INFO - Running pre-action listener: _resource_record_pre_action 11:10:21 INFO - Running main action method: setup_mitmproxy 11:10:21 INFO - Skipping: mitmproxy is not required 11:10:21 INFO - Running post-action listener: _resource_record_post_action 11:10:21 INFO - [mozharness: 2017-08-04 18:10:21.616919Z] Finished setup-mitmproxy step (success) 11:10:21 INFO - [mozharness: 2017-08-04 18:10:21.617138Z] Running run-tests step. 11:10:21 INFO - Running pre-action listener: _resource_record_pre_action 11:10:21 INFO - Running pre-action listener: _set_gcov_prefix 11:10:21 INFO - Running main action method: run_tests 11:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:21 INFO - Python 2.7.3 11:10:21 INFO - Return code: 0 11:10:21 INFO - grabbing minidump binary from tooltool 11:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:10:21 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/linux64/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 0x2ba4eb0>, '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 0x2ba5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba6240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:21 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:10:21 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/linux64/releng.manifest -o -c /builds/tooltool_cache 11:10:21 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:10:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:21 INFO - Return code: 0 11:10:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:10:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:21 INFO - ENV: RUST_BACKTRACE is now 1 11:10:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:10:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 11:10:21 INFO - Using env: {'DISPLAY': ':0', 11:10:21 INFO - 'HOME': '/home/cltbld', 11:10:21 INFO - 'LANG': 'en_US.UTF-8', 11:10:21 INFO - 'LANGUAGE': 'en_US:en', 11:10:21 INFO - 'LOGNAME': 'cltbld', 11:10:21 INFO - 'MAIL': '/var/mail/cltbld', 11:10:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:21 INFO - 'MOZ_NO_REMOTE': '1', 11:10:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:21 INFO - 'NO_EM_RESTART': '1', 11:10:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:21 INFO - 'PWD': '/builds/slave/test', 11:10:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:21 INFO - 'RUST_BACKTRACE': '1', 11:10:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:10:21 INFO - 'SHELL': '/bin/bash', 11:10:21 INFO - 'SHLVL': '1', 11:10:21 INFO - 'STYLO_FORCE_ENABLED': '1', 11:10:21 INFO - 'TERM': 'linux', 11:10:21 INFO - 'TMOUT': '86400', 11:10:21 INFO - 'USER': 'cltbld', 11:10:21 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561', 11:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:21 INFO - '_': '/tools/buildbot/bin/python'} 11:10:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 11:10:21 INFO - mozversion application_buildid: 20170804171917 11:10:21 INFO - mozversion application_changeset: 357ef8a67e8893d91ec6716fb66f42031c34a14c 11:10:21 INFO - mozversion application_display_name: Nightly 11:10:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:21 INFO - mozversion application_name: Firefox 11:10:21 INFO - mozversion application_remotingname: firefox 11:10:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:10:21 INFO - mozversion application_vendor: Mozilla 11:10:21 INFO - mozversion application_version: 57.0a1 11:10:21 INFO - mozversion platform_buildid: 20170804171917 11:10:21 INFO - mozversion platform_changeset: 357ef8a67e8893d91ec6716fb66f42031c34a14c 11:10:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:10:21 INFO - mozversion platform_version: 57.0a1 11:10:21 INFO - using testdate: 1501870221 11:10:21 INFO - actual date: 1501870221 11:10:21 INFO - starting webserver on 'localhost:56588' 11:10:21 INFO - SUITE-START | Running 2 tests 11:10:21 INFO - TEST-START | dromaeo_css 11:10:21 INFO - Initialising browser for dromaeo_css test... 11:10:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56588/getInfo.html -profile /tmp/tmpxCrJsp/profile 11:10:21 INFO - TEST-INFO | started process 27066 (/builds/slave/test/build/application/firefox/firefox http://localhost:56588/getInfo.html) 11:10:28 INFO - TEST-INFO | 27066: exit 0 11:10:28 INFO - Browser initialized. 11:10:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:28 INFO - TEST-INFO | started process 27291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCrJsp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:29 INFO - PID 27291 | 11:10:29 INFO - PID 27291 | (/builds/slave/test/build/application/firefox/firefox:27345): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:10:29 INFO - PID 27291 | 11:10:39 INFO - PID 27291 | RSS: Main: 173719552 11:10:39 INFO - PID 27291 | 11:13:39 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56588/tests/dromaeo/cssquery-ext.html) 11:13:40 INFO - PID 27291 | RSS: Main: 175898624 11:13:40 INFO - PID 27291 | 11:16:42 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-ext.html (next: http://localhost:56588/tests/dromaeo/cssquery-jquery.html) 11:16:42 INFO - PID 27291 | RSS: Main: 172748800 11:16:42 INFO - PID 27291 | 11:19:44 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56588/tests/dromaeo/cssquery-mootools.html) 11:19:45 INFO - PID 27291 | RSS: Main: 174665728 11:19:45 INFO - PID 27291 | 11:22:47 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56588/tests/dromaeo/cssquery-prototype.html) 11:22:47 INFO - PID 27291 | RSS: Main: 171343872 11:22:47 INFO - PID 27291 | 11:25:51 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56588/tests/dromaeo/cssquery-yui.html) 11:25:52 INFO - PID 27291 | RSS: Main: 176754688 11:25:52 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-yui.html (next: http://localhost:56588/tests/dromaeo/cssquery-dojo.html) 11:28:54 INFO - PID 27291 | RSS: Main: 176975872 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | __start_tp_report 11:28:54 INFO - PID 27291 | _x_x_mozilla_page_load 11:28:54 INFO - PID 27291 | _x_x_mozilla_page_load_details 11:28:54 INFO - PID 27291 | |i|pagename|runs| 11:28:54 INFO - PID 27291 | |0;dojo.html;3128.092853072609;3151.7005884441;3189.3302406494636;3198.664140265272;3207.695268949449;6121.143039974401;6308.77919272825;6327.841803954903;6346.619202847821;6357.809265722024;6076.939230607703;6159.798839226352;6189.2572891253;6200.441960223579;6210.913090209218;5721.856953576153;5731.340895796985;5731.684757338345;5766.855828604276;5873.85315367115;5756.654600723949;5797.449242321973;5843.357230704641;5848.649081055129;5873.442023007808;5700.116481945305;5778.4799368056865;5787.565932555075;5860.150278209657;5878.794242201524;5128.615353848439;5468.371137319219;5615.438456154352;5796.478316951495;5811.912821307684;5685.374608793029;5703.058995265817;5717.371089180187;5769.913451298234;5817.360090390053;6007.549433792483;6108.664023478706;6118.694065296761;6156.6613836238985;6249.343818899041;6602.1747281589805;6621.370969757913;6633.767818126391;6641.667916604199;6716.966415167942;6794.388505034522;6814.386705196506;6817.284185160586;6852.177738671341;6880.862382752317;6263.498920086382;6336.081268216129;6355.872882542323;6358.713857876407;6360.0777887206095;6902.171739391305;6929.757458488929;6936;6987.231404545496;7030.964845175844;6444;6526.477881769447;6532.6733663316645;6534.117894084333;6534.836629084216;6530.2816690164045;6534.934650653528;6543.476521878239;6543.836404089936;6547.508936829757;6627.03907933347;6741.224759152662;6810.250872404032;6826.112605361272;6849.794506164723;6575.868482630321;6599.241087275025;6676.83307917306;6687.1975362956755;6791.2190098139345;5440.646357986719;5450.046241907729;5509.201165830932;5522.834314970557;5532.170174473861;4567.2464043432465;4571.794269257892;4576.0161565263625;4592.242280023758;4603.309503574491;5839.970800146057;5841.299044114733;5857.297124345106;5860.8241752746635;5868.178455016301;6690.59856408617;6728.966355168192;6765.560238584476;6767.221769496571;6772;5823.679697616672;5865.824025279248;5871.882562348729;5886.470217680429;5962.821115366546;5945.851353716105;5948.375420580864;6039.184710064085;6041.365656605993;6049.516038716892;6321;6394.680265986682;6505.0892874997535;6598.340165983267;6599.571027883172;6685.966570167118;6742.325767423218;6769.593824370357;6772.187337519332;6775.424088952297;6466.902996454963;6506.707198175999;6517.478601711757;6520.641364724986;6523.11937888398;6605.867882642224;6643.40209381158;6650.20197576294;6651.63416012124;6697.062411262525;6729.764458243938;6741.831454213684;6751.527393082437;6847.07564478789;6851.657417129024;6462.547621666627;6516.446102081376;6609.173853268341;6613.867722645424;6617.7683781067435;6495.123158373559;6499.382558657109;6514.902276465951;6516.543841931019;6543.869122617616;6269.529785266214;6404.4876409886165;6477.0608261800835;6524.641144737085;6557.377049180321;6566.212054553484;6604.867902642017;6682.799516014527;6708.563943343667;6717.16035495563;6383.138276332821;6427.903581446376;6487.675616219264;6501.73993040292;6503.837404064936 11:28:54 INFO - PID 27291 | |1;ext.html;800.4396922154493;871.4379225399617;890.363390176024;891.8929728432593;1168.84220630215;30621.387572248543;40638.59361406385;41305;41515.58484415155;41614.375784363256;41075.79462102693;41474.585254147525;41508.37737433933;41508.58491415085;41534.16931661365;7292.781216563511;7472.327490525851;7623.428242881779;7929.801754956115;7931.405144614148;7636.3890888728765;7738.419618528605;7764.961175194145;7765;7774.183710710378;7697.961510192469;7747.5738834364365;7796.532208067534;7807.765767026998;7822;7637.961810190941;7791.610419479031;7793.96103019487;7794.493357931773;7802.882956755653;7697.961510192469;7794.259545343183;7797.337226335769;7802.453828232026;7802.804929876742;38345;38440.423393649115;38481;38578.80710596457;38684.806575967224;3619.149499867529;3647.598764135943;3652.4886515887797;3653.488511608377;3654.5614526256754;31082;31185.532217016764;31298.530522042187;31328.686713132804;31451.52822707661;4918.2376731606655;4969.900601987976;4994.625403094746;5003.399592048941;5027;190560;191493;192854;192871;194736;48888.75555622199;48990;49041.75479122653;49074.509254906996;49254;50924;51161.48838511642;51215.743921280155;51279.23081153711;51307;16520.83479165217;17046.23291951865;17054.74417883733;17072.061036643103;17083;12455.688607784878;12565.623031309075;12593.811092833432;13935.930320348536;14262.85737142636;13850.376733047036;13967.301634918416;14055.367508461939;14115.505957291445;14163.50427735045;5826.155207494974;5855.619384739978;5880.470757631833;5916;5999.760009599567;994.9005099489993;1013.4324778124274;1016.2682868334787;1024.2113572549094;1037.1754455207977;22785.772142278696;23263.651045234335;23318.766812332;23385.41536461602;23442.296731098093;1109.4785450838094;1121.1535290855352;1127.0926903842485;1133.2124173699365;1137.9374134422521;11988.820167697491;12000.759984800256;12138.757224855453;12162.270263784025;12253.75492490163;223927;225525;225561;225710;225891;49827;50113;50246;50353.24470132951;50384.748076259384;1478;1497.5582203250067;1502.2638906935522;1511.7278889799722;1528.0220658778392;22134.55730885341;22269.331920042423;22340.329790106323;22493.550128997;22516;37054.629453705114;37166;37178.628213717515;37182.25635487221;37186.44220336643;191397;191585;191888;192196;192210;33830;34452;36479.45280820843;36481.63518364782;36660.633393665725;44769.77615111903;46028.30957535573;46181;46206.30690539712;46828.531714682416;33343;33432.1641958953;33596.66403335935;33787.83106084454;34335.828320858236;33157.83421082879;33305.66694333026;33437;33511.99464016083;33835.83082084574;36324.09189770277;36489.63510364862;36584.81707591445;36827.26345473022;36837.26325473529;32406.18984525406;32555.511667324536;32933;33078.66921330852;33238.16904577405;23850.64224036606;23943.640845387683;24079.277621670677;24532;24548 11:28:54 INFO - PID 27291 | |2;jquery.html;564.3369041376382;574.6810520161312;580.7270582826076;584.8567101060239;590.6338070396355;21703.782962170375;22309.665355019686;22480.66279005814;22522.66216006757;22533.54932901343;25215;27173.728262717366;27216.863915680442;27249.591256131174;27421.588676169875;6470.255920569136;6591.5056370772145;6597.9340206598035;6621.404073633372;6663.833404164886;6389.808305750835;6512.7069281882195;6580.868382632344;6693.297203793581;7030.89453658193;7012.228654847962;7056.682449289769;7067.363937245646;7069.717211311541;7080.575165490061;7051.189113251965;7057.788266351992;7078.610676412795;7080.645967701595;7082.504224704273;6916.273791251947;6917.100776898971;6936.895946560806;6937.445004399636;6953.513254072217;30614.234644134074;31266.687333126603;32042.839785801156;32218.516722249184;32228;1947.8733882297606;1983.1769815526538;1984.0972357577268;1984.5237143085699;1985.7815640279557;20349;20754.896225518925;20979.370618881458;20980.16079356824;21020.579588408298;2526.6589010483535;2536.365908522869;2615.2677250369925;2621.357767346993;2633.907813226547;138980;141091;141282.29358853243;141786;142105.289473553;19383.4184974451;21558.676619850714;21718.78281217199;23473.887350138568;23513.412164695677;44325.77837110794;44512;44626.33060504095;44687.32969005468;44810.32784508235;11768.588099416651;11866.88133118675;12037.638870833889;12074.879251207376;12327.815082773766;10086.193104551618;10247.948760256151;10323.328983616191;10432.165426765841;10627.202959777893;11595.594154204562;11925.522979080914;12181.756364872654;12491.93754031224;12506.374681265901;4475.865724028285;4499.267781903991;4609.976950115228;4803.982327422491;4831.855044348676;947.3415975896824;968.7626531499686;978.7406337320616;995.348047029197;996.267743208741;20505.334306540055;20712.378628641163;20791.480212994495;20850.58298834015;20965.37103886886;1045.8431235314763;1046.41400815542;1056.587930707025;1062.4209805655937;1062.8086944349936;11316.94341528287;11481.942590287163;11575.42122893852;11655.59205427823;11748;414800;416447;423906;424240;429959;118572;118644;120809;121240;122167;1184.2539200303754;1260.4076084240576;1261.0794120292237;1261.211742660837;1264.5953294945714;18145.45563633093;18348.541286467946;18403.263869445072;18560.535986600444;18721.812781872006;56854.431455686565;57246.713766430905;58794.7060264696;60342;61689.69155154195;71747;71948;72663.27336726565;72673;72869.6356518214;14931.253437328307;15568.377264909277;15571.610709732347;15596.68806623884;15687.215639218222;24042;24253.878730606233;24889.87555062213;25128.49743005093;25197.370065748502;19230.519237019187;19543;19567.119479623736;19749.802501974795;19779.307724229584;16904.66190676155;17483.475495735147;17903.28386864563;18101.728474072635;18175;19287.228510859968;19816.60366792685;20275.391738247876;20443.284485042954;20622.38132856017;14890.702185956437;14989.925050374679;15170.317335719697;15362.462313818962;15395.07629542231;17980.19089141018;18118.637627247645;18325.450236492925;18593.81406185975;18883.244670213036 11:28:54 INFO - PID 27291 | |3;mootools.html;1353.1948490648065;1419.5386499387696;1422.0401229170307;1424.430227908837;1427.7644188708864;13485.123466974639;13651.863481365184;14067.226302553356;14094.64763380916;14104.294785260721;13853.445862165527;14584.708305833878;14586.562403127924;14603.926980365084;14661;2611.986940065297;2676.1570105416827;2679.517686816372;2679.5712685970248;2684;2516.5973444248925;2543.4531575711217;2624.868756562174;2678.4375281190974;2687.556553168725;2601.9479610407875;2602.8178027537983;2634.828736132155;2644.7619714225716;2644.907428240012;2458.2256589174353;2494.9251522454356;2506.486170335077;2523.974760252392;2538.5557527432716;2444.951100977988;2498.2755001049673;2502.3744063984004;2510.1214574898822;2551.56623374025;13042.673933151653;13163.802542961863;13206.669833254246;13240.668983275495;13241.73516529664;7422.331990120861;7698.884516732253;7710.845783084307;7711.498752581064;7711.884321735179;4595.816167353302;4822.252550854623;4944.851654450372;4958.826441074545;4994.175960966436;1869.9813001869943;1893.479293194369;1929.9807001929942;1968.931087411948;1973.526353675122;22902.88548557263;23365.182218622438;23414.88292558526;23420.18029368964;23460.296191114296;6426.132472116205;6466.605032357956;6468.15913931186;6587.440067594308;6634.800955971328;15727.764083538756;15850.52448426549;15859;15883;15918.681626367408;7396.593187374746;7513.060867391576;7527.8118047049265;7536.585487798224;7541;6857.245702972669;6972.616506092112;6991.126109236346;7014;7051.365377116084;4580.908381832344;4765.451973023147;4797.4482934462985;4844.370231869834;5002.199648056367;1254.5044707340548;1300.6098170548798;1301.5704817410233;1350.4665657065405;1399.944002239899;909.6770646420558;929.0987741890356;937.7561833923229;942.9057094290654;944.2210176604328;7925.405594580429;8091.231333023354;8104.756857294291;8165.63254653542;8167.305779008732;1011.959521619127;1019.5819713917407;1020.8009438159636;1021.065724861758;1025.564135242519;4604.5035363506995;4944.233643785219;4984.925226121611;5003.099442100457;5063.443021267658;18113.728294075598;18362;18521.259149634134;18579.535511612317;18833.434996950113;18069.367572134914;18136.818631813778;18276.08619569016;19457;19608.90195549013;10760.246782725135;10861.782764344669;10914.399708015977;10930.836037459445;10936.781264374667;8163.387745919199;8339.583020849055;8418.368622353226;8550.74347769568;8779.56102194875;16246.512604621881;16253.431129910396;16703.832961670712;16959.91520042392;17064.65870682604;17114.914425427793;17192.140392980553;17388.13059347053;17457.214425351143;17462.12689365552;10942.17933654963;10951.123910087015;11134.109271258118;11142.721431964266;11147.88852111501;12347.567835125728;12355.75288494207;12428.62714118578;12449.93775031119;12466.688332791753;9780.119789219005;10274.023967723055;10358.223133264884;10418.322809017389;10619.415932123808;9356.766080848034;10042.14641755459;10094.848577271494;10178.287519873538;10491.737706557093;8902.376833621584;9132.452052876848;9134.040925702706;9156.633734650539;9164.95417522908;6962.7911162665205;6995.440364770704;7046.541974771623;7057.858842823218;7096.112985876765;6818.318168183142;6821;6859.965700171467;6860.862782744217;6919.896201557081 11:28:54 INFO - PID 27291 | |4;prototype.html;507.3692902301564;513.2685922560352;534.1587000474253;535.5153586004667;537.498450477253;6116.969415152924;6142.969285153574;6199.225096862892;6264.937350626492;6270.46701030413;6087.77796104422;6090.147379366892;6113.174721412608;6139.600925939811;6174.302066931596;5093.414257360414;5121.3342265505435;5130.3074084998425;5137.306463627418;5158.174692049273;4808.519148085181;4949.158643030693;5086.135356989303;5092.5740792578135;5138.152204886189;4909.189983652693;4929.162042452792;4939.827106051289;4942.233953737176;4960.801567937278;4913.410390753114;4947.876303092397;4948.950510494885;4950.653454258203;4969.254611808222;4442.533533978918;4449.911001779947;4458.729262160269;4461.196984542814;4474.328850672393;6058.273007239115;6070.453659170696;6081.874853152137;6083.634981901056;6103.816885493442;5620.381758006616;5644.238027866227;5704.401037891003;5751.137329400582;5757.222774925415;6494.805155845285;6504.349565043505;6505.512086593524;6532.379423954764;6558.442532384753;4784.641151913585;4817.759112044384;4840.370751802278;4847.51524847516;4899.619262708755;6538.6730663467115;6567.179102612174;6801.557898736566;6814.591124532593;6827.795166145023;4933.679310844784;4933.753312334369;4962.33761689838;4979.4771548987555;5009.148444764399;4989.850304490871;5016.473270306638;5044.596432285409;5065.468125846806;5068.619853510928;5604.299462567179;5619.719014049281;5621.241132447149;5651.4348565143155;5665.575081868877;6456.8062958110395;6491.7078731457195;6531.6283580448635;6533.981601315252;6539.182602174728;1724.905130217825;1739.504241291226;1753.176007276578;1762.6386590748866;1766.2669991953453;1151.9020883225019;1213.4660749270292;1240.1504969096197;1241.2304371289858;1241.5344245907784;5725.77096916127;5755.309362876398;5779.306483222041;5800.187973683687;5813.912791308134;6561.015847622894;6616.900746488806;6751.122354093936;6751.628660423724;6767.39093481589;5790.855228619234;5831.3877042910735;5838.299404071538;5843.357230704619;5850.23946886902;3492;3563.7861728296384;3572.517710109154;3580.534530511017;3595.7662751921043;6348.650824204713;6431.389018043278;6442.194725659293;6450.193725784277;6457.2896981332015;6674.365935236145;6723.63020033893;6753.257141714407;6769.72921083161;6814;6428.453581445629;6441.3880681335195;6492.604784287379;6500.154979852589;6536.24833144185;6589.835254118685;6592.868142637025;6617.437517810848;6640.933590664032;6684.63234522106;6067.939320606737;6560.704768285534;6562.179727534059;6680.331966803281;6738.427233685192;6398.48812095022;6400.807975760735;6455.7740479083;6463.709133089116;6482.1660505543505;4910.508949105061;4918.901621967612;4943.604511638989;4989.226669866177;5023.673461225008;6375.585586936834;6389.808305750835;6550.344965503412;6589.967050164719;6596.340365963365;6392.20097487814;6394.596565901806;6406.583572067801;6453.419192272718;6491.221053473613;6314.431701146918;6365.554411191172;6368.853606350901;6433.388828061326;6485.3514648534765;6329.367063293634;6339.270983836917;6351.079093531504;6388.073729309317;6433.935660643334;6455.160829092188;6515.2833188348295;6518.066869908465;6524.151860258136;6529.249136349191;6230.221222347207;6235.220597425322;6295.464885484602;6315.715792789428;6319.842003949938 11:28:54 INFO - PID 27291 | |5;yui.html;910.1171863292608;912.8128733609609;922.7739203895047;932.5104320231882;938.7183844846544;17876.73184902226;18942.24231030759;18988;18992.430227093173;18992.525186870334;17692.82307176928;18982.810171898276;22520.887395563;22526.54946901061;22527.662085068736;1039.5997540946732;1061.9309744866598;1062.4740753327114;1063.8829728729872;1065.5151905882844;1046.7016900183448;1063.9627613033545;1066.5253961986919;1067.023673338894;1074.355386767941;776.5340795522698;802.1937952357902;811.6753298680545;1057.2018126314622;1116.3302018788702;1116.7878103160415;1121.5065371236672;1122.0630773304301;1122.1247427006947;1122.9438528073563;817.6075483767825;817.889584906036;818.0960039156765;818.4025661267308;818.4925346285281;18867.433976980712;19959.50101247466;20044.69932951007;20050.598988020305;20285.89857050705;20809;21175.47061323464;21380.679289810665;21450.14199432021;21820.563588728295;15036.624084397869;15111.093334399971;15286.694266114615;15372.461963831323;16544.172791360503;3623.2210074833774;3624.4563315502887;3634.7819130852236;3642.3261696586214;3646.781193128421;129438;133041;134752;135484.32257838844;135837;16303.103329316764;16511.422100226435;16770.161491925355;16914.492565223063;16929.06890121055;31254.374912501622;31463;31609;31896.36207275888;32001.679983200334;8559.572021398904;8574.571271436404;8618.525981070976;8640;8655.567221638892;3839.4240863870086;3988.7806170660892;3995.1011022520283;4018.8995275118355;4030.0327921299263;5221.190715439113;5390.676559406448;5390.865228369244;5402.459754024566;5403.162509810985;1104.111190491662;1157.0743405275746;1159.675290918544;1163.953441862333;1164.9941750291193;685.9588424694534;696.095076400677;700.3451772592642;708.5005071424633;713.4114355656604;12267.263964162179;12386.194897331825;12420;12597;12701.936490317674;701.6000879498739;701.8799646077557;708.7873637908607;709.9183593886769;715.3990647855826;5348.224507446476;5528;5591.580631452657;5660.915086273709;5745.913811292834;107330.46334768276;107800;107955;108087;112333.43833280781;76067;91911.54044229737;95270;100186;100726.4963675177;76395.61802191065;79933;80064;82601.17398826055;84377.57811210904;12630.747385052431;12703.745925081632;12716.919061879844;12843.422046007765;12913.225206487641;35251.47122793212;35263.82368088143;35344.646553534134;35674.643253567134;36513.63486365102;47176;47181.29228061651;47401.52598474109;48234.517654824405;49003;17977.460676179737;18174.27302907869;18414.631707366047;18737.063146842876;18770.812291877453;18368.632627347644;18393.448196554124;18484.81515184831;18501;18718.438446846616;18624.627507449502;18714.532136696693;18738.344157954405;18877.05614719286;19005.90497047561;18574.628507430047;18829.717554236973;18835.529111772314;18943.621127577648;18972.810271897106;18404.539886502946;18406.35577754772;18490.167942442353;18630.44108676742;18907.149178286734;13562.86437135616;13958.441662333393;14018;14451.349689263798;15136;12911.870881291066;13671.863281367458;14333.641658958193;14353.712925741218;14486.348114334669 11:28:54 INFO - PID 27291 | __end_tp_report 11:28:54 INFO - PID 27291 | __start_cc_report 11:28:54 INFO - PID 27291 | _x_x_mozilla_cycle_collect,375 11:28:54 INFO - PID 27291 | __end_cc_report 11:28:54 INFO - PID 27291 | __startTimestamp1501871334274__endTimestamp 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | ------- Summary: start ------- 11:28:54 INFO - PID 27291 | Number of tests: 6 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#0] dojo.html Cycles:165 Average:6184.49 Median:6462.55 stddev:733.12 (11.3%) stddev-sans-first:695.06 11:28:54 INFO - PID 27291 | Values: 3128.1 3151.7 3189.3 3198.7 3207.7 6121.1 6308.8 6327.8 6346.6 6357.8 6076.9 6159.8 6189.3 6200.4 6210.9 5721.9 5731.3 5731.7 5766.9 5873.9 5756.7 5797.4 5843.4 5848.6 5873.4 5700.1 5778.5 5787.6 5860.2 5878.8 5128.6 5468.4 5615.4 5796.5 5811.9 5685.4 5703.1 5717.4 5769.9 5817.4 6007.5 6108.7 6118.7 6156.7 6249.3 6602.2 6621.4 6633.8 6641.7 6717.0 6794.4 6814.4 6817.3 6852.2 6880.9 6263.5 6336.1 6355.9 6358.7 6360.1 6902.2 6929.8 6936.0 6987.2 7031.0 6444.0 6526.5 6532.7 6534.1 6534.8 6530.3 6534.9 6543.5 6543.8 6547.5 6627.0 6741.2 6810.3 6826.1 6849.8 6575.9 6599.2 6676.8 6687.2 6791.2 5440.6 5450.0 5509.2 5522.8 5532.2 4567.2 4571.8 4576.0 4592.2 4603.3 5840.0 5841.3 5857.3 5860.8 5868.2 6690.6 6729.0 6765.6 6767.2 6772.0 5823.7 5865.8 5871.9 5886.5 5962.8 5945.9 5948.4 6039.2 6041.4 6049.5 6321.0 6394.7 6505.1 6598.3 6599.6 6686.0 6742.3 6769.6 6772.2 6775.4 6466.9 6506.7 6517.5 6520.6 6523.1 6605.9 6643.4 6650.2 6651.6 6697.1 6729.8 6741.8 6751.5 6847.1 6851.7 6462.5 6516.4 6609.2 6613.9 6617.8 6495.1 6499.4 6514.9 6516.5 6543.9 6269.5 6404.5 6477.1 6524.6 6557.4 6566.2 6604.9 6682.8 6708.6 6717.2 6383.1 6427.9 6487.7 6501.7 6503.8 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#1] ext.html Cycles:180 Average:37489.01 Median:20063.53 stddev:52735.13 (262.8%) stddev-sans-first:52811.11 11:28:54 INFO - PID 27291 | Values: 800.4 871.4 890.4 891.9 1168.8 30621.4 40638.6 41305.0 41515.6 41614.4 41075.8 41474.6 41508.4 41508.6 41534.2 7292.8 7472.3 7623.4 7929.8 7931.4 7636.4 7738.4 7765.0 7765.0 7774.2 7698.0 7747.6 7796.5 7807.8 7822.0 7638.0 7791.6 7794.0 7794.5 7802.9 7698.0 7794.3 7797.3 7802.5 7802.8 38345.0 38440.4 38481.0 38578.8 38684.8 3619.1 3647.6 3652.5 3653.5 3654.6 31082.0 31185.5 31298.5 31328.7 31451.5 4918.2 4969.9 4994.6 5003.4 5027.0 190560.0 191493.0 192854.0 192871.0 194736.0 48888.8 48990.0 49041.8 49074.5 49254.0 50924.0 51161.5 51215.7 51279.2 51307.0 16520.8 17046.2 17054.7 17072.1 17083.0 12455.7 12565.6 12593.8 13935.9 14262.9 13850.4 13967.3 14055.4 14115.5 14163.5 5826.2 5855.6 5880.5 5916.0 5999.8 994.9 1013.4 1016.3 1024.2 1037.2 22785.8 23263.7 23318.8 23385.4 23442.3 1109.5 1121.2 1127.1 1133.2 1137.9 11988.8 12000.8 12138.8 12162.3 12253.8 223927.0 225525.0 225561.0 225710.0 225891.0 49827.0 50113.0 50246.0 50353.2 50384.7 1478.0 1497.6 1502.3 1511.7 1528.0 22134.6 22269.3 22340.3 22493.6 22516.0 37054.6 37166.0 37178.6 37182.3 37186.4 191397.0 191585.0 191888.0 192196.0 192210.0 33830.0 34452.0 36479.5 36481.6 36660.6 44769.8 46028.3 46181.0 46206.3 46828.5 33343.0 33432.2 33596.7 33787.8 34335.8 33157.8 33305.7 33437.0 33512.0 33835.8 36324.1 36489.6 36584.8 36827.3 36837.3 32406.2 32555.5 32933.0 33078.7 33238.2 23850.6 23943.6 24079.3 24532.0 24548.0 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#2] jquery.html Cycles:180 Average:34623.68 Median:21289.63 stddev:72304.40 (339.6%) stddev-sans-first:72462.01 11:28:54 INFO - PID 27291 | Values: 564.3 574.7 580.7 584.9 590.6 21703.8 22309.7 22480.7 22522.7 22533.5 25215.0 27173.7 27216.9 27249.6 27421.6 6470.3 6591.5 6597.9 6621.4 6663.8 6389.8 6512.7 6580.9 6693.3 7030.9 7012.2 7056.7 7067.4 7069.7 7080.6 7051.2 7057.8 7078.6 7080.6 7082.5 6916.3 6917.1 6936.9 6937.4 6953.5 30614.2 31266.7 32042.8 32218.5 32228.0 1947.9 1983.2 1984.1 1984.5 1985.8 20349.0 20754.9 20979.4 20980.2 21020.6 2526.7 2536.4 2615.3 2621.4 2633.9 138980.0 141091.0 141282.3 141786.0 142105.3 19383.4 21558.7 21718.8 23473.9 23513.4 44325.8 44512.0 44626.3 44687.3 44810.3 11768.6 11866.9 12037.6 12074.9 12327.8 10086.2 10247.9 10323.3 10432.2 10627.2 11595.6 11925.5 12181.8 12491.9 12506.4 4475.9 4499.3 4610.0 4804.0 4831.9 947.3 968.8 978.7 995.3 996.3 20505.3 20712.4 20791.5 20850.6 20965.4 1045.8 1046.4 1056.6 1062.4 1062.8 11316.9 11481.9 11575.4 11655.6 11748.0 414800.0 416447.0 423906.0 424240.0 429959.0 118572.0 118644.0 120809.0 121240.0 122167.0 1184.3 1260.4 1261.1 1261.2 1264.6 18145.5 18348.5 18403.3 18560.5 18721.8 56854.4 57246.7 58794.7 60342.0 61689.7 71747.0 71948.0 72663.3 72673.0 72869.6 14931.3 15568.4 15571.6 15596.7 15687.2 24042.0 24253.9 24889.9 25128.5 25197.4 19230.5 19543.0 19567.1 19749.8 19779.3 16904.7 17483.5 17903.3 18101.7 18175.0 19287.2 19816.6 20275.4 20443.3 20622.4 14890.7 14989.9 15170.3 15362.5 15395.1 17980.2 18118.6 18325.5 18593.8 18883.2 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#3] mootools.html Cycles:180 Average:8577.51 Median:2496.60 stddev:5857.81 (234.6%) stddev-sans-first:5849.09 11:28:54 INFO - PID 27291 | Values: 1353.2 1419.5 1422.0 1424.4 1427.8 13485.1 13651.9 14067.2 14094.6 14104.3 13853.4 14584.7 14586.6 14603.9 14661.0 2612.0 2676.2 2679.5 2679.6 2684.0 2516.6 2543.5 2624.9 2678.4 2687.6 2601.9 2602.8 2634.8 2644.8 2644.9 2458.2 2494.9 2506.5 2524.0 2538.6 2445.0 2498.3 2502.4 2510.1 2551.6 13042.7 13163.8 13206.7 13240.7 13241.7 7422.3 7698.9 7710.8 7711.5 7711.9 4595.8 4822.3 4944.9 4958.8 4994.2 1870.0 1893.5 1930.0 1968.9 1973.5 22902.9 23365.2 23414.9 23420.2 23460.3 6426.1 6466.6 6468.2 6587.4 6634.8 15727.8 15850.5 15859.0 15883.0 15918.7 7396.6 7513.1 7527.8 7536.6 7541.0 6857.2 6972.6 6991.1 7014.0 7051.4 4580.9 4765.5 4797.4 4844.4 5002.2 1254.5 1300.6 1301.6 1350.5 1399.9 909.7 929.1 937.8 942.9 944.2 7925.4 8091.2 8104.8 8165.6 8167.3 1012.0 1019.6 1020.8 1021.1 1025.6 4604.5 4944.2 4984.9 5003.1 5063.4 18113.7 18362.0 18521.3 18579.5 18833.4 18069.4 18136.8 18276.1 19457.0 19608.9 10760.2 10861.8 10914.4 10930.8 10936.8 8163.4 8339.6 8418.4 8550.7 8779.6 16246.5 16253.4 16703.8 16959.9 17064.7 17114.9 17192.1 17388.1 17457.2 17462.1 10942.2 10951.1 11134.1 11142.7 11147.9 12347.6 12355.8 12428.6 12449.9 12466.7 9780.1 10274.0 10358.2 10418.3 10619.4 9356.8 10042.1 10094.8 10178.3 10491.7 8902.4 9132.5 9134.0 9156.6 9165.0 6962.8 6995.4 7046.5 7057.9 7096.1 6818.3 6821.0 6860.0 6860.9 6919.9 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#4] prototype.html Cycles:180 Average:5467.00 Median:6088.96 stddev:1516.47 (24.9%) stddev-sans-first:1474.32 11:28:54 INFO - PID 27291 | Values: 507.4 513.3 534.2 535.5 537.5 6117.0 6143.0 6199.2 6264.9 6270.5 6087.8 6090.1 6113.2 6139.6 6174.3 5093.4 5121.3 5130.3 5137.3 5158.2 4808.5 4949.2 5086.1 5092.6 5138.2 4909.2 4929.2 4939.8 4942.2 4960.8 4913.4 4947.9 4949.0 4950.7 4969.3 4442.5 4449.9 4458.7 4461.2 4474.3 6058.3 6070.5 6081.9 6083.6 6103.8 5620.4 5644.2 5704.4 5751.1 5757.2 6494.8 6504.3 6505.5 6532.4 6558.4 4784.6 4817.8 4840.4 4847.5 4899.6 6538.7 6567.2 6801.6 6814.6 6827.8 4933.7 4933.8 4962.3 4979.5 5009.1 4989.9 5016.5 5044.6 5065.5 5068.6 5604.3 5619.7 5621.2 5651.4 5665.6 6456.8 6491.7 6531.6 6534.0 6539.2 1724.9 1739.5 1753.2 1762.6 1766.3 1151.9 1213.5 1240.2 1241.2 1241.5 5725.8 5755.3 5779.3 5800.2 5813.9 6561.0 6616.9 6751.1 6751.6 6767.4 5790.9 5831.4 5838.3 5843.4 5850.2 3492.0 3563.8 3572.5 3580.5 3595.8 6348.7 6431.4 6442.2 6450.2 6457.3 6674.4 6723.6 6753.3 6769.7 6814.0 6428.5 6441.4 6492.6 6500.2 6536.2 6589.8 6592.9 6617.4 6640.9 6684.6 6067.9 6560.7 6562.2 6680.3 6738.4 6398.5 6400.8 6455.8 6463.7 6482.2 4910.5 4918.9 4943.6 4989.2 5023.7 6375.6 6389.8 6550.3 6590.0 6596.3 6392.2 6394.6 6406.6 6453.4 6491.2 6314.4 6365.6 6368.9 6433.4 6485.4 6329.4 6339.3 6351.1 6388.1 6433.9 6455.2 6515.3 6518.1 6524.2 6529.2 6230.2 6235.2 6295.5 6315.7 6319.8 11:28:54 INFO - PID 27291 | 11:28:54 INFO - PID 27291 | [#5] yui.html Cycles:180 Average:22945.23 Median:18958.22 stddev:31400.53 (165.6%) stddev-sans-first:31445.03 11:28:54 INFO - PID 27291 | Values: 910.1 912.8 922.8 932.5 938.7 17876.7 18942.2 18988.0 18992.4 18992.5 17692.8 18982.8 22520.9 22526.5 22527.7 1039.6 1061.9 1062.5 1063.9 1065.5 1046.7 1064.0 1066.5 1067.0 1074.4 776.5 802.2 811.7 1057.2 1116.3 1116.8 1121.5 1122.1 1122.1 1122.9 817.6 817.9 818.1 818.4 818.5 18867.4 19959.5 20044.7 20050.6 20285.9 20809.0 21175.5 21380.7 21450.1 21820.6 15036.6 15111.1 15286.7 15372.5 16544.2 3623.2 3624.5 3634.8 3642.3 3646.8 129438.0 133041.0 134752.0 135484.3 135837.0 16303.1 16511.4 16770.2 16914.5 16929.1 31254.4 31463.0 31609.0 31896.4 32001.7 8559.6 8574.6 8618.5 8640.0 8655.6 3839.4 3988.8 3995.1 4018.9 4030.0 5221.2 5390.7 5390.9 5402.5 5403.2 1104.1 1157.1 1159.7 1164.0 1165.0 686.0 696.1 700.3 708.5 713.4 12267.3 12386.2 12420.0 12597.0 12701.9 701.6 701.9 708.8 709.9 715.4 5348.2 5528.0 5591.6 5660.9 5745.9 107330.5 107800.0 107955.0 108087.0 112333.4 76067.0 91911.5 95270.0 100186.0 100726.5 76395.6 79933.0 80064.0 82601.2 84377.6 12630.7 12703.7 12716.9 12843.4 12913.2 35251.5 35263.8 35344.6 35674.6 36513.6 47176.0 47181.3 47401.5 48234.5 49003.0 17977.5 18174.3 18414.6 18737.1 18770.8 18368.6 18393.4 18484.8 18501.0 18718.4 18624.6 18714.5 18738.3 18877.1 19005.9 18574.6 18829.7 18835.5 18943.6 18972.8 18404.5 18406.4 18490.2 18630.4 18907.1 13562.9 13958.4 14018.0 14451.3 15136.0 12911.9 13671.9 14333.6 14353.7 14486.3 11:28:54 INFO - PID 27291 | -------- Summary: end -------- 11:28:54 INFO - PID 27291 | 11:28:54 INFO - TEST-INFO | 27291: exit 0 11:28:54 INFO - TEST-OK | dromaeo_css | took 1112981ms 11:28:54 INFO - TEST-START | kraken 11:28:54 INFO - Initialising browser for kraken test... 11:28:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56588/getInfo.html -profile /tmp/tmpCXqzRF/profile 11:28:54 INFO - TEST-INFO | started process 27670 (/builds/slave/test/build/application/firefox/firefox http://localhost:56588/getInfo.html) 11:29:00 INFO - TEST-INFO | 27670: exit 0 11:29:00 INFO - Browser initialized. 11:29:00 INFO - Running cycle 1/1 for kraken test... 11:29:00 INFO - TEST-INFO | started process 27896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXqzRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:01 INFO - PID 27896 | 11:29:01 INFO - PID 27896 | (/builds/slave/test/build/application/firefox/firefox:27950): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:29:01 INFO - PID 27896 | 11:29:12 INFO - PID 27896 | RSS: Main: 173400064 11:29:12 INFO - PID 27896 | 11:29:14 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:15 INFO - PID 27896 | RSS: Main: 178548736 11:29:15 INFO - PID 27896 | 11:29:18 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-dft) 11:29:19 INFO - PID 27896 | RSS: Main: 179003392 11:29:19 INFO - PID 27896 | 11:29:22 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-fft) 11:29:22 INFO - PID 27896 | RSS: Main: 173338624 11:29:22 INFO - PID 27896 | 11:29:25 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-oscillator) 11:29:25 INFO - PID 27896 | RSS: Main: 173699072 11:29:25 INFO - PID 27896 | 11:29:28 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:28 INFO - PID 27896 | RSS: Main: 174215168 11:29:28 INFO - PID 27896 | 11:29:31 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:32 INFO - PID 27896 | RSS: Main: 176852992 11:29:32 INFO - PID 27896 | 11:29:36 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:36 INFO - PID 27896 | RSS: Main: 176652288 11:29:36 INFO - PID 27896 | 11:29:39 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56588/tests/kraken/driver.html?testName=json-parse-financial) 11:29:40 INFO - PID 27896 | RSS: Main: 177553408 11:29:40 INFO - PID 27896 | 11:29:41 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:42 INFO - PID 27896 | RSS: Main: 177405952 11:29:42 INFO - PID 27896 | 11:29:44 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:45 INFO - PID 27896 | RSS: Main: 174387200 11:29:45 INFO - PID 27896 | 11:29:47 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:48 INFO - PID 27896 | RSS: Main: 174272512 11:29:48 INFO - PID 27896 | 11:29:50 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:51 INFO - PID 27896 | RSS: Main: 174538752 11:29:51 INFO - PID 27896 | 11:29:54 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:55 INFO - PID 27896 | RSS: Main: 174542848 11:29:55 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56588/tests/kraken/driver.html?testName=ai-astar) 11:29:57 INFO - PID 27896 | RSS: Main: 176156672 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | __start_tp_report 11:29:57 INFO - PID 27896 | _x_x_mozilla_page_load 11:29:57 INFO - PID 27896 | _x_x_mozilla_page_load_details 11:29:57 INFO - PID 27896 | |i|pagename|runs| 11:29:57 INFO - PID 27896 | |0;ai-astar;101;108;103;110;108;113;112;101;116;109 11:29:57 INFO - PID 27896 | |1;audio-beat-detection;152;126;143;188;131;149;155;127;168;124 11:29:57 INFO - PID 27896 | |2;audio-dft;166;162;171;165;161;176;169;163;164;164 11:29:57 INFO - PID 27896 | |3;audio-fft;75;74;75;168;84;84;77;74;155;80 11:29:57 INFO - PID 27896 | |4;audio-oscillator;83;80;132;80;85;80;133;78;81;138 11:29:57 INFO - PID 27896 | |5;imaging-gaussian-blur;114;115;118;118;118;114;118;119;115;120 11:29:57 INFO - PID 27896 | |6;imaging-darkroom;151;153;150;151;151;152;153;159;152;151 11:29:57 INFO - PID 27896 | |7;imaging-desaturate;95;94;93;93;95;94;94;96;97;94 11:29:57 INFO - PID 27896 | |8;json-parse-financial;57;60;55;54;54;54;55;54;54;65 11:29:57 INFO - PID 27896 | |9;json-stringify-tinderbox;55;61;55;55;54;59;54;55;55;55 11:29:57 INFO - PID 27896 | |10;stanford-crypto-aes;81;95;79;100;78;92;79;90;90;77 11:29:57 INFO - PID 27896 | |11;stanford-crypto-ccm;136;127;127;135;130;134;127;127;133;162 11:29:57 INFO - PID 27896 | |12;stanford-crypto-pbkdf2;174;194;178;176;174;178;178;175;175;190 11:29:57 INFO - PID 27896 | |13;stanford-crypto-sha256-iterative;72;72;66;71;69;67;68;64;71;67 11:29:57 INFO - PID 27896 | __end_tp_report 11:29:57 INFO - PID 27896 | __start_cc_report 11:29:57 INFO - PID 27896 | _x_x_mozilla_cycle_collect,1008 11:29:57 INFO - PID 27896 | __end_cc_report 11:29:57 INFO - PID 27896 | __startTimestamp1501871397347__endTimestamp 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | ------- Summary: start ------- 11:29:57 INFO - PID 27896 | Number of tests: 14 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:5.09 (4.6%) stddev-sans-first:4.70 11:29:57 INFO - PID 27896 | Values: 101.0 108.0 103.0 110.0 108.0 113.0 112.0 101.0 116.0 109.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:150.50 stddev:20.69 (13.7%) stddev-sans-first:21.84 11:29:57 INFO - PID 27896 | Values: 152.0 126.0 143.0 188.0 131.0 149.0 155.0 127.0 168.0 124.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:4.63 (2.8%) stddev-sans-first:4.91 11:29:57 INFO - PID 27896 | Values: 166.0 162.0 171.0 165.0 161.0 176.0 169.0 163.0 164.0 164.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:35.59 (46.8%) stddev-sans-first:37.04 11:29:57 INFO - PID 27896 | Values: 75.0 74.0 75.0 168.0 84.0 84.0 77.0 74.0 155.0 80.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:80.00 stddev:25.88 (32.3%) stddev-sans-first:26.94 11:29:57 INFO - PID 27896 | Values: 83.0 80.0 132.0 80.0 85.0 80.0 133.0 78.0 81.0 138.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:118.00 stddev:2.18 (1.9%) stddev-sans-first:2.05 11:29:57 INFO - PID 27896 | Values: 114.0 115.0 118.0 118.0 118.0 114.0 118.0 119.0 115.0 120.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.00 stddev:2.54 (1.7%) stddev-sans-first:2.65 11:29:57 INFO - PID 27896 | Values: 151.0 153.0 150.0 151.0 151.0 152.0 153.0 159.0 152.0 151.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:1.27 (1.3%) stddev-sans-first:1.33 11:29:57 INFO - PID 27896 | Values: 95.0 94.0 93.0 93.0 95.0 94.0 94.0 96.0 97.0 94.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:3.65 (6.6%) stddev-sans-first:3.86 11:29:57 INFO - PID 27896 | Values: 57.0 60.0 55.0 54.0 54.0 54.0 55.0 54.0 54.0 65.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:55.00 stddev:2.30 (4.2%) stddev-sans-first:2.42 11:29:57 INFO - PID 27896 | Values: 55.0 61.0 55.0 55.0 54.0 59.0 54.0 55.0 55.0 55.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:8.25 (9.7%) stddev-sans-first:8.54 11:29:57 INFO - PID 27896 | Values: 81.0 95.0 79.0 100.0 78.0 92.0 79.0 90.0 90.0 77.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:133.50 stddev:10.55 (7.9%) stddev-sans-first:11.16 11:29:57 INFO - PID 27896 | Values: 136.0 127.0 127.0 135.0 130.0 134.0 127.0 127.0 133.0 162.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:178.00 stddev:6.99 (3.9%) stddev-sans-first:7.16 11:29:57 INFO - PID 27896 | Values: 174.0 194.0 178.0 176.0 174.0 178.0 178.0 175.0 175.0 190.0 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:70.00 stddev:2.75 (3.9%) stddev-sans-first:2.65 11:29:57 INFO - PID 27896 | Values: 72.0 72.0 66.0 71.0 69.0 67.0 68.0 64.0 71.0 67.0 11:29:57 INFO - PID 27896 | -------- Summary: end -------- 11:29:57 INFO - PID 27896 | 11:29:57 INFO - PID 27896 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:29:58 INFO - TEST-INFO | 27896: exit 0 11:29:58 INFO - TEST-OK | kraken | took 63285ms 11:29:58 INFO - SUITE-END | took 1176s 11:29:58 INFO - Completed test suite (00:19:36) 11:29:58 INFO - javascript benchmark 11:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8577.451229494874, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.092853072609, 3151.7005884441, 3189.3302406494636, 3198.664140265272, 3207.695268949449, 6121.143039974401, 6308.77919272825, 6327.841803954903, 6346.619202847821, 6357.809265722024, 6076.939230607703, 6159.798839226352, 6189.2572891253, 6200.441960223579, 6210.913090209218, 5721.856953576153, 5731.340895796985, 5731.684757338345, 5766.855828604276, 5873.85315367115, 5756.654600723949, 5797.449242321973, 5843.357230704641, 5848.649081055129, 5873.442023007808, 5700.116481945305, 5778.4799368056865, 5787.565932555075, 5860.150278209657, 5878.794242201524, 5128.615353848439, 5468.371137319219, 5615.438456154352, 5796.478316951495, 5811.912821307684, 5685.374608793029, 5703.058995265817, 5717.371089180187, 5769.913451298234, 5817.360090390053, 6007.549433792483, 6108.664023478706, 6118.694065296761, 6156.6613836238985, 6249.343818899041, 6602.1747281589805, 6621.370969757913, 6633.767818126391, 6641.667916604199, 6716.966415167942, 6794.388505034522, 6814.386705196506, 6817.284185160586, 6852.177738671341, 6880.862382752317, 6263.498920086382, 6336.081268216129, 6355.872882542323, 6358.713857876407, 6360.0777887206095, 6902.171739391305, 6929.757458488929, 6936.0, 6987.231404545496, 7030.964845175844, 6444.0, 6526.477881769447, 6532.6733663316645, 6534.117894084333, 6534.836629084216, 6530.2816690164045, 6534.934650653528, 6543.476521878239, 6543.836404089936, 6547.508936829757, 6627.03907933347, 6741.224759152662, 6810.250872404032, 6826.112605361272, 6849.794506164723, 6575.868482630321, 6599.241087275025, 6676.83307917306, 6687.1975362956755, 6791.2190098139345, 5440.646357986719, 5450.046241907729, 5509.201165830932, 5522.834314970557, 5532.170174473861, 4567.2464043432465, 4571.794269257892, 4576.0161565263625, 4592.242280023758, 4603.309503574491, 5839.970800146057, 5841.299044114733, 5857.297124345106, 5860.8241752746635, 5868.178455016301, 6690.59856408617, 6728.966355168192, 6765.560238584476, 6767.221769496571, 6772.0, 5823.679697616672, 5865.824025279248, 5871.882562348729, 5886.470217680429, 5962.821115366546, 5945.851353716105, 5948.375420580864, 6039.184710064085, 6041.365656605993, 6049.516038716892, 6321.0, 6394.680265986682, 6505.0892874997535, 6598.340165983267, 6599.571027883172, 6685.966570167118, 6742.325767423218, 6769.593824370357, 6772.187337519332, 6775.424088952297, 6466.902996454963, 6506.707198175999, 6517.478601711757, 6520.641364724986, 6523.11937888398, 6605.867882642224, 6643.40209381158, 6650.20197576294, 6651.63416012124, 6697.062411262525, 6729.764458243938, 6741.831454213684, 6751.527393082437, 6847.07564478789, 6851.657417129024, 6462.547621666627, 6516.446102081376, 6609.173853268341, 6613.867722645424, 6617.7683781067435, 6495.123158373559, 6499.382558657109, 6514.902276465951, 6516.543841931019, 6543.869122617616, 6269.529785266214, 6404.4876409886165, 6477.0608261800835, 6524.641144737085, 6557.377049180321, 6566.212054553484, 6604.867902642017, 6682.799516014527, 6708.563943343667, 6717.16035495563, 6383.138276332821, 6427.903581446376, 6487.675616219264, 6501.73993040292, 6503.837404064936], "value": 6129.307162579845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.4396922154493, 871.4379225399617, 890.363390176024, 891.8929728432593, 1168.84220630215, 30621.387572248543, 40638.59361406385, 41305.0, 41515.58484415155, 41614.375784363256, 41075.79462102693, 41474.585254147525, 41508.37737433933, 41508.58491415085, 41534.16931661365, 7292.781216563511, 7472.327490525851, 7623.428242881779, 7929.801754956115, 7931.405144614148, 7636.3890888728765, 7738.419618528605, 7764.961175194145, 7765.0, 7774.183710710378, 7697.961510192469, 7747.5738834364365, 7796.532208067534, 7807.765767026998, 7822.0, 7637.961810190941, 7791.610419479031, 7793.96103019487, 7794.493357931773, 7802.882956755653, 7697.961510192469, 7794.259545343183, 7797.337226335769, 7802.453828232026, 7802.804929876742, 38345.0, 38440.423393649115, 38481.0, 38578.80710596457, 38684.806575967224, 3619.149499867529, 3647.598764135943, 3652.4886515887797, 3653.488511608377, 3654.5614526256754, 31082.0, 31185.532217016764, 31298.530522042187, 31328.686713132804, 31451.52822707661, 4918.2376731606655, 4969.900601987976, 4994.625403094746, 5003.399592048941, 5027.0, 190560.0, 191493.0, 192854.0, 192871.0, 194736.0, 48888.75555622199, 48990.0, 49041.75479122653, 49074.509254906996, 49254.0, 50924.0, 51161.48838511642, 51215.743921280155, 51279.23081153711, 51307.0, 16520.83479165217, 17046.23291951865, 17054.74417883733, 17072.061036643103, 17083.0, 12455.688607784878, 12565.623031309075, 12593.811092833432, 13935.930320348536, 14262.85737142636, 13850.376733047036, 13967.301634918416, 14055.367508461939, 14115.505957291445, 14163.50427735045, 5826.155207494974, 5855.619384739978, 5880.470757631833, 5916.0, 5999.760009599567, 994.9005099489993, 1013.4324778124274, 1016.2682868334787, 1024.2113572549094, 1037.1754455207977, 22785.772142278696, 23263.651045234335, 23318.766812332, 23385.41536461602, 23442.296731098093, 1109.4785450838094, 1121.1535290855352, 1127.0926903842485, 1133.2124173699365, 1137.9374134422521, 11988.820167697491, 12000.759984800256, 12138.757224855453, 12162.270263784025, 12253.75492490163, 223927.0, 225525.0, 225561.0, 225710.0, 225891.0, 49827.0, 50113.0, 50246.0, 50353.24470132951, 50384.748076259384, 1478.0, 1497.5582203250067, 1502.2638906935522, 1511.7278889799722, 1528.0220658778392, 22134.55730885341, 22269.331920042423, 22340.329790106323, 22493.550128997, 22516.0, 37054.629453705114, 37166.0, 37178.628213717515, 37182.25635487221, 37186.44220336643, 191397.0, 191585.0, 191888.0, 192196.0, 192210.0, 33830.0, 34452.0, 36479.45280820843, 36481.63518364782, 36660.633393665725, 44769.77615111903, 46028.30957535573, 46181.0, 46206.30690539712, 46828.531714682416, 33343.0, 33432.1641958953, 33596.66403335935, 33787.83106084454, 34335.828320858236, 33157.83421082879, 33305.66694333026, 33437.0, 33511.99464016083, 33835.83082084574, 36324.09189770277, 36489.63510364862, 36584.81707591445, 36827.26345473022, 36837.26325473529, 32406.18984525406, 32555.511667324536, 32933.0, 33078.66921330852, 33238.16904577405, 23850.64224036606, 23943.640845387683, 24079.277621670677, 24532.0, 24548.0], "value": 17313.78438183542, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3369041376382, 574.6810520161312, 580.7270582826076, 584.8567101060239, 590.6338070396355, 21703.782962170375, 22309.665355019686, 22480.66279005814, 22522.66216006757, 22533.54932901343, 25215.0, 27173.728262717366, 27216.863915680442, 27249.591256131174, 27421.588676169875, 6470.255920569136, 6591.5056370772145, 6597.9340206598035, 6621.404073633372, 6663.833404164886, 6389.808305750835, 6512.7069281882195, 6580.868382632344, 6693.297203793581, 7030.89453658193, 7012.228654847962, 7056.682449289769, 7067.363937245646, 7069.717211311541, 7080.575165490061, 7051.189113251965, 7057.788266351992, 7078.610676412795, 7080.645967701595, 7082.504224704273, 6916.273791251947, 6917.100776898971, 6936.895946560806, 6937.445004399636, 6953.513254072217, 30614.234644134074, 31266.687333126603, 32042.839785801156, 32218.516722249184, 32228.0, 1947.8733882297606, 1983.1769815526538, 1984.0972357577268, 1984.5237143085699, 1985.7815640279557, 20349.0, 20754.896225518925, 20979.370618881458, 20980.16079356824, 21020.579588408298, 2526.6589010483535, 2536.365908522869, 2615.2677250369925, 2621.357767346993, 2633.907813226547, 138980.0, 141091.0, 141282.29358853243, 141786.0, 142105.289473553, 19383.4184974451, 21558.676619850714, 21718.78281217199, 23473.887350138568, 23513.412164695677, 44325.77837110794, 44512.0, 44626.33060504095, 44687.32969005468, 44810.32784508235, 11768.588099416651, 11866.88133118675, 12037.638870833889, 12074.879251207376, 12327.815082773766, 10086.193104551618, 10247.948760256151, 10323.328983616191, 10432.165426765841, 10627.202959777893, 11595.594154204562, 11925.522979080914, 12181.756364872654, 12491.93754031224, 12506.374681265901, 4475.865724028285, 4499.267781903991, 4609.976950115228, 4803.982327422491, 4831.855044348676, 947.3415975896824, 968.7626531499686, 978.7406337320616, 995.348047029197, 996.267743208741, 20505.334306540055, 20712.378628641163, 20791.480212994495, 20850.58298834015, 20965.37103886886, 1045.8431235314763, 1046.41400815542, 1056.587930707025, 1062.4209805655937, 1062.8086944349936, 11316.94341528287, 11481.942590287163, 11575.42122893852, 11655.59205427823, 11748.0, 414800.0, 416447.0, 423906.0, 424240.0, 429959.0, 118572.0, 118644.0, 120809.0, 121240.0, 122167.0, 1184.2539200303754, 1260.4076084240576, 1261.0794120292237, 1261.211742660837, 1264.5953294945714, 18145.45563633093, 18348.541286467946, 18403.263869445072, 18560.535986600444, 18721.812781872006, 56854.431455686565, 57246.713766430905, 58794.7060264696, 60342.0, 61689.69155154195, 71747.0, 71948.0, 72663.27336726565, 72673.0, 72869.6356518214, 14931.253437328307, 15568.377264909277, 15571.610709732347, 15596.68806623884, 15687.215639218222, 24042.0, 24253.878730606233, 24889.87555062213, 25128.49743005093, 25197.370065748502, 19230.519237019187, 19543.0, 19567.119479623736, 19749.802501974795, 19779.307724229584, 16904.66190676155, 17483.475495735147, 17903.28386864563, 18101.728474072635, 18175.0, 19287.228510859968, 19816.60366792685, 20275.391738247876, 20443.284485042954, 20622.38132856017, 14890.702185956437, 14989.925050374679, 15170.317335719697, 15362.462313818962, 15395.07629542231, 17980.19089141018, 18118.637627247645, 18325.450236492925, 18593.81406185975, 18883.244670213036], "value": 13078.488087738056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.1948490648065, 1419.5386499387696, 1422.0401229170307, 1424.430227908837, 1427.7644188708864, 13485.123466974639, 13651.863481365184, 14067.226302553356, 14094.64763380916, 14104.294785260721, 13853.445862165527, 14584.708305833878, 14586.562403127924, 14603.926980365084, 14661.0, 2611.986940065297, 2676.1570105416827, 2679.517686816372, 2679.5712685970248, 2684.0, 2516.5973444248925, 2543.4531575711217, 2624.868756562174, 2678.4375281190974, 2687.556553168725, 2601.9479610407875, 2602.8178027537983, 2634.828736132155, 2644.7619714225716, 2644.907428240012, 2458.2256589174353, 2494.9251522454356, 2506.486170335077, 2523.974760252392, 2538.5557527432716, 2444.951100977988, 2498.2755001049673, 2502.3744063984004, 2510.1214574898822, 2551.56623374025, 13042.673933151653, 13163.802542961863, 13206.669833254246, 13240.668983275495, 13241.73516529664, 7422.331990120861, 7698.884516732253, 7710.845783084307, 7711.498752581064, 7711.884321735179, 4595.816167353302, 4822.252550854623, 4944.851654450372, 4958.826441074545, 4994.175960966436, 1869.9813001869943, 1893.479293194369, 1929.9807001929942, 1968.931087411948, 1973.526353675122, 22902.88548557263, 23365.182218622438, 23414.88292558526, 23420.18029368964, 23460.296191114296, 6426.132472116205, 6466.605032357956, 6468.15913931186, 6587.440067594308, 6634.800955971328, 15727.764083538756, 15850.52448426549, 15859.0, 15883.0, 15918.681626367408, 7396.593187374746, 7513.060867391576, 7527.8118047049265, 7536.585487798224, 7541.0, 6857.245702972669, 6972.616506092112, 6991.126109236346, 7014.0, 7051.365377116084, 4580.908381832344, 4765.451973023147, 4797.4482934462985, 4844.370231869834, 5002.199648056367, 1254.5044707340548, 1300.6098170548798, 1301.5704817410233, 1350.4665657065405, 1399.944002239899, 909.6770646420558, 929.0987741890356, 937.7561833923229, 942.9057094290654, 944.2210176604328, 7925.405594580429, 8091.231333023354, 8104.756857294291, 8165.63254653542, 8167.305779008732, 1011.959521619127, 1019.5819713917407, 1020.8009438159636, 1021.065724861758, 1025.564135242519, 4604.5035363506995, 4944.233643785219, 4984.925226121611, 5003.099442100457, 5063.443021267658, 18113.728294075598, 18362.0, 18521.259149634134, 18579.535511612317, 18833.434996950113, 18069.367572134914, 18136.818631813778, 18276.08619569016, 19457.0, 19608.90195549013, 10760.246782725135, 10861.782764344669, 10914.399708015977, 10930.836037459445, 10936.781264374667, 8163.387745919199, 8339.583020849055, 8418.368622353226, 8550.74347769568, 8779.56102194875, 16246.512604621881, 16253.431129910396, 16703.832961670712, 16959.91520042392, 17064.65870682604, 17114.914425427793, 17192.140392980553, 17388.13059347053, 17457.214425351143, 17462.12689365552, 10942.17933654963, 10951.123910087015, 11134.109271258118, 11142.721431964266, 11147.88852111501, 12347.567835125728, 12355.75288494207, 12428.62714118578, 12449.93775031119, 12466.688332791753, 9780.119789219005, 10274.023967723055, 10358.223133264884, 10418.322809017389, 10619.415932123808, 9356.766080848034, 10042.14641755459, 10094.848577271494, 10178.287519873538, 10491.737706557093, 8902.376833621584, 9132.452052876848, 9134.040925702706, 9156.633734650539, 9164.95417522908, 6962.7911162665205, 6995.440364770704, 7046.541974771623, 7057.858842823218, 7096.112985876765, 6818.318168183142, 6821.0, 6859.965700171467, 6860.862782744217, 6919.896201557081], "value": 6278.885768446901, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.3692902301564, 513.2685922560352, 534.1587000474253, 535.5153586004667, 537.498450477253, 6116.969415152924, 6142.969285153574, 6199.225096862892, 6264.937350626492, 6270.46701030413, 6087.77796104422, 6090.147379366892, 6113.174721412608, 6139.600925939811, 6174.302066931596, 5093.414257360414, 5121.3342265505435, 5130.3074084998425, 5137.306463627418, 5158.174692049273, 4808.519148085181, 4949.158643030693, 5086.135356989303, 5092.5740792578135, 5138.152204886189, 4909.189983652693, 4929.162042452792, 4939.827106051289, 4942.233953737176, 4960.801567937278, 4913.410390753114, 4947.876303092397, 4948.950510494885, 4950.653454258203, 4969.254611808222, 4442.533533978918, 4449.911001779947, 4458.729262160269, 4461.196984542814, 4474.328850672393, 6058.273007239115, 6070.453659170696, 6081.874853152137, 6083.634981901056, 6103.816885493442, 5620.381758006616, 5644.238027866227, 5704.401037891003, 5751.137329400582, 5757.222774925415, 6494.805155845285, 6504.349565043505, 6505.512086593524, 6532.379423954764, 6558.442532384753, 4784.641151913585, 4817.759112044384, 4840.370751802278, 4847.51524847516, 4899.619262708755, 6538.6730663467115, 6567.179102612174, 6801.557898736566, 6814.591124532593, 6827.795166145023, 4933.679310844784, 4933.753312334369, 4962.33761689838, 4979.4771548987555, 5009.148444764399, 4989.850304490871, 5016.473270306638, 5044.596432285409, 5065.468125846806, 5068.619853510928, 5604.299462567179, 5619.719014049281, 5621.241132447149, 5651.4348565143155, 5665.575081868877, 6456.8062958110395, 6491.7078731457195, 6531.6283580448635, 6533.981601315252, 6539.182602174728, 1724.905130217825, 1739.504241291226, 1753.176007276578, 1762.6386590748866, 1766.2669991953453, 1151.9020883225019, 1213.4660749270292, 1240.1504969096197, 1241.2304371289858, 1241.5344245907784, 5725.77096916127, 5755.309362876398, 5779.306483222041, 5800.187973683687, 5813.912791308134, 6561.015847622894, 6616.900746488806, 6751.122354093936, 6751.628660423724, 6767.39093481589, 5790.855228619234, 5831.3877042910735, 5838.299404071538, 5843.357230704619, 5850.23946886902, 3492.0, 3563.7861728296384, 3572.517710109154, 3580.534530511017, 3595.7662751921043, 6348.650824204713, 6431.389018043278, 6442.194725659293, 6450.193725784277, 6457.2896981332015, 6674.365935236145, 6723.63020033893, 6753.257141714407, 6769.72921083161, 6814.0, 6428.453581445629, 6441.3880681335195, 6492.604784287379, 6500.154979852589, 6536.24833144185, 6589.835254118685, 6592.868142637025, 6617.437517810848, 6640.933590664032, 6684.63234522106, 6067.939320606737, 6560.704768285534, 6562.179727534059, 6680.331966803281, 6738.427233685192, 6398.48812095022, 6400.807975760735, 6455.7740479083, 6463.709133089116, 6482.1660505543505, 4910.508949105061, 4918.901621967612, 4943.604511638989, 4989.226669866177, 5023.673461225008, 6375.585586936834, 6389.808305750835, 6550.344965503412, 6589.967050164719, 6596.340365963365, 6392.20097487814, 6394.596565901806, 6406.583572067801, 6453.419192272718, 6491.221053473613, 6314.431701146918, 6365.554411191172, 6368.853606350901, 6433.388828061326, 6485.3514648534765, 6329.367063293634, 6339.270983836917, 6351.079093531504, 6388.073729309317, 6433.935660643334, 6455.160829092188, 6515.2833188348295, 6518.066869908465, 6524.151860258136, 6529.249136349191, 6230.221222347207, 6235.220597425322, 6295.464885484602, 6315.715792789428, 6319.842003949938], "value": 5024.031168868077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.1171863292608, 912.8128733609609, 922.7739203895047, 932.5104320231882, 938.7183844846544, 17876.73184902226, 18942.24231030759, 18988.0, 18992.430227093173, 18992.525186870334, 17692.82307176928, 18982.810171898276, 22520.887395563, 22526.54946901061, 22527.662085068736, 1039.5997540946732, 1061.9309744866598, 1062.4740753327114, 1063.8829728729872, 1065.5151905882844, 1046.7016900183448, 1063.9627613033545, 1066.5253961986919, 1067.023673338894, 1074.355386767941, 776.5340795522698, 802.1937952357902, 811.6753298680545, 1057.2018126314622, 1116.3302018788702, 1116.7878103160415, 1121.5065371236672, 1122.0630773304301, 1122.1247427006947, 1122.9438528073563, 817.6075483767825, 817.889584906036, 818.0960039156765, 818.4025661267308, 818.4925346285281, 18867.433976980712, 19959.50101247466, 20044.69932951007, 20050.598988020305, 20285.89857050705, 20809.0, 21175.47061323464, 21380.679289810665, 21450.14199432021, 21820.563588728295, 15036.624084397869, 15111.093334399971, 15286.694266114615, 15372.461963831323, 16544.172791360503, 3623.2210074833774, 3624.4563315502887, 3634.7819130852236, 3642.3261696586214, 3646.781193128421, 129438.0, 133041.0, 134752.0, 135484.32257838844, 135837.0, 16303.103329316764, 16511.422100226435, 16770.161491925355, 16914.492565223063, 16929.06890121055, 31254.374912501622, 31463.0, 31609.0, 31896.36207275888, 32001.679983200334, 8559.572021398904, 8574.571271436404, 8618.525981070976, 8640.0, 8655.567221638892, 3839.4240863870086, 3988.7806170660892, 3995.1011022520283, 4018.8995275118355, 4030.0327921299263, 5221.190715439113, 5390.676559406448, 5390.865228369244, 5402.459754024566, 5403.162509810985, 1104.111190491662, 1157.0743405275746, 1159.675290918544, 1163.953441862333, 1164.9941750291193, 685.9588424694534, 696.095076400677, 700.3451772592642, 708.5005071424633, 713.4114355656604, 12267.263964162179, 12386.194897331825, 12420.0, 12597.0, 12701.936490317674, 701.6000879498739, 701.8799646077557, 708.7873637908607, 709.9183593886769, 715.3990647855826, 5348.224507446476, 5528.0, 5591.580631452657, 5660.915086273709, 5745.913811292834, 107330.46334768276, 107800.0, 107955.0, 108087.0, 112333.43833280781, 76067.0, 91911.54044229737, 95270.0, 100186.0, 100726.4963675177, 76395.61802191065, 79933.0, 80064.0, 82601.17398826055, 84377.57811210904, 12630.747385052431, 12703.745925081632, 12716.919061879844, 12843.422046007765, 12913.225206487641, 35251.47122793212, 35263.82368088143, 35344.646553534134, 35674.643253567134, 36513.63486365102, 47176.0, 47181.29228061651, 47401.52598474109, 48234.517654824405, 49003.0, 17977.460676179737, 18174.27302907869, 18414.631707366047, 18737.063146842876, 18770.812291877453, 18368.632627347644, 18393.448196554124, 18484.81515184831, 18501.0, 18718.438446846616, 18624.627507449502, 18714.532136696693, 18738.344157954405, 18877.05614719286, 19005.90497047561, 18574.628507430047, 18829.717554236973, 18835.529111772314, 18943.621127577648, 18972.810271897106, 18404.539886502946, 18406.35577754772, 18490.167942442353, 18630.44108676742, 18907.149178286734, 13562.86437135616, 13958.441662333393, 14018.0, 14451.349689263798, 15136.0, 12911.870881291066, 13671.863281367458, 14333.641658958193, 14353.712925741218, 14486.348114334669], "value": 9095.46693796431, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 103.0, 110.0, 108.0, 113.0, 112.0, 101.0, 116.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 143.0, 188.0, 131.0, 149.0, 155.0, 127.0, 168.0, 124.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 171.0, 165.0, 161.0, 176.0, 169.0, 163.0, 164.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 168.0, 84.0, 84.0, 77.0, 74.0, 155.0, 80.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 132.0, 80.0, 85.0, 80.0, 133.0, 78.0, 81.0, 138.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 118.0, 118.0, 118.0, 114.0, 118.0, 119.0, 115.0, 120.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 150.0, 151.0, 151.0, 152.0, 153.0, 159.0, 152.0, 151.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 93.0, 95.0, 94.0, 94.0, 96.0, 97.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 65.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 55.0, 55.0, 54.0, 59.0, 54.0, 55.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 95.0, 79.0, 100.0, 78.0, 92.0, 79.0, 90.0, 90.0, 77.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 127.0, 135.0, 130.0, 134.0, 127.0, 127.0, 133.0, 162.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 194.0, 178.0, 176.0, 174.0, 178.0, 178.0, 175.0, 175.0, 190.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 66.0, 71.0, 69.0, 67.0, 68.0, 64.0, 71.0, 67.0], "value": 68.7, "unit": "score"}]}]} 11:29:58 INFO - Return code: 0 11:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:29:58 INFO - # TBPL SUCCESS # 11:29:58 INFO - Running post-action listener: _package_coverage_data 11:29:58 INFO - Running post-action listener: _resource_record_post_action 11:29:58 INFO - [mozharness: 2017-08-04 18:29:58.603293Z] Finished run-tests step (success) 11:29:58 INFO - Running post-run listener: _resource_record_post_run 11:29:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432132096; Read time: 16; Write time: 326412 11:29:58 INFO - TinderboxPrint: CPU usage
13.2% 11:29:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:29:58 INFO - TinderboxPrint: I/O write bytes / time
432,132,096 / 326,412 11:29:58 INFO - TinderboxPrint: CPU idle
8,268.9 (86.8%) 11:29:58 INFO - TinderboxPrint: CPU user
1,205.1 (12.7%) 11:29:58 INFO - TinderboxPrint: Swap in / out
0 / 0 11:29:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107737088; Read time: 0; Write time: 96224 11:29:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:29:58 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 324395008; Read time: 0; Write time: 230188 11:29:59 INFO - Running post-run listener: _upload_blobber_files 11:29:59 INFO - Blob upload gear active. 11:29:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:59 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 11:29:59 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29:59 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:59 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:00 INFO - (blobuploader) - INFO - Done attempting. 11:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:01 INFO - (blobuploader) - INFO - Done attempting. 11:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:01 INFO - (blobuploader) - INFO - Done attempting. 11:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:05 INFO - (blobuploader) - INFO - Done attempting. 11:30:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:30:05 INFO - Return code: 0 11:30:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:30:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:30:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7245f3d41e79b0b6ea8554cc31c5eef13d494f5623ab67a1b096098972cead847bc0bf4a1a72679d1c57809a77db8f70bc56956c5170013b86a5ae2d36a43515", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4081081be728c82532960e6585a3d363ed4f40464d10c96ec78fb278dec11d0e6eb4838266c07538a67ba7d8eb4a3b2cfd71cec20731217eed4446b2eef0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5fe04b8453a4257c284c4db347c193f47251150568945980c510bb85fb97e59810423ee2656e7064359664e3cca83d4711b6976809c08c3c1d0d4fc0526b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1c186a411f45c103a555f7184e5c1a535597fb39cefdee01ac096666ab21d5087d8b2d82ca79b7494ae791031c1d5e2a5f83477f85d7775aa8f7a4a768a721"} 11:30:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:30:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:30:05 INFO - Contents: 11:30:05 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7245f3d41e79b0b6ea8554cc31c5eef13d494f5623ab67a1b096098972cead847bc0bf4a1a72679d1c57809a77db8f70bc56956c5170013b86a5ae2d36a43515", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4081081be728c82532960e6585a3d363ed4f40464d10c96ec78fb278dec11d0e6eb4838266c07538a67ba7d8eb4a3b2cfd71cec20731217eed4446b2eef0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5fe04b8453a4257c284c4db347c193f47251150568945980c510bb85fb97e59810423ee2656e7064359664e3cca83d4711b6976809c08c3c1d0d4fc0526b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1c186a411f45c103a555f7184e5c1a535597fb39cefdee01ac096666ab21d5087d8b2d82ca79b7494ae791031c1d5e2a5f83477f85d7775aa8f7a4a768a721"} 11:30:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:30:05 INFO - Copying logs to upload dir... 11:30:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:30:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.965867 ========= master_lag: -0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-04 11:30:04.511660) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:30:04.515448) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7245f3d41e79b0b6ea8554cc31c5eef13d494f5623ab67a1b096098972cead847bc0bf4a1a72679d1c57809a77db8f70bc56956c5170013b86a5ae2d36a43515", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4081081be728c82532960e6585a3d363ed4f40464d10c96ec78fb278dec11d0e6eb4838266c07538a67ba7d8eb4a3b2cfd71cec20731217eed4446b2eef0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5fe04b8453a4257c284c4db347c193f47251150568945980c510bb85fb97e59810423ee2656e7064359664e3cca83d4711b6976809c08c3c1d0d4fc0526b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1c186a411f45c103a555f7184e5c1a535597fb39cefdee01ac096666ab21d5087d8b2d82ca79b7494ae791031c1d5e2a5f83477f85d7775aa8f7a4a768a721"} build_url:https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/YhryPzAGTxmLADsZTzVodg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7245f3d41e79b0b6ea8554cc31c5eef13d494f5623ab67a1b096098972cead847bc0bf4a1a72679d1c57809a77db8f70bc56956c5170013b86a5ae2d36a43515", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c4081081be728c82532960e6585a3d363ed4f40464d10c96ec78fb278dec11d0e6eb4838266c07538a67ba7d8eb4a3b2cfd71cec20731217eed4446b2eef0db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5fe04b8453a4257c284c4db347c193f47251150568945980c510bb85fb97e59810423ee2656e7064359664e3cca83d4711b6976809c08c3c1d0d4fc0526b46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d1c186a411f45c103a555f7184e5c1a535597fb39cefdee01ac096666ab21d5087d8b2d82ca79b7494ae791031c1d5e2a5f83477f85d7775aa8f7a4a768a721"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:30:04.540677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:30:04.541037) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=769a0cfe1e83e11e6f11f5a3000001a8-1501870151.871541-378910561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:30:04.625091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:30:04.625431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:30:04.625872) ========= ========= Total master_lag: -0.01 =========