builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1508424173.22 results: success (0) revision: 5ddf0b9c8ff294b1a530724379095c822f8c7b89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.223508) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.224006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.224304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.266904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.267269) ========= 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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-19 07:42:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.9M=0s 2017-10-19 07:42:53 (24.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.455158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.455454) ========= 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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018220 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.516061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:53.516380) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5ddf0b9c8ff294b1a530724379095c822f8c7b89 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5ddf0b9c8ff294b1a530724379095c822f8c7b89 --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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-19 07:42:53,697 truncating revision to first 12 chars 2017-10-19 07:42:53,697 Setting DEBUG logging. 2017-10-19 07:42:53,697 attempt 1/10 2017-10-19 07:42:53,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5ddf0b9c8ff2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-19 07:42:54,186 unpacking tar archive at: mozilla-beta-5ddf0b9c8ff2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.832492 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:54.378012) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:54.378284) ========= script_repo_revision: 5ddf0b9c8ff294b1a530724379095c822f8c7b89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:54.378659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:54.378930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-19 07:42:54.397247) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-19 07:42:54.400538) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:42:54 INFO - MultiFileLogger online at 20171019 07:42:54 in /builds/slave/test 07:42:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 07:42:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:54 INFO - {'append_to_log': False, 07:42:54 INFO - 'base_work_dir': '/builds/slave/test', 07:42:54 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:42:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:54 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:42:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:54 INFO - 'code_coverage': False, 07:42:54 INFO - 'config_files': ('talos/linux_config.py',), 07:42:54 INFO - 'default_actions': ('clobber', 07:42:54 INFO - 'read-buildbot-config', 07:42:54 INFO - 'download-and-extract', 07:42:54 INFO - 'populate-webroot', 07:42:54 INFO - 'create-virtualenv', 07:42:54 INFO - 'install', 07:42:54 INFO - 'setup-mitmproxy', 07:42:54 INFO - 'run-tests'), 07:42:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:54 INFO - 'disable_ccov_upload': False, 07:42:54 INFO - 'disable_stylo': False, 07:42:54 INFO - 'download_minidump_stackwalk': True, 07:42:54 INFO - 'download_symbols': 'ondemand', 07:42:54 INFO - 'enable_stylo': False, 07:42:54 INFO - 'enable_webrender': False, 07:42:54 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:42:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:54 INFO - 'gecko_profile': False, 07:42:54 INFO - 'gecko_profile_interval': 0, 07:42:54 INFO - 'installer_path': 'installer.exe', 07:42:54 INFO - 'log_level': 'info', 07:42:54 INFO - 'log_name': 'talos', 07:42:54 INFO - 'log_to_console': True, 07:42:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:42:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:42:54 INFO - 'opt_config_files': (), 07:42:54 INFO - 'pip_index': False, 07:42:54 INFO - 'suite': 'dromaeojs-e10s', 07:42:54 INFO - 'system_bits': '32', 07:42:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:54 INFO - 'title': 'talos-linux64-ix-024', 07:42:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:54 INFO - 'use_talos_json': True, 07:42:54 INFO - 'verify': 'False', 07:42:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:54 INFO - 'work_dir': 'build'} 07:42:54 INFO - [mozharness: 2017-10-19 14:42:54.728077Z] Running clobber step. 07:42:54 INFO - Running pre-action listener: _resource_record_pre_action 07:42:54 INFO - Running main action method: clobber 07:42:54 INFO - rmtree: /builds/slave/test/build 07:42:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:56 INFO - Running post-action listener: _resource_record_post_action 07:42:56 INFO - [mozharness: 2017-10-19 14:42:56.323569Z] Finished clobber step (success) 07:42:56 INFO - [mozharness: 2017-10-19 14:42:56.323667Z] Running read-buildbot-config step. 07:42:56 INFO - Running pre-action listener: _resource_record_pre_action 07:42:56 INFO - Running main action method: read_buildbot_config 07:42:56 INFO - Using buildbot properties: 07:42:56 INFO - { 07:42:56 INFO - "project": "", 07:42:56 INFO - "product": "firefox", 07:42:56 INFO - "who": "ryanvm@gmail.com", 07:42:56 INFO - "installer_path": "public/build/target.tar.bz2", 07:42:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:42:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:42:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:42:56 INFO - "stage_platform": "linux64", 07:42:56 INFO - "basedir": "/builds/slave/test", 07:42:56 INFO - "buildnumber": 169, 07:42:56 INFO - "platform": "ubuntu64_hw", 07:42:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:42:56 INFO - "slavebuilddir": "test", 07:42:56 INFO - "taskId": "HK1UlnHnRtKBpsoqbLKNpA", 07:42:56 INFO - "branch": "mozilla-beta", 07:42:56 INFO - "script_repo_revision": "production", 07:42:56 INFO - "revision": "5ddf0b9c8ff294b1a530724379095c822f8c7b89", 07:42:56 INFO - "slavename": "talos-linux64-ix-024", 07:42:56 INFO - "repo_path": "releases/mozilla-beta" 07:42:56 INFO - } 07:42:56 INFO - Finding installer, test and symbols from parent task. 07:42:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK1UlnHnRtKBpsoqbLKNpA'}, attempt #1 07:42:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HK1UlnHnRtKBpsoqbLKNpA'}, attempt #1 07:42:57 INFO - Task dependencies: eCj2xzuFSri3h8uQrGZksg 07:42:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg'}, attempt #1 07:42:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 07:42:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.test_packages.json 07:42:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.crashreporter-symbols.zip 07:42:57 INFO - Running post-action listener: _resource_record_post_action 07:42:57 INFO - [mozharness: 2017-10-19 14:42:57.642344Z] Finished read-buildbot-config step (success) 07:42:57 INFO - [mozharness: 2017-10-19 14:42:57.642562Z] Running download-and-extract step. 07:42:57 INFO - Running pre-action listener: _resource_record_pre_action 07:42:57 INFO - Running main action method: download_and_extract 07:42:57 INFO - mkdir: /builds/slave/test/build/tests 07:42: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')]} 07:42:57 INFO - trying https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.test_packages.json 07:42:57 INFO - Downloading https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:42:58 INFO - Downloaded 989 bytes. 07:42:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:42:58 INFO - Using the following test package requirements: 07:42:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:42:58 INFO - u'common': [u'target.common.tests.zip'], 07:42:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:42:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:42:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:42:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:42:58 INFO - u'mozbase': [u'target.common.tests.zip'], 07:42:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:42:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:42:58 INFO - u'web-platform': [u'target.common.tests.zip', 07:42:58 INFO - u'target.web-platform.tests.tar.gz'], 07:42:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:42:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.common.tests.zip 07:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.common.tests.zip into memory 07:43:01 INFO - Content-Length response header: 55175190 07:43:01 INFO - Bytes received: 55175190 07:43:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.talos.tests.zip 07:43:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:43:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.talos.tests.zip into memory 07:43:13 INFO - Content-Length response header: 14509096 07:43:13 INFO - Bytes received: 14509096 07:43:13 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')]} 07:43:13 INFO - trying https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 07:43:13 INFO - Downloading https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:43:18 INFO - Downloaded 53576938 bytes. 07:43:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 07:43:18 INFO - mkdir: /builds/slave/test/properties 07:43:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:43:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:43:18 INFO - Contents: 07:43:18 INFO - build_url:https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 07:43:18 INFO - Running post-action listener: _resource_record_post_action 07:43:18 INFO - Running post-action listener: find_tests_for_verification 07:43:18 INFO - Running post-action listener: set_extra_try_arguments 07:43:18 INFO - [mozharness: 2017-10-19 14:43:18.614615Z] Finished download-and-extract step (success) 07:43:18 INFO - [mozharness: 2017-10-19 14:43:18.614768Z] Running populate-webroot step. 07:43:18 INFO - Running pre-action listener: _resource_record_pre_action 07:43:18 INFO - Running main action method: populate_webroot 07:43:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:19 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['tresize', 07:43:19 INFO - 'tcanvasmark']}, 07:43:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:19 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['dromaeo_css', 07:43:19 INFO - 'kraken']}, 07:43:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:19 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'tests': ['damp', 'tps']}, 07:43:19 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['damp', 'tps']}, 07:43:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:19 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['dromaeo_dom']}, 07:43:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:43:19 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['basic_compositor_video', 07:43:19 INFO - 'glvideo']}, 07:43:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:43:19 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['ts_paint_webext', 07:43:19 INFO - 'tp5o_webext']}, 07:43:19 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:19 INFO - 'ts_paint', 07:43:19 INFO - 'tpaint', 07:43:19 INFO - 'sessionrestore', 07:43:19 INFO - 'sessionrestore_many_windows', 07:43:19 INFO - 'sessionrestore_no_auto_restore', 07:43:19 INFO - 'tabpaint']}, 07:43:19 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['a11yr', 07:43:19 INFO - 'ts_paint', 07:43:19 INFO - 'tpaint', 07:43:19 INFO - 'sessionrestore', 07:43:19 INFO - 'sessionrestore_many_windows', 07:43:19 INFO - 'sessionrestore_no_auto_restore', 07:43:19 INFO - 'tabpaint']}, 07:43:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:43:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:43:19 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['perf_reftest_singletons']}, 07:43:19 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['bloom_basic']}, 07:43:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:19 INFO - 'tsvgr_opacity', 07:43:19 INFO - 'tart', 07:43:19 INFO - 'tscrollx', 07:43:19 INFO - 'tsvg_static']}, 07:43:19 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['tsvgx', 07:43:19 INFO - 'tsvgr_opacity', 07:43:19 INFO - 'tart', 07:43:19 INFO - 'tscrollx', 07:43:19 INFO - 'tsvg_static']}, 07:43:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:43:19 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo'], 07:43:19 INFO - 'tests': ['tp5o']}, 07:43:19 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:19 INFO - 'talos_options': ['--mitmproxy', 07:43:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:19 INFO - '--firstNonBlankPaint'], 07:43:19 INFO - 'tests': ['tp6_google', 07:43:19 INFO - 'tp6_youtube', 07:43:19 INFO - 'tp6_amazon', 07:43:19 INFO - 'tp6_facebook']}, 07:43:19 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo', 07:43:19 INFO - '--mitmproxy', 07:43:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:19 INFO - '--firstNonBlankPaint'], 07:43:19 INFO - 'tests': ['tp6_google', 07:43:19 INFO - 'tp6_youtube', 07:43:19 INFO - 'tp6_amazon', 07:43:19 INFO - 'tp6_facebook']}, 07:43:19 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:43:19 INFO - 'talos_options': ['--stylo-threads=1', 07:43:19 INFO - '--mitmproxy', 07:43:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:43:19 INFO - '--firstNonBlankPaint'], 07:43:19 INFO - 'tests': ['tp6_google', 07:43:19 INFO - 'tp6_youtube', 07:43:19 INFO - 'tp6_amazon', 07:43:19 INFO - 'tp6_facebook']}, 07:43:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--xperf_path', 07:43:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:19 INFO - 'tests': ['tp5n']}, 07:43:19 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:43:19 INFO - 'talos_options': ['--disable-stylo', 07:43:19 INFO - '--xperf_path', 07:43:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:19 INFO - 'tests': ['tp5n']}}} 07:43:19 INFO - Running post-action listener: _resource_record_post_action 07:43:19 INFO - [mozharness: 2017-10-19 14:43:19.042409Z] Finished populate-webroot step (success) 07:43:19 INFO - [mozharness: 2017-10-19 14:43:19.042506Z] Running create-virtualenv step. 07:43:19 INFO - Running pre-action listener: _resource_record_pre_action 07:43:19 INFO - Running main action method: create_virtualenv 07:43:19 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:19 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:43:19 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:43:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:43:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:19 INFO - Installing pip...............done. 07:43:19 INFO - Return code: 0 07:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:43:20 INFO - Reading from file tmpfile_stdout 07:43:20 INFO - Output received: 07:43:20 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:43:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43:20 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')]} 07:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:20 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')]} 07:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:20 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 07:43:20 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 07:43:20 INFO - Using env: {'DISPLAY': ':0', 07:43:20 INFO - 'HOME': '/home/cltbld', 07:43:20 INFO - 'LANG': 'en_US.UTF-8', 07:43:20 INFO - 'LANGUAGE': 'en_US:en', 07:43:20 INFO - 'LOGNAME': 'cltbld', 07:43:20 INFO - 'MAIL': '/var/mail/cltbld', 07:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:20 INFO - 'MOZ_NO_REMOTE': '1', 07:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:20 INFO - 'NO_EM_RESTART': '1', 07:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:20 INFO - 'PWD': '/builds/slave/test', 07:43:20 INFO - 'SHELL': '/bin/bash', 07:43:20 INFO - 'SHLVL': '1', 07:43:20 INFO - 'TERM': 'linux', 07:43:20 INFO - 'TMOUT': '86400', 07:43:20 INFO - 'USER': 'cltbld', 07:43:20 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:20 INFO - '_': '/tools/buildbot/bin/python'} 07:43:21 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:43:21 INFO - Downloading/unpacking pip>=1.5 07:43:21 INFO - Running setup.py egg_info for package pip 07:43:21 INFO - warning: no files found matching 'pip/cacert.pem' 07:43:21 INFO - warning: no files found matching '*.html' under directory 'docs' 07:43:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:43:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:43:21 INFO - Installing collected packages: pip 07:43:21 INFO - Found existing installation: pip 1.1 07:43:21 INFO - Uninstalling pip: 07:43:21 INFO - Successfully uninstalled pip 07:43:21 INFO - Running setup.py install for pip 07:43:21 INFO - warning: no files found matching 'pip/cacert.pem' 07:43:21 INFO - warning: no files found matching '*.html' under directory 'docs' 07:43:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:43:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:43:21 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:43:21 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:43:21 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:43:21 INFO - Successfully installed pip 07:43:21 INFO - Cleaning up... 07:43:21 INFO - Return code: 0 07:43:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43: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')]} 07:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:21 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 07:43:21 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 07:43:21 INFO - Using env: {'DISPLAY': ':0', 07:43:21 INFO - 'HOME': '/home/cltbld', 07:43:21 INFO - 'LANG': 'en_US.UTF-8', 07:43:21 INFO - 'LANGUAGE': 'en_US:en', 07:43:21 INFO - 'LOGNAME': 'cltbld', 07:43:21 INFO - 'MAIL': '/var/mail/cltbld', 07:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:21 INFO - 'MOZ_NO_REMOTE': '1', 07:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:21 INFO - 'NO_EM_RESTART': '1', 07:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:21 INFO - 'PWD': '/builds/slave/test', 07:43:21 INFO - 'SHELL': '/bin/bash', 07:43:21 INFO - 'SHLVL': '1', 07:43:21 INFO - 'TERM': 'linux', 07:43:21 INFO - 'TMOUT': '86400', 07:43:21 INFO - 'USER': 'cltbld', 07:43:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:21 INFO - '_': '/tools/buildbot/bin/python'} 07:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:21 INFO - Downloading/unpacking psutil>=3.1.1 07:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:22 INFO - Installing collected packages: psutil 07:43:22 INFO - Running setup.py install for psutil 07:43:22 INFO - building 'psutil._psutil_linux' extension 07:43:22 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 07:43:22 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 07:43:23 INFO - building 'psutil._psutil_posix' extension 07:43:23 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 07:43:23 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 07:43:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:23 INFO - Successfully installed psutil 07:43:23 INFO - Cleaning up... 07:43:23 INFO - Return code: 0 07:43:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:43:23 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')]} 07:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:23 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')]} 07:43:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:23 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:23 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 07:43:23 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 07:43:23 INFO - Using env: {'DISPLAY': ':0', 07:43:23 INFO - 'HOME': '/home/cltbld', 07:43:23 INFO - 'LANG': 'en_US.UTF-8', 07:43:23 INFO - 'LANGUAGE': 'en_US:en', 07:43:23 INFO - 'LOGNAME': 'cltbld', 07:43:23 INFO - 'MAIL': '/var/mail/cltbld', 07:43:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:23 INFO - 'MOZ_NO_REMOTE': '1', 07:43:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:23 INFO - 'NO_EM_RESTART': '1', 07:43:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:23 INFO - 'PWD': '/builds/slave/test', 07:43:23 INFO - 'SHELL': '/bin/bash', 07:43:23 INFO - 'SHLVL': '1', 07:43:23 INFO - 'TERM': 'linux', 07:43:23 INFO - 'TMOUT': '86400', 07:43:23 INFO - 'USER': 'cltbld', 07:43:23 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:23 INFO - '_': '/tools/buildbot/bin/python'} 07:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:43:23 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 07:43:23 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 07:43:23 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 07:43:23 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 07:43:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:43:24 INFO - Installing collected packages: mozsystemmonitor 07:43:24 INFO - Running setup.py install for mozsystemmonitor 07:43:24 INFO - Successfully installed mozsystemmonitor 07:43:24 INFO - Cleaning up... 07:43:25 INFO - Return code: 0 07:43:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:43:25 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')]} 07:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:25 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')]} 07:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:25 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:25 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 07:43:25 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 07:43:25 INFO - Using env: {'DISPLAY': ':0', 07:43:25 INFO - 'HOME': '/home/cltbld', 07:43:25 INFO - 'LANG': 'en_US.UTF-8', 07:43:25 INFO - 'LANGUAGE': 'en_US:en', 07:43:25 INFO - 'LOGNAME': 'cltbld', 07:43:25 INFO - 'MAIL': '/var/mail/cltbld', 07:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:25 INFO - 'MOZ_NO_REMOTE': '1', 07:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:25 INFO - 'NO_EM_RESTART': '1', 07:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:25 INFO - 'PWD': '/builds/slave/test', 07:43:25 INFO - 'SHELL': '/bin/bash', 07:43:25 INFO - 'SHLVL': '1', 07:43:25 INFO - 'TERM': 'linux', 07:43:25 INFO - 'TMOUT': '86400', 07:43:25 INFO - 'USER': 'cltbld', 07:43:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:25 INFO - '_': '/tools/buildbot/bin/python'} 07:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:43:26 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 07:43:26 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 07:43:26 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 07:43:26 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 07:43:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:26 INFO - warning: no files found matching '*.txt' 07:43:26 INFO - no previously-included directories found matching 'build' 07:43:26 INFO - no previously-included directories found matching 'dist' 07:43:26 INFO - no previously-included directories found matching '.git*' 07:43:26 INFO - Installing collected packages: jsonschema, functools32 07:43:26 INFO - Running setup.py install for functools32 07:43:26 INFO - warning: no files found matching '*.txt' 07:43:26 INFO - no previously-included directories found matching 'build' 07:43:26 INFO - no previously-included directories found matching 'dist' 07:43:26 INFO - no previously-included directories found matching '.git*' 07:43:26 INFO - Successfully installed jsonschema functools32 07:43:26 INFO - Cleaning up... 07:43:26 INFO - Return code: 0 07:43:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:43:26 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')]} 07:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:26 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')]} 07:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:26 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:26 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 07:43:26 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 07:43:26 INFO - Using env: {'DISPLAY': ':0', 07:43:26 INFO - 'HOME': '/home/cltbld', 07:43:26 INFO - 'LANG': 'en_US.UTF-8', 07:43:26 INFO - 'LANGUAGE': 'en_US:en', 07:43:26 INFO - 'LOGNAME': 'cltbld', 07:43:26 INFO - 'MAIL': '/var/mail/cltbld', 07:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:26 INFO - 'MOZ_NO_REMOTE': '1', 07:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:26 INFO - 'NO_EM_RESTART': '1', 07:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:26 INFO - 'PWD': '/builds/slave/test', 07:43:26 INFO - 'SHELL': '/bin/bash', 07:43:26 INFO - 'SHLVL': '1', 07:43:26 INFO - 'TERM': 'linux', 07:43:26 INFO - 'TMOUT': '86400', 07:43:26 INFO - 'USER': 'cltbld', 07:43:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:26 INFO - '_': '/tools/buildbot/bin/python'} 07:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:43:26 INFO - Cleaning up... 07:43:26 INFO - Return code: 0 07:43:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:26 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')]} 07:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:26 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')]} 07:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:26 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:26 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 07:43:26 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 07:43:26 INFO - Using env: {'DISPLAY': ':0', 07:43:26 INFO - 'HOME': '/home/cltbld', 07:43:26 INFO - 'LANG': 'en_US.UTF-8', 07:43:26 INFO - 'LANGUAGE': 'en_US:en', 07:43:26 INFO - 'LOGNAME': 'cltbld', 07:43:26 INFO - 'MAIL': '/var/mail/cltbld', 07:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:26 INFO - 'MOZ_NO_REMOTE': '1', 07:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:26 INFO - 'NO_EM_RESTART': '1', 07:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:26 INFO - 'PWD': '/builds/slave/test', 07:43:26 INFO - 'SHELL': '/bin/bash', 07:43:26 INFO - 'SHLVL': '1', 07:43:26 INFO - 'TERM': 'linux', 07:43:26 INFO - 'TMOUT': '86400', 07:43:26 INFO - 'USER': 'cltbld', 07:43:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:26 INFO - '_': '/tools/buildbot/bin/python'} 07:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 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 07:43:28 INFO - Downloading docopt-0.6.1.tar.gz 07:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:28 INFO - Running setup.py install for blobuploader 07:43:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:28 INFO - Running setup.py install for requests 07:43:29 INFO - Running setup.py install for docopt 07:43:29 INFO - Successfully installed blobuploader requests docopt 07:43:29 INFO - Cleaning up... 07:43:29 INFO - Return code: 0 07:43:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:29 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')]} 07:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:29 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')]} 07:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:29 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:29 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 07:43:29 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 07:43:29 INFO - Using env: {'DISPLAY': ':0', 07:43:29 INFO - 'HOME': '/home/cltbld', 07:43:29 INFO - 'LANG': 'en_US.UTF-8', 07:43:29 INFO - 'LANGUAGE': 'en_US:en', 07:43:29 INFO - 'LOGNAME': 'cltbld', 07:43:29 INFO - 'MAIL': '/var/mail/cltbld', 07:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:29 INFO - 'MOZ_NO_REMOTE': '1', 07:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:29 INFO - 'NO_EM_RESTART': '1', 07:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:29 INFO - 'PWD': '/builds/slave/test', 07:43:29 INFO - 'SHELL': '/bin/bash', 07:43:29 INFO - 'SHLVL': '1', 07:43:29 INFO - 'TERM': 'linux', 07:43:29 INFO - 'TMOUT': '86400', 07:43:29 INFO - 'USER': 'cltbld', 07:43:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:29 INFO - '_': '/tools/buildbot/bin/python'} 07:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:29 INFO - Running setup.py (path:/tmp/pip-F9mTL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:29 INFO - Running setup.py (path:/tmp/pip-3XrtDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:29 INFO - Running setup.py (path:/tmp/pip-wB1aWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:29 INFO - Running setup.py (path:/tmp/pip-O_Nnu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:29 INFO - Running setup.py (path:/tmp/pip-MzcFde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:30 INFO - Running setup.py (path:/tmp/pip-5YrUOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:30 INFO - Running setup.py (path:/tmp/pip-CitHTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:30 INFO - Running setup.py (path:/tmp/pip-v1uXYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:30 INFO - Running setup.py (path:/tmp/pip-aLwIXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:30 INFO - Running setup.py (path:/tmp/pip-BSU6Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:30 INFO - Running setup.py (path:/tmp/pip-JlVzi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:30 INFO - Running setup.py (path:/tmp/pip-xfJMmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:30 INFO - Running setup.py (path:/tmp/pip-YyyUDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:30 INFO - Running setup.py (path:/tmp/pip-PHuSKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:30 INFO - Running setup.py (path:/tmp/pip-hCXWDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:30 INFO - Running setup.py (path:/tmp/pip-wr03SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:30 INFO - Running setup.py (path:/tmp/pip-slXpax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:30 INFO - Running setup.py install for manifestparser 07:43:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:30 INFO - Running setup.py install for mozcrash 07:43:31 INFO - Running setup.py install for mozdebug 07:43:31 INFO - Running setup.py install for mozdevice 07:43:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for mozfile 07:43:31 INFO - Running setup.py install for mozhttpd 07:43:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for mozinfo 07:43:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for mozInstall 07:43:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for mozleak 07:43:31 INFO - Running setup.py install for mozlog 07:43:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for moznetwork 07:43:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:31 INFO - Running setup.py install for mozprocess 07:43:32 INFO - Running setup.py install for mozprofile 07:43:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:32 INFO - Running setup.py install for mozrunner 07:43:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:32 INFO - Running setup.py install for mozscreenshot 07:43:32 INFO - Running setup.py install for moztest 07:43:32 INFO - Running setup.py install for mozversion 07:43:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:32 INFO - Cleaning up... 07:43:32 INFO - Return code: 0 07:43:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:32 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')]} 07:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:32 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')]} 07:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:32 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:32 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 07:43:32 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 07:43:32 INFO - Using env: {'DISPLAY': ':0', 07:43:32 INFO - 'HOME': '/home/cltbld', 07:43:32 INFO - 'LANG': 'en_US.UTF-8', 07:43:32 INFO - 'LANGUAGE': 'en_US:en', 07:43:32 INFO - 'LOGNAME': 'cltbld', 07:43:32 INFO - 'MAIL': '/var/mail/cltbld', 07:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:32 INFO - 'MOZ_NO_REMOTE': '1', 07:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:32 INFO - 'NO_EM_RESTART': '1', 07:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:32 INFO - 'PWD': '/builds/slave/test', 07:43:32 INFO - 'SHELL': '/bin/bash', 07:43:32 INFO - 'SHLVL': '1', 07:43:32 INFO - 'TERM': 'linux', 07:43:32 INFO - 'TMOUT': '86400', 07:43:32 INFO - 'USER': 'cltbld', 07:43:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:32 INFO - '_': '/tools/buildbot/bin/python'} 07:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:32 INFO - Running setup.py (path:/tmp/pip-sMmvGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:32 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)) 07:43:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:32 INFO - Running setup.py (path:/tmp/pip-gHlVqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:33 INFO - Running setup.py (path:/tmp/pip-DaWuLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:33 INFO - Running setup.py (path:/tmp/pip-TkZXD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:33 INFO - Running setup.py (path:/tmp/pip-GB1D4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:33 INFO - Running setup.py (path:/tmp/pip-Y8a3aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:33 INFO - Running setup.py (path:/tmp/pip-zvqSfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:33 INFO - Running setup.py (path:/tmp/pip-iPCva9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:33 INFO - Running setup.py (path:/tmp/pip-2yJzI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:33 INFO - Running setup.py (path:/tmp/pip-Kj5M69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:33 INFO - Running setup.py (path:/tmp/pip-8LOq_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:33 INFO - Running setup.py (path:/tmp/pip-AqvB0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:33 INFO - Running setup.py (path:/tmp/pip-TLyjtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:33 INFO - Running setup.py (path:/tmp/pip-YMmeDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:33 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)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:33 INFO - Running setup.py (path:/tmp/pip-pByT84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:33 INFO - Running setup.py (path:/tmp/pip-yVo14X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:34 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)) 07:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:34 INFO - Running setup.py (path:/tmp/pip-TnmZOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:34 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)) 07:43:34 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)) 07:43:34 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)) 07:43:34 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)) 07:43:34 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)) 07:43:34 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)) 07:43:34 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)) 07:43:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:34 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 07:43:34 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 07:43:34 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 07:43:34 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 07:43:35 INFO - Downloading blessings-1.6.tar.gz 07:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:35 INFO - Installing collected packages: blessings 07:43:35 INFO - Running setup.py install for blessings 07:43:35 INFO - Successfully installed blessings 07:43:35 INFO - Cleaning up... 07:43:35 INFO - Return code: 0 07:43:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:35 INFO - Reading from file tmpfile_stdout 07:43:35 INFO - Current package versions: 07:43:35 INFO - argparse == 1.2.1 07:43:35 INFO - blessings == 1.6 07:43:35 INFO - blobuploader == 1.2.4 07:43:35 INFO - docopt == 0.6.1 07:43:35 INFO - functools32 == 3.2.3-2 07:43:35 INFO - jsonschema == 2.5.1 07:43:35 INFO - manifestparser == 1.1 07:43:35 INFO - mozInstall == 1.13 07:43:35 INFO - mozcrash == 1.0 07:43:35 INFO - mozdebug == 0.1 07:43:35 INFO - mozdevice == 0.51 07:43:35 INFO - mozfile == 1.2 07:43:35 INFO - mozhttpd == 0.7 07:43:35 INFO - mozinfo == 0.10 07:43:35 INFO - mozleak == 0.1 07:43:35 INFO - mozlog == 3.5 07:43:35 INFO - moznetwork == 0.27 07:43:35 INFO - mozprocess == 0.25 07:43:35 INFO - mozprofile == 0.28 07:43:35 INFO - mozrunner == 6.13 07:43:35 INFO - mozscreenshot == 0.1 07:43:35 INFO - mozsystemmonitor == 0.3 07:43:35 INFO - moztest == 0.8 07:43:35 INFO - mozversion == 1.4 07:43:35 INFO - psutil == 3.1.1 07:43:35 INFO - requests == 1.2.3 07:43:35 INFO - wsgiref == 0.1.2 07:43:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:35 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')]} 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:35 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')]} 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:35 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:35 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 07:43:35 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 07:43:35 INFO - Using env: {'DISPLAY': ':0', 07:43:35 INFO - 'HOME': '/home/cltbld', 07:43:35 INFO - 'LANG': 'en_US.UTF-8', 07:43:35 INFO - 'LANGUAGE': 'en_US:en', 07:43:35 INFO - 'LOGNAME': 'cltbld', 07:43:35 INFO - 'MAIL': '/var/mail/cltbld', 07:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:35 INFO - 'MOZ_NO_REMOTE': '1', 07:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:35 INFO - 'NO_EM_RESTART': '1', 07:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:35 INFO - 'PWD': '/builds/slave/test', 07:43:35 INFO - 'SHELL': '/bin/bash', 07:43:35 INFO - 'SHLVL': '1', 07:43:35 INFO - 'TERM': 'linux', 07:43:35 INFO - 'TMOUT': '86400', 07:43:35 INFO - 'USER': 'cltbld', 07:43:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:35 INFO - '_': '/tools/buildbot/bin/python'} 07:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 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)) 07:43:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:43:37 INFO - Installing collected packages: simplejson 07:43:37 INFO - Running setup.py install for simplejson 07:43:37 INFO - building 'simplejson._speedups' extension 07:43:37 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 07:43:38 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 07:43:38 INFO - Successfully installed simplejson 07:43:38 INFO - Cleaning up... 07:43:38 INFO - Return code: 0 07:43:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:38 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')]} 07:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:38 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')]} 07:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:38 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 0xa2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbf4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd97a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, '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': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', '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 07:43:38 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 07:43:38 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 07:43:38 INFO - Using env: {'DISPLAY': ':0', 07:43:38 INFO - 'HOME': '/home/cltbld', 07:43:38 INFO - 'LANG': 'en_US.UTF-8', 07:43:38 INFO - 'LANGUAGE': 'en_US:en', 07:43:38 INFO - 'LOGNAME': 'cltbld', 07:43:38 INFO - 'MAIL': '/var/mail/cltbld', 07:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:38 INFO - 'MOZ_NO_REMOTE': '1', 07:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:38 INFO - 'NO_EM_RESTART': '1', 07:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:38 INFO - 'PWD': '/builds/slave/test', 07:43:38 INFO - 'SHELL': '/bin/bash', 07:43:38 INFO - 'SHLVL': '1', 07:43:38 INFO - 'TERM': 'linux', 07:43:38 INFO - 'TMOUT': '86400', 07:43:38 INFO - 'USER': 'cltbld', 07:43:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:38 INFO - '_': '/tools/buildbot/bin/python'} 07:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:38 INFO - Cleaning up... 07:43:38 INFO - Return code: 0 07:43:38 INFO - Running post-action listener: _resource_record_post_action 07:43:38 INFO - Running post-action listener: _start_resource_monitoring 07:43:38 INFO - Starting resource monitoring. 07:43:38 INFO - [mozharness: 2017-10-19 14:43:38.416949Z] Finished create-virtualenv step (success) 07:43:38 INFO - [mozharness: 2017-10-19 14:43:38.417465Z] Running install step. 07:43:38 INFO - Running pre-action listener: _resource_record_pre_action 07:43:38 INFO - Running main action method: install 07:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:38 INFO - Reading from file tmpfile_stdout 07:43:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:38 INFO - Reading from file tmpfile_stdout 07:43:38 INFO - Output received: 07:43:38 INFO - Usage: mozinstall [options] installer 07:43:38 INFO - Options: 07:43:38 INFO - -h, --help show this help message and exit 07:43:38 INFO - -d DEST, --destination=DEST 07:43:38 INFO - Directory to install application into. [default: 07:43:38 INFO - "/builds/slave/test"] 07:43:38 INFO - --app=APP Application being installed. [default: firefox] 07:43:38 INFO - mkdir: /builds/slave/test/build/application 07:43:38 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'] 07:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:43:53 INFO - Reading from file tmpfile_stdout 07:43:53 INFO - Output received: 07:43:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:43:53 INFO - Running post-action listener: _resource_record_post_action 07:43:53 INFO - [mozharness: 2017-10-19 14:43:53.386146Z] Finished install step (success) 07:43:53 INFO - [mozharness: 2017-10-19 14:43:53.386379Z] Running setup-mitmproxy step. 07:43:53 INFO - Running pre-action listener: _resource_record_pre_action 07:43:53 INFO - Running main action method: setup_mitmproxy 07:43:53 INFO - Skipping: mitmproxy is not required 07:43:53 INFO - Running post-action listener: _resource_record_post_action 07:43:53 INFO - [mozharness: 2017-10-19 14:43:53.387510Z] Finished setup-mitmproxy step (success) 07:43:53 INFO - [mozharness: 2017-10-19 14:43:53.387729Z] Running run-tests step. 07:43:53 INFO - Running pre-action listener: _resource_record_pre_action 07:43:53 INFO - Running pre-action listener: _set_gcov_prefix 07:43:53 INFO - Running main action method: run_tests 07:43:53 WARNING - Try message not found. 07:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:53 INFO - Python 2.7.3 07:43:53 INFO - Return code: 0 07:43:53 INFO - grabbing minidump binary from tooltool 07:43:53 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')]} 07:43:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0xd9b090>, '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 0xd9bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd95f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 07:43:53 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:43:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 07:43:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:53 INFO - Return code: 0 07:43:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:43:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:53 INFO - ENV: RUST_BACKTRACE is now full 07:43:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:43:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 07:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 07:43:53 INFO - Using env: {'DISPLAY': ':0', 07:43:53 INFO - 'HOME': '/home/cltbld', 07:43:53 INFO - 'LANG': 'en_US.UTF-8', 07:43:53 INFO - 'LANGUAGE': 'en_US:en', 07:43:53 INFO - 'LOGNAME': 'cltbld', 07:43:53 INFO - 'MAIL': '/var/mail/cltbld', 07:43:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:53 INFO - 'MOZ_NO_REMOTE': '1', 07:43:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:53 INFO - 'NO_EM_RESTART': '1', 07:43:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:53 INFO - 'PWD': '/builds/slave/test', 07:43:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:53 INFO - 'RUST_BACKTRACE': 'full', 07:43:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:43:53 INFO - 'SHELL': '/bin/bash', 07:43:53 INFO - 'SHLVL': '1', 07:43:53 INFO - 'TERM': 'linux', 07:43:53 INFO - 'TMOUT': '86400', 07:43:53 INFO - 'USER': 'cltbld', 07:43:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:53 INFO - '_': '/tools/buildbot/bin/python'} 07:43:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 07:43:53 INFO - mozversion application_buildid: 20171019132320 07:43:53 INFO - mozversion application_changeset: 5ddf0b9c8ff294b1a530724379095c822f8c7b89 07:43:53 INFO - mozversion application_display_name: Firefox 07:43:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:53 INFO - mozversion application_name: Firefox 07:43:53 INFO - mozversion application_remotingname: firefox 07:43:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:43:53 INFO - mozversion application_vendor: Mozilla 07:43:53 INFO - mozversion application_version: 57.0 07:43:53 INFO - mozversion platform_buildid: 20171019132320 07:43:53 INFO - mozversion platform_changeset: 5ddf0b9c8ff294b1a530724379095c822f8c7b89 07:43:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:43:53 INFO - mozversion platform_version: 57.0 07:43:53 INFO - using testdate: 1508424233 07:43:53 INFO - actual date: 1508424233 07:43:53 INFO - starting webserver on 'localhost:33351' 07:43:53 INFO - SUITE-START | Running 2 tests 07:43:53 INFO - TEST-START | dromaeo_css 07:43:53 INFO - Initialising browser for dromaeo_css test... 07:43:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33351/getInfo.html -profile /tmp/tmp1EC5uV/profile 07:43:53 INFO - TEST-INFO | started process 12081 (/builds/slave/test/build/application/firefox/firefox http://localhost:33351/getInfo.html) 07:43:58 INFO - TEST-INFO | 12081: exit 0 07:43:58 INFO - Browser initialized. 07:43:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:58 INFO - Using env: {'DISPLAY': ':0', 07:43:58 INFO - 'HOME': '/home/cltbld', 07:43:58 INFO - 'JSGC_DISABLE_POISONING': '1', 07:43:58 INFO - 'LANG': 'en_US.UTF-8', 07:43:58 INFO - 'LANGUAGE': 'en_US:en', 07:43:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:43:58 INFO - 'LOGNAME': 'cltbld', 07:43:58 INFO - 'MAIL': '/var/mail/cltbld', 07:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:58 INFO - 'MOZ_CRASHREPORTER': '1', 07:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:43:58 INFO - 'MOZ_NO_REMOTE': '1', 07:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:58 INFO - 'NO_EM_RESTART': '1', 07:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:58 INFO - 'PWD': '/builds/slave/test', 07:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:58 INFO - 'RUST_BACKTRACE': 'full', 07:43:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:43:58 INFO - 'SHELL': '/bin/bash', 07:43:58 INFO - 'SHLVL': '1', 07:43:58 INFO - 'TERM': 'linux', 07:43:58 INFO - 'TMOUT': '86400', 07:43:58 INFO - 'USER': 'cltbld', 07:43:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 07:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:58 INFO - '_': '/tools/buildbot/bin/python'} 07:43:58 INFO - TEST-INFO | started process 12318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1EC5uV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:59 INFO - PID 12318 | 07:43:59 INFO - PID 12318 | (/builds/slave/test/build/application/firefox/firefox:12366): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:43:59 INFO - PID 12318 | 07:44:09 INFO - PID 12318 | RSS: Main: 143392768 07:44:09 INFO - PID 12318 | 07:47:07 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33351/tests/dromaeo/cssquery-ext.html) 07:47:08 INFO - PID 12318 | RSS: Main: 145039360 07:47:08 INFO - PID 12318 | 07:50:09 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-ext.html (next: http://localhost:33351/tests/dromaeo/cssquery-jquery.html) 07:50:10 INFO - PID 12318 | RSS: Main: 144584704 07:50:10 INFO - PID 12318 | 07:53:11 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33351/tests/dromaeo/cssquery-mootools.html) 07:53:12 INFO - PID 12318 | RSS: Main: 145387520 07:53:12 INFO - PID 12318 | 07:56:13 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33351/tests/dromaeo/cssquery-prototype.html) 07:56:14 INFO - PID 12318 | RSS: Main: 145268736 07:56:14 INFO - PID 12318 | 07:59:17 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33351/tests/dromaeo/cssquery-yui.html) 07:59:18 INFO - PID 12318 | RSS: Main: 147509248 07:59:18 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | Cycle 1(1): loaded http://localhost:33351/tests/dromaeo/cssquery-yui.html (next: http://localhost:33351/tests/dromaeo/cssquery-dojo.html) 08:02:19 INFO - PID 12318 | RSS: Main: 148701184 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | __start_tp_report 08:02:19 INFO - PID 12318 | _x_x_mozilla_page_load 08:02:19 INFO - PID 12318 | _x_x_mozilla_page_load_details 08:02:19 INFO - PID 12318 | |i|pagename|runs| 08:02:19 INFO - PID 12318 | |0;dojo.html;3964.6431821136093;3969.940450893237;3978.343573310402;3981.4425980362753;3983.223271462066;6205.875882482348;6262.373762623735;6325.620462772237;6356.2372515298175;6360.268569114553;6258.655773932432;6282.68586570672;6339.524535659821;6342.112104305401;6380.968095159529;5641.633293835887;5666.490015898558;5731.914021289663;5760.62555933865;5769.394213607574;5734.827955161331;5735.799247026355;5753.395893431192;5753.568482363839;5816.389279125694;5801.158831969362;5867.266591676041;5895.469407753301;5902.291724993007;5903.114532820068;5796.391378905218;5811.970940145272;5822.359540450547;5889.116632505115;5909.379515150933;5599.076152434844;5674.3190817101795;5692.459216374438;5737.598368114233;5769.07694768835;6234.750609975596;6304.621722696607;6306.590071645374;6337.271213810379;6347.682615869188;6859.485538584576;6892.310768923067;6941.826454338631;6949.89575156373;6972.860542789166;6801.965990170018;6926.480513961473;6959.6868140933275;7026.1217347831525;7035.437165026786;6378.170837791104;6454.93545064548;6458.192725909262;6464.903026454654;6475.417212450855;6957.8956315655305;7030.367266945999;7041.507094503438;7139.071920650283;7146.392556632641;6674.199096108498;6763.864722705518;6777.695003724844;6850.554713943678;6873.965630171817;6780;6891.310868913069;6917.723291068301;6996.510244282851;7003.92996070043;6787.864242715118;6850.040994260808;6923.6192009438955;6929.965350173317;6930.896036559456;6666.96666516674;6855.211650660138;6873.450123990069;6919.584824910521;6950.096487456598;5042.773075211624;5062;5087.923681144785;5097.057044446789;5110.795568177231;4626.976865115653;4688.0858232644305;4732.574068333866;4742.95257047432;4769.093872164278;6474.15835941334;6479.449246814073;6531.444827189647;6545.4436372907885;6561.639109848908;6742.49431292655;6788.694508747119;6825.726970921207;6831.385175334144;6866;6404.775832845921;6504.739810407626;6520.934790652128;6528.967355163194;6542.803715888531;5655.123455864347;5734.397888221677;5753.482186603226;5806.912896306559;5827.504662103684;7132.358087772125;7194.316539928698;7210.2789721027475;7212.3148300911325;7316.378107860785;6771.153605799275;6784.185897692309;6788.558743681645;6813.250542440229;6841.828954276183;7118.430525558047;7121.46589005837;7141.500094993301;7220.422366210795;7233.3851622612665;6784.76253331131;6796.76211332601;6803.149606299213;6847.657617119224;6874.896876546756;6843.828904277433;6893.517453778188;6907.378335949788;6997.1253593300835;7002.984567237824;6610.636414997221;6646.9335306648245;6660.500462465237;6670.366315200048;6713.899291510534;6635.336466353326;6645.734170633121;6671.5997040177745;6699.363560461748;6702.597844129368;6540.018997150465;6587.2753997061245;6600.273969863407;6615.702293396713;6633.9668301658185;6547.312532184243;6616.735330586723;6717.05961165447;6722.092517510074;6732.899006514808;6429.742810287723;6445.903311450238;6523.608583485006;6524.2823289439075;6560.901586476302 08:02:19 INFO - PID 12318 | |1;ext.html;907.6233363154287;958.966436174734;979.9951000244998;1003.3829195045045;1024.0118285854153;46177.30734038988;46842.29736553946;47074.2938855917;47089.76455117728;47210.2918456223;43890.341644875356;44040.55959440413;44153.55846441535;44203;44394.7780261099;8061.6372263248;8085.3127484163915;8141.877871831927;8154.184581541828;8158.959205203966;8080.636371363274;8188.877166842502;8195.221453961864;8195.959020204891;8209.548474833882;8460;8545.27365173961;8672.566371681422;8710.651573937035;8792.69225577105;8466.66133354665;8484.448510846836;8537.701180458685;8879.95560022199;8935.151160639729;8828.293736501064;8916.687915922912;8945.418547794372;8951;8955.328350373748;43042.35436468456;43332.350014749805;43368.78315608433;43458;43485.78257108726;3822.789746563938;3835;3853.2100919311756;3861.9806900965596;3873.5158105236846;35683.64316356855;35917.46123808145;35989.46015809765;35991.4601280981;36150.096247593756;5397;5432.70120143392;5456.317960254968;5494.560435165217;5495.780168793283;227760;228933;229541;230617;231146;50214.49785502171;56758.71620641871;56797.7160114205;57049.71475142598;57233.71383143058;58937.642494300606;59501.404985949586;59682.40317596855;59750.70124649349;59753.402465975654;18468.44594662162;18588.535286617673;18635.975021373684;18643.347482838308;18676.25294988185;15661.451849185223;15735.213239337987;15761.763573546406;15866.286017129027;15870.761938570931;16116.75824862628;16139.677206455804;16158.596035099217;16213.189340532927;16264.67470650604;6096.146539484475;6166;6202.224721909762;6366.554341196164;6382.234131904202;1116.3246236027248;1123.5225029362489;1133.795916734979;1138.743782648914;1145.8052131137727;26137.954481820896;26839.597406038924;26876.865615672188;26879;27038.459230815668;1225.8345123408403;1243.490169030693;1244.4337826289018;1256.7109564800148;1264.4626033935724;14007.369668364949;14211.64470888236;14293;14377.353019114165;14449.855501445061;291887;300040;304702;307665;308134;67377.66311168413;67422.3257767416;67971.32028679749;68012;68122;1545.652228248635;1558.968820623604;1559.5087547422524;1562.2266977846039;1567.4200545798128;31055.66525060336;31157;31420.461927462908;31527.21181970469;31773.523397149525;43121.3531797017;43337.48318808826;43385.3492197611;43433.78283108691;43584;266336;268866;269378;270128;270944;38440.42339364856;39429.2114157721;39807.2038559233;40173.59826401698;40314.596854031086;49701.751491242314;49741.751291243316;50128.248076278156;50214.49785502244;50245.49754502408;35184.472232916014;35588.822055889555;35739.82130089333;35796.64203357933;35901.82049089738;35260.47109293311;35342;35496.290074198885;35828.64171358357;35842.10394740153;42021.36967945422;42044.15911681688;42205;42350.788246058575;42418;33736;33868;34354.312913742084;34550.30899382049;34670.82664586661;25944.362811247298;26029.634290680064;26438.735612643628;26462.867685661447;26687.599686004338 08:02:19 INFO - PID 12318 | |2;jquery.html;645.7216037055396;647.1471841217465;648.0199665570093;651.9373421323245;661.1075048684276;24126.396840078985;25021.874890625546;25224;25332.113376031844;25877;27182;27967.58048629272;28087.157385278424;28114;28170.295742606446;7162.4270058395205;7277.781666550012;7287.9271207287775;7292;7294.562326260415;6836;7090.574565526059;7121.679524421387;7128.429725621938;7132.179799323067;7043.718251269943;7077.2568880267345;7080.221175670672;7088.71645134194;7094.077769889907;7090.361867431956;7091.184513780904;7094.042304288907;7097.18382386027;7107.6090815005155;6621.536492445531;6630.668466576652;6641.136652235226;6641.468682505388;6643.468522518187;31294.21764455884;31684.366312673847;31749.365012699847;31840;31868.521972170434;2379.6311571706415;2407.1935901473025;2414.38433199533;2419.6249581314746;2424.3090719144957;20637.690434643493;21128;21150.894245528674;21222.787772122236;21227.787722122735;2365.9645105323434;2415.420299128214;2636.4990651776293;2642.1545105566224;2658.2689760315875;171675.14162429233;174120.99999999872;174290;174897;175104;16636;16971.15144242783;16982.57543561421;17098.401555945482;17111.657766844593;28542.571861422097;28568.142955711362;28604.284892877844;28623.14130576086;28686.713132868823;11495.206581827977;11683;11836.230645008047;11883.702907427383;11908.106891983136;9686.273529485317;10073.597056117673;10843.51204195813;10890.509927053301;10992;9741.366811157252;10102.242331825142;10652.147828173882;10654.295312750079;10672.252942293964;3087.228192951762;3099.342775524857;3128.515080162578;3184.888528901524;3257.8371081445835;1063.9680809575725;1080.5137688040413;1093.8960798724108;1099.7910397024539;1109.5062697099713;22945.770542294696;22994.355649100235;23368.182113625942;23386.298411047697;23528.354901657178;1141.4406940599213;1163.1857699610307;1171.3557543351124;1171.6075114836456;1177.4936777185721;12586.748265034832;12777.872221277854;12794.360281985864;12811.423485942969;12855.421506032251;657902;661743;667648;677765;678116;132624;142143.28928355293;142784;143043.2847835775;143413;1280.3470230182675;1299.2918859221747;1324.3510679766846;1324.8542660307357;1327.3827670133435;19699;20159.39521814348;20268.391948241577;20436.897815511424;20709.896450517652;66799.66600166968;67773.32226677868;69244;69984.65007674928;70083.94874076791;83959;84150;84302.57848710717;84356;84925;16979.49061528156;17143.828561714723;17158;17193.14034298305;17228.224729887435;24837.87581062083;25431.109911153762;25492;25507.489850203263;25635.871820640776;20670.586588268452;20916.58166836624;21028.26401075955;21076.789232107483;21086.894565527073;17019.40432084871;17438.738418923473;17650.382236622172;17961.820381796013;18477.72283415723;20151.89924050429;20697.689534657293;20951.266705665228;21119.260825871635;21204.575908482053;16633.50099497017;16746.748798768273;16902.830971690124;16915.7462638063;16926.57683557921;20727.378178654664;20787.272445464336;20789.79210207939;20843.58312833765;20890 08:02:19 INFO - PID 12318 | |3;mootools.html;1386.3068465767117;1459.620498670346;1465.54568083894;1465.5676575410253;1469.4048910191377;17945.371911983068;18539.536511587216;18566.257349705997;18571.628567428645;18613.97623130729;18190.818091819077;18419.447416577492;18431.17059732312;18471.630567388678;18489.907550462263;3131.3111115554543;3161.65221825599;3206.7434605231524;3221.2591104046082;3224.4518431866522;3067.8005929614505;3126.7498600111935;3138.105639892631;3140.152158917091;3140.544621029949;3067.4938635125177;3108.2540190354266;3124.0627811656527;3178.904632861006;3179.380020895926;3049.573059771634;3063.1270088024917;3078.569000339954;3080.152957936563;3084.0439463766306;2932.692067332942;2978;2988.9402211955858;2998.6401631804106;3014.9095527134223;17200.45195932372;17401.738973915275;17411.912940435217;17428.215730292166;17429.564260893578;8621.956890215572;8886.111388861127;8929.508877011762;8929.821403571957;8933.330000249942;5447.237386765856;5575.414581468928;5686.0617998030275;5730.971345143289;5764.538836893081;1974.1215159254139;2002.079043639913;2008.086320724067;2042.7344445222027;2050.2106688924723;31670.524942125885;31960.840195799105;31978.840105799554;31995.840020799747;32009.679903200904;7780.922190778133;7793.688252469838;7837.647305871249;7837.804054898673;7967.322777563856;20856.89571552163;20860.687089693667;20921;20940;20961.37115886526;8496.957515212507;8674.306055515544;8676.262517686067;8684.60919258635;8693;7568.356689681439;7947.841043179104;8052.315553178046;8203.384746143944;8214.8357032859;6181.536384771161;6200.689965501707;6238.500919926395;6328.525360597881;6355.173827402408;1659.2947997101185;1706.7951845778587;1795.3626462605848;1814.7368631548352;1815.6005678750653;976.2482888176065;1036.8703912011;1038.7721971575766;1042.2339580408393;1043.6973277749519;10147.492625368703;10180;10275.948620256851;10314;10432.165426765841;824.3940703582862;831.9043310019305;836.8200836820113;839.1817977472039;886.1006078829993;6294.339094395023;6351;6490.935090649033;6509.153810004669;6591.802245932629;26231.213063608124;27298.590521141803;27424.862875685492;27597.86201068982;27639.585406218925;25406;26469.735302646728;26483.47033059328;26553.20340389753;26558;12825.743485130432;12974.610761676977;13017.739645207042;13122.475100996044;13169.275689837152;10139.797204056025;10167.593296268362;10199.38803671782;10375.16998640122;10410.427426491615;22386.552268954856;22507.424480286223;22724.4318892029;22781.544369112857;23377.064917403794;23361.649575256044;23534.29397118089;23807.761922381247;23994.640080399156;24004.51990960206;12672.809907851573;12872.549460768829;12875.742485150431;12934.288614125937;13022.348882556023;16271.918640406722;16433.09617971023;16483.34066637321;16488;16576.83423165753;12019.519219231483;12112.394380281126;12301.815472767737;12381.133320667466;12547.686307842378;11839.82240266414;11961.760764784482;12035.819462707892;12091.455884485395;12199.329036903055;11303.208775385645;11350.205485615928;11417.60038398652;11491.367974761133;11533.077353811506;8452.873206902024;8456.577171141294;8562.143785621638;8615.82768344617;8698.91301086981;8691.782705432162;8749.65001399937;8784.341174412073;8801.339899507435;8806.471611703319 08:02:19 INFO - PID 12318 | |4;prototype.html;572.1332181744656;573.8852229554091;576.5906206593319;610.7556977209116;625.6465097220071;5974.253218347707;6090.23872015998;6090.8172754817315;6118.235220597426;6203.8138855834395;6023.488003519695;6057.303410107839;6096.237970253718;6098.481629061535;6112.6638034908065;5093.898122037557;5100.515451032146;5110.386753589574;5112.846614601568;5118.206677964921;4900.7794649240695;4993.900121997558;5001.249812528114;5004.599632029447;5012.273220383042;4980.427250866161;4993.675411098285;4994.150994330954;5001.524855138756;5048.192289233723;4945.604351651859;4947.109520286347;4982.676126051795;4987.329244703029;4992.950070499285;4562.543745625411;4583.587477127041;4586.105709386671;4592.425946756655;4608.539146085398;6087.817365479043;6112.463327718991;6116.785912493086;6123.601965872249;6140.600860944024;5715.171300161495;5756;5769.24999750034;5802.520357308901;5847.8245652630485;6449.484041276686;6499.837504062389;6531.216254049497;6531.902021469682;6537.477001839841;4859.902801943977;5058.418281897592;5088.287639730441;5089.7530105124115;5096.745162741848;6623.23832759234;6685.264620891747;6760.763373281911;6827.249002609709;6827.48793840464;5165.896682066337;5191.377034755854;5199.974000129975;5215.58275337972;5237.188235823453;5315.149576067811;5327.440618735054;5327.573794096463;5351.973240133774;5354.732263386815;5768.7118342544345;5811.070228763462;5824.883502330014;5847.736851841677;5848.941510584839;6439.613623182624;6539.149910511603;6544.116544266558;6558;6563.737450502022;1768.5932235585888;1799.0285245967293;1800.540862080161;1801.5406071451696;1823.5441139715072;1275.2157423184674;1310.7050913544376;1315.552712077879;1332.187365706918;1336.358547897015;6121.123721227671;6136.723847426787;6206.906896396557;6217.96891015542;6289.339619339903;6620.139381880324;6638.336166383419;6651.800445986628;6652.70062847173;6669.599824010575;6198.566100373021;6251.9684252098805;6254.468370188494;6258.624482531062;6289.276733175743;3359.731221502274;3379.9324013520086;3401.5067815166663;3453.689167974894;3489.1277180704824;6880.174379074443;6880.965595171992;6897.55165914214;6955.234924158339;6987.965060174768;6700.262971073178;6716.126903502513;6751.223609284897;6794.76218332356;6831.726730930806;6779.15260592426;6851.760188393382;6853.305485742282;6898.792386436292;6926.272741362185;6529.934700652932;6635.3790252848885;6640.83397915056;6644.933550664431;6676.49926255523;6505.51208659343;6530.934690653033;6533.705983230671;6536.509761767981;6562.573432726857;6903.482238832007;6938.8612227756175;6944.756933507303;6974.37230649244;7017.157941047107;5162.174052151638;5201.42784293735;5210.342725210095;5226.97386513065;5241.50205730455;6382;6427.3251308611925;6488.286288508355;6501;6654.800355989328;6271.306747178328;6309.842253943688;6320.241571011324;6384.776532821329;6392.561673623398;6252.749890004349;6314.368563143649;6338.809835704937;6405.135306733531;6419.518536109717;6316.873662526816;6328.430441260309;6340.175777148941;6365.2361716594305;6411.5832470889245;6382.266039405527;6400.359964003563;6463.806085817433;6493.350664933658;6508.576942498722;6316.747330106744;6335.968320158554;6345.969289827211;6353.96823015882;6383.308268422613 08:02:19 INFO - PID 12318 | |5;yui.html;980.7155924781814;998.0169533009984;1028.233965695557;1029.094396930701;1035.823909935311;16938.83061169388;17213.483595492125;17287.308507659694;17309.39417120401;17329.566760830985;16409.343626254966;16539;18221.817781822177;18355.632887342246;18427.355042573512;1025.2669341420883;1045.3518818332607;1046.142163425991;1046.837740150278;1049.8635177426943;1015.7105225010873;1075.6235317638802;1077.245927850504;1080.2384319055047;1081.0270756319296;1157.7105723569107;1165.2367699157066;1169.8830116988318;1172.109197010274;1176.2119380015367;1115.8047341715167;1134.6539305511858;1138.0383575878411;1138.7039369763838;1139.3619573039125;824.7031068815222;831.7878940870039;832.5504227717025;832.7751507093051;835.1022650650575;18833;19355;19446.70829937552;19531.414057578295;19592.902035489875;19176.520586985436;19375.709364359547;19473.51316217092;19540.413787586396;19637.705434418494;16861.662766744717;16924.746128808078;16959.067251301174;16969.745453818203;17162.742558861628;3812.390017597171;3840.1935593525395;3841.635044670752;3847.1728578355787;3850.7111966602615;156348;157498;157614;159179.2041039799;160549.19725401414;14555.708885822225;14883.47907823221;14942.477013304482;14987.250637468302;15047.849521504644;27777.305567360978;27995;28118.578221326698;28238.85880570584;28315.71684283172;8989.505577193317;9441.055894410503;9565.569549370295;9569.33014688979;9582.137607615348;4334.371516130143;4399.450068741407;4399.5160532341415;4408.338749187647;4419.40338054365;5808.361080281165;5845.240118784616;5888.5289176865745;5930.11048342752;5962.2249107615735;1099.9890001100046;1133.3766428464312;1142.4002398740727;1143.3997151495532;1148.5004023249912;725.698834983476;760.1979911193633;762.6453699029978;776.7863837444635;784.2432053068816;12860.356982150855;12880.935595321964;12950.935245323713;13130;13560.186388816703;766;769.3691173238003;774.7172282116986;777.2421888658625;782.8238646304536;6077.75688972445;6152.384761523812;6163.291221509584;6205.255369355616;6264.874702506016;149587;151176;152103;152318.807270693;158499;132202;132934;133815;133941;140200;116151;118511.40744296396;119311.40344298397;120011.39994299972;120778.3961080189;12934.805977910151;13671.632836716646;14042.578722638336;14184.645383865485;14188.148711077369;55696.44303556912;56051;56359;56954.43045569657;57101.433335165326;73931.26068739244;74844;74895;75168.62415687887;75598.62200688961;20026.399208023784;20301.59396812085;20352.592948140657;20395;20585.89707051455;22045.33863984083;22076.558468830855;22110.557788844453;22111.55776884421;22415.32754017382;19679.917604531314;19753.209871604973;19778.30775922836;19789.901050494656;19797.60404791925;20241.392758217276;20390.796092039483;20575.69136462984;20875.686864697345;20911.89544052331;18880.24479020824;18976.905115474336;19107.426777196706;19257.13342899601;19308.517287067934;14600.12399256048;14922.701545969237;15003.774943376076;15220.467283645019;15507.224638767791;15557;15750.9212453937;15887.68224635524;16122.838771612134;16257.51227463178 08:02:19 INFO - PID 12318 | __end_tp_report 08:02:19 INFO - PID 12318 | __start_cc_report 08:02:19 INFO - PID 12318 | _x_x_mozilla_cycle_collect,252 08:02:19 INFO - PID 12318 | __end_cc_report 08:02:19 INFO - PID 12318 | __startTimestamp1508425339821__endTimestamp 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | ------- Summary: start ------- 08:02:19 INFO - PID 12318 | Number of tests: 6 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#0] dojo.html Cycles:165 Average:6364.13 Median:6587.28 stddev:722.45 (11.0%) stddev-sans-first:699.71 08:02:19 INFO - PID 12318 | Values: 3964.6 3969.9 3978.3 3981.4 3983.2 6205.9 6262.4 6325.6 6356.2 6360.3 6258.7 6282.7 6339.5 6342.1 6381.0 5641.6 5666.5 5731.9 5760.6 5769.4 5734.8 5735.8 5753.4 5753.6 5816.4 5801.2 5867.3 5895.5 5902.3 5903.1 5796.4 5812.0 5822.4 5889.1 5909.4 5599.1 5674.3 5692.5 5737.6 5769.1 6234.8 6304.6 6306.6 6337.3 6347.7 6859.5 6892.3 6941.8 6949.9 6972.9 6802.0 6926.5 6959.7 7026.1 7035.4 6378.2 6454.9 6458.2 6464.9 6475.4 6957.9 7030.4 7041.5 7139.1 7146.4 6674.2 6763.9 6777.7 6850.6 6874.0 6780.0 6891.3 6917.7 6996.5 7003.9 6787.9 6850.0 6923.6 6930.0 6930.9 6667.0 6855.2 6873.5 6919.6 6950.1 5042.8 5062.0 5087.9 5097.1 5110.8 4627.0 4688.1 4732.6 4743.0 4769.1 6474.2 6479.4 6531.4 6545.4 6561.6 6742.5 6788.7 6825.7 6831.4 6866.0 6404.8 6504.7 6520.9 6529.0 6542.8 5655.1 5734.4 5753.5 5806.9 5827.5 7132.4 7194.3 7210.3 7212.3 7316.4 6771.2 6784.2 6788.6 6813.3 6841.8 7118.4 7121.5 7141.5 7220.4 7233.4 6784.8 6796.8 6803.1 6847.7 6874.9 6843.8 6893.5 6907.4 6997.1 7003.0 6610.6 6646.9 6660.5 6670.4 6713.9 6635.3 6645.7 6671.6 6699.4 6702.6 6540.0 6587.3 6600.3 6615.7 6634.0 6547.3 6616.7 6717.1 6722.1 6732.9 6429.7 6445.9 6523.6 6524.3 6560.9 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#1] ext.html Cycles:180 Average:45759.31 Median:3857.60 stddev:69957.05 (1813.5%) stddev-sans-first:70072.23 08:02:19 INFO - PID 12318 | Values: 907.6 959.0 980.0 1003.4 1024.0 46177.3 46842.3 47074.3 47089.8 47210.3 43890.3 44040.6 44153.6 44203.0 44394.8 8061.6 8085.3 8141.9 8154.2 8159.0 8080.6 8188.9 8195.2 8196.0 8209.5 8460.0 8545.3 8672.6 8710.7 8792.7 8466.7 8484.4 8537.7 8880.0 8935.2 8828.3 8916.7 8945.4 8951.0 8955.3 43042.4 43332.4 43368.8 43458.0 43485.8 3822.8 3835.0 3853.2 3862.0 3873.5 35683.6 35917.5 35989.5 35991.5 36150.1 5397.0 5432.7 5456.3 5494.6 5495.8 227760.0 228933.0 229541.0 230617.0 231146.0 50214.5 56758.7 56797.7 57049.7 57233.7 58937.6 59501.4 59682.4 59750.7 59753.4 18468.4 18588.5 18636.0 18643.3 18676.3 15661.5 15735.2 15761.8 15866.3 15870.8 16116.8 16139.7 16158.6 16213.2 16264.7 6096.1 6166.0 6202.2 6366.6 6382.2 1116.3 1123.5 1133.8 1138.7 1145.8 26138.0 26839.6 26876.9 26879.0 27038.5 1225.8 1243.5 1244.4 1256.7 1264.5 14007.4 14211.6 14293.0 14377.4 14449.9 291887.0 300040.0 304702.0 307665.0 308134.0 67377.7 67422.3 67971.3 68012.0 68122.0 1545.7 1559.0 1559.5 1562.2 1567.4 31055.7 31157.0 31420.5 31527.2 31773.5 43121.4 43337.5 43385.3 43433.8 43584.0 266336.0 268866.0 269378.0 270128.0 270944.0 38440.4 39429.2 39807.2 40173.6 40314.6 49701.8 49741.8 50128.2 50214.5 50245.5 35184.5 35588.8 35739.8 35796.6 35901.8 35260.5 35342.0 35496.3 35828.6 35842.1 42021.4 42044.2 42205.0 42350.8 42418.0 33736.0 33868.0 34354.3 34550.3 34670.8 25944.4 26029.6 26438.7 26462.9 26687.6 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#2] jquery.html Cycles:180 Average:43441.71 Median:23377.24 stddev:112080.51 (479.4%) stddev-sans-first:112348.87 08:02:19 INFO - PID 12318 | Values: 645.7 647.1 648.0 651.9 661.1 24126.4 25021.9 25224.0 25332.1 25877.0 27182.0 27967.6 28087.2 28114.0 28170.3 7162.4 7277.8 7287.9 7292.0 7294.6 6836.0 7090.6 7121.7 7128.4 7132.2 7043.7 7077.3 7080.2 7088.7 7094.1 7090.4 7091.2 7094.0 7097.2 7107.6 6621.5 6630.7 6641.1 6641.5 6643.5 31294.2 31684.4 31749.4 31840.0 31868.5 2379.6 2407.2 2414.4 2419.6 2424.3 20637.7 21128.0 21150.9 21222.8 21227.8 2366.0 2415.4 2636.5 2642.2 2658.3 171675.1 174121.0 174290.0 174897.0 175104.0 16636.0 16971.2 16982.6 17098.4 17111.7 28542.6 28568.1 28604.3 28623.1 28686.7 11495.2 11683.0 11836.2 11883.7 11908.1 9686.3 10073.6 10843.5 10890.5 10992.0 9741.4 10102.2 10652.1 10654.3 10672.3 3087.2 3099.3 3128.5 3184.9 3257.8 1064.0 1080.5 1093.9 1099.8 1109.5 22945.8 22994.4 23368.2 23386.3 23528.4 1141.4 1163.2 1171.4 1171.6 1177.5 12586.7 12777.9 12794.4 12811.4 12855.4 657902.0 661743.0 667648.0 677765.0 678116.0 132624.0 142143.3 142784.0 143043.3 143413.0 1280.3 1299.3 1324.4 1324.9 1327.4 19699.0 20159.4 20268.4 20436.9 20709.9 66799.7 67773.3 69244.0 69984.7 70083.9 83959.0 84150.0 84302.6 84356.0 84925.0 16979.5 17143.8 17158.0 17193.1 17228.2 24837.9 25431.1 25492.0 25507.5 25635.9 20670.6 20916.6 21028.3 21076.8 21086.9 17019.4 17438.7 17650.4 17961.8 18477.7 20151.9 20697.7 20951.3 21119.3 21204.6 16633.5 16746.7 16902.8 16915.7 16926.6 20727.4 20787.3 20789.8 20843.6 20890.0 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#3] mootools.html Cycles:180 Average:11035.73 Median:26350.47 stddev:8206.74 (31.1%) stddev-sans-first:8197.74 08:02:19 INFO - PID 12318 | Values: 1386.3 1459.6 1465.5 1465.6 1469.4 17945.4 18539.5 18566.3 18571.6 18614.0 18190.8 18419.4 18431.2 18471.6 18489.9 3131.3 3161.7 3206.7 3221.3 3224.5 3067.8 3126.7 3138.1 3140.2 3140.5 3067.5 3108.3 3124.1 3178.9 3179.4 3049.6 3063.1 3078.6 3080.2 3084.0 2932.7 2978.0 2988.9 2998.6 3014.9 17200.5 17401.7 17411.9 17428.2 17429.6 8622.0 8886.1 8929.5 8929.8 8933.3 5447.2 5575.4 5686.1 5731.0 5764.5 1974.1 2002.1 2008.1 2042.7 2050.2 31670.5 31960.8 31978.8 31995.8 32009.7 7780.9 7793.7 7837.6 7837.8 7967.3 20856.9 20860.7 20921.0 20940.0 20961.4 8497.0 8674.3 8676.3 8684.6 8693.0 7568.4 7947.8 8052.3 8203.4 8214.8 6181.5 6200.7 6238.5 6328.5 6355.2 1659.3 1706.8 1795.4 1814.7 1815.6 976.2 1036.9 1038.8 1042.2 1043.7 10147.5 10180.0 10275.9 10314.0 10432.2 824.4 831.9 836.8 839.2 886.1 6294.3 6351.0 6490.9 6509.2 6591.8 26231.2 27298.6 27424.9 27597.9 27639.6 25406.0 26469.7 26483.5 26553.2 26558.0 12825.7 12974.6 13017.7 13122.5 13169.3 10139.8 10167.6 10199.4 10375.2 10410.4 22386.6 22507.4 22724.4 22781.5 23377.1 23361.6 23534.3 23807.8 23994.6 24004.5 12672.8 12872.5 12875.7 12934.3 13022.3 16271.9 16433.1 16483.3 16488.0 16576.8 12019.5 12112.4 12301.8 12381.1 12547.7 11839.8 11961.8 12035.8 12091.5 12199.3 11303.2 11350.2 11417.6 11491.4 11533.1 8452.9 8456.6 8562.1 8615.8 8698.9 8691.8 8749.7 8784.3 8801.3 8806.5 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#4] prototype.html Cycles:180 Average:5563.83 Median:6201.19 stddev:1528.70 (24.7%) stddev-sans-first:1486.37 08:02:19 INFO - PID 12318 | Values: 572.1 573.9 576.6 610.8 625.6 5974.3 6090.2 6090.8 6118.2 6203.8 6023.5 6057.3 6096.2 6098.5 6112.7 5093.9 5100.5 5110.4 5112.8 5118.2 4900.8 4993.9 5001.2 5004.6 5012.3 4980.4 4993.7 4994.2 5001.5 5048.2 4945.6 4947.1 4982.7 4987.3 4993.0 4562.5 4583.6 4586.1 4592.4 4608.5 6087.8 6112.5 6116.8 6123.6 6140.6 5715.2 5756.0 5769.2 5802.5 5847.8 6449.5 6499.8 6531.2 6531.9 6537.5 4859.9 5058.4 5088.3 5089.8 5096.7 6623.2 6685.3 6760.8 6827.2 6827.5 5165.9 5191.4 5200.0 5215.6 5237.2 5315.1 5327.4 5327.6 5352.0 5354.7 5768.7 5811.1 5824.9 5847.7 5848.9 6439.6 6539.1 6544.1 6558.0 6563.7 1768.6 1799.0 1800.5 1801.5 1823.5 1275.2 1310.7 1315.6 1332.2 1336.4 6121.1 6136.7 6206.9 6218.0 6289.3 6620.1 6638.3 6651.8 6652.7 6669.6 6198.6 6252.0 6254.5 6258.6 6289.3 3359.7 3379.9 3401.5 3453.7 3489.1 6880.2 6881.0 6897.6 6955.2 6988.0 6700.3 6716.1 6751.2 6794.8 6831.7 6779.2 6851.8 6853.3 6898.8 6926.3 6529.9 6635.4 6640.8 6644.9 6676.5 6505.5 6530.9 6533.7 6536.5 6562.6 6903.5 6938.9 6944.8 6974.4 7017.2 5162.2 5201.4 5210.3 5227.0 5241.5 6382.0 6427.3 6488.3 6501.0 6654.8 6271.3 6309.8 6320.2 6384.8 6392.6 6252.7 6314.4 6338.8 6405.1 6419.5 6316.9 6328.4 6340.2 6365.2 6411.6 6382.3 6400.4 6463.8 6493.4 6508.6 6316.7 6336.0 6346.0 6354.0 6383.3 08:02:19 INFO - PID 12318 | 08:02:19 INFO - PID 12318 | [#5] yui.html Cycles:180 Average:28551.49 Median:19042.17 stddev:42903.32 (225.3%) stddev-sans-first:42973.74 08:02:19 INFO - PID 12318 | Values: 980.7 998.0 1028.2 1029.1 1035.8 16938.8 17213.5 17287.3 17309.4 17329.6 16409.3 16539.0 18221.8 18355.6 18427.4 1025.3 1045.4 1046.1 1046.8 1049.9 1015.7 1075.6 1077.2 1080.2 1081.0 1157.7 1165.2 1169.9 1172.1 1176.2 1115.8 1134.7 1138.0 1138.7 1139.4 824.7 831.8 832.6 832.8 835.1 18833.0 19355.0 19446.7 19531.4 19592.9 19176.5 19375.7 19473.5 19540.4 19637.7 16861.7 16924.7 16959.1 16969.7 17162.7 3812.4 3840.2 3841.6 3847.2 3850.7 156348.0 157498.0 157614.0 159179.2 160549.2 14555.7 14883.5 14942.5 14987.3 15047.8 27777.3 27995.0 28118.6 28238.9 28315.7 8989.5 9441.1 9565.6 9569.3 9582.1 4334.4 4399.5 4399.5 4408.3 4419.4 5808.4 5845.2 5888.5 5930.1 5962.2 1100.0 1133.4 1142.4 1143.4 1148.5 725.7 760.2 762.6 776.8 784.2 12860.4 12880.9 12950.9 13130.0 13560.2 766.0 769.4 774.7 777.2 782.8 6077.8 6152.4 6163.3 6205.3 6264.9 149587.0 151176.0 152103.0 152318.8 158499.0 132202.0 132934.0 133815.0 133941.0 140200.0 116151.0 118511.4 119311.4 120011.4 120778.4 12934.8 13671.6 14042.6 14184.6 14188.1 55696.4 56051.0 56359.0 56954.4 57101.4 73931.3 74844.0 74895.0 75168.6 75598.6 20026.4 20301.6 20352.6 20395.0 20585.9 22045.3 22076.6 22110.6 22111.6 22415.3 19679.9 19753.2 19778.3 19789.9 19797.6 20241.4 20390.8 20575.7 20875.7 20911.9 18880.2 18976.9 19107.4 19257.1 19308.5 14600.1 14922.7 15003.8 15220.5 15507.2 15557.0 15750.9 15887.7 16122.8 16257.5 08:02:19 INFO - PID 12318 | -------- Summary: end -------- 08:02:19 INFO - PID 12318 | 08:02:20 INFO - TEST-INFO | 12318: exit 0 08:02:20 INFO - TEST-OK | dromaeo_css | took 1106716ms 08:02:20 INFO - TEST-START | kraken 08:02:20 INFO - Initialising browser for kraken test... 08:02:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33351/getInfo.html -profile /tmp/tmpKQUDqV/profile 08:02:20 INFO - TEST-INFO | started process 12684 (/builds/slave/test/build/application/firefox/firefox http://localhost:33351/getInfo.html) 08:02:25 INFO - TEST-INFO | 12684: exit 0 08:02:25 INFO - Browser initialized. 08:02:25 INFO - Running cycle 1/1 for kraken test... 08:02:25 INFO - Using env: {'DISPLAY': ':0', 08:02:25 INFO - 'HOME': '/home/cltbld', 08:02:25 INFO - 'JSGC_DISABLE_POISONING': '1', 08:02:25 INFO - 'LANG': 'en_US.UTF-8', 08:02:25 INFO - 'LANGUAGE': 'en_US:en', 08:02:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:02:25 INFO - 'LOGNAME': 'cltbld', 08:02:25 INFO - 'MAIL': '/var/mail/cltbld', 08:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:25 INFO - 'MOZ_CRASHREPORTER': '1', 08:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:02:25 INFO - 'MOZ_NO_REMOTE': '1', 08:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:25 INFO - 'NO_EM_RESTART': '1', 08:02:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:25 INFO - 'PWD': '/builds/slave/test', 08:02:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:25 INFO - 'RUST_BACKTRACE': 'full', 08:02:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:02:25 INFO - 'SHELL': '/bin/bash', 08:02:25 INFO - 'SHLVL': '1', 08:02:25 INFO - 'TERM': 'linux', 08:02:25 INFO - 'TMOUT': '86400', 08:02:25 INFO - 'USER': 'cltbld', 08:02:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398', 08:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:25 INFO - '_': '/tools/buildbot/bin/python'} 08:02:25 INFO - TEST-INFO | started process 12914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKQUDqV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:26 INFO - PID 12914 | 08:02:26 INFO - PID 12914 | (/builds/slave/test/build/application/firefox/firefox:12962): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:02:26 INFO - PID 12914 | 08:02:36 INFO - PID 12914 | RSS: Main: 143417344 08:02:36 INFO - PID 12914 | 08:02:39 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33351/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:39 INFO - PID 12914 | RSS: Main: 149295104 08:02:39 INFO - PID 12914 | 08:02:42 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33351/tests/kraken/driver.html?testName=audio-dft) 08:02:42 INFO - PID 12914 | RSS: Main: 149561344 08:02:42 INFO - PID 12914 | 08:02:45 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33351/tests/kraken/driver.html?testName=audio-fft) 08:02:46 INFO - PID 12914 | RSS: Main: 150876160 08:02:46 INFO - PID 12914 | 08:02:48 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33351/tests/kraken/driver.html?testName=audio-oscillator) 08:02:49 INFO - PID 12914 | RSS: Main: 151285760 08:02:49 INFO - PID 12914 | 08:02:51 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33351/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:51 INFO - PID 12914 | RSS: Main: 150720512 08:02:51 INFO - PID 12914 | 08:02:54 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33351/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:55 INFO - PID 12914 | RSS: Main: 150175744 08:02:55 INFO - PID 12914 | 08:02:58 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33351/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:59 INFO - PID 12914 | RSS: Main: 153645056 08:02:59 INFO - PID 12914 | 08:03:02 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33351/tests/kraken/driver.html?testName=json-parse-financial) 08:03:02 INFO - PID 12914 | RSS: Main: 153587712 08:03:02 INFO - PID 12914 | 08:03:04 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33351/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:04 INFO - PID 12914 | RSS: Main: 153362432 08:03:04 INFO - PID 12914 | 08:03:06 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:07 INFO - PID 12914 | RSS: Main: 153505792 08:03:07 INFO - PID 12914 | 08:03:09 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:09 INFO - PID 12914 | RSS: Main: 150142976 08:03:09 INFO - PID 12914 | 08:03:12 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:12 INFO - PID 12914 | RSS: Main: 150347776 08:03:12 INFO - PID 12914 | 08:03:15 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:16 INFO - PID 12914 | RSS: Main: 150745088 08:03:16 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | Cycle 1(1): loaded http://localhost:33351/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33351/tests/kraken/driver.html?testName=ai-astar) 08:03:17 INFO - PID 12914 | RSS: Main: 152035328 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | __start_tp_report 08:03:17 INFO - PID 12914 | _x_x_mozilla_page_load 08:03:17 INFO - PID 12914 | _x_x_mozilla_page_load_details 08:03:17 INFO - PID 12914 | |i|pagename|runs| 08:03:17 INFO - PID 12914 | |0;ai-astar;104;104;104;105;106;108;106;105;105;106 08:03:17 INFO - PID 12914 | |1;audio-beat-detection;111;112;116;113;113;110;118;115;113;111 08:03:17 INFO - PID 12914 | |2;audio-dft;161;163;163;163;163;163;162;162;163;160 08:03:17 INFO - PID 12914 | |3;audio-fft;75;74;72;75;72;75;73;74;73;73 08:03:17 INFO - PID 12914 | |4;audio-oscillator;78;77;79;78;76;77;77;77;77;77 08:03:17 INFO - PID 12914 | |5;imaging-gaussian-blur;114;114;112;113;113;114;113;114;114;114 08:03:17 INFO - PID 12914 | |6;imaging-darkroom;148;148;148;150;148;148;151;148;150;148 08:03:17 INFO - PID 12914 | |7;imaging-desaturate;94;95;99;95;94;94;94;97;94;97 08:03:17 INFO - PID 12914 | |8;json-parse-financial;44;44;44;44;44;43;43;44;44;43 08:03:17 INFO - PID 12914 | |9;json-stringify-tinderbox;38;39;38;38;38;38;38;37;38;38 08:03:17 INFO - PID 12914 | |10;stanford-crypto-aes;69;70;75;71;86;72;74;71;69;71 08:03:17 INFO - PID 12914 | |11;stanford-crypto-ccm;108;102;107;110;103;108;101;101;113;111 08:03:17 INFO - PID 12914 | |12;stanford-crypto-pbkdf2;154;149;149;150;151;152;148;151;151;151 08:03:17 INFO - PID 12914 | |13;stanford-crypto-sha256-iterative;60;59;64;62;58;58;61;61;59;59 08:03:17 INFO - PID 12914 | __end_tp_report 08:03:17 INFO - PID 12914 | __start_cc_report 08:03:17 INFO - PID 12914 | _x_x_mozilla_cycle_collect,667 08:03:17 INFO - PID 12914 | __end_cc_report 08:03:17 INFO - PID 12914 | __startTimestamp1508425397943__endTimestamp 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | ------- Summary: start ------- 08:03:17 INFO - PID 12914 | Number of tests: 14 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.50 stddev:1.25 (1.2%) stddev-sans-first:1.24 08:03:17 INFO - PID 12914 | Values: 104.0 104.0 104.0 105.0 106.0 108.0 106.0 105.0 105.0 106.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#1] audio-beat-detection Cycles:10 Average:113.20 Median:113.00 stddev:2.49 (2.2%) stddev-sans-first:2.51 08:03:17 INFO - PID 12914 | Values: 111.0 112.0 116.0 113.0 113.0 110.0 118.0 115.0 113.0 111.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 08:03:17 INFO - PID 12914 | Values: 161.0 163.0 163.0 163.0 163.0 163.0 162.0 162.0 163.0 160.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#3] audio-fft Cycles:10 Average:73.60 Median:74.00 stddev:1.17 (1.6%) stddev-sans-first:1.13 08:03:17 INFO - PID 12914 | Values: 75.0 74.0 72.0 75.0 72.0 75.0 73.0 74.0 73.0 73.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 08:03:17 INFO - PID 12914 | Values: 78.0 77.0 79.0 78.0 76.0 77.0 77.0 77.0 77.0 77.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:03:17 INFO - PID 12914 | Values: 114.0 114.0 112.0 113.0 113.0 114.0 113.0 114.0 114.0 114.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 08:03:17 INFO - PID 12914 | Values: 148.0 148.0 148.0 150.0 148.0 148.0 151.0 148.0 150.0 148.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.77 (1.9%) stddev-sans-first:1.81 08:03:17 INFO - PID 12914 | Values: 94.0 95.0 99.0 95.0 94.0 94.0 94.0 97.0 94.0 97.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:0.48 (1.1%) stddev-sans-first:0.50 08:03:17 INFO - PID 12914 | Values: 44.0 44.0 44.0 44.0 44.0 43.0 43.0 44.0 44.0 43.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 08:03:17 INFO - PID 12914 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:71.50 stddev:5.03 (7.0%) stddev-sans-first:5.14 08:03:17 INFO - PID 12914 | Values: 69.0 70.0 75.0 71.0 86.0 72.0 74.0 71.0 69.0 71.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#11] stanford-crypto-ccm Cycles:10 Average:106.40 Median:108.00 stddev:4.38 (4.1%) stddev-sans-first:4.60 08:03:17 INFO - PID 12914 | Values: 108.0 102.0 107.0 110.0 103.0 108.0 101.0 101.0 113.0 111.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.60 Median:151.00 stddev:1.71 (1.1%) stddev-sans-first:1.30 08:03:17 INFO - PID 12914 | Values: 154.0 149.0 149.0 150.0 151.0 152.0 148.0 151.0 151.0 151.0 08:03:17 INFO - PID 12914 | 08:03:17 INFO - PID 12914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:1.91 (3.2%) stddev-sans-first:2.03 08:03:17 INFO - PID 12914 | Values: 60.0 59.0 64.0 62.0 58.0 58.0 61.0 61.0 59.0 59.0 08:03:17 INFO - PID 12914 | -------- Summary: end -------- 08:03:17 INFO - PID 12914 | 08:03:18 INFO - PID 12914 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:03:18 INFO - TEST-INFO | 12914: exit 0 08:03:18 INFO - TEST-OK | kraken | took 58138ms 08:03:18 INFO - SUITE-END | took 1164s 08:03:19 INFO - Completed test suite (00:19:25) 08:03:19 INFO - javascript benchmark 08:03:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9352.0596651436, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3964.6431821136093, 3969.940450893237, 3978.343573310402, 3981.4425980362753, 3983.223271462066, 6205.875882482348, 6262.373762623735, 6325.620462772237, 6356.2372515298175, 6360.268569114553, 6258.655773932432, 6282.68586570672, 6339.524535659821, 6342.112104305401, 6380.968095159529, 5641.633293835887, 5666.490015898558, 5731.914021289663, 5760.62555933865, 5769.394213607574, 5734.827955161331, 5735.799247026355, 5753.395893431192, 5753.568482363839, 5816.389279125694, 5801.158831969362, 5867.266591676041, 5895.469407753301, 5902.291724993007, 5903.114532820068, 5796.391378905218, 5811.970940145272, 5822.359540450547, 5889.116632505115, 5909.379515150933, 5599.076152434844, 5674.3190817101795, 5692.459216374438, 5737.598368114233, 5769.07694768835, 6234.750609975596, 6304.621722696607, 6306.590071645374, 6337.271213810379, 6347.682615869188, 6859.485538584576, 6892.310768923067, 6941.826454338631, 6949.89575156373, 6972.860542789166, 6801.965990170018, 6926.480513961473, 6959.6868140933275, 7026.1217347831525, 7035.437165026786, 6378.170837791104, 6454.93545064548, 6458.192725909262, 6464.903026454654, 6475.417212450855, 6957.8956315655305, 7030.367266945999, 7041.507094503438, 7139.071920650283, 7146.392556632641, 6674.199096108498, 6763.864722705518, 6777.695003724844, 6850.554713943678, 6873.965630171817, 6780.0, 6891.310868913069, 6917.723291068301, 6996.510244282851, 7003.92996070043, 6787.864242715118, 6850.040994260808, 6923.6192009438955, 6929.965350173317, 6930.896036559456, 6666.96666516674, 6855.211650660138, 6873.450123990069, 6919.584824910521, 6950.096487456598, 5042.773075211624, 5062.0, 5087.923681144785, 5097.057044446789, 5110.795568177231, 4626.976865115653, 4688.0858232644305, 4732.574068333866, 4742.95257047432, 4769.093872164278, 6474.15835941334, 6479.449246814073, 6531.444827189647, 6545.4436372907885, 6561.639109848908, 6742.49431292655, 6788.694508747119, 6825.726970921207, 6831.385175334144, 6866.0, 6404.775832845921, 6504.739810407626, 6520.934790652128, 6528.967355163194, 6542.803715888531, 5655.123455864347, 5734.397888221677, 5753.482186603226, 5806.912896306559, 5827.504662103684, 7132.358087772125, 7194.316539928698, 7210.2789721027475, 7212.3148300911325, 7316.378107860785, 6771.153605799275, 6784.185897692309, 6788.558743681645, 6813.250542440229, 6841.828954276183, 7118.430525558047, 7121.46589005837, 7141.500094993301, 7220.422366210795, 7233.3851622612665, 6784.76253331131, 6796.76211332601, 6803.149606299213, 6847.657617119224, 6874.896876546756, 6843.828904277433, 6893.517453778188, 6907.378335949788, 6997.1253593300835, 7002.984567237824, 6610.636414997221, 6646.9335306648245, 6660.500462465237, 6670.366315200048, 6713.899291510534, 6635.336466353326, 6645.734170633121, 6671.5997040177745, 6699.363560461748, 6702.597844129368, 6540.018997150465, 6587.2753997061245, 6600.273969863407, 6615.702293396713, 6633.9668301658185, 6547.312532184243, 6616.735330586723, 6717.05961165447, 6722.092517510074, 6732.899006514808, 6429.742810287723, 6445.903311450238, 6523.608583485006, 6524.2823289439075, 6560.901586476302], "value": 6317.299456825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.6233363154287, 958.966436174734, 979.9951000244998, 1003.3829195045045, 1024.0118285854153, 46177.30734038988, 46842.29736553946, 47074.2938855917, 47089.76455117728, 47210.2918456223, 43890.341644875356, 44040.55959440413, 44153.55846441535, 44203.0, 44394.7780261099, 8061.6372263248, 8085.3127484163915, 8141.877871831927, 8154.184581541828, 8158.959205203966, 8080.636371363274, 8188.877166842502, 8195.221453961864, 8195.959020204891, 8209.548474833882, 8460.0, 8545.27365173961, 8672.566371681422, 8710.651573937035, 8792.69225577105, 8466.66133354665, 8484.448510846836, 8537.701180458685, 8879.95560022199, 8935.151160639729, 8828.293736501064, 8916.687915922912, 8945.418547794372, 8951.0, 8955.328350373748, 43042.35436468456, 43332.350014749805, 43368.78315608433, 43458.0, 43485.78257108726, 3822.789746563938, 3835.0, 3853.2100919311756, 3861.9806900965596, 3873.5158105236846, 35683.64316356855, 35917.46123808145, 35989.46015809765, 35991.4601280981, 36150.096247593756, 5397.0, 5432.70120143392, 5456.317960254968, 5494.560435165217, 5495.780168793283, 227760.0, 228933.0, 229541.0, 230617.0, 231146.0, 50214.49785502171, 56758.71620641871, 56797.7160114205, 57049.71475142598, 57233.71383143058, 58937.642494300606, 59501.404985949586, 59682.40317596855, 59750.70124649349, 59753.402465975654, 18468.44594662162, 18588.535286617673, 18635.975021373684, 18643.347482838308, 18676.25294988185, 15661.451849185223, 15735.213239337987, 15761.763573546406, 15866.286017129027, 15870.761938570931, 16116.75824862628, 16139.677206455804, 16158.596035099217, 16213.189340532927, 16264.67470650604, 6096.146539484475, 6166.0, 6202.224721909762, 6366.554341196164, 6382.234131904202, 1116.3246236027248, 1123.5225029362489, 1133.795916734979, 1138.743782648914, 1145.8052131137727, 26137.954481820896, 26839.597406038924, 26876.865615672188, 26879.0, 27038.459230815668, 1225.8345123408403, 1243.490169030693, 1244.4337826289018, 1256.7109564800148, 1264.4626033935724, 14007.369668364949, 14211.64470888236, 14293.0, 14377.353019114165, 14449.855501445061, 291887.0, 300040.0, 304702.0, 307665.0, 308134.0, 67377.66311168413, 67422.3257767416, 67971.32028679749, 68012.0, 68122.0, 1545.652228248635, 1558.968820623604, 1559.5087547422524, 1562.2266977846039, 1567.4200545798128, 31055.66525060336, 31157.0, 31420.461927462908, 31527.21181970469, 31773.523397149525, 43121.3531797017, 43337.48318808826, 43385.3492197611, 43433.78283108691, 43584.0, 266336.0, 268866.0, 269378.0, 270128.0, 270944.0, 38440.42339364856, 39429.2114157721, 39807.2038559233, 40173.59826401698, 40314.596854031086, 49701.751491242314, 49741.751291243316, 50128.248076278156, 50214.49785502244, 50245.49754502408, 35184.472232916014, 35588.822055889555, 35739.82130089333, 35796.64203357933, 35901.82049089738, 35260.47109293311, 35342.0, 35496.290074198885, 35828.64171358357, 35842.10394740153, 42021.36967945422, 42044.15911681688, 42205.0, 42350.788246058575, 42418.0, 33736.0, 33868.0, 34354.312913742084, 34550.30899382049, 34670.82664586661, 25944.362811247298, 26029.634290680064, 26438.735612643628, 26462.867685661447, 26687.599686004338], "value": 19698.65457072219, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.7216037055396, 647.1471841217465, 648.0199665570093, 651.9373421323245, 661.1075048684276, 24126.396840078985, 25021.874890625546, 25224.0, 25332.113376031844, 25877.0, 27182.0, 27967.58048629272, 28087.157385278424, 28114.0, 28170.295742606446, 7162.4270058395205, 7277.781666550012, 7287.9271207287775, 7292.0, 7294.562326260415, 6836.0, 7090.574565526059, 7121.679524421387, 7128.429725621938, 7132.179799323067, 7043.718251269943, 7077.2568880267345, 7080.221175670672, 7088.71645134194, 7094.077769889907, 7090.361867431956, 7091.184513780904, 7094.042304288907, 7097.18382386027, 7107.6090815005155, 6621.536492445531, 6630.668466576652, 6641.136652235226, 6641.468682505388, 6643.468522518187, 31294.21764455884, 31684.366312673847, 31749.365012699847, 31840.0, 31868.521972170434, 2379.6311571706415, 2407.1935901473025, 2414.38433199533, 2419.6249581314746, 2424.3090719144957, 20637.690434643493, 21128.0, 21150.894245528674, 21222.787772122236, 21227.787722122735, 2365.9645105323434, 2415.420299128214, 2636.4990651776293, 2642.1545105566224, 2658.2689760315875, 171675.14162429233, 174120.99999999872, 174290.0, 174897.0, 175104.0, 16636.0, 16971.15144242783, 16982.57543561421, 17098.401555945482, 17111.657766844593, 28542.571861422097, 28568.142955711362, 28604.284892877844, 28623.14130576086, 28686.713132868823, 11495.206581827977, 11683.0, 11836.230645008047, 11883.702907427383, 11908.106891983136, 9686.273529485317, 10073.597056117673, 10843.51204195813, 10890.509927053301, 10992.0, 9741.366811157252, 10102.242331825142, 10652.147828173882, 10654.295312750079, 10672.252942293964, 3087.228192951762, 3099.342775524857, 3128.515080162578, 3184.888528901524, 3257.8371081445835, 1063.9680809575725, 1080.5137688040413, 1093.8960798724108, 1099.7910397024539, 1109.5062697099713, 22945.770542294696, 22994.355649100235, 23368.182113625942, 23386.298411047697, 23528.354901657178, 1141.4406940599213, 1163.1857699610307, 1171.3557543351124, 1171.6075114836456, 1177.4936777185721, 12586.748265034832, 12777.872221277854, 12794.360281985864, 12811.423485942969, 12855.421506032251, 657902.0, 661743.0, 667648.0, 677765.0, 678116.0, 132624.0, 142143.28928355293, 142784.0, 143043.2847835775, 143413.0, 1280.3470230182675, 1299.2918859221747, 1324.3510679766846, 1324.8542660307357, 1327.3827670133435, 19699.0, 20159.39521814348, 20268.391948241577, 20436.897815511424, 20709.896450517652, 66799.66600166968, 67773.32226677868, 69244.0, 69984.65007674928, 70083.94874076791, 83959.0, 84150.0, 84302.57848710717, 84356.0, 84925.0, 16979.49061528156, 17143.828561714723, 17158.0, 17193.14034298305, 17228.224729887435, 24837.87581062083, 25431.109911153762, 25492.0, 25507.489850203263, 25635.871820640776, 20670.586588268452, 20916.58166836624, 21028.26401075955, 21076.789232107483, 21086.894565527073, 17019.40432084871, 17438.738418923473, 17650.382236622172, 17961.820381796013, 18477.72283415723, 20151.89924050429, 20697.689534657293, 20951.266705665228, 21119.260825871635, 21204.575908482053, 16633.50099497017, 16746.748798768273, 16902.830971690124, 16915.7462638063, 16926.57683557921, 20727.378178654664, 20787.272445464336, 20789.79210207939, 20843.58312833765, 20890.0], "value": 13633.538637744789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.3068465767117, 1459.620498670346, 1465.54568083894, 1465.5676575410253, 1469.4048910191377, 17945.371911983068, 18539.536511587216, 18566.257349705997, 18571.628567428645, 18613.97623130729, 18190.818091819077, 18419.447416577492, 18431.17059732312, 18471.630567388678, 18489.907550462263, 3131.3111115554543, 3161.65221825599, 3206.7434605231524, 3221.2591104046082, 3224.4518431866522, 3067.8005929614505, 3126.7498600111935, 3138.105639892631, 3140.152158917091, 3140.544621029949, 3067.4938635125177, 3108.2540190354266, 3124.0627811656527, 3178.904632861006, 3179.380020895926, 3049.573059771634, 3063.1270088024917, 3078.569000339954, 3080.152957936563, 3084.0439463766306, 2932.692067332942, 2978.0, 2988.9402211955858, 2998.6401631804106, 3014.9095527134223, 17200.45195932372, 17401.738973915275, 17411.912940435217, 17428.215730292166, 17429.564260893578, 8621.956890215572, 8886.111388861127, 8929.508877011762, 8929.821403571957, 8933.330000249942, 5447.237386765856, 5575.414581468928, 5686.0617998030275, 5730.971345143289, 5764.538836893081, 1974.1215159254139, 2002.079043639913, 2008.086320724067, 2042.7344445222027, 2050.2106688924723, 31670.524942125885, 31960.840195799105, 31978.840105799554, 31995.840020799747, 32009.679903200904, 7780.922190778133, 7793.688252469838, 7837.647305871249, 7837.804054898673, 7967.322777563856, 20856.89571552163, 20860.687089693667, 20921.0, 20940.0, 20961.37115886526, 8496.957515212507, 8674.306055515544, 8676.262517686067, 8684.60919258635, 8693.0, 7568.356689681439, 7947.841043179104, 8052.315553178046, 8203.384746143944, 8214.8357032859, 6181.536384771161, 6200.689965501707, 6238.500919926395, 6328.525360597881, 6355.173827402408, 1659.2947997101185, 1706.7951845778587, 1795.3626462605848, 1814.7368631548352, 1815.6005678750653, 976.2482888176065, 1036.8703912011, 1038.7721971575766, 1042.2339580408393, 1043.6973277749519, 10147.492625368703, 10180.0, 10275.948620256851, 10314.0, 10432.165426765841, 824.3940703582862, 831.9043310019305, 836.8200836820113, 839.1817977472039, 886.1006078829993, 6294.339094395023, 6351.0, 6490.935090649033, 6509.153810004669, 6591.802245932629, 26231.213063608124, 27298.590521141803, 27424.862875685492, 27597.86201068982, 27639.585406218925, 25406.0, 26469.735302646728, 26483.47033059328, 26553.20340389753, 26558.0, 12825.743485130432, 12974.610761676977, 13017.739645207042, 13122.475100996044, 13169.275689837152, 10139.797204056025, 10167.593296268362, 10199.38803671782, 10375.16998640122, 10410.427426491615, 22386.552268954856, 22507.424480286223, 22724.4318892029, 22781.544369112857, 23377.064917403794, 23361.649575256044, 23534.29397118089, 23807.761922381247, 23994.640080399156, 24004.51990960206, 12672.809907851573, 12872.549460768829, 12875.742485150431, 12934.288614125937, 13022.348882556023, 16271.918640406722, 16433.09617971023, 16483.34066637321, 16488.0, 16576.83423165753, 12019.519219231483, 12112.394380281126, 12301.815472767737, 12381.133320667466, 12547.686307842378, 11839.82240266414, 11961.760764784482, 12035.819462707892, 12091.455884485395, 12199.329036903055, 11303.208775385645, 11350.205485615928, 11417.60038398652, 11491.367974761133, 11533.077353811506, 8452.873206902024, 8456.577171141294, 8562.143785621638, 8615.82768344617, 8698.91301086981, 8691.782705432162, 8749.65001399937, 8784.341174412073, 8801.339899507435, 8806.471611703319], "value": 7689.6746254939135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1332181744656, 573.8852229554091, 576.5906206593319, 610.7556977209116, 625.6465097220071, 5974.253218347707, 6090.23872015998, 6090.8172754817315, 6118.235220597426, 6203.8138855834395, 6023.488003519695, 6057.303410107839, 6096.237970253718, 6098.481629061535, 6112.6638034908065, 5093.898122037557, 5100.515451032146, 5110.386753589574, 5112.846614601568, 5118.206677964921, 4900.7794649240695, 4993.900121997558, 5001.249812528114, 5004.599632029447, 5012.273220383042, 4980.427250866161, 4993.675411098285, 4994.150994330954, 5001.524855138756, 5048.192289233723, 4945.604351651859, 4947.109520286347, 4982.676126051795, 4987.329244703029, 4992.950070499285, 4562.543745625411, 4583.587477127041, 4586.105709386671, 4592.425946756655, 4608.539146085398, 6087.817365479043, 6112.463327718991, 6116.785912493086, 6123.601965872249, 6140.600860944024, 5715.171300161495, 5756.0, 5769.24999750034, 5802.520357308901, 5847.8245652630485, 6449.484041276686, 6499.837504062389, 6531.216254049497, 6531.902021469682, 6537.477001839841, 4859.902801943977, 5058.418281897592, 5088.287639730441, 5089.7530105124115, 5096.745162741848, 6623.23832759234, 6685.264620891747, 6760.763373281911, 6827.249002609709, 6827.48793840464, 5165.896682066337, 5191.377034755854, 5199.974000129975, 5215.58275337972, 5237.188235823453, 5315.149576067811, 5327.440618735054, 5327.573794096463, 5351.973240133774, 5354.732263386815, 5768.7118342544345, 5811.070228763462, 5824.883502330014, 5847.736851841677, 5848.941510584839, 6439.613623182624, 6539.149910511603, 6544.116544266558, 6558.0, 6563.737450502022, 1768.5932235585888, 1799.0285245967293, 1800.540862080161, 1801.5406071451696, 1823.5441139715072, 1275.2157423184674, 1310.7050913544376, 1315.552712077879, 1332.187365706918, 1336.358547897015, 6121.123721227671, 6136.723847426787, 6206.906896396557, 6217.96891015542, 6289.339619339903, 6620.139381880324, 6638.336166383419, 6651.800445986628, 6652.70062847173, 6669.599824010575, 6198.566100373021, 6251.9684252098805, 6254.468370188494, 6258.624482531062, 6289.276733175743, 3359.731221502274, 3379.9324013520086, 3401.5067815166663, 3453.689167974894, 3489.1277180704824, 6880.174379074443, 6880.965595171992, 6897.55165914214, 6955.234924158339, 6987.965060174768, 6700.262971073178, 6716.126903502513, 6751.223609284897, 6794.76218332356, 6831.726730930806, 6779.15260592426, 6851.760188393382, 6853.305485742282, 6898.792386436292, 6926.272741362185, 6529.934700652932, 6635.3790252848885, 6640.83397915056, 6644.933550664431, 6676.49926255523, 6505.51208659343, 6530.934690653033, 6533.705983230671, 6536.509761767981, 6562.573432726857, 6903.482238832007, 6938.8612227756175, 6944.756933507303, 6974.37230649244, 7017.157941047107, 5162.174052151638, 5201.42784293735, 5210.342725210095, 5226.97386513065, 5241.50205730455, 6382.0, 6427.3251308611925, 6488.286288508355, 6501.0, 6654.800355989328, 6271.306747178328, 6309.842253943688, 6320.241571011324, 6384.776532821329, 6392.561673623398, 6252.749890004349, 6314.368563143649, 6338.809835704937, 6405.135306733531, 6419.518536109717, 6316.873662526816, 6328.430441260309, 6340.175777148941, 6365.2361716594305, 6411.5832470889245, 6382.266039405527, 6400.359964003563, 6463.806085817433, 6493.350664933658, 6508.576942498722, 6316.747330106744, 6335.968320158554, 6345.969289827211, 6353.96823015882, 6383.308268422613], "value": 5132.54470414534, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [980.7155924781814, 998.0169533009984, 1028.233965695557, 1029.094396930701, 1035.823909935311, 16938.83061169388, 17213.483595492125, 17287.308507659694, 17309.39417120401, 17329.566760830985, 16409.343626254966, 16539.0, 18221.817781822177, 18355.632887342246, 18427.355042573512, 1025.2669341420883, 1045.3518818332607, 1046.142163425991, 1046.837740150278, 1049.8635177426943, 1015.7105225010873, 1075.6235317638802, 1077.245927850504, 1080.2384319055047, 1081.0270756319296, 1157.7105723569107, 1165.2367699157066, 1169.8830116988318, 1172.109197010274, 1176.2119380015367, 1115.8047341715167, 1134.6539305511858, 1138.0383575878411, 1138.7039369763838, 1139.3619573039125, 824.7031068815222, 831.7878940870039, 832.5504227717025, 832.7751507093051, 835.1022650650575, 18833.0, 19355.0, 19446.70829937552, 19531.414057578295, 19592.902035489875, 19176.520586985436, 19375.709364359547, 19473.51316217092, 19540.413787586396, 19637.705434418494, 16861.662766744717, 16924.746128808078, 16959.067251301174, 16969.745453818203, 17162.742558861628, 3812.390017597171, 3840.1935593525395, 3841.635044670752, 3847.1728578355787, 3850.7111966602615, 156348.0, 157498.0, 157614.0, 159179.2041039799, 160549.19725401414, 14555.708885822225, 14883.47907823221, 14942.477013304482, 14987.250637468302, 15047.849521504644, 27777.305567360978, 27995.0, 28118.578221326698, 28238.85880570584, 28315.71684283172, 8989.505577193317, 9441.055894410503, 9565.569549370295, 9569.33014688979, 9582.137607615348, 4334.371516130143, 4399.450068741407, 4399.5160532341415, 4408.338749187647, 4419.40338054365, 5808.361080281165, 5845.240118784616, 5888.5289176865745, 5930.11048342752, 5962.2249107615735, 1099.9890001100046, 1133.3766428464312, 1142.4002398740727, 1143.3997151495532, 1148.5004023249912, 725.698834983476, 760.1979911193633, 762.6453699029978, 776.7863837444635, 784.2432053068816, 12860.356982150855, 12880.935595321964, 12950.935245323713, 13130.0, 13560.186388816703, 766.0, 769.3691173238003, 774.7172282116986, 777.2421888658625, 782.8238646304536, 6077.75688972445, 6152.384761523812, 6163.291221509584, 6205.255369355616, 6264.874702506016, 149587.0, 151176.0, 152103.0, 152318.807270693, 158499.0, 132202.0, 132934.0, 133815.0, 133941.0, 140200.0, 116151.0, 118511.40744296396, 119311.40344298397, 120011.39994299972, 120778.3961080189, 12934.805977910151, 13671.632836716646, 14042.578722638336, 14184.645383865485, 14188.148711077369, 55696.44303556912, 56051.0, 56359.0, 56954.43045569657, 57101.433335165326, 73931.26068739244, 74844.0, 74895.0, 75168.62415687887, 75598.62200688961, 20026.399208023784, 20301.59396812085, 20352.592948140657, 20395.0, 20585.89707051455, 22045.33863984083, 22076.558468830855, 22110.557788844453, 22111.55776884421, 22415.32754017382, 19679.917604531314, 19753.209871604973, 19778.30775922836, 19789.901050494656, 19797.60404791925, 20241.392758217276, 20390.796092039483, 20575.69136462984, 20875.686864697345, 20911.89544052331, 18880.24479020824, 18976.905115474336, 19107.426777196706, 19257.13342899601, 19308.517287067934, 14600.12399256048, 14922.701545969237, 15003.774943376076, 15220.467283645019, 15507.224638767791, 15557.0, 15750.9212453937, 15887.68224635524, 16122.838771612134, 16257.51227463178], "value": 9990.741261103265, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1360.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 104.0, 105.0, 106.0, 108.0, 106.0, 105.0, 105.0, 106.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 116.0, 113.0, 113.0, 110.0, 118.0, 115.0, 113.0, 111.0], "value": 113.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 163.0, 163.0, 163.0, 162.0, 162.0, 163.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 75.0, 72.0, 75.0, 73.0, 74.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 79.0, 78.0, 76.0, 77.0, 77.0, 77.0, 77.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 112.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 151.0, 148.0, 150.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 99.0, 95.0, 94.0, 94.0, 94.0, 97.0, 94.0, 97.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 44.0, 44.0, 44.0, 43.0, 43.0, 44.0, 44.0, 43.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 75.0, 71.0, 86.0, 72.0, 74.0, 71.0, 69.0, 71.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 102.0, 107.0, 110.0, 103.0, 108.0, 101.0, 101.0, 113.0, 111.0], "value": 106.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 149.0, 150.0, 151.0, 152.0, 148.0, 151.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 64.0, 62.0, 58.0, 58.0, 61.0, 61.0, 59.0, 59.0], "value": 60.1, "unit": "score"}]}]} 08:03:19 INFO - Return code: 0 08:03:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:19 INFO - # TBPL SUCCESS # 08:03:19 INFO - Running post-action listener: _package_coverage_data 08:03:19 INFO - Running post-action listener: _resource_record_post_action 08:03:19 INFO - [mozharness: 2017-10-19 15:03:19.223675Z] Finished run-tests step (success) 08:03:19 INFO - Running post-run listener: _resource_record_post_run 08:03:19 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292753408; Read time: 96; Write time: 135932 08:03:19 INFO - TinderboxPrint: CPU usage
13.0% 08:03:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 08:03:19 INFO - TinderboxPrint: I/O write bytes / time
292,753,408 / 135,932 08:03:19 INFO - TinderboxPrint: CPU idle
8,181.6 (87.0%) 08:03:19 INFO - TinderboxPrint: CPU user
1,178.0 (12.5%) 08:03:19 INFO - TinderboxPrint: Swap in / out
0 / 0 08:03:19 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 11022336; Read time: 0; Write time: 1036 08:03:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:03:19 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281731072; Read time: 96; Write time: 134896 08:03:19 INFO - Running post-run listener: _upload_blobber_files 08:03:19 INFO - Blob upload gear active. 08:03:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:03:19 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:03:19 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:03:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:03:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:03:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:21 INFO - (blobuploader) - INFO - Done attempting. 08:03:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:28 INFO - (blobuploader) - INFO - Done attempting. 08:03:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:03:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:03:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:29 INFO - (blobuploader) - INFO - Done attempting. 08:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:30 INFO - (blobuploader) - INFO - Done attempting. 08:03:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:30 INFO - Return code: 0 08:03:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d5a2b14d562479c0b933bfdd7c23927d54bfcb27bd550dfd372d6819e660fb4aaca1da68a5c9b74865f4b3c91c33bf412b7dd30c290cf0687a4bcd382327bc01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f2e5f3ae71d8fc6c4ab671013a2b68dac00b5ad349c721a0ad7ffb5e2569203a560059c5596bac4c648400b2cdf6d01e346d559ce804b5c00e4845330abcbfe6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6687c4baa5a2294d009929f1bc83708d6ed3a22c76eb2bebde2bc3853cbd0b9a606983f22f29542652ee24ba358da41ca75096df6fac65b776c47988e33a0cae", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b1e733d1b664a5065af6226b3fc3658161ea28ab5129677fb861d59febfdef3a5aa802294839fbd60fcbdafd3bdde7e2fedf0cbaaf68e5a84ce14ae902de463f"} 08:03:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:30 INFO - Contents: 08:03:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d5a2b14d562479c0b933bfdd7c23927d54bfcb27bd550dfd372d6819e660fb4aaca1da68a5c9b74865f4b3c91c33bf412b7dd30c290cf0687a4bcd382327bc01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f2e5f3ae71d8fc6c4ab671013a2b68dac00b5ad349c721a0ad7ffb5e2569203a560059c5596bac4c648400b2cdf6d01e346d559ce804b5c00e4845330abcbfe6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6687c4baa5a2294d009929f1bc83708d6ed3a22c76eb2bebde2bc3853cbd0b9a606983f22f29542652ee24ba358da41ca75096df6fac65b776c47988e33a0cae", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b1e733d1b664a5065af6226b3fc3658161ea28ab5129677fb861d59febfdef3a5aa802294839fbd60fcbdafd3bdde7e2fedf0cbaaf68e5a84ce14ae902de463f"} 08:03:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:30 INFO - Copying logs to upload dir... 08:03:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.139719 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-10-19 08:03:30.541608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-19 08:03:30.548698) ========= 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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d5a2b14d562479c0b933bfdd7c23927d54bfcb27bd550dfd372d6819e660fb4aaca1da68a5c9b74865f4b3c91c33bf412b7dd30c290cf0687a4bcd382327bc01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f2e5f3ae71d8fc6c4ab671013a2b68dac00b5ad349c721a0ad7ffb5e2569203a560059c5596bac4c648400b2cdf6d01e346d559ce804b5c00e4845330abcbfe6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6687c4baa5a2294d009929f1bc83708d6ed3a22c76eb2bebde2bc3853cbd0b9a606983f22f29542652ee24ba358da41ca75096df6fac65b776c47988e33a0cae", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b1e733d1b664a5065af6226b3fc3658161ea28ab5129677fb861d59febfdef3a5aa802294839fbd60fcbdafd3bdde7e2fedf0cbaaf68e5a84ce14ae902de463f"} build_url:https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/eCj2xzuFSri3h8uQrGZksg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d5a2b14d562479c0b933bfdd7c23927d54bfcb27bd550dfd372d6819e660fb4aaca1da68a5c9b74865f4b3c91c33bf412b7dd30c290cf0687a4bcd382327bc01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f2e5f3ae71d8fc6c4ab671013a2b68dac00b5ad349c721a0ad7ffb5e2569203a560059c5596bac4c648400b2cdf6d01e346d559ce804b5c00e4845330abcbfe6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6687c4baa5a2294d009929f1bc83708d6ed3a22c76eb2bebde2bc3853cbd0b9a606983f22f29542652ee24ba358da41ca75096df6fac65b776c47988e33a0cae", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b1e733d1b664a5065af6226b3fc3658161ea28ab5129677fb861d59febfdef3a5aa802294839fbd60fcbdafd3bdde7e2fedf0cbaaf68e5a84ce14ae902de463f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-19 08:03:30.580438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 08:03:30.580726) ========= 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=41a7e32711b8e08598a63237000001d6-1508423979.469373-2039788398 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-19 08:03:30.661786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-19 08:03:30.662055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-19 08:03:30.665328) ========= ========= Total master_lag: 0.19 =========