builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1507168577.79 results: success (0) revision: 8c7645234f86018b46dab62fdcc39955f229c74a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.787462) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.787884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.788153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.810183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.810491) ========= 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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 18:56:17-- 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% 46.9M=0s 2017-10-04 18:56:17 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.927739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.928015) ========= 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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020152 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.980379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:17.980731) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8c7645234f86018b46dab62fdcc39955f229c74a --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 8c7645234f86018b46dab62fdcc39955f229c74a --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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 18:56:18,018 truncating revision to first 12 chars 2017-10-04 18:56:18,018 Setting DEBUG logging. 2017-10-04 18:56:18,018 attempt 1/10 2017-10-04 18:56:18,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8c7645234f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 18:56:18,364 unpacking tar archive at: mozilla-beta-8c7645234f86/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:18.664393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:18.664715) ========= script_repo_revision: 8c7645234f86018b46dab62fdcc39955f229c74a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:18.665087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:18.665354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 18:56:18.693754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-04 18:56:18.694136) ========= /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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:56:18 INFO - MultiFileLogger online at 20171004 18:56:18 in /builds/slave/test 18:56:18 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 18:56:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:56:18 INFO - {'append_to_log': False, 18:56:18 INFO - 'base_work_dir': '/builds/slave/test', 18:56:18 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:56:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:56:18 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:56:18 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:18 INFO - 'code_coverage': False, 18:56:18 INFO - 'config_files': ('talos/linux_config.py',), 18:56:18 INFO - 'default_actions': ('clobber', 18:56:18 INFO - 'read-buildbot-config', 18:56:18 INFO - 'download-and-extract', 18:56:18 INFO - 'populate-webroot', 18:56:18 INFO - 'create-virtualenv', 18:56:18 INFO - 'install', 18:56:18 INFO - 'setup-mitmproxy', 18:56:18 INFO - 'run-tests'), 18:56:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:18 INFO - 'disable_ccov_upload': False, 18:56:18 INFO - 'disable_stylo': False, 18:56:18 INFO - 'download_minidump_stackwalk': True, 18:56:18 INFO - 'download_symbols': 'ondemand', 18:56:18 INFO - 'enable_stylo': False, 18:56:18 INFO - 'enable_webrender': False, 18:56:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:56:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:18 INFO - 'gecko_profile': False, 18:56:18 INFO - 'gecko_profile_interval': 0, 18:56:18 INFO - 'installer_path': 'installer.exe', 18:56:18 INFO - 'log_level': 'info', 18:56:18 INFO - 'log_name': 'talos', 18:56:18 INFO - 'log_to_console': True, 18:56:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:56:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:56:18 INFO - 'opt_config_files': (), 18:56:18 INFO - 'pip_index': False, 18:56:18 INFO - 'suite': 'dromaeojs-e10s', 18:56:18 INFO - 'system_bits': '32', 18:56:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:18 INFO - 'title': 'talos-linux64-ix-027', 18:56:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:18 INFO - 'use_talos_json': True, 18:56:18 INFO - 'verify': 'False', 18:56:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:56:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:18 INFO - 'work_dir': 'build'} 18:56:18 INFO - [mozharness: 2017-10-05 01:56:18.874406Z] Running clobber step. 18:56:18 INFO - Running pre-action listener: _resource_record_pre_action 18:56:18 INFO - Running main action method: clobber 18:56:18 INFO - rmtree: /builds/slave/test/build 18:56:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:56:19 INFO - Running post-action listener: _resource_record_post_action 18:56:19 INFO - [mozharness: 2017-10-05 01:56:19.870193Z] Finished clobber step (success) 18:56:19 INFO - [mozharness: 2017-10-05 01:56:19.870291Z] Running read-buildbot-config step. 18:56:19 INFO - Running pre-action listener: _resource_record_pre_action 18:56:19 INFO - Running main action method: read_buildbot_config 18:56:19 INFO - Using buildbot properties: 18:56:19 INFO - { 18:56:19 INFO - "project": "", 18:56:19 INFO - "product": "firefox", 18:56:19 INFO - "who": "ryanvm@gmail.com", 18:56:19 INFO - "installer_path": "public/build/target.tar.bz2", 18:56:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:56:19 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:56:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:56:19 INFO - "stage_platform": "linux64", 18:56:19 INFO - "basedir": "/builds/slave/test", 18:56:19 INFO - "buildnumber": 156, 18:56:19 INFO - "platform": "ubuntu64_hw", 18:56:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:56:19 INFO - "slavebuilddir": "test", 18:56:19 INFO - "taskId": "FWp1BbhESMWy6Y-TPLM_JQ", 18:56:19 INFO - "branch": "mozilla-beta", 18:56:19 INFO - "script_repo_revision": "production", 18:56:19 INFO - "revision": "8c7645234f86018b46dab62fdcc39955f229c74a", 18:56:19 INFO - "slavename": "talos-linux64-ix-027", 18:56:19 INFO - "repo_path": "releases/mozilla-beta" 18:56:19 INFO - } 18:56:19 INFO - Finding installer, test and symbols from parent task. 18:56:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWp1BbhESMWy6Y-TPLM_JQ'}, attempt #1 18:56:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWp1BbhESMWy6Y-TPLM_JQ'}, attempt #1 18:56:20 INFO - Task dependencies: P5plh6KMQkyDf6QPX90VPQ 18:56:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ'}, attempt #1 18:56:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 18:56:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.test_packages.json 18:56:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.crashreporter-symbols.zip 18:56:21 INFO - Running post-action listener: _resource_record_post_action 18:56:21 INFO - [mozharness: 2017-10-05 01:56:21.238148Z] Finished read-buildbot-config step (success) 18:56:21 INFO - [mozharness: 2017-10-05 01:56:21.238365Z] Running download-and-extract step. 18:56:21 INFO - Running pre-action listener: _resource_record_pre_action 18:56:21 INFO - Running main action method: download_and_extract 18:56:21 INFO - mkdir: /builds/slave/test/build/tests 18:56: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')]} 18:56:21 INFO - trying https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.test_packages.json 18:56:21 INFO - Downloading https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:56:21 INFO - Downloaded 989 bytes. 18:56:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:56:21 INFO - Using the following test package requirements: 18:56:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:56:21 INFO - u'common': [u'target.common.tests.zip'], 18:56:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:56:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:56:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:56:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:56:21 INFO - u'mozbase': [u'target.common.tests.zip'], 18:56:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:56:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:56:21 INFO - u'web-platform': [u'target.common.tests.zip', 18:56:21 INFO - u'target.web-platform.tests.tar.gz'], 18:56:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:56:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:56:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.common.tests.zip 18:56:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:56:21 INFO - Fetch https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.common.tests.zip into memory 18:56:25 INFO - Content-Length response header: 55185323 18:56:25 INFO - Bytes received: 55185323 18:56:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.talos.tests.zip 18:56:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:56:36 INFO - Fetch https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.talos.tests.zip into memory 18:56:37 INFO - Content-Length response header: 14509224 18:56:37 INFO - Bytes received: 14509224 18:56:37 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')]} 18:56:37 INFO - trying https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 18:56:37 INFO - Downloading https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:56:41 INFO - Downloaded 53568824 bytes. 18:56:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 18:56:41 INFO - mkdir: /builds/slave/test/properties 18:56:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:56:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:56:41 INFO - Contents: 18:56:41 INFO - build_url:https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 18:56:41 INFO - Running post-action listener: _resource_record_post_action 18:56:41 INFO - Running post-action listener: find_tests_for_verification 18:56:41 INFO - Running post-action listener: set_extra_try_arguments 18:56:41 INFO - [mozharness: 2017-10-05 01:56:41.243000Z] Finished download-and-extract step (success) 18:56:41 INFO - [mozharness: 2017-10-05 01:56:41.243229Z] Running populate-webroot step. 18:56:41 INFO - Running pre-action listener: _resource_record_pre_action 18:56:41 INFO - Running main action method: populate_webroot 18:56:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:56:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['tresize', 18:56:41 INFO - 'tcanvasmark']}, 18:56:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:56:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['dromaeo_css', 18:56:41 INFO - 'kraken']}, 18:56:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:56:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'tests': ['damp', 'tps']}, 18:56:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['damp', 'tps']}, 18:56:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:56:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['dromaeo_dom']}, 18:56:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:56:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['basic_compositor_video', 18:56:41 INFO - 'glvideo']}, 18:56:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:56:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['ts_paint_webext', 18:56:41 INFO - 'tp5o_webext']}, 18:56:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:56:41 INFO - 'ts_paint', 18:56:41 INFO - 'tpaint', 18:56:41 INFO - 'sessionrestore', 18:56:41 INFO - 'sessionrestore_many_windows', 18:56:41 INFO - 'sessionrestore_no_auto_restore', 18:56:41 INFO - 'tabpaint']}, 18:56:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['a11yr', 18:56:41 INFO - 'ts_paint', 18:56:41 INFO - 'tpaint', 18:56:41 INFO - 'sessionrestore', 18:56:41 INFO - 'sessionrestore_many_windows', 18:56:41 INFO - 'sessionrestore_no_auto_restore', 18:56:41 INFO - 'tabpaint']}, 18:56:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:56:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:56:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['perf_reftest_singletons']}, 18:56:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['bloom_basic']}, 18:56:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:56:41 INFO - 'tsvgr_opacity', 18:56:41 INFO - 'tart', 18:56:41 INFO - 'tscrollx', 18:56:41 INFO - 'tsvg_static']}, 18:56:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['tsvgx', 18:56:41 INFO - 'tsvgr_opacity', 18:56:41 INFO - 'tart', 18:56:41 INFO - 'tscrollx', 18:56:41 INFO - 'tsvg_static']}, 18:56:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:56:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo'], 18:56:41 INFO - 'tests': ['tp5o']}, 18:56:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:56:41 INFO - 'talos_options': ['--mitmproxy', 18:56:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:56:41 INFO - '--firstNonBlankPaint'], 18:56:41 INFO - 'tests': ['tp6_google', 18:56:41 INFO - 'tp6_youtube', 18:56:41 INFO - 'tp6_amazon', 18:56:41 INFO - 'tp6_facebook']}, 18:56:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo', 18:56:41 INFO - '--mitmproxy', 18:56:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:56:41 INFO - '--firstNonBlankPaint'], 18:56:41 INFO - 'tests': ['tp6_google', 18:56:41 INFO - 'tp6_youtube', 18:56:41 INFO - 'tp6_amazon', 18:56:41 INFO - 'tp6_facebook']}, 18:56:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:56:41 INFO - 'talos_options': ['--stylo-threads=1', 18:56:41 INFO - '--mitmproxy', 18:56:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:56:41 INFO - '--firstNonBlankPaint'], 18:56:41 INFO - 'tests': ['tp6_google', 18:56:41 INFO - 'tp6_youtube', 18:56:41 INFO - 'tp6_amazon', 18:56:41 INFO - 'tp6_facebook']}, 18:56:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--xperf_path', 18:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:41 INFO - 'tests': ['tp5n']}, 18:56:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:56:41 INFO - 'talos_options': ['--disable-stylo', 18:56:41 INFO - '--xperf_path', 18:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:56:41 INFO - 'tests': ['tp5n']}}} 18:56:41 INFO - Running post-action listener: _resource_record_post_action 18:56:41 INFO - [mozharness: 2017-10-05 01:56:41.262482Z] Finished populate-webroot step (success) 18:56:41 INFO - [mozharness: 2017-10-05 01:56:41.262572Z] Running create-virtualenv step. 18:56:41 INFO - Running pre-action listener: _resource_record_pre_action 18:56:41 INFO - Running main action method: create_virtualenv 18:56:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:56:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:56:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:56:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:56:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:56:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:56:41 INFO - Installing distribute.............................................................................................................................................................................................done. 18:56:42 INFO - Installing pip...............done. 18:56:42 INFO - Return code: 0 18:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:56:42 INFO - Reading from file tmpfile_stdout 18:56:42 INFO - Output received: 18:56:42 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:42 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:42 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 18:56:42 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 18:56:42 INFO - Using env: {'DISPLAY': ':0', 18:56:42 INFO - 'HOME': '/home/cltbld', 18:56:42 INFO - 'LANG': 'en_US.UTF-8', 18:56:42 INFO - 'LANGUAGE': 'en_US:en', 18:56:42 INFO - 'LOGNAME': 'cltbld', 18:56:42 INFO - 'MAIL': '/var/mail/cltbld', 18:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:42 INFO - 'MOZ_NO_REMOTE': '1', 18:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:42 INFO - 'NO_EM_RESTART': '1', 18:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:42 INFO - 'PWD': '/builds/slave/test', 18:56:42 INFO - 'SHELL': '/bin/bash', 18:56:42 INFO - 'SHLVL': '1', 18:56:42 INFO - 'TERM': 'linux', 18:56:42 INFO - 'TMOUT': '86400', 18:56:42 INFO - 'USER': 'cltbld', 18:56:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:42 INFO - '_': '/tools/buildbot/bin/python'} 18:56:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:56:44 INFO - Downloading/unpacking pip>=1.5 18:56:44 INFO - Running setup.py egg_info for package pip 18:56:44 INFO - warning: no files found matching 'pip/cacert.pem' 18:56:44 INFO - warning: no files found matching '*.html' under directory 'docs' 18:56:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:56:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:56:44 INFO - Installing collected packages: pip 18:56:44 INFO - Found existing installation: pip 1.1 18:56:44 INFO - Uninstalling pip: 18:56:44 INFO - Successfully uninstalled pip 18:56:44 INFO - Running setup.py install for pip 18:56:44 INFO - warning: no files found matching 'pip/cacert.pem' 18:56:44 INFO - warning: no files found matching '*.html' under directory 'docs' 18:56:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:56:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:56:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:56:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:56:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:56:44 INFO - Successfully installed pip 18:56:44 INFO - Cleaning up... 18:56:44 INFO - Return code: 0 18:56:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:56:44 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')]} 18:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:44 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')]} 18:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:44 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:44 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 18:56:44 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 18:56:44 INFO - Using env: {'DISPLAY': ':0', 18:56:44 INFO - 'HOME': '/home/cltbld', 18:56:44 INFO - 'LANG': 'en_US.UTF-8', 18:56:44 INFO - 'LANGUAGE': 'en_US:en', 18:56:44 INFO - 'LOGNAME': 'cltbld', 18:56:44 INFO - 'MAIL': '/var/mail/cltbld', 18:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:44 INFO - 'MOZ_NO_REMOTE': '1', 18:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:44 INFO - 'NO_EM_RESTART': '1', 18:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:44 INFO - 'PWD': '/builds/slave/test', 18:56:44 INFO - 'SHELL': '/bin/bash', 18:56:44 INFO - 'SHLVL': '1', 18:56:44 INFO - 'TERM': 'linux', 18:56:44 INFO - 'TMOUT': '86400', 18:56:44 INFO - 'USER': 'cltbld', 18:56:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:44 INFO - '_': '/tools/buildbot/bin/python'} 18:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:44 INFO - Downloading/unpacking psutil>=3.1.1 18:56:44 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 18:56:44 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 18:56:44 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 18:56:44 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 18:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:56:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:45 INFO - Installing collected packages: psutil 18:56:45 INFO - Running setup.py install for psutil 18:56:45 INFO - building 'psutil._psutil_linux' extension 18:56:45 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 18:56:45 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 18:56:45 INFO - building 'psutil._psutil_posix' extension 18:56:45 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 18:56:46 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 18:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:56:46 INFO - Successfully installed psutil 18:56:46 INFO - Cleaning up... 18:56:46 INFO - Return code: 0 18:56:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:56:46 INFO - Using env: {'DISPLAY': ':0', 18:56:46 INFO - 'HOME': '/home/cltbld', 18:56:46 INFO - 'LANG': 'en_US.UTF-8', 18:56:46 INFO - 'LANGUAGE': 'en_US:en', 18:56:46 INFO - 'LOGNAME': 'cltbld', 18:56:46 INFO - 'MAIL': '/var/mail/cltbld', 18:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:46 INFO - 'MOZ_NO_REMOTE': '1', 18:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:46 INFO - 'NO_EM_RESTART': '1', 18:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:46 INFO - 'PWD': '/builds/slave/test', 18:56:46 INFO - 'SHELL': '/bin/bash', 18:56:46 INFO - 'SHLVL': '1', 18:56:46 INFO - 'TERM': 'linux', 18:56:46 INFO - 'TMOUT': '86400', 18:56:46 INFO - 'USER': 'cltbld', 18:56:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:46 INFO - '_': '/tools/buildbot/bin/python'} 18:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:56:47 INFO - Installing collected packages: mozsystemmonitor 18:56:47 INFO - Running setup.py install for mozsystemmonitor 18:56:47 INFO - Successfully installed mozsystemmonitor 18:56:47 INFO - Cleaning up... 18:56:47 INFO - Return code: 0 18:56:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:56:47 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')]} 18:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:47 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')]} 18:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:47 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:47 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 18:56:47 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 18:56:47 INFO - Using env: {'DISPLAY': ':0', 18:56:47 INFO - 'HOME': '/home/cltbld', 18:56:47 INFO - 'LANG': 'en_US.UTF-8', 18:56:47 INFO - 'LANGUAGE': 'en_US:en', 18:56:47 INFO - 'LOGNAME': 'cltbld', 18:56:47 INFO - 'MAIL': '/var/mail/cltbld', 18:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:47 INFO - 'MOZ_NO_REMOTE': '1', 18:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:47 INFO - 'NO_EM_RESTART': '1', 18:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:47 INFO - 'PWD': '/builds/slave/test', 18:56:47 INFO - 'SHELL': '/bin/bash', 18:56:47 INFO - 'SHLVL': '1', 18:56:47 INFO - 'TERM': 'linux', 18:56:47 INFO - 'TMOUT': '86400', 18:56:47 INFO - 'USER': 'cltbld', 18:56:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:47 INFO - '_': '/tools/buildbot/bin/python'} 18:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:47 INFO - Downloading/unpacking jsonschema==2.5.1 18:56:47 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 18:56:47 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 18:56:47 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 18:56:47 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 18:56:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:56:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:56:49 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 18:56:49 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 18:56:49 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 18:56:49 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 18:56:49 INFO - Downloading functools32-3.2.3-2.tar.gz 18:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:56:49 INFO - warning: no files found matching '*.txt' 18:56:49 INFO - no previously-included directories found matching 'build' 18:56:49 INFO - no previously-included directories found matching 'dist' 18:56:49 INFO - no previously-included directories found matching '.git*' 18:56:49 INFO - Installing collected packages: jsonschema, functools32 18:56:49 INFO - Running setup.py install for functools32 18:56:49 INFO - warning: no files found matching '*.txt' 18:56:49 INFO - no previously-included directories found matching 'build' 18:56:49 INFO - no previously-included directories found matching 'dist' 18:56:49 INFO - no previously-included directories found matching '.git*' 18:56:49 INFO - Successfully installed jsonschema functools32 18:56:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:56:49 INFO - Using env: {'DISPLAY': ':0', 18:56:49 INFO - 'HOME': '/home/cltbld', 18:56:49 INFO - 'LANG': 'en_US.UTF-8', 18:56:49 INFO - 'LANGUAGE': 'en_US:en', 18:56:49 INFO - 'LOGNAME': 'cltbld', 18:56:49 INFO - 'MAIL': '/var/mail/cltbld', 18:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:49 INFO - 'MOZ_NO_REMOTE': '1', 18:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:49 INFO - 'NO_EM_RESTART': '1', 18:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:49 INFO - 'PWD': '/builds/slave/test', 18:56:49 INFO - 'SHELL': '/bin/bash', 18:56:49 INFO - 'SHLVL': '1', 18:56:49 INFO - 'TERM': 'linux', 18:56:49 INFO - 'TMOUT': '86400', 18:56:49 INFO - 'USER': 'cltbld', 18:56:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:49 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:56:49 INFO - Cleaning up... 18:56:49 INFO - Return code: 0 18:56:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:56:49 INFO - Using env: {'DISPLAY': ':0', 18:56:49 INFO - 'HOME': '/home/cltbld', 18:56:49 INFO - 'LANG': 'en_US.UTF-8', 18:56:49 INFO - 'LANGUAGE': 'en_US:en', 18:56:49 INFO - 'LOGNAME': 'cltbld', 18:56:49 INFO - 'MAIL': '/var/mail/cltbld', 18:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:49 INFO - 'MOZ_NO_REMOTE': '1', 18:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:49 INFO - 'NO_EM_RESTART': '1', 18:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:49 INFO - 'PWD': '/builds/slave/test', 18:56:49 INFO - 'SHELL': '/bin/bash', 18:56:49 INFO - 'SHLVL': '1', 18:56:49 INFO - 'TERM': 'linux', 18:56:49 INFO - 'TMOUT': '86400', 18:56:49 INFO - 'USER': 'cltbld', 18:56:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:49 INFO - '_': '/tools/buildbot/bin/python'} 18:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:56:49 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 18:56:49 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 18:56:49 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 18:56:49 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 18:56:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:56:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:56:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:51 INFO - Downloading docopt-0.6.1.tar.gz 18:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:56:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:56:51 INFO - Running setup.py install for blobuploader 18:56:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:56:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:56:51 INFO - Running setup.py install for requests 18:56:52 INFO - Running setup.py install for docopt 18:56:52 INFO - Successfully installed blobuploader requests docopt 18:56:52 INFO - Cleaning up... 18:56:52 INFO - Return code: 0 18:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:52 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')]} 18:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:52 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')]} 18:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:52 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:52 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 18:56:52 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 18:56:52 INFO - Using env: {'DISPLAY': ':0', 18:56:52 INFO - 'HOME': '/home/cltbld', 18:56:52 INFO - 'LANG': 'en_US.UTF-8', 18:56:52 INFO - 'LANGUAGE': 'en_US:en', 18:56:52 INFO - 'LOGNAME': 'cltbld', 18:56:52 INFO - 'MAIL': '/var/mail/cltbld', 18:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:52 INFO - 'MOZ_NO_REMOTE': '1', 18:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:52 INFO - 'NO_EM_RESTART': '1', 18:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:52 INFO - 'PWD': '/builds/slave/test', 18:56:52 INFO - 'SHELL': '/bin/bash', 18:56:52 INFO - 'SHLVL': '1', 18:56:52 INFO - 'TERM': 'linux', 18:56:52 INFO - 'TMOUT': '86400', 18:56:52 INFO - 'USER': 'cltbld', 18:56:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:52 INFO - '_': '/tools/buildbot/bin/python'} 18:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:52 INFO - Running setup.py (path:/tmp/pip-_lEU_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:52 INFO - Running setup.py (path:/tmp/pip-e_sZtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:52 INFO - Running setup.py (path:/tmp/pip-CwgzB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:52 INFO - Running setup.py (path:/tmp/pip-qzOrv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:52 INFO - Running setup.py (path:/tmp/pip-H7H6CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:52 INFO - Running setup.py (path:/tmp/pip-myO9yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:52 INFO - Running setup.py (path:/tmp/pip-CWCHuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:52 INFO - Running setup.py (path:/tmp/pip-YttSya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:52 INFO - Running setup.py (path:/tmp/pip-MpjA_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:53 INFO - Running setup.py (path:/tmp/pip-QBo6cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:53 INFO - Running setup.py (path:/tmp/pip-i61bF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:53 INFO - Running setup.py (path:/tmp/pip-Cjm4oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:53 INFO - Running setup.py (path:/tmp/pip-4zBE3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:53 INFO - Running setup.py (path:/tmp/pip-50XDhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:53 INFO - Running setup.py (path:/tmp/pip-Ni46tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:53 INFO - Running setup.py (path:/tmp/pip-_qzFBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:53 INFO - Running setup.py (path:/tmp/pip-vJpJ2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:56:53 INFO - Running setup.py install for manifestparser 18:56:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:56:53 INFO - Running setup.py install for mozcrash 18:56:53 INFO - Running setup.py install for mozdebug 18:56:53 INFO - Running setup.py install for mozdevice 18:56:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozfile 18:56:54 INFO - Running setup.py install for mozhttpd 18:56:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozinfo 18:56:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozInstall 18:56:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozleak 18:56:54 INFO - Running setup.py install for mozlog 18:56:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for moznetwork 18:56:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozprocess 18:56:54 INFO - Running setup.py install for mozprofile 18:56:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:56:54 INFO - Running setup.py install for mozrunner 18:56:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:56:55 INFO - Running setup.py install for mozscreenshot 18:56:55 INFO - Running setup.py install for moztest 18:56:55 INFO - Running setup.py install for mozversion 18:56:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:56:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:56:55 INFO - Cleaning up... 18:56:55 INFO - Return code: 0 18:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:55 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')]} 18:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:55 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')]} 18:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:55 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:55 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 18:56:55 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 18:56:55 INFO - Using env: {'DISPLAY': ':0', 18:56:55 INFO - 'HOME': '/home/cltbld', 18:56:55 INFO - 'LANG': 'en_US.UTF-8', 18:56:55 INFO - 'LANGUAGE': 'en_US:en', 18:56:55 INFO - 'LOGNAME': 'cltbld', 18:56:55 INFO - 'MAIL': '/var/mail/cltbld', 18:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:55 INFO - 'MOZ_NO_REMOTE': '1', 18:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:55 INFO - 'NO_EM_RESTART': '1', 18:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:55 INFO - 'PWD': '/builds/slave/test', 18:56:55 INFO - 'SHELL': '/bin/bash', 18:56:55 INFO - 'SHLVL': '1', 18:56:55 INFO - 'TERM': 'linux', 18:56:55 INFO - 'TMOUT': '86400', 18:56:55 INFO - 'USER': 'cltbld', 18:56:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:55 INFO - '_': '/tools/buildbot/bin/python'} 18:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:56:55 INFO - Running setup.py (path:/tmp/pip-Pt_ynI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:56:55 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)) 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:56:55 INFO - Running setup.py (path:/tmp/pip-R875r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:56:55 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)) 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:56:55 INFO - Running setup.py (path:/tmp/pip-s1ERnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:56:55 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)) 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:56:55 INFO - Running setup.py (path:/tmp/pip-kGO77q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:56:55 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)) 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:56:55 INFO - Running setup.py (path:/tmp/pip-CoV5Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:56:55 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)) 18:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:56:55 INFO - Running setup.py (path:/tmp/pip-ycVDH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:56:56 INFO - Running setup.py (path:/tmp/pip-56urr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:56:56 INFO - Running setup.py (path:/tmp/pip-8Mwl4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:56:56 INFO - Running setup.py (path:/tmp/pip-moWHyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:56:56 INFO - Running setup.py (path:/tmp/pip-VmeXvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:56:56 INFO - Running setup.py (path:/tmp/pip-v3hMjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:56:56 INFO - Running setup.py (path:/tmp/pip-rDnuK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:56:56 INFO - Running setup.py (path:/tmp/pip-bEqTQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:56:56 INFO - Running setup.py (path:/tmp/pip-Jx_fL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:56 INFO - Running setup.py (path:/tmp/pip-BSTGeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:56:56 INFO - Running setup.py (path:/tmp/pip-Oge40N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:56:56 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)) 18:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:56:56 INFO - Running setup.py (path:/tmp/pip-vgDPeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:56:56 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)) 18:56:56 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)) 18:56:56 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)) 18:56:56 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)) 18:56:56 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)) 18:56:56 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)) 18:56:56 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)) 18:56:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:56:56 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 18:56:56 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 18:56:56 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 18:56:56 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 18:56:57 INFO - Downloading blessings-1.6.tar.gz 18:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:56:58 INFO - Installing collected packages: blessings 18:56:58 INFO - Running setup.py install for blessings 18:56:58 INFO - Successfully installed blessings 18:56:58 INFO - Cleaning up... 18:56:58 INFO - Return code: 0 18:56:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:56:58 INFO - Reading from file tmpfile_stdout 18:56:58 INFO - Current package versions: 18:56:58 INFO - argparse == 1.2.1 18:56:58 INFO - blessings == 1.6 18:56:58 INFO - blobuploader == 1.2.4 18:56:58 INFO - docopt == 0.6.1 18:56:58 INFO - functools32 == 3.2.3-2 18:56:58 INFO - jsonschema == 2.5.1 18:56:58 INFO - manifestparser == 1.1 18:56:58 INFO - mozInstall == 1.13 18:56:58 INFO - mozcrash == 1.0 18:56:58 INFO - mozdebug == 0.1 18:56:58 INFO - mozdevice == 0.51 18:56:58 INFO - mozfile == 1.2 18:56:58 INFO - mozhttpd == 0.7 18:56:58 INFO - mozinfo == 0.10 18:56:58 INFO - mozleak == 0.1 18:56:58 INFO - mozlog == 3.5 18:56:58 INFO - moznetwork == 0.27 18:56:58 INFO - mozprocess == 0.25 18:56:58 INFO - mozprofile == 0.28 18:56:58 INFO - mozrunner == 6.13 18:56:58 INFO - mozscreenshot == 0.1 18:56:58 INFO - mozsystemmonitor == 0.3 18:56:58 INFO - moztest == 0.8 18:56:58 INFO - mozversion == 1.4 18:56:58 INFO - psutil == 3.1.1 18:56:58 INFO - requests == 1.2.3 18:56:58 INFO - wsgiref == 0.1.2 18:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:56:58 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')]} 18:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:56:58 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')]} 18:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:56:58 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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:56:58 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 18:56:58 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 18:56:58 INFO - Using env: {'DISPLAY': ':0', 18:56:58 INFO - 'HOME': '/home/cltbld', 18:56:58 INFO - 'LANG': 'en_US.UTF-8', 18:56:58 INFO - 'LANGUAGE': 'en_US:en', 18:56:58 INFO - 'LOGNAME': 'cltbld', 18:56:58 INFO - 'MAIL': '/var/mail/cltbld', 18:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:56:58 INFO - 'MOZ_NO_REMOTE': '1', 18:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:56:58 INFO - 'NO_EM_RESTART': '1', 18:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:56:58 INFO - 'PWD': '/builds/slave/test', 18:56:58 INFO - 'SHELL': '/bin/bash', 18:56:58 INFO - 'SHLVL': '1', 18:56:58 INFO - 'TERM': 'linux', 18:56:58 INFO - 'TMOUT': '86400', 18:56:58 INFO - 'USER': 'cltbld', 18:56:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:56:58 INFO - '_': '/tools/buildbot/bin/python'} 18:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 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)) 18:56:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:56:59 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)) 18:56:59 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)) 18:56:59 INFO - Installing collected packages: simplejson 18:56:59 INFO - Running setup.py install for simplejson 18:56:59 INFO - building 'simplejson._speedups' extension 18:56:59 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 18:57:00 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 18:57:00 INFO - Successfully installed simplejson 18:57:00 INFO - Cleaning up... 18:57:00 INFO - Return code: 0 18:57:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x25611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, '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': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', '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 18:57:00 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 18:57:00 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 18:57:00 INFO - Using env: {'DISPLAY': ':0', 18:57:00 INFO - 'HOME': '/home/cltbld', 18:57:00 INFO - 'LANG': 'en_US.UTF-8', 18:57:00 INFO - 'LANGUAGE': 'en_US:en', 18:57:00 INFO - 'LOGNAME': 'cltbld', 18:57:00 INFO - 'MAIL': '/var/mail/cltbld', 18:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:00 INFO - 'MOZ_NO_REMOTE': '1', 18:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:00 INFO - 'NO_EM_RESTART': '1', 18:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:00 INFO - 'PWD': '/builds/slave/test', 18:57:00 INFO - 'SHELL': '/bin/bash', 18:57:00 INFO - 'SHLVL': '1', 18:57:00 INFO - 'TERM': 'linux', 18:57:00 INFO - 'TMOUT': '86400', 18:57:00 INFO - 'USER': 'cltbld', 18:57:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:00 INFO - '_': '/tools/buildbot/bin/python'} 18:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:57:01 INFO - Cleaning up... 18:57:01 INFO - Return code: 0 18:57:01 INFO - Running post-action listener: _resource_record_post_action 18:57:01 INFO - Running post-action listener: _start_resource_monitoring 18:57:01 INFO - Starting resource monitoring. 18:57:01 INFO - [mozharness: 2017-10-05 01:57:01.125118Z] Finished create-virtualenv step (success) 18:57:01 INFO - [mozharness: 2017-10-05 01:57:01.125579Z] Running install step. 18:57:01 INFO - Running pre-action listener: _resource_record_pre_action 18:57:01 INFO - Running main action method: install 18:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:01 INFO - Reading from file tmpfile_stdout 18:57:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:01 INFO - Reading from file tmpfile_stdout 18:57:01 INFO - Output received: 18:57:01 INFO - Usage: mozinstall [options] installer 18:57:01 INFO - Options: 18:57:01 INFO - -h, --help show this help message and exit 18:57:01 INFO - -d DEST, --destination=DEST 18:57:01 INFO - Directory to install application into. [default: 18:57:01 INFO - "/builds/slave/test"] 18:57:01 INFO - --app=APP Application being installed. [default: firefox] 18:57:01 INFO - mkdir: /builds/slave/test/build/application 18:57:01 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'] 18:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:57:16 INFO - Reading from file tmpfile_stdout 18:57:16 INFO - Output received: 18:57:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:57:16 INFO - Running post-action listener: _resource_record_post_action 18:57:16 INFO - [mozharness: 2017-10-05 01:57:16.217122Z] Finished install step (success) 18:57:16 INFO - [mozharness: 2017-10-05 01:57:16.217458Z] Running setup-mitmproxy step. 18:57:16 INFO - Running pre-action listener: _resource_record_pre_action 18:57:16 INFO - Running main action method: setup_mitmproxy 18:57:16 INFO - Skipping: mitmproxy is not required 18:57:16 INFO - Running post-action listener: _resource_record_post_action 18:57:16 INFO - [mozharness: 2017-10-05 01:57:16.219180Z] Finished setup-mitmproxy step (success) 18:57:16 INFO - [mozharness: 2017-10-05 01:57:16.219493Z] Running run-tests step. 18:57:16 INFO - Running pre-action listener: _resource_record_pre_action 18:57:16 INFO - Running pre-action listener: _set_gcov_prefix 18:57:16 INFO - Running main action method: run_tests 18:57:16 WARNING - Try message not found. 18:57:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:57:16 INFO - Python 2.7.3 18:57:16 INFO - Return code: 0 18:57:16 INFO - grabbing minidump binary from tooltool 18:57:16 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')]} 18:57:16 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 0x28d0090>, '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 0x28d0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28caf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:57:16 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 18:57:16 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 18:57:16 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 18:57:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:57:16 INFO - Return code: 0 18:57:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:57:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:57:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:57:16 INFO - ENV: RUST_BACKTRACE is now full 18:57:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:57:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:57:16 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/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 18:57:16 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/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 18:57:16 INFO - Using env: {'DISPLAY': ':0', 18:57:16 INFO - 'HOME': '/home/cltbld', 18:57:16 INFO - 'LANG': 'en_US.UTF-8', 18:57:16 INFO - 'LANGUAGE': 'en_US:en', 18:57:16 INFO - 'LOGNAME': 'cltbld', 18:57:16 INFO - 'MAIL': '/var/mail/cltbld', 18:57:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:16 INFO - 'MOZ_NO_REMOTE': '1', 18:57:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:16 INFO - 'NO_EM_RESTART': '1', 18:57:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:16 INFO - 'PWD': '/builds/slave/test', 18:57:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:16 INFO - 'RUST_BACKTRACE': 'full', 18:57:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:57:16 INFO - 'SHELL': '/bin/bash', 18:57:16 INFO - 'SHLVL': '1', 18:57:16 INFO - 'TERM': 'linux', 18:57:16 INFO - 'TMOUT': '86400', 18:57:16 INFO - 'USER': 'cltbld', 18:57:16 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:16 INFO - '_': '/tools/buildbot/bin/python'} 18:57:16 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/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 18:57:16 INFO - mozversion application_buildid: 20171005002616 18:57:16 INFO - mozversion application_changeset: 8c7645234f86018b46dab62fdcc39955f229c74a 18:57:16 INFO - mozversion application_display_name: Firefox 18:57:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:57:16 INFO - mozversion application_name: Firefox 18:57:16 INFO - mozversion application_remotingname: firefox 18:57:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:57:16 INFO - mozversion application_vendor: Mozilla 18:57:16 INFO - mozversion application_version: 57.0 18:57:16 INFO - mozversion platform_buildid: 20171005002616 18:57:16 INFO - mozversion platform_changeset: 8c7645234f86018b46dab62fdcc39955f229c74a 18:57:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:57:16 INFO - mozversion platform_version: 57.0 18:57:16 INFO - using testdate: 1507168636 18:57:16 INFO - actual date: 1507168636 18:57:16 INFO - starting webserver on 'localhost:45386' 18:57:16 INFO - SUITE-START | Running 2 tests 18:57:16 INFO - TEST-START | dromaeo_css 18:57:16 INFO - Initialising browser for dromaeo_css test... 18:57:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45386/getInfo.html -profile /tmp/tmp2HkbAk/profile 18:57:16 INFO - TEST-INFO | started process 14885 (/builds/slave/test/build/application/firefox/firefox http://localhost:45386/getInfo.html) 18:57:22 INFO - TEST-INFO | 14885: exit 0 18:57:22 INFO - Browser initialized. 18:57:22 INFO - Running cycle 1/1 for dromaeo_css test... 18:57:22 INFO - Using env: {'DISPLAY': ':0', 18:57:22 INFO - 'HOME': '/home/cltbld', 18:57:22 INFO - 'JSGC_DISABLE_POISONING': '1', 18:57:22 INFO - 'LANG': 'en_US.UTF-8', 18:57:22 INFO - 'LANGUAGE': 'en_US:en', 18:57:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:57:22 INFO - 'LOGNAME': 'cltbld', 18:57:22 INFO - 'MAIL': '/var/mail/cltbld', 18:57:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:22 INFO - 'MOZ_CRASHREPORTER': '1', 18:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:57:22 INFO - 'MOZ_NO_REMOTE': '1', 18:57:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:22 INFO - 'NO_EM_RESTART': '1', 18:57:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:22 INFO - 'PWD': '/builds/slave/test', 18:57:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:22 INFO - 'RUST_BACKTRACE': 'full', 18:57:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:57:22 INFO - 'SHELL': '/bin/bash', 18:57:22 INFO - 'SHLVL': '1', 18:57:22 INFO - 'TERM': 'linux', 18:57:22 INFO - 'TMOUT': '86400', 18:57:22 INFO - 'USER': 'cltbld', 18:57:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 18:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:22 INFO - '_': '/tools/buildbot/bin/python'} 18:57:22 INFO - TEST-INFO | started process 15120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2HkbAk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:23 INFO - PID 15120 | 18:57:23 INFO - PID 15120 | (/builds/slave/test/build/application/firefox/firefox:15169): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:57:23 INFO - PID 15120 | 18:57:33 INFO - PID 15120 | RSS: Main: 138543104 18:57:33 INFO - PID 15120 | 19:00:30 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45386/tests/dromaeo/cssquery-ext.html) 19:00:31 INFO - PID 15120 | RSS: Main: 145240064 19:00:31 INFO - PID 15120 | 19:03:33 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-ext.html (next: http://localhost:45386/tests/dromaeo/cssquery-jquery.html) 19:03:34 INFO - PID 15120 | RSS: Main: 143900672 19:03:34 INFO - PID 15120 | 19:06:35 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45386/tests/dromaeo/cssquery-mootools.html) 19:06:36 INFO - PID 15120 | RSS: Main: 143556608 19:06:36 INFO - PID 15120 | 19:09:37 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45386/tests/dromaeo/cssquery-prototype.html) 19:09:38 INFO - PID 15120 | RSS: Main: 145453056 19:09:38 INFO - PID 15120 | 19:12:41 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45386/tests/dromaeo/cssquery-yui.html) 19:12:41 INFO - PID 15120 | RSS: Main: 146485248 19:12:41 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | Cycle 1(1): loaded http://localhost:45386/tests/dromaeo/cssquery-yui.html (next: http://localhost:45386/tests/dromaeo/cssquery-dojo.html) 19:15:43 INFO - PID 15120 | RSS: Main: 148631552 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | __start_tp_report 19:15:43 INFO - PID 15120 | _x_x_mozilla_page_load 19:15:43 INFO - PID 15120 | _x_x_mozilla_page_load_details 19:15:43 INFO - PID 15120 | |i|pagename|runs| 19:15:43 INFO - PID 15120 | |0;dojo.html;3933.3706606942897;3983.820728067237;4004.5594984551703;4007.859724909628;4011.1777085697436;6444.452221561167;6454.806355809322;6464.547481676284;6491.058796474508;6519.054737063123;6473.158489396372;6480.675966201695;6528.41244288014;6551.672416379174;6552.344765523445;5795.449432303924;5819.912701309484;5915.349311575723;5965.522758179357;5980.073088671263;5853.61951473155;5863.79476718315;5871.882562348772;5966.343702192756;5969.313528944162;5829.533637309027;5854.5023672987845;5874.88250234995;5924.0521516557355;5946.583739138262;5817.301923769175;5949.286085669725;5956.22569066023;5979.133025711248;6006.069059295816;5778.971105144447;5830.067189249699;5883.970580147072;5954.583179177459;5979.43195396441;6386.457151142158;6400.39196276353;6405.103285540028;6428.357164283581;6439.710213040425;6981.930180698178;7044.401225895805;7053.435725142028;7058.047163632895;7083.610401427919;6897.586144831276;6952.374286314205;7011.544249623758;7066.434685225169;7107.964460177666;6470.158879345702;6492.350764923517;6496.577722448026;6498.5126115542;6510.479161667103;7155.069840920647;7180.138383394026;7238.638068096574;7240.167380751281;7276.381507571809;6932.861342773116;6938.930610693929;7003.264657211022;7021.403180729593;7050.365467107985;6888.448924086061;7076.221615622278;7080;7168.211496735355;7170.78487645361;6953.304669533108;6959.408450281681;6997.965010174917;7010.439164866799;7026.543274687129;6926.480513961473;6962.443004559623;7013.684384202723;7025.859482810315;7029.121359830021;5228.2941802856885;5244.213367994831;5302.522772950453;5305.283786688748;5316.76074576645;4777.641676874248;4792.2332426811545;4803.303520989507;4814.277858321209;4871.318015477765;6590.505712071614;6614.768483103165;6618.7352505899225;6628.502862285348;6641.402273795382;6974.128233970754;6995.8950615740805;6996.090508233897;7089.468289878279;7094.042304288855;6556.409923106943;6560.639164845979;6594.208694956636;6614.437772789271;6622.139121914121;5869.413058694182;5947.6431414115295;5949.405059494016;5954.642721436641;5956.493698035629;7299.5255308404785;7300.890486642705;7394.55632662042;7398.371138453184;7398.926010739824;6934.16789985205;6945.131858517685;7067.187273463617;7070.929290707233;7092.184398793998;7345.963270183829;7349.963250183715;7403.777886663409;7452.888206676796;7453.888191677238;6850.8972365413565;6920.273371295942;6982.1272340957385;7017.438604911493;7035.085438892911;6927.480438967198;7011;7030.824229394306;7046.189688185924;7092.9645351772915;6817.897731533932;6902.447804175554;6909.2745261746795;6911.101556797584;6915.204751453647;6792.456603471809;6795.354441328066;6804.863902721819;6887.449004079762;6894.172699276119;6569.277379488157;6681.164854393201;6699.5310328276555;6707.899381509379;6774.966125169342;6812.965935170292;6853.851263595142;6854.280300568368;6888.311168883272;6903.827404314932;6670.566413183127;6679.4990375721045;6744.460443164633;6758.5269031167345;6769.052332673528 19:15:43 INFO - PID 15120 | |1;ext.html;938.1603464898919;964.768455570663;993.1210878372638;994.622043623423;995.3480470291956;44317.55682443175;45184.322235166495;45283.54716452835;45314.54685453144;45329.99999999992;41364.79317603408;44547;45220.32169517452;45390.773046134804;45412.54587454125;8646.61090250937;8807.339449541278;8809.823803523926;8823.205911467967;8824.470531768115;8680.913190868105;8831.823363532758;8834.160754728291;8839.337049721264;8842.425242359259;8817.42686725364;8831.64673413066;8872.157145071207;8876.511791851446;8907.510086945216;8804.339674524404;8832.911670883306;8834.514101724402;8841.69054083104;8858.512781796999;8672.826543469095;8679.088695686989;8691.130886911258;8740.344474164463;8744.781380465476;41064;41163.38254926178;41220;41391;41420.37869431961;3756.530433695788;3795.9810200949096;3821.5987321331136;3824.560175579816;3837.865674701372;34009.829950850086;34180.658193418;34290.65709342925;34310.313793724235;34397.6560234397;5604.467575580314;5607.803726869581;5616.1014237721765;5626.465485778845;5627.071533197018;233899;236823;249733;250503;254857.7257113721;53304.46695532995;53660.19509707358;53692;53738.46261537335;53767.19349209765;55231.44768552263;55246.723766380914;55282;55355.16967245495;55442.44557554454;18417.26330946747;18498.537536561693;18565.535861603566;18575.34986275501;18734.1569629367;15616.141112238709;15635.296411661502;15639.68720625604;15659.686806264039;15671.451499197701;13597.252151131584;13597.592072237849;13748.243846588533;13759.312034398441;13920.860791392159;5456.399796022434;5474.890502190014;5635.718214089279;5637.295338082739;5690.5163061140265;1094.414488248783;1097.05653138301;1098.9230753847314;1099.1646348774989;1104.7569534702352;25017.249482515555;25077.87461062683;25166.496670066495;25404.872975635004;25428.872855635604;1204.235310577772;1214.987850121505;1216.5086202598422;1219.7987332090106;1233.0382301804607;13365.866341336656;13383.665408364868;13394.995210727899;13396;13547.254900980344;306338;308264;308271;310427;315657;61933.38066619366;61968.690156549834;62202;62284.68857655773;62292.37707622956;1445.8192725909262;1487.516557118919;1492.5000124958044;1498.8126484189477;1500.422337400087;29316.41367172602;29579;29772.702272976992;29936.101916942527;30047.3990520184;40299.1940161201;40556.79721601373;40586.18827623372;40661.39007914943;40781.38827917524;235446;236006;236869;236912;238274;34513.13717157091;35634.46548301829;35753.64246357607;35920.28159436849;36050.819745901106;45158.54841451543;46444.53555464402;46511.76744116258;46606.30090548712;46700.7664961673;34597.48103778395;34932.82533587316;35235.64764352324;35554.28891422209;35942.8202858984;34568.82715586406;34592.308153837286;34825.303493930485;35055.29889402249;35161.824190878884;39901.80049099736;40106.799466002485;40396.1920761589;40485.98785030398;40559.17483713299;32720.672793271762;33065.50401743928;33595.664043359255;33607;33736.83131584425;24970.750292496843;25052.62421063649;25155.371115721522;25208.621870672323;25722.742772572034 19:15:43 INFO - PID 15120 | |2;jquery.html;638.438251959947;639.7024458638417;643.297437075636;648.47072272949;650.8946085715986;23797.28608141754;24391.268261952126;24533.75466245337;24586.262412127642;24601.876990615045;26018;26180;26474.867625661846;26485.07302244422;26623.733762662418;6531.934680653204;6744.5616034957575;6814.557053791487;6828.931710682904;6896.75861344853;6854.520183587151;6956;6962.477814163933;6964.233934267227;6972.023916651673;6640.1035860158745;6895.965520172417;6947.201071876749;6951.2701166377565;6953.756618518353;6781.118454600895;6799.456043516507;6804.829879253009;6833.589984600915;6833.931660683379;6398.200224971879;6404.263509696398;6412.358764123597;6414.839629009265;6418.582792118544;29229.26926826825;29248.41503169946;30032;30063.248418789488;30071.548926766118;2385.7137143542714;2427.8664673442954;2430.270918724393;2432.1001229545004;2432.671589335435;20296.594068118557;20696.79303206979;20800;20808.16767329305;20865.68701469479;2569.755873192044;2586.7154612992554;2627.78977681785;2628.132716203648;2643.722409147031;137337;144205;166412;173387.99999999875;173818;16253.268602912898;16462.835371646368;16569.42007029772;16905.80224570798;17011.744823827652;26998.32504187411;27102;27147.321316966838;27150.185494435198;27245.727542724715;11353.886461135447;11378.715532111764;11472;11493.712657183638;11641.126915481203;10277.486125693686;10369.63706270277;10428.165746740242;10490.499865493657;10552.261341706007;9857.950710246547;10115.544800483996;10275.7431064224;10366.118879895294;10457.215708821868;2948.7935844491108;2971.3109635779656;2994.4609970205574;3009.277773334384;3131.874725010974;1054.7099547624312;1063.7606538528769;1070.5931745936493;1080.4111759091313;1083.2092572422175;20813.479663008242;21159.15363385478;21179.470513236985;21586.89206553957;21996.670049949265;1138.8681126901022;1152.5159433038143;1160.7910576096383;1162.0935670177275;1171.824226366052;11289.379084150287;11546.59586914454;11549.307041577364;11597.826032609517;11692;660305;668752;676314;683457;690528;138598;140896;142215.28892355473;142354.2882285582;145519;1181.5569161564413;1234.5555599983998;1284.9743005139844;1293.534327642048;1349.291621898511;21429.571408571428;21965.67051494197;22190.778092218872;22246.332610021724;22297.287168391646;65367.67316163389;65858;66139;67416.325836741;68600;80250.19749802427;80600;81024.59487702524;81028.59485702534;85174;15767.659748921471;15961.68076638484;15993.760093598838;16007.199640018185;16085.597860053593;24204.757952420252;24211.51576968486;24390.634140488262;24496.6325505114;24592.631110533;19846.702299465232;20013.6997945028;20066;20217.191312347342;20299.898500507403;17127.743083854002;17887.195076221342;18097.18562664657;18261.086945652398;18376.724349134507;20145.597088057864;20332.59334813325;20412;20561.38315850527;20840.58318833645;15541.689166216838;15858.92070539686;15911.124888131264;15927.522174334788;15929.522114336589;19447.3193438229;19573.902130489256;19649.60700786005;19761.40715778529;19799.703004454655 19:15:43 INFO - PID 15120 | |3;mootools.html;1401.551503518874;1448.246911605965;1458.1688437590565;1465.9047161934473;1471.57324375931;14809.703805923875;15424.537263882088;17888.19503122358;18213.726794098067;18279.268829246816;17250.137493125356;17506.212220450077;17509.212085456154;17524.21141048653;17553.210105545248;2988.566657834618;3026.379592183608;3060.9846950765213;3150.7951983121025;3150.8897188598403;3153.4166179256913;3157.6368717597543;3184.283536204347;3185.5540224368606;3211.486162214046;3094.4894092474715;3132.9530057049164;3163.9367212655734;3165.145410739099;3165.208697825544;3013.5630333601616;3036.7722420818527;3038.787284890059;3067.708567686066;3071.3703690743346;3017.1401150671954;3029.3941211757738;3042.6957304269395;3047.7866549341556;3057.6942305769244;16888.746668799977;17042.318307267695;17045.23296451663;17084.658306833917;17160.742588861176;9114.58984345706;9399.577019034092;9422.199113075398;9485.193758530533;9495.715128546155;5650.152477128422;5774.595778295521;5790.739416726257;5863.912041319383;5883.38224486427;2004.6391649503084;2012.87922724637;2031.0651109147288;2052.4560991337307;2074.63074370916;31319.37361252785;31853.203669908205;31883.521747173578;31972;32012;7452.292032256927;7681.577513236825;7718.343940764986;7854.057513098464;7906.920930790733;20552.38342849717;20553.280635177696;20581.58836823255;20639.277625283343;20658.276960306317;7930.167332430127;8891.866622000674;9225.169734723908;9246.90753092474;9249.16757491829;6912.688928998207;7516.736914208086;8435.95782021086;8535.359848011423;8538.359623028298;6176.7838125665385;6208.161898143783;6216.44052035319;6256.718447669866;6333.524985626096;1773.7782777152856;1797.9640407192044;1802.0088951076855;1826.3516451659734;1848.8151184881403;994.8955359687274;1018.8420794776821;1021.7598864266891;1021.9233557483218;1042.0100904141095;8855.822883542422;8907.51008694528;8976.326775491863;9077.863832042525;9109.99790023097;827.1728271728272;841.4362377207286;847.4913856633542;853.3983541603155;855.1790281329869;5705.372409035002;6285.308616052231;6521.608703477807;6545.214574251025;6561.671916404161;25854;26245.606315905276;26425.207243782334;26484.47031059368;26739.197824065308;25287.11495097663;25947.351316216867;25970.480590388088;26039.609405858926;26302.868485657833;12778.169418987922;12782.105252632227;12857.678558036125;12861.614151575468;12928.741425171444;10154.136898363722;10306.742331441774;10353.84469232947;10412.68761937143;10458.95410458948;22105.557888842453;22319.77680223242;22404.663930040737;22490.775092248867;22755;23181.768182318636;23343.88328058349;23388.18141365044;23507.647385288892;23655.763442365354;12970.870291296966;13095.541656041993;13109.344532773133;13110.410031548794;13117.672058198239;16149.507048559211;16202.756958645394;16235.269412876685;16246.675066498368;16285.267162977458;12882.549110781078;12984.480620775441;12988.870111298766;13009.349532523147;13350.732985340434;12687.936560317139;12717.682057948625;12733.61799146027;12930.094893357375;12990.155639883755;11415.771684566429;11670.70823229426;11680.70798230051;11688.123390745557;11704.648860534198;8752.474851508676;8757.124287571192;8768.506257529578;8861.24679402258;8894.28845692356;8567.528785916835;8719.956400217958;8819.514926679094;8824.073472285574;8858.424202426822 19:15:43 INFO - PID 15120 | |4;prototype.html;563.4590792838875;578.7511370110852;589.2604780999844;600.3756093662591;607.2439812433521;6392.977123660221;6456.741730330787;6483.059956306332;6545.116409284745;6622.8675426491445;6344.714487848047;6398.616083035021;6417.582857114285;6447.935520644792;6486.383793539618;5312.857735586848;5317.601179911503;5351.25082488452;5365.570754339644;5369.301990741198;5033.496650334974;5148.760289274178;5304.681719096847;5349.598780091489;5352.564583114693;5160.91620759639;5168.069747445458;5170.603936937025;5187.948120518803;5203.4796520348045;5064.442911279756;5122.897542049175;5140.66585671932;5146.408163061258;5158.174692049273;4713.740744259065;4715.64632652549;4750.2874568814605;4781.784819683088;4797.280407938802;6421;6432.935670643281;6443.806685799386;6449.484041276686;6463.7737679181;6080.756769729205;6088.360722124202;6128.754849806002;6136.938630613726;6169.969150154266;6870.553414028072;6904.930950690479;6905.240423553405;6951.617661028641;6959.164900211957;5092.10888094582;5290.259363689087;5295.126304159809;5305.602079843989;5309.177077552986;7063.8587228255665;7085.291470852925;7169.390601798853;7186.820329491805;7246.311600398007;5397.8380648580605;5422.4753909958845;5427.891442171134;5446.7276636168035;5453.345598528202;5487.75305111271;5492.313460817398;5505.421930697299;5510.476504732044;5515.4760297771645;5993.400659934059;6011.819645410645;6056.36408177135;6056.878862422727;6090.33006369299;6864.519483636197;6867.313268673192;6902.240753517109;6918.273581273894;6944.861102777916;1885.3212843376373;1888.886666799969;1893.176468236294;1907.8950657713958;1914.224738980715;1304.6412236634812;1348.7707089794562;1353.7969304604387;1359.5445525748985;1363.2161507133437;6356.427921486996;6383.234011918506;6408.198975128109;6438.77464288757;6506.251781045145;6886.724531018703;6903.413209877116;6992.79021629352;7022.92977070233;7032.98021786838;6449.290578036413;6457.644829534327;6475.805725828139;6510.18622672166;6523.119378883885;3656.451532270181;3671.632836716307;3671.8531258749886;3694.796786176786;3729.5151630287887;7138.321859423347;7212.170600380919;7239.74660886877;7293.781186564412;7321.267873212636;7060.717571297193;7077.3984211341585;7161.526659570104;7190.964045179845;7216.278372162742;7175.928240717526;7241.384482319062;7249.528780629243;7274.345308922222;7293;6902.93097069043;6960.060391847036;6965.756198533027;6988.274572916668;7032.156141263081;6857.5199736019995;6919.95861220931;6937.0288159656675;6993.895091573529;7024.192217895007;7299.598522081336;7347.963260183665;7359.668814903235;7367.889481657887;7394.260573942563;5433.8369848904595;5437.601499063086;5438.564914806885;5485.177223416519;5505.476979686923;6717.899231511434;6875;7062.435005199674;7066.681999310146;7115.67979440916;6646.60120392778;6768.593884366954;6784.525083244125;6822.147231596051;6839.418649414656;6663.167104111986;6721.731130754715;6791.185057793096;6796.858989418318;6802.449081594402;6477.611343319416;6632.436242919213;6670.533062685759;6697;6721.1598550181225;6776.83141394749;6823.692933817891;6900.275471075464;6952.374286314256;6964.860702786017;6573.769918053036;6656.30108838565;6676.83307917306;6687.130673012477;6716.227633821977 19:15:43 INFO - PID 15120 | |5;yui.html;992.3946392700451;1008.4806324742757;1013.5540362240614;1023.0383439566803;1045.822210224262;21590.784092159094;22019.22932697356;22035.338939831792;22040.228591999305;22047.11811527537;19280;19418.708719369184;19710.704339434884;19711.901440492813;19759.209631614718;1034.4827586206916;1056.8943105689445;1057.2282233969206;1058.253930978662;1058.8729352477712;1096.2435919215754;1100.114407901639;1101.0530943388678;1101.2181351240629;1101.7686285879975;1100.367288808934;1142.103448792698;1151.2574389518754;1158.28186524355;1158.9478473468714;1148.9023433008203;1152.446825523745;1152.8097863852454;1152.8443660105863;1153.521288665203;820.4789958376414;820.6020080261069;820.819419727659;822.116225058065;822.3914303415489;20045.899770501055;21220.681689774665;21925.12299508018;22332.441688957744;22353.10587576495;22356.77643223563;22734.88632556843;23405;23425.41436464085;23456.76543234563;18264;18792.530186745305;19028.238870445166;19067.80932190674;19105;3553.5558055243096;3562.4300111981956;3593.1376469647357;3595.442706380515;3603.3153700796765;130947;139648;157005;159735.2013239938;161419;17654;17787.28850845952;17956.1021948902;18050.90974545119;18174.5456363592;35603.28793424117;35724.28551428957;36015.63984360123;36102.097447563494;36288.45567316492;10227.795444091076;10297.227707921937;10341.327813692085;10366;10366.222533310032;4583.220852455091;4599.793009314589;4607.35497030416;4613.192691279013;4629.259318509023;6382.521310901701;6523.18460192476;6551.508636852255;6598.637074960923;6618.205815302194;1311.514739546374;1328.93355332233;1334.5462542735515;1346.696993176547;1350.844652864933;713.2261496276598;723.0997408226791;733.2813842434444;742.1279996004673;754.6151462753925;13379.598612041655;13881.722365552632;13935.790963135561;14970.17664028489;15156.848431515544;724.9565026098451;743.2827321634649;745.2919726260075;750.1298493747227;754.3964828137468;6610.7025183866845;6710.9262517996885;6763.256041835394;6767.221769496472;6795;154560;155233.96767791963;155936.22031889996;158206;161905;125386.3730681359;129542.35228823796;133008;133187;138950;115287.42356288333;117001;117097;118171.8182818178;118605;13198.736025279248;13208.73582528325;13283.269420181983;13372.264525451194;13385.464581416634;58432.4156758427;58560;58645;58742.706286468296;61567;75912.24087759052;76483.61758191173;77011.2298877004;77315;79049.20950790419;19691.507712307306;20482.38552843417;20555.07502162436;20620.381388558366;20630.381088567367;19797.703034454207;20125.39623811288;20356.592868142852;20419.183232671123;20478;22374.552508949404;22461.663075054214;22726.545469090855;22754.31737047891;23014.42463938415;22039.33881983543;22265.44336391603;22378;22406.439839003502;22569.661455077858;21511.677324839828;21518.354449366543;21583.784162158805;21702.782972170076;21726;14774;14869.702605947605;14960.775588365965;14978.700425991638;15349.462768803038;13626.386812593655;13862.237576933365;13936.512222072179;14054.086484378891;14064.08583442073 19:15:43 INFO - PID 15120 | __end_tp_report 19:15:43 INFO - PID 15120 | __start_cc_report 19:15:43 INFO - PID 15120 | _x_x_mozilla_cycle_collect,230 19:15:43 INFO - PID 15120 | __end_cc_report 19:15:43 INFO - PID 15120 | __startTimestamp1507169743434__endTimestamp 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | ------- Summary: start ------- 19:15:43 INFO - PID 15120 | Number of tests: 6 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#0] dojo.html Cycles:165 Average:6507.42 Median:6758.53 stddev:741.96 (11.0%) stddev-sans-first:716.23 19:15:43 INFO - PID 15120 | Values: 3933.4 3983.8 4004.6 4007.9 4011.2 6444.5 6454.8 6464.5 6491.1 6519.1 6473.2 6480.7 6528.4 6551.7 6552.3 5795.4 5819.9 5915.3 5965.5 5980.1 5853.6 5863.8 5871.9 5966.3 5969.3 5829.5 5854.5 5874.9 5924.1 5946.6 5817.3 5949.3 5956.2 5979.1 6006.1 5779.0 5830.1 5884.0 5954.6 5979.4 6386.5 6400.4 6405.1 6428.4 6439.7 6981.9 7044.4 7053.4 7058.0 7083.6 6897.6 6952.4 7011.5 7066.4 7108.0 6470.2 6492.4 6496.6 6498.5 6510.5 7155.1 7180.1 7238.6 7240.2 7276.4 6932.9 6938.9 7003.3 7021.4 7050.4 6888.4 7076.2 7080.0 7168.2 7170.8 6953.3 6959.4 6998.0 7010.4 7026.5 6926.5 6962.4 7013.7 7025.9 7029.1 5228.3 5244.2 5302.5 5305.3 5316.8 4777.6 4792.2 4803.3 4814.3 4871.3 6590.5 6614.8 6618.7 6628.5 6641.4 6974.1 6995.9 6996.1 7089.5 7094.0 6556.4 6560.6 6594.2 6614.4 6622.1 5869.4 5947.6 5949.4 5954.6 5956.5 7299.5 7300.9 7394.6 7398.4 7398.9 6934.2 6945.1 7067.2 7070.9 7092.2 7346.0 7350.0 7403.8 7452.9 7453.9 6850.9 6920.3 6982.1 7017.4 7035.1 6927.5 7011.0 7030.8 7046.2 7093.0 6817.9 6902.4 6909.3 6911.1 6915.2 6792.5 6795.4 6804.9 6887.4 6894.2 6569.3 6681.2 6699.5 6707.9 6775.0 6813.0 6853.9 6854.3 6888.3 6903.8 6670.6 6679.5 6744.5 6758.5 6769.1 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#1] ext.html Cycles:180 Average:44420.83 Median:3776.26 stddev:69244.55 (1833.7%) stddev-sans-first:69361.83 19:15:43 INFO - PID 15120 | Values: 938.2 964.8 993.1 994.6 995.3 44317.6 45184.3 45283.5 45314.5 45330.0 41364.8 44547.0 45220.3 45390.8 45412.5 8646.6 8807.3 8809.8 8823.2 8824.5 8680.9 8831.8 8834.2 8839.3 8842.4 8817.4 8831.6 8872.2 8876.5 8907.5 8804.3 8832.9 8834.5 8841.7 8858.5 8672.8 8679.1 8691.1 8740.3 8744.8 41064.0 41163.4 41220.0 41391.0 41420.4 3756.5 3796.0 3821.6 3824.6 3837.9 34009.8 34180.7 34290.7 34310.3 34397.7 5604.5 5607.8 5616.1 5626.5 5627.1 233899.0 236823.0 249733.0 250503.0 254857.7 53304.5 53660.2 53692.0 53738.5 53767.2 55231.4 55246.7 55282.0 55355.2 55442.4 18417.3 18498.5 18565.5 18575.3 18734.2 15616.1 15635.3 15639.7 15659.7 15671.5 13597.3 13597.6 13748.2 13759.3 13920.9 5456.4 5474.9 5635.7 5637.3 5690.5 1094.4 1097.1 1098.9 1099.2 1104.8 25017.2 25077.9 25166.5 25404.9 25428.9 1204.2 1215.0 1216.5 1219.8 1233.0 13365.9 13383.7 13395.0 13396.0 13547.3 306338.0 308264.0 308271.0 310427.0 315657.0 61933.4 61968.7 62202.0 62284.7 62292.4 1445.8 1487.5 1492.5 1498.8 1500.4 29316.4 29579.0 29772.7 29936.1 30047.4 40299.2 40556.8 40586.2 40661.4 40781.4 235446.0 236006.0 236869.0 236912.0 238274.0 34513.1 35634.5 35753.6 35920.3 36050.8 45158.5 46444.5 46511.8 46606.3 46700.8 34597.5 34932.8 35235.6 35554.3 35942.8 34568.8 34592.3 34825.3 35055.3 35161.8 39901.8 40106.8 40396.2 40486.0 40559.2 32720.7 33065.5 33595.7 33607.0 33736.8 24970.8 25052.6 25155.4 25208.6 25722.7 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#2] jquery.html Cycles:180 Average:42704.53 Median:22093.72 stddev:112855.68 (510.8%) stddev-sans-first:113128.07 19:15:43 INFO - PID 15120 | Values: 638.4 639.7 643.3 648.5 650.9 23797.3 24391.3 24533.8 24586.3 24601.9 26018.0 26180.0 26474.9 26485.1 26623.7 6531.9 6744.6 6814.6 6828.9 6896.8 6854.5 6956.0 6962.5 6964.2 6972.0 6640.1 6896.0 6947.2 6951.3 6953.8 6781.1 6799.5 6804.8 6833.6 6833.9 6398.2 6404.3 6412.4 6414.8 6418.6 29229.3 29248.4 30032.0 30063.2 30071.5 2385.7 2427.9 2430.3 2432.1 2432.7 20296.6 20696.8 20800.0 20808.2 20865.7 2569.8 2586.7 2627.8 2628.1 2643.7 137337.0 144205.0 166412.0 173388.0 173818.0 16253.3 16462.8 16569.4 16905.8 17011.7 26998.3 27102.0 27147.3 27150.2 27245.7 11353.9 11378.7 11472.0 11493.7 11641.1 10277.5 10369.6 10428.2 10490.5 10552.3 9858.0 10115.5 10275.7 10366.1 10457.2 2948.8 2971.3 2994.5 3009.3 3131.9 1054.7 1063.8 1070.6 1080.4 1083.2 20813.5 21159.2 21179.5 21586.9 21996.7 1138.9 1152.5 1160.8 1162.1 1171.8 11289.4 11546.6 11549.3 11597.8 11692.0 660305.0 668752.0 676314.0 683457.0 690528.0 138598.0 140896.0 142215.3 142354.3 145519.0 1181.6 1234.6 1285.0 1293.5 1349.3 21429.6 21965.7 22190.8 22246.3 22297.3 65367.7 65858.0 66139.0 67416.3 68600.0 80250.2 80600.0 81024.6 81028.6 85174.0 15767.7 15961.7 15993.8 16007.2 16085.6 24204.8 24211.5 24390.6 24496.6 24592.6 19846.7 20013.7 20066.0 20217.2 20299.9 17127.7 17887.2 18097.2 18261.1 18376.7 20145.6 20332.6 20412.0 20561.4 20840.6 15541.7 15858.9 15911.1 15927.5 15929.5 19447.3 19573.9 19649.6 19761.4 19799.7 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#3] mootools.html Cycles:180 Average:10929.18 Median:26364.04 stddev:8034.54 (30.5%) stddev-sans-first:8025.19 19:15:43 INFO - PID 15120 | Values: 1401.6 1448.2 1458.2 1465.9 1471.6 14809.7 15424.5 17888.2 18213.7 18279.3 17250.1 17506.2 17509.2 17524.2 17553.2 2988.6 3026.4 3061.0 3150.8 3150.9 3153.4 3157.6 3184.3 3185.6 3211.5 3094.5 3133.0 3163.9 3165.1 3165.2 3013.6 3036.8 3038.8 3067.7 3071.4 3017.1 3029.4 3042.7 3047.8 3057.7 16888.7 17042.3 17045.2 17084.7 17160.7 9114.6 9399.6 9422.2 9485.2 9495.7 5650.2 5774.6 5790.7 5863.9 5883.4 2004.6 2012.9 2031.1 2052.5 2074.6 31319.4 31853.2 31883.5 31972.0 32012.0 7452.3 7681.6 7718.3 7854.1 7906.9 20552.4 20553.3 20581.6 20639.3 20658.3 7930.2 8891.9 9225.2 9246.9 9249.2 6912.7 7516.7 8436.0 8535.4 8538.4 6176.8 6208.2 6216.4 6256.7 6333.5 1773.8 1798.0 1802.0 1826.4 1848.8 994.9 1018.8 1021.8 1021.9 1042.0 8855.8 8907.5 8976.3 9077.9 9110.0 827.2 841.4 847.5 853.4 855.2 5705.4 6285.3 6521.6 6545.2 6561.7 25854.0 26245.6 26425.2 26484.5 26739.2 25287.1 25947.4 25970.5 26039.6 26302.9 12778.2 12782.1 12857.7 12861.6 12928.7 10154.1 10306.7 10353.8 10412.7 10459.0 22105.6 22319.8 22404.7 22490.8 22755.0 23181.8 23343.9 23388.2 23507.6 23655.8 12970.9 13095.5 13109.3 13110.4 13117.7 16149.5 16202.8 16235.3 16246.7 16285.3 12882.5 12984.5 12988.9 13009.3 13350.7 12687.9 12717.7 12733.6 12930.1 12990.2 11415.8 11670.7 11680.7 11688.1 11704.6 8752.5 8757.1 8768.5 8861.2 8894.3 8567.5 8720.0 8819.5 8824.1 8858.4 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#4] prototype.html Cycles:180 Average:5854.06 Median:6460.71 stddev:1626.13 (25.2%) stddev-sans-first:1581.46 19:15:43 INFO - PID 15120 | Values: 563.5 578.8 589.3 600.4 607.2 6393.0 6456.7 6483.1 6545.1 6622.9 6344.7 6398.6 6417.6 6447.9 6486.4 5312.9 5317.6 5351.3 5365.6 5369.3 5033.5 5148.8 5304.7 5349.6 5352.6 5160.9 5168.1 5170.6 5187.9 5203.5 5064.4 5122.9 5140.7 5146.4 5158.2 4713.7 4715.6 4750.3 4781.8 4797.3 6421.0 6432.9 6443.8 6449.5 6463.8 6080.8 6088.4 6128.8 6136.9 6170.0 6870.6 6904.9 6905.2 6951.6 6959.2 5092.1 5290.3 5295.1 5305.6 5309.2 7063.9 7085.3 7169.4 7186.8 7246.3 5397.8 5422.5 5427.9 5446.7 5453.3 5487.8 5492.3 5505.4 5510.5 5515.5 5993.4 6011.8 6056.4 6056.9 6090.3 6864.5 6867.3 6902.2 6918.3 6944.9 1885.3 1888.9 1893.2 1907.9 1914.2 1304.6 1348.8 1353.8 1359.5 1363.2 6356.4 6383.2 6408.2 6438.8 6506.3 6886.7 6903.4 6992.8 7022.9 7033.0 6449.3 6457.6 6475.8 6510.2 6523.1 3656.5 3671.6 3671.9 3694.8 3729.5 7138.3 7212.2 7239.7 7293.8 7321.3 7060.7 7077.4 7161.5 7191.0 7216.3 7175.9 7241.4 7249.5 7274.3 7293.0 6902.9 6960.1 6965.8 6988.3 7032.2 6857.5 6920.0 6937.0 6993.9 7024.2 7299.6 7348.0 7359.7 7367.9 7394.3 5433.8 5437.6 5438.6 5485.2 5505.5 6717.9 6875.0 7062.4 7066.7 7115.7 6646.6 6768.6 6784.5 6822.1 6839.4 6663.2 6721.7 6791.2 6796.9 6802.4 6477.6 6632.4 6670.5 6697.0 6721.2 6776.8 6823.7 6900.3 6952.4 6964.9 6573.8 6656.3 6676.8 6687.1 6716.2 19:15:43 INFO - PID 15120 | 19:15:43 INFO - PID 15120 | [#5] yui.html Cycles:180 Average:29332.31 Median:19921.80 stddev:42326.07 (212.5%) stddev-sans-first:42391.32 19:15:43 INFO - PID 15120 | Values: 992.4 1008.5 1013.6 1023.0 1045.8 21590.8 22019.2 22035.3 22040.2 22047.1 19280.0 19418.7 19710.7 19711.9 19759.2 1034.5 1056.9 1057.2 1058.3 1058.9 1096.2 1100.1 1101.1 1101.2 1101.8 1100.4 1142.1 1151.3 1158.3 1158.9 1148.9 1152.4 1152.8 1152.8 1153.5 820.5 820.6 820.8 822.1 822.4 20045.9 21220.7 21925.1 22332.4 22353.1 22356.8 22734.9 23405.0 23425.4 23456.8 18264.0 18792.5 19028.2 19067.8 19105.0 3553.6 3562.4 3593.1 3595.4 3603.3 130947.0 139648.0 157005.0 159735.2 161419.0 17654.0 17787.3 17956.1 18050.9 18174.5 35603.3 35724.3 36015.6 36102.1 36288.5 10227.8 10297.2 10341.3 10366.0 10366.2 4583.2 4599.8 4607.4 4613.2 4629.3 6382.5 6523.2 6551.5 6598.6 6618.2 1311.5 1328.9 1334.5 1346.7 1350.8 713.2 723.1 733.3 742.1 754.6 13379.6 13881.7 13935.8 14970.2 15156.8 725.0 743.3 745.3 750.1 754.4 6610.7 6710.9 6763.3 6767.2 6795.0 154560.0 155234.0 155936.2 158206.0 161905.0 125386.4 129542.4 133008.0 133187.0 138950.0 115287.4 117001.0 117097.0 118171.8 118605.0 13198.7 13208.7 13283.3 13372.3 13385.5 58432.4 58560.0 58645.0 58742.7 61567.0 75912.2 76483.6 77011.2 77315.0 79049.2 19691.5 20482.4 20555.1 20620.4 20630.4 19797.7 20125.4 20356.6 20419.2 20478.0 22374.6 22461.7 22726.5 22754.3 23014.4 22039.3 22265.4 22378.0 22406.4 22569.7 21511.7 21518.4 21583.8 21702.8 21726.0 14774.0 14869.7 14960.8 14978.7 15349.5 13626.4 13862.2 13936.5 14054.1 14064.1 19:15:43 INFO - PID 15120 | -------- Summary: end -------- 19:15:43 INFO - PID 15120 | 19:15:43 INFO - TEST-INFO | 15120: exit 0 19:15:44 INFO - TEST-OK | dromaeo_css | took 1107424ms 19:15:44 INFO - TEST-START | kraken 19:15:44 INFO - Initialising browser for kraken test... 19:15:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45386/getInfo.html -profile /tmp/tmpRPKj4i/profile 19:15:44 INFO - TEST-INFO | started process 15484 (/builds/slave/test/build/application/firefox/firefox http://localhost:45386/getInfo.html) 19:15:48 INFO - TEST-INFO | 15484: exit 0 19:15:49 INFO - Browser initialized. 19:15:49 INFO - Running cycle 1/1 for kraken test... 19:15:49 INFO - Using env: {'DISPLAY': ':0', 19:15:49 INFO - 'HOME': '/home/cltbld', 19:15:49 INFO - 'JSGC_DISABLE_POISONING': '1', 19:15:49 INFO - 'LANG': 'en_US.UTF-8', 19:15:49 INFO - 'LANGUAGE': 'en_US:en', 19:15:49 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 19:15:49 INFO - 'LOGNAME': 'cltbld', 19:15:49 INFO - 'MAIL': '/var/mail/cltbld', 19:15:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:15:49 INFO - 'MOZ_CRASHREPORTER': '1', 19:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:49 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 19:15:49 INFO - 'MOZ_NO_REMOTE': '1', 19:15:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:15:49 INFO - 'NO_EM_RESTART': '1', 19:15:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:49 INFO - 'PWD': '/builds/slave/test', 19:15:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:49 INFO - 'RUST_BACKTRACE': 'full', 19:15:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:15:49 INFO - 'SHELL': '/bin/bash', 19:15:49 INFO - 'SHLVL': '1', 19:15:49 INFO - 'TERM': 'linux', 19:15:49 INFO - 'TMOUT': '86400', 19:15:49 INFO - 'USER': 'cltbld', 19:15:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782', 19:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:49 INFO - '_': '/tools/buildbot/bin/python'} 19:15:49 INFO - TEST-INFO | started process 15722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPKj4i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:15:49 INFO - PID 15722 | 19:15:49 INFO - PID 15722 | (/builds/slave/test/build/application/firefox/firefox:15771): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:15:49 INFO - PID 15722 | 19:16:00 INFO - PID 15722 | RSS: Main: 142020608 19:16:00 INFO - PID 15722 | 19:16:02 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45386/tests/kraken/driver.html?testName=audio-beat-detection) 19:16:03 INFO - PID 15722 | RSS: Main: 147931136 19:16:03 INFO - PID 15722 | 19:16:06 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45386/tests/kraken/driver.html?testName=audio-dft) 19:16:06 INFO - PID 15722 | RSS: Main: 148398080 19:16:06 INFO - PID 15722 | 19:16:09 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45386/tests/kraken/driver.html?testName=audio-fft) 19:16:10 INFO - PID 15722 | RSS: Main: 149868544 19:16:10 INFO - PID 15722 | 19:16:12 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45386/tests/kraken/driver.html?testName=audio-oscillator) 19:16:12 INFO - PID 15722 | RSS: Main: 149979136 19:16:12 INFO - PID 15722 | 19:16:14 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:16:15 INFO - PID 15722 | RSS: Main: 149282816 19:16:15 INFO - PID 15722 | 19:16:18 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45386/tests/kraken/driver.html?testName=imaging-darkroom) 19:16:19 INFO - PID 15722 | RSS: Main: 149692416 19:16:19 INFO - PID 15722 | 19:16:22 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45386/tests/kraken/driver.html?testName=imaging-desaturate) 19:16:23 INFO - PID 15722 | RSS: Main: 150740992 19:16:23 INFO - PID 15722 | 19:16:26 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45386/tests/kraken/driver.html?testName=json-parse-financial) 19:16:26 INFO - PID 15722 | RSS: Main: 151973888 19:16:26 INFO - PID 15722 | 19:16:28 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:16:28 INFO - PID 15722 | RSS: Main: 151822336 19:16:28 INFO - PID 15722 | 19:16:30 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:16:30 INFO - PID 15722 | RSS: Main: 151801856 19:16:30 INFO - PID 15722 | 19:16:32 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:16:33 INFO - PID 15722 | RSS: Main: 148750336 19:16:33 INFO - PID 15722 | 19:16:36 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:16:36 INFO - PID 15722 | RSS: Main: 148762624 19:16:36 INFO - PID 15722 | 19:16:39 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:16:39 INFO - PID 15722 | RSS: Main: 149647360 19:16:39 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | Cycle 1(1): loaded http://localhost:45386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45386/tests/kraken/driver.html?testName=ai-astar) 19:16:41 INFO - PID 15722 | RSS: Main: 151027712 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | __start_tp_report 19:16:41 INFO - PID 15722 | _x_x_mozilla_page_load 19:16:41 INFO - PID 15722 | _x_x_mozilla_page_load_details 19:16:41 INFO - PID 15722 | |i|pagename|runs| 19:16:41 INFO - PID 15722 | |0;ai-astar;104;104;106;105;104;104;107;106;106;105 19:16:41 INFO - PID 15722 | |1;audio-beat-detection;112;109;113;112;111;111;112;145;114;115 19:16:41 INFO - PID 15722 | |2;audio-dft;162;163;161;170;162;162;163;162;160;162 19:16:41 INFO - PID 15722 | |3;audio-fft;74;75;74;73;73;82;73;75;76;74 19:16:41 INFO - PID 15722 | |4;audio-oscillator;77;80;76;77;78;77;78;78;77;77 19:16:41 INFO - PID 15722 | |5;imaging-gaussian-blur;110;113;113;113;117;113;113;115;115;114 19:16:41 INFO - PID 15722 | |6;imaging-darkroom;154;148;148;148;149;148;148;148;149;148 19:16:41 INFO - PID 15722 | |7;imaging-desaturate;93;94;95;94;95;96;94;94;95;95 19:16:41 INFO - PID 15722 | |8;json-parse-financial;46;46;42;44;44;44;48;43;42;43 19:16:41 INFO - PID 15722 | |9;json-stringify-tinderbox;38;38;41;39;38;43;43;44;38;39 19:16:41 INFO - PID 15722 | |10;stanford-crypto-aes;68;73;72;69;69;74;69;68;75;70 19:16:41 INFO - PID 15722 | |11;stanford-crypto-ccm;106;104;105;109;104;106;107;100;112;101 19:16:41 INFO - PID 15722 | |12;stanford-crypto-pbkdf2;152;148;148;154;156;150;149;154;150;151 19:16:41 INFO - PID 15722 | |13;stanford-crypto-sha256-iterative;61;59;59;59;55;57;56;58;63;60 19:16:41 INFO - PID 15722 | __end_tp_report 19:16:41 INFO - PID 15722 | __start_cc_report 19:16:41 INFO - PID 15722 | _x_x_mozilla_cycle_collect,670 19:16:41 INFO - PID 15722 | __end_cc_report 19:16:41 INFO - PID 15722 | __startTimestamp1507169801774__endTimestamp 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | ------- Summary: start ------- 19:16:41 INFO - PID 15722 | Number of tests: 14 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.50 stddev:1.10 (1.0%) stddev-sans-first:1.09 19:16:41 INFO - PID 15722 | Values: 104.0 104.0 106.0 105.0 104.0 104.0 107.0 106.0 106.0 105.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:112.50 stddev:10.53 (9.4%) stddev-sans-first:11.10 19:16:41 INFO - PID 15722 | Values: 112.0 109.0 113.0 112.0 111.0 111.0 112.0 145.0 114.0 115.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.71 (1.7%) stddev-sans-first:2.86 19:16:41 INFO - PID 15722 | Values: 162.0 163.0 161.0 170.0 162.0 162.0 163.0 162.0 160.0 162.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.69 (3.6%) stddev-sans-first:2.83 19:16:41 INFO - PID 15722 | Values: 74.0 75.0 74.0 73.0 73.0 82.0 73.0 75.0 76.0 74.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.50 stddev:1.08 (1.4%) stddev-sans-first:1.13 19:16:41 INFO - PID 15722 | Values: 77.0 80.0 76.0 77.0 78.0 77.0 78.0 78.0 77.0 77.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:1.84 (1.6%) stddev-sans-first:1.41 19:16:41 INFO - PID 15722 | Values: 110.0 113.0 113.0 113.0 117.0 113.0 113.0 115.0 115.0 114.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.00 stddev:1.87 (1.3%) stddev-sans-first:0.44 19:16:41 INFO - PID 15722 | Values: 154.0 148.0 148.0 148.0 149.0 148.0 148.0 148.0 149.0 148.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 19:16:41 INFO - PID 15722 | Values: 93.0 94.0 95.0 94.0 95.0 96.0 94.0 94.0 95.0 95.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.00 stddev:1.93 (4.4%) stddev-sans-first:1.94 19:16:41 INFO - PID 15722 | Values: 46.0 46.0 42.0 44.0 44.0 44.0 48.0 43.0 42.0 43.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#9] json-stringify-tinderbox Cycles:10 Average:40.10 Median:40.00 stddev:2.42 (6.1%) stddev-sans-first:2.45 19:16:41 INFO - PID 15722 | Values: 38.0 38.0 41.0 39.0 38.0 43.0 43.0 44.0 38.0 39.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#10] stanford-crypto-aes Cycles:10 Average:70.70 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:2.55 19:16:41 INFO - PID 15722 | Values: 68.0 73.0 72.0 69.0 69.0 74.0 69.0 68.0 75.0 70.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#11] stanford-crypto-ccm Cycles:10 Average:105.40 Median:106.00 stddev:3.53 (3.3%) stddev-sans-first:3.74 19:16:41 INFO - PID 15722 | Values: 106.0 104.0 105.0 109.0 104.0 106.0 107.0 100.0 112.0 101.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.50 stddev:2.74 (1.8%) stddev-sans-first:2.89 19:16:41 INFO - PID 15722 | Values: 152.0 148.0 148.0 154.0 156.0 150.0 149.0 154.0 150.0 151.0 19:16:41 INFO - PID 15722 | 19:16:41 INFO - PID 15722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.70 Median:59.00 stddev:2.36 (4.0%) stddev-sans-first:2.35 19:16:41 INFO - PID 15722 | Values: 61.0 59.0 59.0 59.0 55.0 57.0 56.0 58.0 63.0 60.0 19:16:41 INFO - PID 15722 | -------- Summary: end -------- 19:16:41 INFO - PID 15722 | 19:16:42 INFO - PID 15722 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:16:42 INFO - TEST-INFO | 15722: exit 0 19:16:42 INFO - TEST-OK | kraken | took 58320ms 19:16:42 INFO - SUITE-END | took 1165s 19:16:42 INFO - Completed test suite (00:19:25) 19:16:42 INFO - javascript benchmark 19:16:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9436.057823180112, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3933.3706606942897, 3983.820728067237, 4004.5594984551703, 4007.859724909628, 4011.1777085697436, 6444.452221561167, 6454.806355809322, 6464.547481676284, 6491.058796474508, 6519.054737063123, 6473.158489396372, 6480.675966201695, 6528.41244288014, 6551.672416379174, 6552.344765523445, 5795.449432303924, 5819.912701309484, 5915.349311575723, 5965.522758179357, 5980.073088671263, 5853.61951473155, 5863.79476718315, 5871.882562348772, 5966.343702192756, 5969.313528944162, 5829.533637309027, 5854.5023672987845, 5874.88250234995, 5924.0521516557355, 5946.583739138262, 5817.301923769175, 5949.286085669725, 5956.22569066023, 5979.133025711248, 6006.069059295816, 5778.971105144447, 5830.067189249699, 5883.970580147072, 5954.583179177459, 5979.43195396441, 6386.457151142158, 6400.39196276353, 6405.103285540028, 6428.357164283581, 6439.710213040425, 6981.930180698178, 7044.401225895805, 7053.435725142028, 7058.047163632895, 7083.610401427919, 6897.586144831276, 6952.374286314205, 7011.544249623758, 7066.434685225169, 7107.964460177666, 6470.158879345702, 6492.350764923517, 6496.577722448026, 6498.5126115542, 6510.479161667103, 7155.069840920647, 7180.138383394026, 7238.638068096574, 7240.167380751281, 7276.381507571809, 6932.861342773116, 6938.930610693929, 7003.264657211022, 7021.403180729593, 7050.365467107985, 6888.448924086061, 7076.221615622278, 7080.0, 7168.211496735355, 7170.78487645361, 6953.304669533108, 6959.408450281681, 6997.965010174917, 7010.439164866799, 7026.543274687129, 6926.480513961473, 6962.443004559623, 7013.684384202723, 7025.859482810315, 7029.121359830021, 5228.2941802856885, 5244.213367994831, 5302.522772950453, 5305.283786688748, 5316.76074576645, 4777.641676874248, 4792.2332426811545, 4803.303520989507, 4814.277858321209, 4871.318015477765, 6590.505712071614, 6614.768483103165, 6618.7352505899225, 6628.502862285348, 6641.402273795382, 6974.128233970754, 6995.8950615740805, 6996.090508233897, 7089.468289878279, 7094.042304288855, 6556.409923106943, 6560.639164845979, 6594.208694956636, 6614.437772789271, 6622.139121914121, 5869.413058694182, 5947.6431414115295, 5949.405059494016, 5954.642721436641, 5956.493698035629, 7299.5255308404785, 7300.890486642705, 7394.55632662042, 7398.371138453184, 7398.926010739824, 6934.16789985205, 6945.131858517685, 7067.187273463617, 7070.929290707233, 7092.184398793998, 7345.963270183829, 7349.963250183715, 7403.777886663409, 7452.888206676796, 7453.888191677238, 6850.8972365413565, 6920.273371295942, 6982.1272340957385, 7017.438604911493, 7035.085438892911, 6927.480438967198, 7011.0, 7030.824229394306, 7046.189688185924, 7092.9645351772915, 6817.897731533932, 6902.447804175554, 6909.2745261746795, 6911.101556797584, 6915.204751453647, 6792.456603471809, 6795.354441328066, 6804.863902721819, 6887.449004079762, 6894.172699276119, 6569.277379488157, 6681.164854393201, 6699.5310328276555, 6707.899381509379, 6774.966125169342, 6812.965935170292, 6853.851263595142, 6854.280300568368, 6888.311168883272, 6903.827404314932, 6670.566413183127, 6679.4990375721045, 6744.460443164633, 6758.5269031167345, 6769.052332673528], "value": 6458.728199707551, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [938.1603464898919, 964.768455570663, 993.1210878372638, 994.622043623423, 995.3480470291956, 44317.55682443175, 45184.322235166495, 45283.54716452835, 45314.54685453144, 45329.99999999992, 41364.79317603408, 44547.0, 45220.32169517452, 45390.773046134804, 45412.54587454125, 8646.61090250937, 8807.339449541278, 8809.823803523926, 8823.205911467967, 8824.470531768115, 8680.913190868105, 8831.823363532758, 8834.160754728291, 8839.337049721264, 8842.425242359259, 8817.42686725364, 8831.64673413066, 8872.157145071207, 8876.511791851446, 8907.510086945216, 8804.339674524404, 8832.911670883306, 8834.514101724402, 8841.69054083104, 8858.512781796999, 8672.826543469095, 8679.088695686989, 8691.130886911258, 8740.344474164463, 8744.781380465476, 41064.0, 41163.38254926178, 41220.0, 41391.0, 41420.37869431961, 3756.530433695788, 3795.9810200949096, 3821.5987321331136, 3824.560175579816, 3837.865674701372, 34009.829950850086, 34180.658193418, 34290.65709342925, 34310.313793724235, 34397.6560234397, 5604.467575580314, 5607.803726869581, 5616.1014237721765, 5626.465485778845, 5627.071533197018, 233899.0, 236823.0, 249733.0, 250503.0, 254857.7257113721, 53304.46695532995, 53660.19509707358, 53692.0, 53738.46261537335, 53767.19349209765, 55231.44768552263, 55246.723766380914, 55282.0, 55355.16967245495, 55442.44557554454, 18417.26330946747, 18498.537536561693, 18565.535861603566, 18575.34986275501, 18734.1569629367, 15616.141112238709, 15635.296411661502, 15639.68720625604, 15659.686806264039, 15671.451499197701, 13597.252151131584, 13597.592072237849, 13748.243846588533, 13759.312034398441, 13920.860791392159, 5456.399796022434, 5474.890502190014, 5635.718214089279, 5637.295338082739, 5690.5163061140265, 1094.414488248783, 1097.05653138301, 1098.9230753847314, 1099.1646348774989, 1104.7569534702352, 25017.249482515555, 25077.87461062683, 25166.496670066495, 25404.872975635004, 25428.872855635604, 1204.235310577772, 1214.987850121505, 1216.5086202598422, 1219.7987332090106, 1233.0382301804607, 13365.866341336656, 13383.665408364868, 13394.995210727899, 13396.0, 13547.254900980344, 306338.0, 308264.0, 308271.0, 310427.0, 315657.0, 61933.38066619366, 61968.690156549834, 62202.0, 62284.68857655773, 62292.37707622956, 1445.8192725909262, 1487.516557118919, 1492.5000124958044, 1498.8126484189477, 1500.422337400087, 29316.41367172602, 29579.0, 29772.702272976992, 29936.101916942527, 30047.3990520184, 40299.1940161201, 40556.79721601373, 40586.18827623372, 40661.39007914943, 40781.38827917524, 235446.0, 236006.0, 236869.0, 236912.0, 238274.0, 34513.13717157091, 35634.46548301829, 35753.64246357607, 35920.28159436849, 36050.819745901106, 45158.54841451543, 46444.53555464402, 46511.76744116258, 46606.30090548712, 46700.7664961673, 34597.48103778395, 34932.82533587316, 35235.64764352324, 35554.28891422209, 35942.8202858984, 34568.82715586406, 34592.308153837286, 34825.303493930485, 35055.29889402249, 35161.824190878884, 39901.80049099736, 40106.799466002485, 40396.1920761589, 40485.98785030398, 40559.17483713299, 32720.672793271762, 33065.50401743928, 33595.664043359255, 33607.0, 33736.83131584425, 24970.750292496843, 25052.62421063649, 25155.371115721522, 25208.621870672323, 25722.742772572034], "value": 19087.382409749614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.438251959947, 639.7024458638417, 643.297437075636, 648.47072272949, 650.8946085715986, 23797.28608141754, 24391.268261952126, 24533.75466245337, 24586.262412127642, 24601.876990615045, 26018.0, 26180.0, 26474.867625661846, 26485.07302244422, 26623.733762662418, 6531.934680653204, 6744.5616034957575, 6814.557053791487, 6828.931710682904, 6896.75861344853, 6854.520183587151, 6956.0, 6962.477814163933, 6964.233934267227, 6972.023916651673, 6640.1035860158745, 6895.965520172417, 6947.201071876749, 6951.2701166377565, 6953.756618518353, 6781.118454600895, 6799.456043516507, 6804.829879253009, 6833.589984600915, 6833.931660683379, 6398.200224971879, 6404.263509696398, 6412.358764123597, 6414.839629009265, 6418.582792118544, 29229.26926826825, 29248.41503169946, 30032.0, 30063.248418789488, 30071.548926766118, 2385.7137143542714, 2427.8664673442954, 2430.270918724393, 2432.1001229545004, 2432.671589335435, 20296.594068118557, 20696.79303206979, 20800.0, 20808.16767329305, 20865.68701469479, 2569.755873192044, 2586.7154612992554, 2627.78977681785, 2628.132716203648, 2643.722409147031, 137337.0, 144205.0, 166412.0, 173387.99999999875, 173818.0, 16253.268602912898, 16462.835371646368, 16569.42007029772, 16905.80224570798, 17011.744823827652, 26998.32504187411, 27102.0, 27147.321316966838, 27150.185494435198, 27245.727542724715, 11353.886461135447, 11378.715532111764, 11472.0, 11493.712657183638, 11641.126915481203, 10277.486125693686, 10369.63706270277, 10428.165746740242, 10490.499865493657, 10552.261341706007, 9857.950710246547, 10115.544800483996, 10275.7431064224, 10366.118879895294, 10457.215708821868, 2948.7935844491108, 2971.3109635779656, 2994.4609970205574, 3009.277773334384, 3131.874725010974, 1054.7099547624312, 1063.7606538528769, 1070.5931745936493, 1080.4111759091313, 1083.2092572422175, 20813.479663008242, 21159.15363385478, 21179.470513236985, 21586.89206553957, 21996.670049949265, 1138.8681126901022, 1152.5159433038143, 1160.7910576096383, 1162.0935670177275, 1171.824226366052, 11289.379084150287, 11546.59586914454, 11549.307041577364, 11597.826032609517, 11692.0, 660305.0, 668752.0, 676314.0, 683457.0, 690528.0, 138598.0, 140896.0, 142215.28892355473, 142354.2882285582, 145519.0, 1181.5569161564413, 1234.5555599983998, 1284.9743005139844, 1293.534327642048, 1349.291621898511, 21429.571408571428, 21965.67051494197, 22190.778092218872, 22246.332610021724, 22297.287168391646, 65367.67316163389, 65858.0, 66139.0, 67416.325836741, 68600.0, 80250.19749802427, 80600.0, 81024.59487702524, 81028.59485702534, 85174.0, 15767.659748921471, 15961.68076638484, 15993.760093598838, 16007.199640018185, 16085.597860053593, 24204.757952420252, 24211.51576968486, 24390.634140488262, 24496.6325505114, 24592.631110533, 19846.702299465232, 20013.6997945028, 20066.0, 20217.191312347342, 20299.898500507403, 17127.743083854002, 17887.195076221342, 18097.18562664657, 18261.086945652398, 18376.724349134507, 20145.597088057864, 20332.59334813325, 20412.0, 20561.38315850527, 20840.58318833645, 15541.689166216838, 15858.92070539686, 15911.124888131264, 15927.522174334788, 15929.522114336589, 19447.3193438229, 19573.902130489256, 19649.60700786005, 19761.40715778529, 19799.703004454655], "value": 13232.162417953541, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.551503518874, 1448.246911605965, 1458.1688437590565, 1465.9047161934473, 1471.57324375931, 14809.703805923875, 15424.537263882088, 17888.19503122358, 18213.726794098067, 18279.268829246816, 17250.137493125356, 17506.212220450077, 17509.212085456154, 17524.21141048653, 17553.210105545248, 2988.566657834618, 3026.379592183608, 3060.9846950765213, 3150.7951983121025, 3150.8897188598403, 3153.4166179256913, 3157.6368717597543, 3184.283536204347, 3185.5540224368606, 3211.486162214046, 3094.4894092474715, 3132.9530057049164, 3163.9367212655734, 3165.145410739099, 3165.208697825544, 3013.5630333601616, 3036.7722420818527, 3038.787284890059, 3067.708567686066, 3071.3703690743346, 3017.1401150671954, 3029.3941211757738, 3042.6957304269395, 3047.7866549341556, 3057.6942305769244, 16888.746668799977, 17042.318307267695, 17045.23296451663, 17084.658306833917, 17160.742588861176, 9114.58984345706, 9399.577019034092, 9422.199113075398, 9485.193758530533, 9495.715128546155, 5650.152477128422, 5774.595778295521, 5790.739416726257, 5863.912041319383, 5883.38224486427, 2004.6391649503084, 2012.87922724637, 2031.0651109147288, 2052.4560991337307, 2074.63074370916, 31319.37361252785, 31853.203669908205, 31883.521747173578, 31972.0, 32012.0, 7452.292032256927, 7681.577513236825, 7718.343940764986, 7854.057513098464, 7906.920930790733, 20552.38342849717, 20553.280635177696, 20581.58836823255, 20639.277625283343, 20658.276960306317, 7930.167332430127, 8891.866622000674, 9225.169734723908, 9246.90753092474, 9249.16757491829, 6912.688928998207, 7516.736914208086, 8435.95782021086, 8535.359848011423, 8538.359623028298, 6176.7838125665385, 6208.161898143783, 6216.44052035319, 6256.718447669866, 6333.524985626096, 1773.7782777152856, 1797.9640407192044, 1802.0088951076855, 1826.3516451659734, 1848.8151184881403, 994.8955359687274, 1018.8420794776821, 1021.7598864266891, 1021.9233557483218, 1042.0100904141095, 8855.822883542422, 8907.51008694528, 8976.326775491863, 9077.863832042525, 9109.99790023097, 827.1728271728272, 841.4362377207286, 847.4913856633542, 853.3983541603155, 855.1790281329869, 5705.372409035002, 6285.308616052231, 6521.608703477807, 6545.214574251025, 6561.671916404161, 25854.0, 26245.606315905276, 26425.207243782334, 26484.47031059368, 26739.197824065308, 25287.11495097663, 25947.351316216867, 25970.480590388088, 26039.609405858926, 26302.868485657833, 12778.169418987922, 12782.105252632227, 12857.678558036125, 12861.614151575468, 12928.741425171444, 10154.136898363722, 10306.742331441774, 10353.84469232947, 10412.68761937143, 10458.95410458948, 22105.557888842453, 22319.77680223242, 22404.663930040737, 22490.775092248867, 22755.0, 23181.768182318636, 23343.88328058349, 23388.18141365044, 23507.647385288892, 23655.763442365354, 12970.870291296966, 13095.541656041993, 13109.344532773133, 13110.410031548794, 13117.672058198239, 16149.507048559211, 16202.756958645394, 16235.269412876685, 16246.675066498368, 16285.267162977458, 12882.549110781078, 12984.480620775441, 12988.870111298766, 13009.349532523147, 13350.732985340434, 12687.936560317139, 12717.682057948625, 12733.61799146027, 12930.094893357375, 12990.155639883755, 11415.771684566429, 11670.70823229426, 11680.70798230051, 11688.123390745557, 11704.648860534198, 8752.474851508676, 8757.124287571192, 8768.506257529578, 8861.24679402258, 8894.28845692356, 8567.528785916835, 8719.956400217958, 8819.514926679094, 8824.073472285574, 8858.424202426822], "value": 7664.564642296317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.4590792838875, 578.7511370110852, 589.2604780999844, 600.3756093662591, 607.2439812433521, 6392.977123660221, 6456.741730330787, 6483.059956306332, 6545.116409284745, 6622.8675426491445, 6344.714487848047, 6398.616083035021, 6417.582857114285, 6447.935520644792, 6486.383793539618, 5312.857735586848, 5317.601179911503, 5351.25082488452, 5365.570754339644, 5369.301990741198, 5033.496650334974, 5148.760289274178, 5304.681719096847, 5349.598780091489, 5352.564583114693, 5160.91620759639, 5168.069747445458, 5170.603936937025, 5187.948120518803, 5203.4796520348045, 5064.442911279756, 5122.897542049175, 5140.66585671932, 5146.408163061258, 5158.174692049273, 4713.740744259065, 4715.64632652549, 4750.2874568814605, 4781.784819683088, 4797.280407938802, 6421.0, 6432.935670643281, 6443.806685799386, 6449.484041276686, 6463.7737679181, 6080.756769729205, 6088.360722124202, 6128.754849806002, 6136.938630613726, 6169.969150154266, 6870.553414028072, 6904.930950690479, 6905.240423553405, 6951.617661028641, 6959.164900211957, 5092.10888094582, 5290.259363689087, 5295.126304159809, 5305.602079843989, 5309.177077552986, 7063.8587228255665, 7085.291470852925, 7169.390601798853, 7186.820329491805, 7246.311600398007, 5397.8380648580605, 5422.4753909958845, 5427.891442171134, 5446.7276636168035, 5453.345598528202, 5487.75305111271, 5492.313460817398, 5505.421930697299, 5510.476504732044, 5515.4760297771645, 5993.400659934059, 6011.819645410645, 6056.36408177135, 6056.878862422727, 6090.33006369299, 6864.519483636197, 6867.313268673192, 6902.240753517109, 6918.273581273894, 6944.861102777916, 1885.3212843376373, 1888.886666799969, 1893.176468236294, 1907.8950657713958, 1914.224738980715, 1304.6412236634812, 1348.7707089794562, 1353.7969304604387, 1359.5445525748985, 1363.2161507133437, 6356.427921486996, 6383.234011918506, 6408.198975128109, 6438.77464288757, 6506.251781045145, 6886.724531018703, 6903.413209877116, 6992.79021629352, 7022.92977070233, 7032.98021786838, 6449.290578036413, 6457.644829534327, 6475.805725828139, 6510.18622672166, 6523.119378883885, 3656.451532270181, 3671.632836716307, 3671.8531258749886, 3694.796786176786, 3729.5151630287887, 7138.321859423347, 7212.170600380919, 7239.74660886877, 7293.781186564412, 7321.267873212636, 7060.717571297193, 7077.3984211341585, 7161.526659570104, 7190.964045179845, 7216.278372162742, 7175.928240717526, 7241.384482319062, 7249.528780629243, 7274.345308922222, 7293.0, 6902.93097069043, 6960.060391847036, 6965.756198533027, 6988.274572916668, 7032.156141263081, 6857.5199736019995, 6919.95861220931, 6937.0288159656675, 6993.895091573529, 7024.192217895007, 7299.598522081336, 7347.963260183665, 7359.668814903235, 7367.889481657887, 7394.260573942563, 5433.8369848904595, 5437.601499063086, 5438.564914806885, 5485.177223416519, 5505.476979686923, 6717.899231511434, 6875.0, 7062.435005199674, 7066.681999310146, 7115.67979440916, 6646.60120392778, 6768.593884366954, 6784.525083244125, 6822.147231596051, 6839.418649414656, 6663.167104111986, 6721.731130754715, 6791.185057793096, 6796.858989418318, 6802.449081594402, 6477.611343319416, 6632.436242919213, 6670.533062685759, 6697.0, 6721.1598550181225, 6776.83141394749, 6823.692933817891, 6900.275471075464, 6952.374286314256, 6964.860702786017, 6573.769918053036, 6656.30108838565, 6676.83307917306, 6687.130673012477, 6716.227633821977], "value": 5387.530691638608, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [992.3946392700451, 1008.4806324742757, 1013.5540362240614, 1023.0383439566803, 1045.822210224262, 21590.784092159094, 22019.22932697356, 22035.338939831792, 22040.228591999305, 22047.11811527537, 19280.0, 19418.708719369184, 19710.704339434884, 19711.901440492813, 19759.209631614718, 1034.4827586206916, 1056.8943105689445, 1057.2282233969206, 1058.253930978662, 1058.8729352477712, 1096.2435919215754, 1100.114407901639, 1101.0530943388678, 1101.2181351240629, 1101.7686285879975, 1100.367288808934, 1142.103448792698, 1151.2574389518754, 1158.28186524355, 1158.9478473468714, 1148.9023433008203, 1152.446825523745, 1152.8097863852454, 1152.8443660105863, 1153.521288665203, 820.4789958376414, 820.6020080261069, 820.819419727659, 822.116225058065, 822.3914303415489, 20045.899770501055, 21220.681689774665, 21925.12299508018, 22332.441688957744, 22353.10587576495, 22356.77643223563, 22734.88632556843, 23405.0, 23425.41436464085, 23456.76543234563, 18264.0, 18792.530186745305, 19028.238870445166, 19067.80932190674, 19105.0, 3553.5558055243096, 3562.4300111981956, 3593.1376469647357, 3595.442706380515, 3603.3153700796765, 130947.0, 139648.0, 157005.0, 159735.2013239938, 161419.0, 17654.0, 17787.28850845952, 17956.1021948902, 18050.90974545119, 18174.5456363592, 35603.28793424117, 35724.28551428957, 36015.63984360123, 36102.097447563494, 36288.45567316492, 10227.795444091076, 10297.227707921937, 10341.327813692085, 10366.0, 10366.222533310032, 4583.220852455091, 4599.793009314589, 4607.35497030416, 4613.192691279013, 4629.259318509023, 6382.521310901701, 6523.18460192476, 6551.508636852255, 6598.637074960923, 6618.205815302194, 1311.514739546374, 1328.93355332233, 1334.5462542735515, 1346.696993176547, 1350.844652864933, 713.2261496276598, 723.0997408226791, 733.2813842434444, 742.1279996004673, 754.6151462753925, 13379.598612041655, 13881.722365552632, 13935.790963135561, 14970.17664028489, 15156.848431515544, 724.9565026098451, 743.2827321634649, 745.2919726260075, 750.1298493747227, 754.3964828137468, 6610.7025183866845, 6710.9262517996885, 6763.256041835394, 6767.221769496472, 6795.0, 154560.0, 155233.96767791963, 155936.22031889996, 158206.0, 161905.0, 125386.3730681359, 129542.35228823796, 133008.0, 133187.0, 138950.0, 115287.42356288333, 117001.0, 117097.0, 118171.8182818178, 118605.0, 13198.736025279248, 13208.73582528325, 13283.269420181983, 13372.264525451194, 13385.464581416634, 58432.4156758427, 58560.0, 58645.0, 58742.706286468296, 61567.0, 75912.24087759052, 76483.61758191173, 77011.2298877004, 77315.0, 79049.20950790419, 19691.507712307306, 20482.38552843417, 20555.07502162436, 20620.381388558366, 20630.381088567367, 19797.703034454207, 20125.39623811288, 20356.592868142852, 20419.183232671123, 20478.0, 22374.552508949404, 22461.663075054214, 22726.545469090855, 22754.31737047891, 23014.42463938415, 22039.33881983543, 22265.44336391603, 22378.0, 22406.439839003502, 22569.661455077858, 21511.677324839828, 21518.354449366543, 21583.784162158805, 21702.782972170076, 21726.0, 14774.0, 14869.702605947605, 14960.775588365965, 14978.700425991638, 15349.462768803038, 13626.386812593655, 13862.237576933365, 13936.512222072179, 14054.086484378891, 14064.08583442073], "value": 10478.924904070136, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 106.0, 105.0, 104.0, 104.0, 107.0, 106.0, 106.0, 105.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 113.0, 112.0, 111.0, 111.0, 112.0, 145.0, 114.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 170.0, 162.0, 162.0, 163.0, 162.0, 160.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 73.0, 73.0, 82.0, 73.0, 75.0, 76.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 76.0, 77.0, 78.0, 77.0, 78.0, 78.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 113.0, 117.0, 113.0, 113.0, 115.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 42.0, 44.0, 44.0, 44.0, 48.0, 43.0, 42.0, 43.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 41.0, 39.0, 38.0, 43.0, 43.0, 44.0, 38.0, 39.0], "value": 40.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 72.0, 69.0, 69.0, 74.0, 69.0, 68.0, 75.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 109.0, 104.0, 106.0, 107.0, 100.0, 112.0, 101.0], "value": 105.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 148.0, 154.0, 156.0, 150.0, 149.0, 154.0, 150.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 59.0, 55.0, 57.0, 56.0, 58.0, 63.0, 60.0], "value": 58.7, "unit": "score"}]}]} 19:16:42 INFO - Return code: 0 19:16:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:16:42 INFO - # TBPL SUCCESS # 19:16:42 INFO - Running post-action listener: _package_coverage_data 19:16:42 INFO - Running post-action listener: _resource_record_post_action 19:16:42 INFO - [mozharness: 2017-10-05 02:16:42.550255Z] Finished run-tests step (success) 19:16:42 INFO - Running post-run listener: _resource_record_post_run 19:16:42 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 372649984; Read time: 164; Write time: 166020 19:16:42 INFO - TinderboxPrint: CPU usage
13.0% 19:16:42 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 164 19:16:42 INFO - TinderboxPrint: I/O write bytes / time
372,649,984 / 166,020 19:16:42 INFO - TinderboxPrint: CPU idle
8,187.3 (86.9%) 19:16:42 INFO - TinderboxPrint: CPU user
1,179.5 (12.5%) 19:16:42 INFO - TinderboxPrint: Swap in / out
0 / 0 19:16:42 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 87298048; Read time: 0; Write time: 31204 19:16:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:16:42 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284794880; Read time: 152; Write time: 134784 19:16:43 INFO - Running post-run listener: _upload_blobber_files 19:16:43 INFO - Blob upload gear active. 19:16:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:16:43 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 19:16:43 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'] 19:16:43 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 19:16:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:44 INFO - (blobuploader) - INFO - Done attempting. 19:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:16:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:51 INFO - (blobuploader) - INFO - Done attempting. 19:16:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:16:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:52 INFO - (blobuploader) - INFO - Done attempting. 19:16:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:16:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:16:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:16:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:16:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:16:53 INFO - (blobuploader) - INFO - Done attempting. 19:16:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:16:53 INFO - Return code: 0 19:16:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:16:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:16:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9a588b93238c7dfb280bbff0f2675dd4d961b88880f175687db387d6f1e1efdf29195f15812de1f87c9f369b65a099c1637fb498a7aee018addeffaf3f640cc7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88bfdd3dfcf59e7846b0e235b0692b15fd32513db92585ea50ddbee70cf98736f84415768fd20393b6d05e09667ac2b6fb8ce51ff3801dc2c9a447b9344829a0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74d6ae5dba17403606292bef1e1cf6b074b6a4b00de0e11d2b3a25757f5306a398b3cacd63c1be8de1ec2a23d42adb24e3a9cd59e1c6c8fc28ec996f387f649b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5c3a152900fa7f1305ef681cbb598286f022a0fe18e49b8a7699faafb9f00d9bd7cc1a6440f1d77a0b998d750e32b9c7812efa6a1b06b459acc7f860d75e8b1"} 19:16:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:16:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:16:53 INFO - Contents: 19:16:53 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9a588b93238c7dfb280bbff0f2675dd4d961b88880f175687db387d6f1e1efdf29195f15812de1f87c9f369b65a099c1637fb498a7aee018addeffaf3f640cc7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88bfdd3dfcf59e7846b0e235b0692b15fd32513db92585ea50ddbee70cf98736f84415768fd20393b6d05e09667ac2b6fb8ce51ff3801dc2c9a447b9344829a0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74d6ae5dba17403606292bef1e1cf6b074b6a4b00de0e11d2b3a25757f5306a398b3cacd63c1be8de1ec2a23d42adb24e3a9cd59e1c6c8fc28ec996f387f649b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5c3a152900fa7f1305ef681cbb598286f022a0fe18e49b8a7699faafb9f00d9bd7cc1a6440f1d77a0b998d750e32b9c7812efa6a1b06b459acc7f860d75e8b1"} 19:16:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:16:53 INFO - Copying logs to upload dir... 19:16:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:16:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.071770 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-10-04 19:16:53.814943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 19:16:53.819920) ========= 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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9a588b93238c7dfb280bbff0f2675dd4d961b88880f175687db387d6f1e1efdf29195f15812de1f87c9f369b65a099c1637fb498a7aee018addeffaf3f640cc7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88bfdd3dfcf59e7846b0e235b0692b15fd32513db92585ea50ddbee70cf98736f84415768fd20393b6d05e09667ac2b6fb8ce51ff3801dc2c9a447b9344829a0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74d6ae5dba17403606292bef1e1cf6b074b6a4b00de0e11d2b3a25757f5306a398b3cacd63c1be8de1ec2a23d42adb24e3a9cd59e1c6c8fc28ec996f387f649b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5c3a152900fa7f1305ef681cbb598286f022a0fe18e49b8a7699faafb9f00d9bd7cc1a6440f1d77a0b998d750e32b9c7812efa6a1b06b459acc7f860d75e8b1"} build_url:https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/P5plh6KMQkyDf6QPX90VPQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9a588b93238c7dfb280bbff0f2675dd4d961b88880f175687db387d6f1e1efdf29195f15812de1f87c9f369b65a099c1637fb498a7aee018addeffaf3f640cc7", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88bfdd3dfcf59e7846b0e235b0692b15fd32513db92585ea50ddbee70cf98736f84415768fd20393b6d05e09667ac2b6fb8ce51ff3801dc2c9a447b9344829a0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/74d6ae5dba17403606292bef1e1cf6b074b6a4b00de0e11d2b3a25757f5306a398b3cacd63c1be8de1ec2a23d42adb24e3a9cd59e1c6c8fc28ec996f387f649b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e5c3a152900fa7f1305ef681cbb598286f022a0fe18e49b8a7699faafb9f00d9bd7cc1a6440f1d77a0b998d750e32b9c7812efa6a1b06b459acc7f860d75e8b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 19:16:53.852048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 19:16:53.852391) ========= 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=1f5564757af27664ca02d71f000001b0-1507167618.868933-835299782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 19:16:53.937471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 19:16:53.937812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 19:16:53.938184) ========= ========= Total master_lag: 0.22 =========