builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1506353305.26 results: success (0) revision: fd78928b00d87444d1aefe942d0489e8682e0981 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.261091) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.261570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.261858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.361926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.362177) ========= 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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 08:28:25-- 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% 33.3M=0s 2017-09-25 08:28:25 (33.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.509081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.512446) ========= 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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019063 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.563101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:25.566451) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd78928b00d87444d1aefe942d0489e8682e0981 --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 fd78928b00d87444d1aefe942d0489e8682e0981 --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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 08:28:25,647 truncating revision to first 12 chars 2017-09-25 08:28:25,647 Setting DEBUG logging. 2017-09-25 08:28:25,647 attempt 1/10 2017-09-25 08:28:25,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fd78928b00d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 08:28:26,043 unpacking tar archive at: mozilla-beta-fd78928b00d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:26.271645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:26.271957) ========= script_repo_revision: fd78928b00d87444d1aefe942d0489e8682e0981 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:26.272346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:26.272613) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 08:28:26.292742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-25 08:28:26.293139) ========= /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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:26 INFO - MultiFileLogger online at 20170925 08:28:26 in /builds/slave/test 08:28:26 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 08:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:26 INFO - {'append_to_log': False, 08:28:26 INFO - 'base_work_dir': '/builds/slave/test', 08:28:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:26 INFO - 'code_coverage': False, 08:28:26 INFO - 'config_files': ('talos/linux_config.py',), 08:28:26 INFO - 'default_actions': ('clobber', 08:28:26 INFO - 'read-buildbot-config', 08:28:26 INFO - 'download-and-extract', 08:28:26 INFO - 'populate-webroot', 08:28:26 INFO - 'create-virtualenv', 08:28:26 INFO - 'install', 08:28:26 INFO - 'setup-mitmproxy', 08:28:26 INFO - 'run-tests'), 08:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:26 INFO - 'disable_ccov_upload': False, 08:28:26 INFO - 'disable_stylo': False, 08:28:26 INFO - 'download_minidump_stackwalk': True, 08:28:26 INFO - 'download_symbols': 'ondemand', 08:28:26 INFO - 'enable_stylo': False, 08:28:26 INFO - 'enable_webrender': False, 08:28:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:26 INFO - 'gecko_profile': False, 08:28:26 INFO - 'gecko_profile_interval': 0, 08:28:26 INFO - 'installer_path': 'installer.exe', 08:28:26 INFO - 'log_level': 'info', 08:28:26 INFO - 'log_name': 'talos', 08:28:26 INFO - 'log_to_console': True, 08:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:26 INFO - 'opt_config_files': (), 08:28:26 INFO - 'pip_index': False, 08:28:26 INFO - 'suite': 'dromaeojs-e10s', 08:28:26 INFO - 'system_bits': '32', 08:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:26 INFO - 'title': 'talos-linux64-ix-028', 08:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:26 INFO - 'use_talos_json': True, 08:28:26 INFO - 'verify': 'False', 08:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:26 INFO - 'work_dir': 'build'} 08:28:26 INFO - [mozharness: 2017-09-25 15:28:26.524188Z] Running clobber step. 08:28:26 INFO - Running pre-action listener: _resource_record_pre_action 08:28:26 INFO - Running main action method: clobber 08:28:26 INFO - rmtree: /builds/slave/test/build 08:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:28 INFO - Running post-action listener: _resource_record_post_action 08:28:28 INFO - [mozharness: 2017-09-25 15:28:28.040082Z] Finished clobber step (success) 08:28:28 INFO - [mozharness: 2017-09-25 15:28:28.040178Z] Running read-buildbot-config step. 08:28:28 INFO - Running pre-action listener: _resource_record_pre_action 08:28:28 INFO - Running main action method: read_buildbot_config 08:28:28 INFO - Using buildbot properties: 08:28:28 INFO - { 08:28:28 INFO - "project": "", 08:28:28 INFO - "product": "firefox", 08:28:28 INFO - "who": "ryanvm@gmail.com", 08:28:28 INFO - "installer_path": "public/build/target.tar.bz2", 08:28:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:28:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:28:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:28:28 INFO - "stage_platform": "linux64", 08:28:28 INFO - "basedir": "/builds/slave/test", 08:28:28 INFO - "buildnumber": 123, 08:28:28 INFO - "platform": "ubuntu64_hw", 08:28:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:28:28 INFO - "slavebuilddir": "test", 08:28:28 INFO - "taskId": "IJfjAhPrQqqFtWnQkDT9HA", 08:28:28 INFO - "branch": "mozilla-beta", 08:28:28 INFO - "script_repo_revision": "production", 08:28:28 INFO - "revision": "fd78928b00d87444d1aefe942d0489e8682e0981", 08:28:28 INFO - "slavename": "talos-linux64-ix-028", 08:28:28 INFO - "repo_path": "releases/mozilla-beta" 08:28:28 INFO - } 08:28:28 INFO - Finding installer, test and symbols from parent task. 08:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJfjAhPrQqqFtWnQkDT9HA'}, attempt #1 08:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJfjAhPrQqqFtWnQkDT9HA'}, attempt #1 08:28:28 INFO - Task dependencies: KsrMMmOkQwqsNvV8pBJuNQ 08:28:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ'}, attempt #1 08:28:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 08:28:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.test_packages.json 08:28:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.crashreporter-symbols.zip 08:28:29 INFO - Running post-action listener: _resource_record_post_action 08:28:29 INFO - [mozharness: 2017-09-25 15:28:29.361027Z] Finished read-buildbot-config step (success) 08:28:29 INFO - [mozharness: 2017-09-25 15:28:29.361247Z] Running download-and-extract step. 08:28:29 INFO - Running pre-action listener: _resource_record_pre_action 08:28:29 INFO - Running main action method: download_and_extract 08:28:29 INFO - mkdir: /builds/slave/test/build/tests 08:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:29 INFO - trying https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.test_packages.json 08:28:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:28:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:28:29 INFO - Downloaded 989 bytes. 08:28:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:28:29 INFO - Using the following test package requirements: 08:28:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:28:29 INFO - u'common': [u'target.common.tests.zip'], 08:28:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:28:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:28:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:28:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:28:29 INFO - u'mozbase': [u'target.common.tests.zip'], 08:28:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:28:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:28:29 INFO - u'web-platform': [u'target.common.tests.zip', 08:28:29 INFO - u'target.web-platform.tests.tar.gz'], 08:28:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:28:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:28:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.common.tests.zip 08:28:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:28:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.common.tests.zip into memory 08:28:32 INFO - Content-Length response header: 55185373 08:28:32 INFO - Bytes received: 55185373 08:28:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.talos.tests.zip 08:28:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:28:43 INFO - Fetch https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.talos.tests.zip into memory 08:28:44 INFO - Content-Length response header: 14509184 08:28:44 INFO - Bytes received: 14509184 08:28: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')]} 08:28:44 INFO - trying https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 08:28:44 INFO - Downloading https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:28:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:28:46 INFO - Downloaded 53504355 bytes. 08:28:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 08:28:46 INFO - mkdir: /builds/slave/test/properties 08:28:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:46 INFO - Contents: 08:28:46 INFO - build_url:https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 08:28:46 INFO - Running post-action listener: _resource_record_post_action 08:28:46 INFO - Running post-action listener: find_tests_for_verification 08:28:46 INFO - Running post-action listener: set_extra_try_arguments 08:28:46 INFO - [mozharness: 2017-09-25 15:28:46.183255Z] Finished download-and-extract step (success) 08:28:46 INFO - [mozharness: 2017-09-25 15:28:46.183351Z] Running populate-webroot step. 08:28:46 INFO - Running pre-action listener: _resource_record_pre_action 08:28:46 INFO - Running main action method: populate_webroot 08:28:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['tresize', 08:28:46 INFO - 'tcanvasmark']}, 08:28:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['dromaeo_css', 08:28:46 INFO - 'kraken']}, 08:28:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'tests': ['damp', 'tps']}, 08:28:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['damp', 'tps']}, 08:28:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['dromaeo_dom']}, 08:28:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:28:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['basic_compositor_video', 08:28:46 INFO - 'glvideo']}, 08:28:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:28:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['ts_paint_webext', 08:28:46 INFO - 'tp5o_webext']}, 08:28:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:46 INFO - 'ts_paint', 08:28:46 INFO - 'tpaint', 08:28:46 INFO - 'sessionrestore', 08:28:46 INFO - 'sessionrestore_many_windows', 08:28:46 INFO - 'sessionrestore_no_auto_restore', 08:28:46 INFO - 'tabpaint']}, 08:28:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['a11yr', 08:28:46 INFO - 'ts_paint', 08:28:46 INFO - 'tpaint', 08:28:46 INFO - 'sessionrestore', 08:28:46 INFO - 'sessionrestore_many_windows', 08:28:46 INFO - 'sessionrestore_no_auto_restore', 08:28:46 INFO - 'tabpaint']}, 08:28:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:28:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:28:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['perf_reftest_singletons']}, 08:28:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['bloom_basic']}, 08:28:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:46 INFO - 'tsvgr_opacity', 08:28:46 INFO - 'tart', 08:28:46 INFO - 'tscrollx', 08:28:46 INFO - 'tsvg_static']}, 08:28:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['tsvgx', 08:28:46 INFO - 'tsvgr_opacity', 08:28:46 INFO - 'tart', 08:28:46 INFO - 'tscrollx', 08:28:46 INFO - 'tsvg_static']}, 08:28:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:28:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo'], 08:28:46 INFO - 'tests': ['tp5o']}, 08:28:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:28:46 INFO - 'talos_options': ['--mitmproxy', 08:28:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:28:46 INFO - '--firstNonBlankPaint'], 08:28:46 INFO - 'tests': ['tp6_google', 08:28:46 INFO - 'tp6_youtube', 08:28:46 INFO - 'tp6_amazon', 08:28:46 INFO - 'tp6_facebook']}, 08:28:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo', 08:28:46 INFO - '--mitmproxy', 08:28:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:28:46 INFO - '--firstNonBlankPaint'], 08:28:46 INFO - 'tests': ['tp6_google', 08:28:46 INFO - 'tp6_youtube', 08:28:46 INFO - 'tp6_amazon', 08:28:46 INFO - 'tp6_facebook']}, 08:28:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:28:46 INFO - 'talos_options': ['--stylo-threads=1', 08:28:46 INFO - '--mitmproxy', 08:28:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:28:46 INFO - '--firstNonBlankPaint'], 08:28:46 INFO - 'tests': ['tp6_google', 08:28:46 INFO - 'tp6_youtube', 08:28:46 INFO - 'tp6_amazon', 08:28:46 INFO - 'tp6_facebook']}, 08:28:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--xperf_path', 08:28:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:46 INFO - 'tests': ['tp5n']}, 08:28:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:28:46 INFO - 'talos_options': ['--disable-stylo', 08:28:46 INFO - '--xperf_path', 08:28:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:46 INFO - 'tests': ['tp5n']}}} 08:28:46 INFO - Running post-action listener: _resource_record_post_action 08:28:46 INFO - [mozharness: 2017-09-25 15:28:46.198286Z] Finished populate-webroot step (success) 08:28:46 INFO - [mozharness: 2017-09-25 15:28:46.198375Z] Running create-virtualenv step. 08:28:46 INFO - Running pre-action listener: _resource_record_pre_action 08:28:46 INFO - Running main action method: create_virtualenv 08:28:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:28:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:28:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:28:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:47 INFO - Installing pip...............done. 08:28:47 INFO - Return code: 0 08:28:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:47 INFO - Reading from file tmpfile_stdout 08:28:47 INFO - Output received: 08:28:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:28:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28: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')]} 08:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28: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', 'pip>=1.5'] in /builds/slave/test/build 08:28: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 pip>=1.5 08:28:47 INFO - Using env: {'DISPLAY': ':0', 08:28:47 INFO - 'HOME': '/home/cltbld', 08:28:47 INFO - 'LANG': 'en_US.UTF-8', 08:28:47 INFO - 'LANGUAGE': 'en_US:en', 08:28:47 INFO - 'LOGNAME': 'cltbld', 08:28:47 INFO - 'MAIL': '/var/mail/cltbld', 08:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:47 INFO - 'MOZ_NO_REMOTE': '1', 08:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:47 INFO - 'NO_EM_RESTART': '1', 08:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:47 INFO - 'PWD': '/builds/slave/test', 08:28:47 INFO - 'SHELL': '/bin/bash', 08:28:47 INFO - 'SHLVL': '1', 08:28:47 INFO - 'TERM': 'linux', 08:28:47 INFO - 'TMOUT': '86400', 08:28:47 INFO - 'USER': 'cltbld', 08:28:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:47 INFO - '_': '/tools/buildbot/bin/python'} 08:28:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:28:48 INFO - Downloading/unpacking pip>=1.5 08:28:48 INFO - Running setup.py egg_info for package pip 08:28:48 INFO - warning: no files found matching 'pip/cacert.pem' 08:28:48 INFO - warning: no files found matching '*.html' under directory 'docs' 08:28:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:28:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:28:48 INFO - Installing collected packages: pip 08:28:48 INFO - Found existing installation: pip 1.1 08:28:48 INFO - Uninstalling pip: 08:28:48 INFO - Successfully uninstalled pip 08:28:48 INFO - Running setup.py install for pip 08:28:48 INFO - warning: no files found matching 'pip/cacert.pem' 08:28:48 INFO - warning: no files found matching '*.html' under directory 'docs' 08:28:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:28:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:28:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:28:48 INFO - Successfully installed pip 08:28:48 INFO - Cleaning up... 08:28:48 INFO - Return code: 0 08:28:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:28:48 INFO - Using env: {'DISPLAY': ':0', 08:28:48 INFO - 'HOME': '/home/cltbld', 08:28:48 INFO - 'LANG': 'en_US.UTF-8', 08:28:48 INFO - 'LANGUAGE': 'en_US:en', 08:28:48 INFO - 'LOGNAME': 'cltbld', 08:28:48 INFO - 'MAIL': '/var/mail/cltbld', 08:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:48 INFO - 'MOZ_NO_REMOTE': '1', 08:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:48 INFO - 'NO_EM_RESTART': '1', 08:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:48 INFO - 'PWD': '/builds/slave/test', 08:28:48 INFO - 'SHELL': '/bin/bash', 08:28:48 INFO - 'SHLVL': '1', 08:28:48 INFO - 'TERM': 'linux', 08:28:48 INFO - 'TMOUT': '86400', 08:28:48 INFO - 'USER': 'cltbld', 08:28:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:48 INFO - '_': '/tools/buildbot/bin/python'} 08:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:49 INFO - Downloading/unpacking psutil>=3.1.1 08:28: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 08:28: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 08:28: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 08:28: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 08:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:50 INFO - Installing collected packages: psutil 08:28:50 INFO - Running setup.py install for psutil 08:28:50 INFO - building 'psutil._psutil_linux' extension 08:28:50 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 08:28:50 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 08:28:50 INFO - building 'psutil._psutil_posix' extension 08:28:50 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 08:28:50 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 08:28:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:50 INFO - Successfully installed psutil 08:28:50 INFO - Cleaning up... 08:28:50 INFO - Return code: 0 08:28:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:50 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')]} 08:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:50 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')]} 08:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:50 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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28:50 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 08:28:50 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 08:28:50 INFO - Using env: {'DISPLAY': ':0', 08:28:50 INFO - 'HOME': '/home/cltbld', 08:28:50 INFO - 'LANG': 'en_US.UTF-8', 08:28:50 INFO - 'LANGUAGE': 'en_US:en', 08:28:50 INFO - 'LOGNAME': 'cltbld', 08:28:50 INFO - 'MAIL': '/var/mail/cltbld', 08:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:50 INFO - 'MOZ_NO_REMOTE': '1', 08:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:50 INFO - 'NO_EM_RESTART': '1', 08:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:50 INFO - 'PWD': '/builds/slave/test', 08:28:50 INFO - 'SHELL': '/bin/bash', 08:28:50 INFO - 'SHLVL': '1', 08:28:50 INFO - 'TERM': 'linux', 08:28:50 INFO - 'TMOUT': '86400', 08:28:50 INFO - 'USER': 'cltbld', 08:28:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:50 INFO - '_': '/tools/buildbot/bin/python'} 08:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28: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 08:28: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 08:28: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 08:28: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 08:28:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:52 INFO - Installing collected packages: mozsystemmonitor 08:28:52 INFO - Running setup.py install for mozsystemmonitor 08:28:52 INFO - Successfully installed mozsystemmonitor 08:28:52 INFO - Cleaning up... 08:28:53 INFO - Return code: 0 08:28:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28:53 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 08:28:53 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 08:28:53 INFO - Using env: {'DISPLAY': ':0', 08:28:53 INFO - 'HOME': '/home/cltbld', 08:28:53 INFO - 'LANG': 'en_US.UTF-8', 08:28:53 INFO - 'LANGUAGE': 'en_US:en', 08:28:53 INFO - 'LOGNAME': 'cltbld', 08:28:53 INFO - 'MAIL': '/var/mail/cltbld', 08:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:53 INFO - 'MOZ_NO_REMOTE': '1', 08:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:53 INFO - 'NO_EM_RESTART': '1', 08:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:53 INFO - 'PWD': '/builds/slave/test', 08:28:53 INFO - 'SHELL': '/bin/bash', 08:28:53 INFO - 'SHLVL': '1', 08:28:53 INFO - 'TERM': 'linux', 08:28:53 INFO - 'TMOUT': '86400', 08:28:53 INFO - 'USER': 'cltbld', 08:28:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:53 INFO - '_': '/tools/buildbot/bin/python'} 08:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:53 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:55 INFO - warning: no files found matching '*.txt' 08:28:55 INFO - no previously-included directories found matching 'build' 08:28:55 INFO - no previously-included directories found matching 'dist' 08:28:55 INFO - no previously-included directories found matching '.git*' 08:28:55 INFO - Installing collected packages: jsonschema, functools32 08:28:55 INFO - Running setup.py install for functools32 08:28:57 INFO - warning: no files found matching '*.txt' 08:28:57 INFO - no previously-included directories found matching 'build' 08:28:57 INFO - no previously-included directories found matching 'dist' 08:28:57 INFO - no previously-included directories found matching '.git*' 08:28:57 INFO - Successfully installed jsonschema functools32 08:28:57 INFO - Cleaning up... 08:28:57 INFO - Return code: 0 08:28:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28:57 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 08:28:57 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 08:28:57 INFO - Using env: {'DISPLAY': ':0', 08:28:57 INFO - 'HOME': '/home/cltbld', 08:28:57 INFO - 'LANG': 'en_US.UTF-8', 08:28:57 INFO - 'LANGUAGE': 'en_US:en', 08:28:57 INFO - 'LOGNAME': 'cltbld', 08:28:57 INFO - 'MAIL': '/var/mail/cltbld', 08:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:57 INFO - 'MOZ_NO_REMOTE': '1', 08:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:57 INFO - 'NO_EM_RESTART': '1', 08:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:57 INFO - 'PWD': '/builds/slave/test', 08:28:57 INFO - 'SHELL': '/bin/bash', 08:28:57 INFO - 'SHLVL': '1', 08:28:57 INFO - 'TERM': 'linux', 08:28:57 INFO - 'TMOUT': '86400', 08:28:57 INFO - 'USER': 'cltbld', 08:28:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:57 INFO - '_': '/tools/buildbot/bin/python'} 08:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:58 INFO - Cleaning up... 08:28:58 INFO - Return code: 0 08:28:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28: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')]} 08:28:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:58 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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:28:58 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 08:28:58 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 08:28:58 INFO - Using env: {'DISPLAY': ':0', 08:28:58 INFO - 'HOME': '/home/cltbld', 08:28:58 INFO - 'LANG': 'en_US.UTF-8', 08:28:58 INFO - 'LANGUAGE': 'en_US:en', 08:28:58 INFO - 'LOGNAME': 'cltbld', 08:28:58 INFO - 'MAIL': '/var/mail/cltbld', 08:28:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:58 INFO - 'MOZ_NO_REMOTE': '1', 08:28:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:58 INFO - 'NO_EM_RESTART': '1', 08:28:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:58 INFO - 'PWD': '/builds/slave/test', 08:28:58 INFO - 'SHELL': '/bin/bash', 08:28:58 INFO - 'SHLVL': '1', 08:28:58 INFO - 'TERM': 'linux', 08:28:58 INFO - 'TMOUT': '86400', 08:28:58 INFO - 'USER': 'cltbld', 08:28:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:28:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:58 INFO - '_': '/tools/buildbot/bin/python'} 08:28:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:28: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 08:28: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 08:28: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 08:28: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 08:28:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:59 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 08:28:59 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 08:28:59 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 08:28:59 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 08:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:59 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 08:28:59 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 08:28:59 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 08:28:59 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 08:28:59 INFO - Downloading docopt-0.6.1.tar.gz 08:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:00 INFO - Running setup.py install for blobuploader 08:29:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:00 INFO - Running setup.py install for requests 08:29:00 INFO - Running setup.py install for docopt 08:29:00 INFO - Successfully installed blobuploader requests docopt 08:29:00 INFO - Cleaning up... 08:29:00 INFO - Return code: 0 08:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29: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')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29: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')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:29:00 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 08:29:00 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 08:29:00 INFO - Using env: {'DISPLAY': ':0', 08:29:00 INFO - 'HOME': '/home/cltbld', 08:29:00 INFO - 'LANG': 'en_US.UTF-8', 08:29:00 INFO - 'LANGUAGE': 'en_US:en', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MAIL': '/var/mail/cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SHLVL': '1', 08:29:00 INFO - 'TERM': 'linux', 08:29:00 INFO - 'TMOUT': '86400', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - '_': '/tools/buildbot/bin/python'} 08:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:00 INFO - Running setup.py (path:/tmp/pip-G1hWjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:00 INFO - Running setup.py (path:/tmp/pip-a8dKXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:01 INFO - Running setup.py (path:/tmp/pip-v3dUMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:01 INFO - Running setup.py (path:/tmp/pip-8Mlhrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:01 INFO - Running setup.py (path:/tmp/pip-GLfsuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:01 INFO - Running setup.py (path:/tmp/pip-Zsu82O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:01 INFO - Running setup.py (path:/tmp/pip-AnlCEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:01 INFO - Running setup.py (path:/tmp/pip-Cq0CFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:01 INFO - Running setup.py (path:/tmp/pip-lWyqLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:01 INFO - Running setup.py (path:/tmp/pip-IBeLeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:01 INFO - Running setup.py (path:/tmp/pip-Lt04NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:01 INFO - Running setup.py (path:/tmp/pip-GOAXD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:01 INFO - Running setup.py (path:/tmp/pip-JeOb2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:01 INFO - Running setup.py (path:/tmp/pip-b7trEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:01 INFO - Running setup.py (path:/tmp/pip-Wp843L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:01 INFO - Running setup.py (path:/tmp/pip-2DHYpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:02 INFO - Running setup.py (path:/tmp/pip-cundK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:02 INFO - Running setup.py install for manifestparser 08:29:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Running setup.py install for mozcrash 08:29:02 INFO - Running setup.py install for mozdebug 08:29:02 INFO - Running setup.py install for mozdevice 08:29:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Running setup.py install for mozfile 08:29:02 INFO - Running setup.py install for mozhttpd 08:29:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Running setup.py install for mozinfo 08:29:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Running setup.py install for mozInstall 08:29:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:02 INFO - Running setup.py install for mozleak 08:29:02 INFO - Running setup.py install for mozlog 08:29:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Running setup.py install for moznetwork 08:29:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Running setup.py install for mozprocess 08:29:03 INFO - Running setup.py install for mozprofile 08:29:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Running setup.py install for mozrunner 08:29:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Running setup.py install for mozscreenshot 08:29:03 INFO - Running setup.py install for moztest 08:29:03 INFO - Running setup.py install for mozversion 08:29:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:03 INFO - Cleaning up... 08:29:03 INFO - Return code: 0 08:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:03 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')]} 08:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:03 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')]} 08:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:03 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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:29:03 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 08:29:03 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 08:29:03 INFO - Using env: {'DISPLAY': ':0', 08:29:03 INFO - 'HOME': '/home/cltbld', 08:29:03 INFO - 'LANG': 'en_US.UTF-8', 08:29:03 INFO - 'LANGUAGE': 'en_US:en', 08:29:03 INFO - 'LOGNAME': 'cltbld', 08:29:03 INFO - 'MAIL': '/var/mail/cltbld', 08:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:03 INFO - 'MOZ_NO_REMOTE': '1', 08:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:03 INFO - 'NO_EM_RESTART': '1', 08:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:03 INFO - 'PWD': '/builds/slave/test', 08:29:03 INFO - 'SHELL': '/bin/bash', 08:29:03 INFO - 'SHLVL': '1', 08:29:03 INFO - 'TERM': 'linux', 08:29:03 INFO - 'TMOUT': '86400', 08:29:03 INFO - 'USER': 'cltbld', 08:29:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:03 INFO - '_': '/tools/buildbot/bin/python'} 08:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:04 INFO - Running setup.py (path:/tmp/pip-YBnAqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:04 INFO - Running setup.py (path:/tmp/pip-EiYC4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:04 INFO - Running setup.py (path:/tmp/pip-gtz21Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:04 INFO - Running setup.py (path:/tmp/pip-hj2zyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:04 INFO - Running setup.py (path:/tmp/pip-aunXpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:04 INFO - Running setup.py (path:/tmp/pip-Ta8lcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:04 INFO - Running setup.py (path:/tmp/pip-y8OWaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:04 INFO - Running setup.py (path:/tmp/pip-qFZflD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:04 INFO - Running setup.py (path:/tmp/pip-3_jBKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:04 INFO - Running setup.py (path:/tmp/pip-ygwLXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:04 INFO - Running setup.py (path:/tmp/pip-5s8WGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:04 INFO - Running setup.py (path:/tmp/pip-0Vkt6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:04 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)) 08:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:04 INFO - Running setup.py (path:/tmp/pip-VCxYlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:05 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)) 08:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:05 INFO - Running setup.py (path:/tmp/pip-FRlqdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:05 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)) 08:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:05 INFO - Running setup.py (path:/tmp/pip-3tA9Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:05 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)) 08:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:05 INFO - Running setup.py (path:/tmp/pip-aJsHux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:05 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)) 08:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:05 INFO - Running setup.py (path:/tmp/pip-j1xLtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:06 INFO - Downloading blessings-1.6.tar.gz 08:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:06 INFO - Installing collected packages: blessings 08:29:06 INFO - Running setup.py install for blessings 08:29:06 INFO - Successfully installed blessings 08:29:06 INFO - Cleaning up... 08:29:06 INFO - Return code: 0 08:29:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:06 INFO - Reading from file tmpfile_stdout 08:29:06 INFO - Current package versions: 08:29:06 INFO - argparse == 1.2.1 08:29:06 INFO - blessings == 1.6 08:29:06 INFO - blobuploader == 1.2.4 08:29:06 INFO - docopt == 0.6.1 08:29:06 INFO - functools32 == 3.2.3-2 08:29:06 INFO - jsonschema == 2.5.1 08:29:06 INFO - manifestparser == 1.1 08:29:06 INFO - mozInstall == 1.13 08:29:06 INFO - mozcrash == 1.0 08:29:06 INFO - mozdebug == 0.1 08:29:06 INFO - mozdevice == 0.51 08:29:06 INFO - mozfile == 1.2 08:29:06 INFO - mozhttpd == 0.7 08:29:06 INFO - mozinfo == 0.10 08:29:06 INFO - mozleak == 0.1 08:29:06 INFO - mozlog == 3.5 08:29:06 INFO - moznetwork == 0.27 08:29:06 INFO - mozprocess == 0.25 08:29:06 INFO - mozprofile == 0.28 08:29:06 INFO - mozrunner == 6.13 08:29:06 INFO - mozscreenshot == 0.1 08:29:06 INFO - mozsystemmonitor == 0.3 08:29:06 INFO - moztest == 0.8 08:29:06 INFO - mozversion == 1.4 08:29:06 INFO - psutil == 3.1.1 08:29:06 INFO - requests == 1.2.3 08:29:06 INFO - wsgiref == 0.1.2 08:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:06 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')]} 08:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:06 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')]} 08:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:06 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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:29:06 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 08:29:06 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 08:29:06 INFO - Using env: {'DISPLAY': ':0', 08:29:06 INFO - 'HOME': '/home/cltbld', 08:29:06 INFO - 'LANG': 'en_US.UTF-8', 08:29:06 INFO - 'LANGUAGE': 'en_US:en', 08:29:06 INFO - 'LOGNAME': 'cltbld', 08:29:06 INFO - 'MAIL': '/var/mail/cltbld', 08:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:06 INFO - 'MOZ_NO_REMOTE': '1', 08:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:06 INFO - 'NO_EM_RESTART': '1', 08:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:06 INFO - 'PWD': '/builds/slave/test', 08:29:06 INFO - 'SHELL': '/bin/bash', 08:29:06 INFO - 'SHLVL': '1', 08:29:06 INFO - 'TERM': 'linux', 08:29:06 INFO - 'TMOUT': '86400', 08:29:06 INFO - 'USER': 'cltbld', 08:29:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:06 INFO - '_': '/tools/buildbot/bin/python'} 08:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 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)) 08:29:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:29:07 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 08:29:07 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 08:29:07 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 08:29:07 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 08:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:29:08 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)) 08:29:08 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)) 08:29:08 INFO - Installing collected packages: simplejson 08:29:08 INFO - Running setup.py install for simplejson 08:29:08 INFO - building 'simplejson._speedups' extension 08:29:08 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 08:29:09 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 08:29:09 INFO - Successfully installed simplejson 08:29:09 INFO - Cleaning up... 08:29:09 INFO - Return code: 0 08:29:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:09 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')]} 08:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:09 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')]} 08:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x180c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, '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': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', '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 08:29:09 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 08:29:09 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 08:29:09 INFO - Using env: {'DISPLAY': ':0', 08:29:09 INFO - 'HOME': '/home/cltbld', 08:29:09 INFO - 'LANG': 'en_US.UTF-8', 08:29:09 INFO - 'LANGUAGE': 'en_US:en', 08:29:09 INFO - 'LOGNAME': 'cltbld', 08:29:09 INFO - 'MAIL': '/var/mail/cltbld', 08:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:09 INFO - 'MOZ_NO_REMOTE': '1', 08:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:09 INFO - 'NO_EM_RESTART': '1', 08:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:09 INFO - 'PWD': '/builds/slave/test', 08:29:09 INFO - 'SHELL': '/bin/bash', 08:29:09 INFO - 'SHLVL': '1', 08:29:09 INFO - 'TERM': 'linux', 08:29:09 INFO - 'TMOUT': '86400', 08:29:09 INFO - 'USER': 'cltbld', 08:29:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:09 INFO - '_': '/tools/buildbot/bin/python'} 08:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:09 INFO - Cleaning up... 08:29:09 INFO - Return code: 0 08:29:09 INFO - Running post-action listener: _resource_record_post_action 08:29:09 INFO - Running post-action listener: _start_resource_monitoring 08:29:09 INFO - Starting resource monitoring. 08:29:09 INFO - [mozharness: 2017-09-25 15:29:09.620074Z] Finished create-virtualenv step (success) 08:29:09 INFO - [mozharness: 2017-09-25 15:29:09.620585Z] Running install step. 08:29:09 INFO - Running pre-action listener: _resource_record_pre_action 08:29:09 INFO - Running main action method: install 08:29:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:09 INFO - Reading from file tmpfile_stdout 08:29:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:09 INFO - Reading from file tmpfile_stdout 08:29:09 INFO - Output received: 08:29:09 INFO - Usage: mozinstall [options] installer 08:29:09 INFO - Options: 08:29:09 INFO - -h, --help show this help message and exit 08:29:09 INFO - -d DEST, --destination=DEST 08:29:09 INFO - Directory to install application into. [default: 08:29:09 INFO - "/builds/slave/test"] 08:29:09 INFO - --app=APP Application being installed. [default: firefox] 08:29:09 INFO - mkdir: /builds/slave/test/build/application 08:29:09 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'] 08:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:29:24 INFO - Reading from file tmpfile_stdout 08:29:24 INFO - Output received: 08:29:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:24 INFO - Running post-action listener: _resource_record_post_action 08:29:24 INFO - [mozharness: 2017-09-25 15:29:24.552968Z] Finished install step (success) 08:29:24 INFO - [mozharness: 2017-09-25 15:29:24.553115Z] Running setup-mitmproxy step. 08:29:24 INFO - Running pre-action listener: _resource_record_pre_action 08:29:24 INFO - Running main action method: setup_mitmproxy 08:29:24 INFO - Skipping: mitmproxy is not required 08:29:24 INFO - Running post-action listener: _resource_record_post_action 08:29:24 INFO - [mozharness: 2017-09-25 15:29:24.553643Z] Finished setup-mitmproxy step (success) 08:29:24 INFO - [mozharness: 2017-09-25 15:29:24.553748Z] Running run-tests step. 08:29:24 INFO - Running pre-action listener: _resource_record_pre_action 08:29:24 INFO - Running pre-action listener: _set_gcov_prefix 08:29:24 INFO - Running main action method: run_tests 08:29:24 WARNING - Try message not found. 08:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:24 INFO - Python 2.7.3 08:29:24 INFO - Return code: 0 08:29:24 INFO - grabbing minidump binary from tooltool 08:29:24 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')]} 08:29:24 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 0x1b7b090>, '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 0x1b7bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b75f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:24 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 08:29:24 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 08:29:24 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 08:29:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:24 INFO - Return code: 0 08:29:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:24 INFO - ENV: RUST_BACKTRACE is now full 08:29:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:24 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/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:29:24 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/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 08:29:24 INFO - Using env: {'DISPLAY': ':0', 08:29:24 INFO - 'HOME': '/home/cltbld', 08:29:24 INFO - 'LANG': 'en_US.UTF-8', 08:29:24 INFO - 'LANGUAGE': 'en_US:en', 08:29:24 INFO - 'LOGNAME': 'cltbld', 08:29:24 INFO - 'MAIL': '/var/mail/cltbld', 08:29:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:24 INFO - 'MOZ_NO_REMOTE': '1', 08:29:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:24 INFO - 'NO_EM_RESTART': '1', 08:29:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:24 INFO - 'PWD': '/builds/slave/test', 08:29:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:24 INFO - 'RUST_BACKTRACE': 'full', 08:29:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:29:24 INFO - 'SHELL': '/bin/bash', 08:29:24 INFO - 'SHLVL': '1', 08:29:24 INFO - 'TERM': 'linux', 08:29:24 INFO - 'TMOUT': '86400', 08:29:24 INFO - 'USER': 'cltbld', 08:29:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:24 INFO - '_': '/tools/buildbot/bin/python'} 08:29:24 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/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 08:29:24 INFO - mozversion application_buildid: 20170925140906 08:29:24 INFO - mozversion application_changeset: fd78928b00d87444d1aefe942d0489e8682e0981 08:29:24 INFO - mozversion application_display_name: Firefox 08:29:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:24 INFO - mozversion application_name: Firefox 08:29:24 INFO - mozversion application_remotingname: firefox 08:29:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:29:24 INFO - mozversion application_vendor: Mozilla 08:29:24 INFO - mozversion application_version: 57.0 08:29:24 INFO - mozversion platform_buildid: 20170925140906 08:29:24 INFO - mozversion platform_changeset: fd78928b00d87444d1aefe942d0489e8682e0981 08:29:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:29:24 INFO - mozversion platform_version: 57.0 08:29:24 INFO - using testdate: 1506353364 08:29:24 INFO - actual date: 1506353364 08:29:24 INFO - starting webserver on 'localhost:54751' 08:29:24 INFO - SUITE-START | Running 2 tests 08:29:24 INFO - TEST-START | dromaeo_css 08:29:24 INFO - Initialising browser for dromaeo_css test... 08:29:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54751/getInfo.html -profile /tmp/tmpwjQwPv/profile 08:29:24 INFO - TEST-INFO | started process 15790 (/builds/slave/test/build/application/firefox/firefox http://localhost:54751/getInfo.html) 08:29:30 INFO - TEST-INFO | 15790: exit 0 08:29:30 INFO - Browser initialized. 08:29:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:30 INFO - Using env: {'DISPLAY': ':0', 08:29:30 INFO - 'HOME': '/home/cltbld', 08:29:30 INFO - 'JSGC_DISABLE_POISONING': '1', 08:29:30 INFO - 'LANG': 'en_US.UTF-8', 08:29:30 INFO - 'LANGUAGE': 'en_US:en', 08:29:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:29:30 INFO - 'LOGNAME': 'cltbld', 08:29:30 INFO - 'MAIL': '/var/mail/cltbld', 08:29:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:30 INFO - 'MOZ_CRASHREPORTER': '1', 08:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:29:30 INFO - 'MOZ_NO_REMOTE': '1', 08:29:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:30 INFO - 'NO_EM_RESTART': '1', 08:29:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:30 INFO - 'PWD': '/builds/slave/test', 08:29:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:30 INFO - 'RUST_BACKTRACE': 'full', 08:29:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:29:30 INFO - 'SHELL': '/bin/bash', 08:29:30 INFO - 'SHLVL': '1', 08:29:30 INFO - 'TERM': 'linux', 08:29:30 INFO - 'TMOUT': '86400', 08:29:30 INFO - 'USER': 'cltbld', 08:29:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:30 INFO - '_': '/tools/buildbot/bin/python'} 08:29:30 INFO - TEST-INFO | started process 15982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjQwPv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:31 INFO - PID 15982 | 08:29:31 INFO - PID 15982 | (/builds/slave/test/build/application/firefox/firefox:16030): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:29:31 INFO - PID 15982 | 08:29:41 INFO - PID 15982 | RSS: Main: 141398016 08:29:41 INFO - PID 15982 | 08:32:39 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54751/tests/dromaeo/cssquery-ext.html) 08:32:40 INFO - PID 15982 | RSS: Main: 145367040 08:32:40 INFO - PID 15982 | 08:35:41 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-ext.html (next: http://localhost:54751/tests/dromaeo/cssquery-jquery.html) 08:35:42 INFO - PID 15982 | RSS: Main: 144113664 08:35:42 INFO - PID 15982 | 08:38:43 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54751/tests/dromaeo/cssquery-mootools.html) 08:38:44 INFO - PID 15982 | RSS: Main: 145248256 08:38:44 INFO - PID 15982 | 08:41:45 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54751/tests/dromaeo/cssquery-prototype.html) 08:41:46 INFO - PID 15982 | RSS: Main: 144965632 08:41:46 INFO - PID 15982 | 08:44:49 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54751/tests/dromaeo/cssquery-yui.html) 08:44:50 INFO - PID 15982 | RSS: Main: 146374656 08:44:50 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | Cycle 1(1): loaded http://localhost:54751/tests/dromaeo/cssquery-yui.html (next: http://localhost:54751/tests/dromaeo/cssquery-dojo.html) 08:47:51 INFO - PID 15982 | RSS: Main: 148672512 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | __start_tp_report 08:47:51 INFO - PID 15982 | _x_x_mozilla_page_load 08:47:51 INFO - PID 15982 | _x_x_mozilla_page_load_details 08:47:51 INFO - PID 15982 | |i|pagename|runs| 08:47:51 INFO - PID 15982 | |0;dojo.html;4000.4999375078114;4006.4991876015497;4015.116674331646;4034.112495251047;4039.555648878623;6512.381323774234;6564.343565643439;6573.605583664984;6589.439897608703;6671.866562668743;6499.675016249193;6528.640924749148;6545.672716364186;6601.900971485419;6630.336966303379;5830.5044071254;5871.089981052923;5916.911246331287;5946.197263369444;5946.821595352125;5901.144334071557;5928.49607783339;5932.970335148319;5961.642301461904;6037.72830222641;5905.173275741378;5942.702864856761;5968.970155149218;5972.910406343908;5978.372270911535;5939.3763654816485;5954.821355359346;6004.399560044004;6012.368701286346;6035.78874739382;5846.415358464162;5942.138389933435;5955.583109182359;6010;6014.12795144706;6445.903311450332;6446.129772480749;6502;6520.2175738911155;6534.085228068075;7164.247753985861;7181.06646135999;7195.856082878313;7227.7831665050135;7230.421566274686;7172.426205903515;7188.604626745527;7202.53183543068;7274.781756547259;7275.4179665626625;6589.571677840925;6627.502937279675;6655.46756259498;6660.200775906874;6761;7303.342699157101;7312.378447831888;7391.408687305003;7396.667149978264;7406.666699998513;6943.618101004392;7095;7109.324614161646;7118.074650295428;7120.60836653989;7134.108236470442;7169.103862017248;7176.138863336433;7240.348368646847;7283.562986220738;7021.543599666005;7084.539504932163;7107.71569137239;7155;7159.355657990805;7103.431725461951;7134.250903655042;7172.103487064117;7175.497715159993;7193.2447093055525;5255.106631872591;5321.095413779667;5329.307190065267;5334.333208348957;5344.652597581145;4775.617950563947;4793.832215872428;4812.181929072066;4824.734639594856;4845.297431872429;6670.666466676646;6682.231543372477;6688.665566721645;6707.3628005339415;6714.294999025032;7099.96450017757;7106.040684507525;7177.138743350727;7178.246284140195;7204.53170543913;6573.276939536647;6619.437347825393;6620.702068406933;6677.732890684319;6692.899606505906;5976.073708575178;6010.519158467312;6039.818805435844;6047.12316714074;6053.303870054912;7425.294597013275;7434.145073316529;7477.513961592479;7531.209223031612;7554.093508778872;6997;7090.220075791555;7098.36114749675;7110.288971102952;7223.674934628059;7446;7467.775966721007;7538;7553.546787192567;7557.962210188914;6973.267806880407;7047.577145371089;7135.322144396274;7148.142222933281;7151.642417878981;7102.3962963148715;7135.607541585263;7176.605286709281;7264.564126152448;7269.345758881726;6775.390214880685;6806.217285012287;6873.5875847449315;6940.444764418733;6975.197852247056;6871.4159296458365;6874.072000279898;6920.653967301715;6947.652617369213;6953.895691564529;6810.182778066664;6811;6895.931040689529;6896.206936202401;6923.5499692519825;6887.414569761627;6931.2375638678695;6931.618760967994;7014.403775679124;7035.366816986496;6656.467482601477;6776.254611992578;6777.085093512313;6842.418394436529;6871.9656401717675 08:47:51 INFO - PID 15982 | |1;ext.html;970.2577528190933;976.9316147869652;985.0789511806466;998.5706146357065;1028.6399760083966;45575;46439.99999999991;46471;46473;46477.302840457334;43141;43307.56692433075;43427.34858977118;43431.13137737243;43443.565564344346;8115.14790946951;8256.628451719656;8289.792755181139;8290.046644635853;8296.004479462474;8137.9593102034405;8198.713045043425;8222.342212622976;8250.298724608385;8253.546054966975;8453.619587118594;8596.312295016383;8596.828063438728;8601.655933762673;8604;8432.072472028072;8461.15388461152;8467.703630372938;8511.74464766058;8522.87215691765;8685;8743.606537705818;8778.517181555011;8808.42745221565;8860.158284962918;40565;40769.18461630751;40791.59208407908;40870;40878;3843.5387753469763;3880.5343358797127;3881.4565960765517;3882.9805850970847;3888.1446081861945;33823;33981.83009084963;34076.6592334076;34334.14164645879;34372.82813585941;5663;5700;5710.343310519302;5720.256366672347;5798.797042103548;230531;233560;234441;234656;236029;52920;52962.20556691653;52988.470115299126;53061.734691326295;56112.719436402556;58414.70792646095;59492.40507594955;59513.70243148843;59523.70238148781;59624.70187649034;18350.449486515427;18419.355322563646;18468;18495.90752046231;18553.072346382898;14764.335604897806;14852.70294594102;14954.252287385587;14964.251787410585;14976.850231497763;16274.837251627569;16424.589385265226;16469.258883350278;16494.505164845075;16538.58653533647;6156.353582873734;6168.884713219795;6230.844228894314;6265.4361107499635;6279.340669229665;1131.598282609678;1134.7390100276818;1141.783061218366;1145.3585991844427;1155.7168493719093;26311.73688263093;26496.60255096175;26893;27036.32409189786;27195.456090878466;1234.7407044520571;1242.8011518157052;1249.2379648414642;1252.918560293578;1274.0826604844683;14199.929000354932;14305.856941430453;14338.426462941574;14346.067505612102;14466.132032078109;297028;299291;299444;299521;300998;61073;61097.69451152716;65535.672321638085;65922;65985.34014659889;1568.114015581193;1570.1599644190076;1580.3836503763541;1580.5337425459518;1586.88098392621;31374.686253137177;31589.5261571072;31943;32564.51153232656;32638.020859374257;42584.78707606442;42697.359539607554;42746.14507709766;42852.35721464243;42867.142657147306;258927;259131;261729;262092;262707;38377.61622383852;39157.280058394404;39391.606083938794;39421;39468.40797387984;47968.760156198994;48095.75952120217;48953;49046;49051.509484904695;35598.82200589084;35674.643253567134;35990.46014309735;35996.28007439889;36629.63370366262;34809;35095.47356789599;35450.64549354473;35672.821635891654;36037;41701;42188.578114218464;42192.78903605462;42595;42730;33868.605842517325;33940.321193575495;34022;34483.65516344804;35162.47256291106;26037.349066272738;26050.478990419706;26492.337691557866;26854.731452685224;26888.32779180458 08:47:51 INFO - PID 15982 | |2;jquery.html;649.0069501125375;652.6555296090057;655.2642716657955;657.8553317228022;665.1286814273302;24644;25358.492830143387;25381;25395;25399.873000635016;26711.732882671215;27169.18492445225;27185;27203.319917002034;27227;6987.231404545496;7154.213036565973;7169.103862017248;7177.318154775288;7183.173934997464;7015.473839462061;7087.397571206454;7113.217546069928;7116.217216106224;7123.643817809115;6539.967300163493;6869.450443964471;6890.896636550456;6892.448604111659;6909.654517274142;7004.08946836913;7037.22590515043;7044.401225895805;7049.541779784297;7055.365017148456;6543.770968016144;6545.5418120731565;6549.541532092755;6559.573627714183;6565.704543295563;29977.550336744967;30516.542251866238;30946.690533094607;30996.845015775;31090;2338.707661542307;2390.1395497620842;2392.9042838286446;2393.9281821545205;2394.042383046778;21226.363209103598;21656.89171554148;21801;21814.345569632937;21868.343949681534;2586.5344238037146;2632.907848225322;2683.946321073587;2695.353115252325;2698.5412479878273;139508;145933.27033364872;158661;162796;163635;16393.59016024609;16677.833221667872;16745.162741863103;16856.74714879278;17412.477625670996;27306;27331.453370932868;27343.589846152325;27360.179194624194;27367.589486157725;11283.871612838815;11358.94320528392;11362;11374.886251137383;11589.029864922983;10227.7443063924;10419.218558608134;10539.473026348653;10547.367157970546;10552.683419497427;10036.749081272881;10116.813203840766;10180.694579162637;10209.234307426972;10357.326773759682;2960.171152077422;3022.0507772487063;3030.575719399286;3050.8965441481173;3146.8269245191736;1063.8988646750577;1076.7792602516465;1079.9514021869036;1083.7832433513172;1088.8475613414128;21411.571768564543;21457.248996285056;21566.892165539073;21669.133234670437;21882;1117.6814607836727;1130.9660710178707;1145.8281257811395;1149.724066224117;1160.785254727878;12016.038716902627;12040.795920408063;12195.39023048844;12226.572069977508;12241.387930603434;584233;584471;606636;610779;613897;124294;126791;127163.36418317849;128634;129509.35245323714;1247.2454165230088;1250.5123002029216;1291.754566632337;1291.791037326164;1293.7089154940063;19219.021051737003;19246.326378576683;19372.515687107934;19437.222511099397;19732.112054957273;62915.6854215726;63584.68207658932;64151;64279.67860160669;65017;81103.59448202721;81122;81126;81891;82140.58929705313;15831.920840396186;16217.864749467895;16310.347586096423;16321.428749993693;16363.2636531354;24239.63640545358;24366.75633243645;24596.262112136665;24647;24862.12982545602;19904.90047549753;20138.798612014278;20185;20208.19167233294;20216.292429765475;15430.919835611849;16053.67892642164;16425.26086326142;17263.3957811476;17777.911110444365;17745.822541774418;17793.466196014142;18355.265789368277;18495.72256416128;18533.629327413644;15588.766168507254;15720.842791571939;15800.525984220492;15878.52364429069;15926.283317250984;17458.650826983136;19612.509687257363;19677.31129410464;19994.500137496678;20076.09657565442 08:47:51 INFO - PID 15982 | |3;mootools.html;1441.4378392426954;1513.0619016209944;1525.1916484263338;1528.487956534561;1533.7776022476735;17348.82651173488;18033.63932721345;18039;18040.90979545102;18052.458426247234;17795.82204177958;17926.19332130054;17942.641147177048;17993.280268789233;18058.187381567826;3127.124405166557;3175.174454641798;3214.100051985436;3222.7744057915957;3223.081421794789;3118.2516196112997;3148.7166155046043;3154.511050787132;3155.532677305053;3162.256869635634;3068.401661675974;3180.2367431816315;3183.029176101288;3183.840807959593;3188.7449004079617;3118.9688103118906;3128.1084890806123;3172.7779055466126;3175.460171770793;3184.45864203086;3090.9072727817975;3092.608326253195;3124.453220686371;3151.6375616803903;3173.76196785242;16914.830851691448;17242.827571724247;17253;17281.395151169774;17351.392701255394;9251.491167985758;9549.28380371468;9608.087231712976;9608.51957402134;9617;6204.937950620481;6209.689515524251;6220.751169953196;6368.29948705642;6418.293987661354;1991.7211590377358;2061.80412860778;2074.8312666771294;2106.694529293259;2120.59708655355;31414.371712565622;31445.213869652984;31544.211394715086;31787.682123178936;31790.205244868834;7902.841943161105;8038.718644847402;8114.3102836258395;8116.35069194463;8315.875261871077;20286.391408257776;20359.898200508902;20361.49096272605;20403.693944590843;20435.795642043686;9147.496887671243;9301.162895339452;9339.486328252011;9368.2973776967;9403.4828084456;8261.091279959199;8292.58537073156;8379.706710265233;8585.484870907765;8616.396852220285;6159.3224745277985;6181.258249010148;6182.381761823782;6215.782447614402;6284.685765711696;1677.505135984863;1743.564108972757;1840.1811194018533;1858.4145994011842;1922.7981061988569;1014.6347314966606;1023.411538365428;1041.390786389955;1044.8171569975225;1052.7315534538643;9241.306901982378;9321.627134914663;9339.719808405758;9395.671151509665;9402.717918462457;1057.2652006855162;1086.380762965118;1092.3445932440632;1099.274478843959;1133.9319640821577;5268;5309.044372012998;5322.600804939645;5360.865978350573;5419.241306217133;25903.481930361664;26662;27110.864445677646;27295.181144565693;27402.725972740416;26132.085377011714;26230.606540901903;26583.867080664473;26808;27063.729362706516;12591.181573197897;12692.80960785589;12878.9356053221;13017.934910325577;13066.0200484964;10101.646442374482;10175.949120254352;10261.28171028021;10328.225383096447;10423.270371073952;22056.007479663775;22075.116995320008;22233.888830555745;22455.88772056129;22652.773472265726;23212.651810223197;23700;23705.288841334786;23817.52364952726;23902.402439939142;12238.08214383907;12331.876681233072;12334.75330493403;12413.379331033593;12418.130730848754;15689.98015129013;16027.118508482145;16027.198640068184;16057.394260573848;16174.433894813625;12653.557125500563;12790.68023299425;12852.357382130669;12975.935120324339;13153.276569788753;12540;12680.74638507243;12705.491780328683;12764.744705106032;12803.167794093353;11204.71988200269;11257.099432045581;11260;11264.929831665979;11357.48891299877;8772.78068048304;8842.91157088421;8916.242119419921;8977.506237157018;9012.909870901207;8280.58597070156;8396.580170991303;8478.83042339162;8513.659453622033;8528.658853645784 08:47:51 INFO - PID 15982 | |4;prototype.html;568.3577557360182;585.3707264690457;598.3776872053065;600.2646757721791;624.5596854217777;6430.839229019277;6507.869842603145;6515.511336649753;6518.250401203863;6558.573692709982;6377;6464.385883341075;6473.773417930373;6493.207920594143;6509.9023514647315;5279.128943724281;5297.523222909937;5308.389535203462;5309.230161626562;5310;4969.801207951696;5262.05283049051;5262.868428289305;5294.2852714883575;5326.7869285228735;5116.846494605168;5131.127708289581;5153.011253472995;5170.276161337416;5185.922211166836;5123.641345105844;5158.53573178412;5163.948360516403;5171.844844654629;5201.115810312256;4670.229412147026;4677.7193368398;4695.624350052022;4702.600278976257;4721.716696998157;6356.4279214870885;6390.88159572073;6392.4886009119155;6424.5502814802985;6425.45383642391;6122.816315510542;6137.508999280047;6137.877242455126;6138.17134686816;6170.413810688023;6769.424598909099;6805.672893785713;6822.249552549216;6823.590584564892;6845.623490708009;5037.899242015139;5150.948490515084;5181.404138524081;5198.792048318062;5237.502437268454;6950.131233595801;7020.1202821234965;7177.677004534757;7181.35367816899;7198.712051517985;5403.378611459732;5436.456354364532;5448.182772584065;5459.808906688327;5474.42518535556;5454.727263636882;5495.230667706524;5518.392976772552;5541.750621221974;5555.250041244381;6014.398560144038;6048.304444988795;6053.395850099727;6063.939360606338;6073;6787.911500267366;6922.619255940871;6932.341427564374;6977.7208911642965;6992.79021629352;1872.7733334665816;1879.9060046997595;1891.394753678837;1901.4218198894885;1921.7323558201456;1285;1335.9198448093146;1355.5594431809702;1355.627202519315;1371.5611004478671;6383.39357761012;6420.454261387741;6494.415502604788;6504.837379065467;6512.316206798313;6833.282505336968;6843.486738494633;6958.582485050913;7006.719731210695;7031.226565077837;6454.257760357619;6457.935420645827;6465.288818229991;6475.870482590321;6482.643454610042;3627.1294889226924;3713.628637136265;3718.3307004738867;3731;3734.9439758403646;7363.765834645101;7374.410047196211;7396.223396543285;7403.85192296151;7449.85100297991;7250.709971601183;7275.126984761862;7283.380912622486;7296.452766042462;7304.707811687579;7169.892451613126;7319.158296795937;7349.118105827228;7383.335499805044;7406.444516661272;6789.367688286743;6819.147606549182;6907.309269073254;6919.827004324731;6998.440124790106;6904.551204171713;6910.861782764216;6953.130858642669;6969.1985421677155;6975.96512017457;7203.8559228816175;7216.5206132743715;7230.493865429369;7286.234945330876;7332.523385979895;5418.891622167455;5419.4038655747045;5422.403535611158;5435.211894275387;5465.262189604353;6574.737010519526;6652.580260049076;6809.319068093151;7023.68393422287;7091.574505529685;6695.296993815579;6747.797566073025;6806.693698783468;6811.523193376416;6827.317268273133;6574.934250657623;6674.232463266592;6676.766313179015;6726.562773419712;6778.3221677831825;6601.504887133388;6684.4318232950745;6685.119862500499;6718;6741.348369649468;6778.389944904982;6846.760363387258;6908.274631163656;6909.481788865754;6944.861102777815;6651.933480665325;6658.533902626769;6658.600483970978;6681.966590167018;6687.164104486939 08:47:51 INFO - PID 15982 | |5;yui.html;1009.0666133826213;1014.4674046125783;1043;1053.2469284461608;1060.5068643080967;20277.391678249638;20636.17455301786;21770.782292177075;22032.669509957344;22138.335849924486;20351.796482035174;20434.284800032;20527.897360513176;20546.48633784156;20565.4858628534;1018.4958445569436;1033.7053939627208;1034.2088302448633;1034.8706411698538;1036.7252678040325;1038.392540363888;1042.5777560088177;1052.1057101463732;1053.4943227250924;1056.820340542106;1092.4537731134433;1102.8345748137763;1122.483657517543;1133.1784456269222;1134.9489272982694;1111.5498223219608;1118.0217309853879;1127.1208457403197;1127.2729089737115;1128.621911659595;814.3729328417086;819.49191501269;820.4912953968518;826.1449399871165;826.7850358906668;21251.8937405312;21382.893085534473;21631.134754609797;21635.350939471842;22465.663015054786;18095.185716642784;18527.073646317764;18527.351542695942;18550.814491855042;18554.814451855444;18919.621607567908;19050.237990480364;19143.234270629157;19180.520486987938;19220.231190752354;4046.615571520701;4080.9183816323803;4113;4119.114390406047;4122.649574786146;159819;160274.1986290061;161367;161732;162983;16339.101349425659;16379.918100409423;16381.180940953143;16516.50450486463;16551.420700275434;33339.66660333414;33686.15784605405;33994.660053399646;34863.12842178966;34972;9290.581923813445;9359.812803743887;9433.339666223435;9433.48115853621;9472.715818525456;4481.551844815493;4520.660950428731;4558.9772051139535;4619.815207391666;4653.7207767534055;6262.843428914222;6394.936050639527;6417.7753778617525;6431.839204019843;6442.774502892376;1079.8110330692255;1123.6235860986499;1127.4644543841773;1131.4851742457163;1135.0182092489936;767.5279702982625;770.4914756260841;787.4212453846418;800.7437619961556;806.479820515764;13443.395047222702;13562.457501700019;14256.85743142576;14513.419463221353;14589.124652520883;787.8345547434989;788.4835432791531;793.2741541489588;800.3597122302135;805.2350267246139;6471.935280647133;6558.114654521579;6565.573237739532;6568.934310656928;6579.210494740566;146588;147736;147954;150163;150374;125892;126981;127281.36359318144;131262;133554;108204;110513.44743276232;111701.44149279202;112648.43675781568;112984.43507782574;12563.434645440795;12761.744765104831;12777.16948398351;12828.230306181658;12838.935805320914;56455.870882581294;56853.44159512749;57408.42591574031;57854.421455786585;59696.40303597082;70596.64701676664;72801.63599182182;73168.26831731827;74325.62837185779;74750.8787368179;16626.16869156513;16970.575735606708;17302.567435814206;17605.82394176042;17613.031283279543;18706.438806835817;18859.24563017464;18871.905640472258;18949.90525047366;19123.90438047801;17135.22891469862;17279.222434990203;17285.827141728423;17350.30598776035;17567.560810979827;16973.151342432582;17003;17128.914355428144;17152.313907444062;17358.479245622653;15664.92167539155;15696.686066278839;15927.522174334788;15984.840151598335;16006.919965400099;11541.653750387502;11755.529778808752;11824.40877956116;12141.514339426678;12188.634340969786;11834.46744896499;11897.583584574499;12038.939805300917;12044.156909016285;12092.879071209527 08:47:51 INFO - PID 15982 | __end_tp_report 08:47:51 INFO - PID 15982 | __start_cc_report 08:47:51 INFO - PID 15982 | _x_x_mozilla_cycle_collect,272 08:47:51 INFO - PID 15982 | __end_cc_report 08:47:51 INFO - PID 15982 | __startTimestamp1506354471759__endTimestamp 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | ------- Summary: start ------- 08:47:51 INFO - PID 15982 | Number of tests: 6 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#0] dojo.html Cycles:165 Average:6600.11 Median:6842.42 stddev:775.30 (11.3%) stddev-sans-first:750.38 08:47:51 INFO - PID 15982 | Values: 4000.5 4006.5 4015.1 4034.1 4039.6 6512.4 6564.3 6573.6 6589.4 6671.9 6499.7 6528.6 6545.7 6601.9 6630.3 5830.5 5871.1 5916.9 5946.2 5946.8 5901.1 5928.5 5933.0 5961.6 6037.7 5905.2 5942.7 5969.0 5972.9 5978.4 5939.4 5954.8 6004.4 6012.4 6035.8 5846.4 5942.1 5955.6 6010.0 6014.1 6445.9 6446.1 6502.0 6520.2 6534.1 7164.2 7181.1 7195.9 7227.8 7230.4 7172.4 7188.6 7202.5 7274.8 7275.4 6589.6 6627.5 6655.5 6660.2 6761.0 7303.3 7312.4 7391.4 7396.7 7406.7 6943.6 7095.0 7109.3 7118.1 7120.6 7134.1 7169.1 7176.1 7240.3 7283.6 7021.5 7084.5 7107.7 7155.0 7159.4 7103.4 7134.3 7172.1 7175.5 7193.2 5255.1 5321.1 5329.3 5334.3 5344.7 4775.6 4793.8 4812.2 4824.7 4845.3 6670.7 6682.2 6688.7 6707.4 6714.3 7100.0 7106.0 7177.1 7178.2 7204.5 6573.3 6619.4 6620.7 6677.7 6692.9 5976.1 6010.5 6039.8 6047.1 6053.3 7425.3 7434.1 7477.5 7531.2 7554.1 6997.0 7090.2 7098.4 7110.3 7223.7 7446.0 7467.8 7538.0 7553.5 7558.0 6973.3 7047.6 7135.3 7148.1 7151.6 7102.4 7135.6 7176.6 7264.6 7269.3 6775.4 6806.2 6873.6 6940.4 6975.2 6871.4 6874.1 6920.7 6947.7 6953.9 6810.2 6811.0 6895.9 6896.2 6923.5 6887.4 6931.2 6931.6 7014.4 7035.4 6656.5 6776.3 6777.1 6842.4 6872.0 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#1] ext.html Cycles:180 Average:45176.76 Median:3885.56 stddev:69184.05 (1780.5%) stddev-sans-first:69298.51 08:47:51 INFO - PID 15982 | Values: 970.3 976.9 985.1 998.6 1028.6 45575.0 46440.0 46471.0 46473.0 46477.3 43141.0 43307.6 43427.3 43431.1 43443.6 8115.1 8256.6 8289.8 8290.0 8296.0 8138.0 8198.7 8222.3 8250.3 8253.5 8453.6 8596.3 8596.8 8601.7 8604.0 8432.1 8461.2 8467.7 8511.7 8522.9 8685.0 8743.6 8778.5 8808.4 8860.2 40565.0 40769.2 40791.6 40870.0 40878.0 3843.5 3880.5 3881.5 3883.0 3888.1 33823.0 33981.8 34076.7 34334.1 34372.8 5663.0 5700.0 5710.3 5720.3 5798.8 230531.0 233560.0 234441.0 234656.0 236029.0 52920.0 52962.2 52988.5 53061.7 56112.7 58414.7 59492.4 59513.7 59523.7 59624.7 18350.4 18419.4 18468.0 18495.9 18553.1 14764.3 14852.7 14954.3 14964.3 14976.9 16274.8 16424.6 16469.3 16494.5 16538.6 6156.4 6168.9 6230.8 6265.4 6279.3 1131.6 1134.7 1141.8 1145.4 1155.7 26311.7 26496.6 26893.0 27036.3 27195.5 1234.7 1242.8 1249.2 1252.9 1274.1 14199.9 14305.9 14338.4 14346.1 14466.1 297028.0 299291.0 299444.0 299521.0 300998.0 61073.0 61097.7 65535.7 65922.0 65985.3 1568.1 1570.2 1580.4 1580.5 1586.9 31374.7 31589.5 31943.0 32564.5 32638.0 42584.8 42697.4 42746.1 42852.4 42867.1 258927.0 259131.0 261729.0 262092.0 262707.0 38377.6 39157.3 39391.6 39421.0 39468.4 47968.8 48095.8 48953.0 49046.0 49051.5 35598.8 35674.6 35990.5 35996.3 36629.6 34809.0 35095.5 35450.6 35672.8 36037.0 41701.0 42188.6 42192.8 42595.0 42730.0 33868.6 33940.3 34022.0 34483.7 35162.5 26037.3 26050.5 26492.3 26854.7 26888.3 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#2] jquery.html Cycles:180 Average:39960.44 Median:21735.07 stddev:100471.25 (462.3%) stddev-sans-first:100709.75 08:47:51 INFO - PID 15982 | Values: 649.0 652.7 655.3 657.9 665.1 24644.0 25358.5 25381.0 25395.0 25399.9 26711.7 27169.2 27185.0 27203.3 27227.0 6987.2 7154.2 7169.1 7177.3 7183.2 7015.5 7087.4 7113.2 7116.2 7123.6 6540.0 6869.5 6890.9 6892.4 6909.7 7004.1 7037.2 7044.4 7049.5 7055.4 6543.8 6545.5 6549.5 6559.6 6565.7 29977.6 30516.5 30946.7 30996.8 31090.0 2338.7 2390.1 2392.9 2393.9 2394.0 21226.4 21656.9 21801.0 21814.3 21868.3 2586.5 2632.9 2683.9 2695.4 2698.5 139508.0 145933.3 158661.0 162796.0 163635.0 16393.6 16677.8 16745.2 16856.7 17412.5 27306.0 27331.5 27343.6 27360.2 27367.6 11283.9 11358.9 11362.0 11374.9 11589.0 10227.7 10419.2 10539.5 10547.4 10552.7 10036.7 10116.8 10180.7 10209.2 10357.3 2960.2 3022.1 3030.6 3050.9 3146.8 1063.9 1076.8 1080.0 1083.8 1088.8 21411.6 21457.2 21566.9 21669.1 21882.0 1117.7 1131.0 1145.8 1149.7 1160.8 12016.0 12040.8 12195.4 12226.6 12241.4 584233.0 584471.0 606636.0 610779.0 613897.0 124294.0 126791.0 127163.4 128634.0 129509.4 1247.2 1250.5 1291.8 1291.8 1293.7 19219.0 19246.3 19372.5 19437.2 19732.1 62915.7 63584.7 64151.0 64279.7 65017.0 81103.6 81122.0 81126.0 81891.0 82140.6 15831.9 16217.9 16310.3 16321.4 16363.3 24239.6 24366.8 24596.3 24647.0 24862.1 19904.9 20138.8 20185.0 20208.2 20216.3 15430.9 16053.7 16425.3 17263.4 17777.9 17745.8 17793.5 18355.3 18495.7 18533.6 15588.8 15720.8 15800.5 15878.5 15926.3 17458.7 19612.5 19677.3 19994.5 20076.1 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#3] mootools.html Cycles:180 Average:10997.17 Median:26017.78 stddev:8079.94 (31.1%) stddev-sans-first:8070.71 08:47:51 INFO - PID 15982 | Values: 1441.4 1513.1 1525.2 1528.5 1533.8 17348.8 18033.6 18039.0 18040.9 18052.5 17795.8 17926.2 17942.6 17993.3 18058.2 3127.1 3175.2 3214.1 3222.8 3223.1 3118.3 3148.7 3154.5 3155.5 3162.3 3068.4 3180.2 3183.0 3183.8 3188.7 3119.0 3128.1 3172.8 3175.5 3184.5 3090.9 3092.6 3124.5 3151.6 3173.8 16914.8 17242.8 17253.0 17281.4 17351.4 9251.5 9549.3 9608.1 9608.5 9617.0 6204.9 6209.7 6220.8 6368.3 6418.3 1991.7 2061.8 2074.8 2106.7 2120.6 31414.4 31445.2 31544.2 31787.7 31790.2 7902.8 8038.7 8114.3 8116.4 8315.9 20286.4 20359.9 20361.5 20403.7 20435.8 9147.5 9301.2 9339.5 9368.3 9403.5 8261.1 8292.6 8379.7 8585.5 8616.4 6159.3 6181.3 6182.4 6215.8 6284.7 1677.5 1743.6 1840.2 1858.4 1922.8 1014.6 1023.4 1041.4 1044.8 1052.7 9241.3 9321.6 9339.7 9395.7 9402.7 1057.3 1086.4 1092.3 1099.3 1133.9 5268.0 5309.0 5322.6 5360.9 5419.2 25903.5 26662.0 27110.9 27295.2 27402.7 26132.1 26230.6 26583.9 26808.0 27063.7 12591.2 12692.8 12878.9 13017.9 13066.0 10101.6 10175.9 10261.3 10328.2 10423.3 22056.0 22075.1 22233.9 22455.9 22652.8 23212.7 23700.0 23705.3 23817.5 23902.4 12238.1 12331.9 12334.8 12413.4 12418.1 15690.0 16027.1 16027.2 16057.4 16174.4 12653.6 12790.7 12852.4 12975.9 13153.3 12540.0 12680.7 12705.5 12764.7 12803.2 11204.7 11257.1 11260.0 11264.9 11357.5 8772.8 8842.9 8916.2 8977.5 9012.9 8280.6 8396.6 8478.8 8513.7 8528.7 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#4] prototype.html Cycles:180 Average:5847.20 Median:6487.93 stddev:1627.93 (25.1%) stddev-sans-first:1583.54 08:47:51 INFO - PID 15982 | Values: 568.4 585.4 598.4 600.3 624.6 6430.8 6507.9 6515.5 6518.3 6558.6 6377.0 6464.4 6473.8 6493.2 6509.9 5279.1 5297.5 5308.4 5309.2 5310.0 4969.8 5262.1 5262.9 5294.3 5326.8 5116.8 5131.1 5153.0 5170.3 5185.9 5123.6 5158.5 5163.9 5171.8 5201.1 4670.2 4677.7 4695.6 4702.6 4721.7 6356.4 6390.9 6392.5 6424.6 6425.5 6122.8 6137.5 6137.9 6138.2 6170.4 6769.4 6805.7 6822.2 6823.6 6845.6 5037.9 5150.9 5181.4 5198.8 5237.5 6950.1 7020.1 7177.7 7181.4 7198.7 5403.4 5436.5 5448.2 5459.8 5474.4 5454.7 5495.2 5518.4 5541.8 5555.3 6014.4 6048.3 6053.4 6063.9 6073.0 6787.9 6922.6 6932.3 6977.7 6992.8 1872.8 1879.9 1891.4 1901.4 1921.7 1285.0 1335.9 1355.6 1355.6 1371.6 6383.4 6420.5 6494.4 6504.8 6512.3 6833.3 6843.5 6958.6 7006.7 7031.2 6454.3 6457.9 6465.3 6475.9 6482.6 3627.1 3713.6 3718.3 3731.0 3734.9 7363.8 7374.4 7396.2 7403.9 7449.9 7250.7 7275.1 7283.4 7296.5 7304.7 7169.9 7319.2 7349.1 7383.3 7406.4 6789.4 6819.1 6907.3 6919.8 6998.4 6904.6 6910.9 6953.1 6969.2 6976.0 7203.9 7216.5 7230.5 7286.2 7332.5 5418.9 5419.4 5422.4 5435.2 5465.3 6574.7 6652.6 6809.3 7023.7 7091.6 6695.3 6747.8 6806.7 6811.5 6827.3 6574.9 6674.2 6676.8 6726.6 6778.3 6601.5 6684.4 6685.1 6718.0 6741.3 6778.4 6846.8 6908.3 6909.5 6944.9 6651.9 6658.5 6658.6 6682.0 6687.2 08:47:51 INFO - PID 15982 | 08:47:51 INFO - PID 15982 | [#5] yui.html Cycles:180 Average:28041.10 Median:17354.39 stddev:42053.42 (242.3%) stddev-sans-first:42122.41 08:47:51 INFO - PID 15982 | Values: 1009.1 1014.5 1043.0 1053.2 1060.5 20277.4 20636.2 21770.8 22032.7 22138.3 20351.8 20434.3 20527.9 20546.5 20565.5 1018.5 1033.7 1034.2 1034.9 1036.7 1038.4 1042.6 1052.1 1053.5 1056.8 1092.5 1102.8 1122.5 1133.2 1134.9 1111.5 1118.0 1127.1 1127.3 1128.6 814.4 819.5 820.5 826.1 826.8 21251.9 21382.9 21631.1 21635.4 22465.7 18095.2 18527.1 18527.4 18550.8 18554.8 18919.6 19050.2 19143.2 19180.5 19220.2 4046.6 4080.9 4113.0 4119.1 4122.6 159819.0 160274.2 161367.0 161732.0 162983.0 16339.1 16379.9 16381.2 16516.5 16551.4 33339.7 33686.2 33994.7 34863.1 34972.0 9290.6 9359.8 9433.3 9433.5 9472.7 4481.6 4520.7 4559.0 4619.8 4653.7 6262.8 6394.9 6417.8 6431.8 6442.8 1079.8 1123.6 1127.5 1131.5 1135.0 767.5 770.5 787.4 800.7 806.5 13443.4 13562.5 14256.9 14513.4 14589.1 787.8 788.5 793.3 800.4 805.2 6471.9 6558.1 6565.6 6568.9 6579.2 146588.0 147736.0 147954.0 150163.0 150374.0 125892.0 126981.0 127281.4 131262.0 133554.0 108204.0 110513.4 111701.4 112648.4 112984.4 12563.4 12761.7 12777.2 12828.2 12838.9 56455.9 56853.4 57408.4 57854.4 59696.4 70596.6 72801.6 73168.3 74325.6 74750.9 16626.2 16970.6 17302.6 17605.8 17613.0 18706.4 18859.2 18871.9 18949.9 19123.9 17135.2 17279.2 17285.8 17350.3 17567.6 16973.2 17003.0 17128.9 17152.3 17358.5 15664.9 15696.7 15927.5 15984.8 16006.9 11541.7 11755.5 11824.4 12141.5 12188.6 11834.5 11897.6 12038.9 12044.2 12092.9 08:47:51 INFO - PID 15982 | -------- Summary: end -------- 08:47:51 INFO - PID 15982 | 08:47:52 INFO - TEST-INFO | 15982: exit 0 08:47:52 INFO - TEST-OK | dromaeo_css | took 1107489ms 08:47:52 INFO - TEST-START | kraken 08:47:52 INFO - Initialising browser for kraken test... 08:47:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54751/getInfo.html -profile /tmp/tmpM6O2dF/profile 08:47:52 INFO - TEST-INFO | started process 16339 (/builds/slave/test/build/application/firefox/firefox http://localhost:54751/getInfo.html) 08:47:57 INFO - TEST-INFO | 16339: exit 0 08:47:57 INFO - Browser initialized. 08:47:57 INFO - Running cycle 1/1 for kraken test... 08:47:57 INFO - Using env: {'DISPLAY': ':0', 08:47:57 INFO - 'HOME': '/home/cltbld', 08:47:57 INFO - 'JSGC_DISABLE_POISONING': '1', 08:47:57 INFO - 'LANG': 'en_US.UTF-8', 08:47:57 INFO - 'LANGUAGE': 'en_US:en', 08:47:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:47:57 INFO - 'LOGNAME': 'cltbld', 08:47:57 INFO - 'MAIL': '/var/mail/cltbld', 08:47:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:57 INFO - 'MOZ_CRASHREPORTER': '1', 08:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:47:57 INFO - 'MOZ_NO_REMOTE': '1', 08:47:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:57 INFO - 'NO_EM_RESTART': '1', 08:47:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:57 INFO - 'PWD': '/builds/slave/test', 08:47:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:57 INFO - 'RUST_BACKTRACE': 'full', 08:47:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:47:57 INFO - 'SHELL': '/bin/bash', 08:47:57 INFO - 'SHLVL': '1', 08:47:57 INFO - 'TERM': 'linux', 08:47:57 INFO - 'TMOUT': '86400', 08:47:57 INFO - 'USER': 'cltbld', 08:47:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127', 08:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:57 INFO - '_': '/tools/buildbot/bin/python'} 08:47:57 INFO - TEST-INFO | started process 16529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM6O2dF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:58 INFO - PID 16529 | 08:47:58 INFO - PID 16529 | (/builds/slave/test/build/application/firefox/firefox:16577): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:47:58 INFO - PID 16529 | 08:48:08 INFO - PID 16529 | RSS: Main: 141561856 08:48:08 INFO - PID 16529 | 08:48:11 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54751/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:12 INFO - PID 16529 | RSS: Main: 147660800 08:48:12 INFO - PID 16529 | 08:48:14 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54751/tests/kraken/driver.html?testName=audio-dft) 08:48:15 INFO - PID 16529 | RSS: Main: 147894272 08:48:15 INFO - PID 16529 | 08:48:18 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54751/tests/kraken/driver.html?testName=audio-fft) 08:48:19 INFO - PID 16529 | RSS: Main: 149602304 08:48:19 INFO - PID 16529 | 08:48:21 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54751/tests/kraken/driver.html?testName=audio-oscillator) 08:48:21 INFO - PID 16529 | RSS: Main: 149344256 08:48:21 INFO - PID 16529 | 08:48:23 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:24 INFO - PID 16529 | RSS: Main: 149045248 08:48:24 INFO - PID 16529 | 08:48:27 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54751/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:27 INFO - PID 16529 | RSS: Main: 149213184 08:48:27 INFO - PID 16529 | 08:48:31 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54751/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:32 INFO - PID 16529 | RSS: Main: 151560192 08:48:32 INFO - PID 16529 | 08:48:34 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54751/tests/kraken/driver.html?testName=json-parse-financial) 08:48:35 INFO - PID 16529 | RSS: Main: 151969792 08:48:35 INFO - PID 16529 | 08:48:37 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:37 INFO - PID 16529 | RSS: Main: 152096768 08:48:37 INFO - PID 16529 | 08:48:39 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:39 INFO - PID 16529 | RSS: Main: 151789568 08:48:39 INFO - PID 16529 | 08:48:41 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:42 INFO - PID 16529 | RSS: Main: 149688320 08:48:42 INFO - PID 16529 | 08:48:44 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:45 INFO - PID 16529 | RSS: Main: 149209088 08:48:45 INFO - PID 16529 | 08:48:48 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:48 INFO - PID 16529 | RSS: Main: 149315584 08:48:48 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | Cycle 1(1): loaded http://localhost:54751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54751/tests/kraken/driver.html?testName=ai-astar) 08:48:50 INFO - PID 16529 | RSS: Main: 150728704 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | __start_tp_report 08:48:50 INFO - PID 16529 | _x_x_mozilla_page_load 08:48:50 INFO - PID 16529 | _x_x_mozilla_page_load_details 08:48:50 INFO - PID 16529 | |i|pagename|runs| 08:48:50 INFO - PID 16529 | |0;ai-astar;105;105;105;104;106;106;110;105;107;104 08:48:50 INFO - PID 16529 | |1;audio-beat-detection;112;112;110;141;115;112;113;140;115;112 08:48:50 INFO - PID 16529 | |2;audio-dft;162;163;163;162;164;162;166;163;163;165 08:48:50 INFO - PID 16529 | |3;audio-fft;81;74;77;75;73;73;74;81;73;72 08:48:50 INFO - PID 16529 | |4;audio-oscillator;78;78;78;77;78;78;78;76;77;77 08:48:50 INFO - PID 16529 | |5;imaging-gaussian-blur;113;113;113;114;110;116;117;113;114;113 08:48:50 INFO - PID 16529 | |6;imaging-darkroom;148;148;147;150;147;149;149;148;149;147 08:48:50 INFO - PID 16529 | |7;imaging-desaturate;94;95;93;94;94;94;93;94;95;94 08:48:50 INFO - PID 16529 | |8;json-parse-financial;43;44;42;46;47;43;43;43;43;47 08:48:50 INFO - PID 16529 | |9;json-stringify-tinderbox;37;36;37;37;37;37;36;37;37;37 08:48:50 INFO - PID 16529 | |10;stanford-crypto-aes;71;71;73;72;73;73;84;75;70;70 08:48:50 INFO - PID 16529 | |11;stanford-crypto-ccm;104;109;108;109;108;104;107;108;105;105 08:48:50 INFO - PID 16529 | |12;stanford-crypto-pbkdf2;147;143;162;151;161;151;153;154;156;170 08:48:50 INFO - PID 16529 | |13;stanford-crypto-sha256-iterative;62;58;59;60;59;64;65;67;64;59 08:48:50 INFO - PID 16529 | __end_tp_report 08:48:50 INFO - PID 16529 | __start_cc_report 08:48:50 INFO - PID 16529 | _x_x_mozilla_cycle_collect,696 08:48:50 INFO - PID 16529 | __end_cc_report 08:48:50 INFO - PID 16529 | __startTimestamp1506354530624__endTimestamp 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | ------- Summary: start ------- 08:48:50 INFO - PID 16529 | Number of tests: 14 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#0] ai-astar Cycles:10 Average:105.70 Median:105.50 stddev:1.77 (1.7%) stddev-sans-first:1.86 08:48:50 INFO - PID 16529 | Values: 105.0 105.0 105.0 104.0 106.0 106.0 110.0 105.0 107.0 104.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:114.00 stddev:11.85 (10.4%) stddev-sans-first:12.35 08:48:50 INFO - PID 16529 | Values: 112.0 112.0 110.0 141.0 115.0 112.0 113.0 140.0 115.0 112.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 08:48:50 INFO - PID 16529 | Values: 162.0 163.0 163.0 162.0 164.0 162.0 166.0 163.0 163.0 165.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#3] audio-fft Cycles:10 Average:75.30 Median:74.50 stddev:3.30 (4.4%) stddev-sans-first:2.78 08:48:50 INFO - PID 16529 | Values: 81.0 74.0 77.0 75.0 73.0 73.0 74.0 81.0 73.0 72.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:0.71 (0.9%) stddev-sans-first:0.73 08:48:50 INFO - PID 16529 | Values: 78.0 78.0 78.0 77.0 78.0 78.0 78.0 76.0 77.0 77.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:1.90 (1.7%) stddev-sans-first:2.00 08:48:50 INFO - PID 16529 | Values: 113.0 113.0 113.0 114.0 110.0 116.0 117.0 113.0 114.0 113.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.09 08:48:50 INFO - PID 16529 | Values: 148.0 148.0 147.0 150.0 147.0 149.0 149.0 148.0 149.0 147.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:48:50 INFO - PID 16529 | Values: 94.0 95.0 93.0 94.0 94.0 94.0 93.0 94.0 95.0 94.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:43.50 stddev:1.85 (4.3%) stddev-sans-first:1.92 08:48:50 INFO - PID 16529 | Values: 43.0 44.0 42.0 46.0 47.0 43.0 43.0 43.0 43.0 47.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 08:48:50 INFO - PID 16529 | Values: 37.0 36.0 37.0 37.0 37.0 37.0 36.0 37.0 37.0 37.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:4.10 (5.6%) stddev-sans-first:4.28 08:48:50 INFO - PID 16529 | Values: 71.0 71.0 73.0 72.0 73.0 73.0 84.0 75.0 70.0 70.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#11] stanford-crypto-ccm Cycles:10 Average:106.70 Median:108.00 stddev:2.00 (1.9%) stddev-sans-first:1.87 08:48:50 INFO - PID 16529 | Values: 104.0 109.0 108.0 109.0 108.0 104.0 107.0 108.0 105.0 105.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:7.86 (5.1%) stddev-sans-first:7.81 08:48:50 INFO - PID 16529 | Values: 147.0 143.0 162.0 151.0 161.0 151.0 153.0 154.0 156.0 170.0 08:48:50 INFO - PID 16529 | 08:48:50 INFO - PID 16529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:63.00 stddev:3.13 (5.0%) stddev-sans-first:3.32 08:48:50 INFO - PID 16529 | Values: 62.0 58.0 59.0 60.0 59.0 64.0 65.0 67.0 64.0 59.0 08:48:50 INFO - PID 16529 | -------- Summary: end -------- 08:48:50 INFO - PID 16529 | 08:48:51 INFO - PID 16529 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:48:51 INFO - TEST-INFO | 16529: exit 0 08:48:51 INFO - TEST-OK | kraken | took 59133ms 08:48:51 INFO - SUITE-END | took 1166s 08:48:51 INFO - Completed test suite (00:19:26) 08:48:51 INFO - javascript benchmark 08:48:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9411.601447852936, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4000.4999375078114, 4006.4991876015497, 4015.116674331646, 4034.112495251047, 4039.555648878623, 6512.381323774234, 6564.343565643439, 6573.605583664984, 6589.439897608703, 6671.866562668743, 6499.675016249193, 6528.640924749148, 6545.672716364186, 6601.900971485419, 6630.336966303379, 5830.5044071254, 5871.089981052923, 5916.911246331287, 5946.197263369444, 5946.821595352125, 5901.144334071557, 5928.49607783339, 5932.970335148319, 5961.642301461904, 6037.72830222641, 5905.173275741378, 5942.702864856761, 5968.970155149218, 5972.910406343908, 5978.372270911535, 5939.3763654816485, 5954.821355359346, 6004.399560044004, 6012.368701286346, 6035.78874739382, 5846.415358464162, 5942.138389933435, 5955.583109182359, 6010.0, 6014.12795144706, 6445.903311450332, 6446.129772480749, 6502.0, 6520.2175738911155, 6534.085228068075, 7164.247753985861, 7181.06646135999, 7195.856082878313, 7227.7831665050135, 7230.421566274686, 7172.426205903515, 7188.604626745527, 7202.53183543068, 7274.781756547259, 7275.4179665626625, 6589.571677840925, 6627.502937279675, 6655.46756259498, 6660.200775906874, 6761.0, 7303.342699157101, 7312.378447831888, 7391.408687305003, 7396.667149978264, 7406.666699998513, 6943.618101004392, 7095.0, 7109.324614161646, 7118.074650295428, 7120.60836653989, 7134.108236470442, 7169.103862017248, 7176.138863336433, 7240.348368646847, 7283.562986220738, 7021.543599666005, 7084.539504932163, 7107.71569137239, 7155.0, 7159.355657990805, 7103.431725461951, 7134.250903655042, 7172.103487064117, 7175.497715159993, 7193.2447093055525, 5255.106631872591, 5321.095413779667, 5329.307190065267, 5334.333208348957, 5344.652597581145, 4775.617950563947, 4793.832215872428, 4812.181929072066, 4824.734639594856, 4845.297431872429, 6670.666466676646, 6682.231543372477, 6688.665566721645, 6707.3628005339415, 6714.294999025032, 7099.96450017757, 7106.040684507525, 7177.138743350727, 7178.246284140195, 7204.53170543913, 6573.276939536647, 6619.437347825393, 6620.702068406933, 6677.732890684319, 6692.899606505906, 5976.073708575178, 6010.519158467312, 6039.818805435844, 6047.12316714074, 6053.303870054912, 7425.294597013275, 7434.145073316529, 7477.513961592479, 7531.209223031612, 7554.093508778872, 6997.0, 7090.220075791555, 7098.36114749675, 7110.288971102952, 7223.674934628059, 7446.0, 7467.775966721007, 7538.0, 7553.546787192567, 7557.962210188914, 6973.267806880407, 7047.577145371089, 7135.322144396274, 7148.142222933281, 7151.642417878981, 7102.3962963148715, 7135.607541585263, 7176.605286709281, 7264.564126152448, 7269.345758881726, 6775.390214880685, 6806.217285012287, 6873.5875847449315, 6940.444764418733, 6975.197852247056, 6871.4159296458365, 6874.072000279898, 6920.653967301715, 6947.652617369213, 6953.895691564529, 6810.182778066664, 6811.0, 6895.931040689529, 6896.206936202401, 6923.5499692519825, 6887.414569761627, 6931.2375638678695, 6931.618760967994, 7014.403775679124, 7035.366816986496, 6656.467482601477, 6776.254611992578, 6777.085093512313, 6842.418394436529, 6871.9656401717675], "value": 6547.702514189388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.2577528190933, 976.9316147869652, 985.0789511806466, 998.5706146357065, 1028.6399760083966, 45575.0, 46439.99999999991, 46471.0, 46473.0, 46477.302840457334, 43141.0, 43307.56692433075, 43427.34858977118, 43431.13137737243, 43443.565564344346, 8115.14790946951, 8256.628451719656, 8289.792755181139, 8290.046644635853, 8296.004479462474, 8137.9593102034405, 8198.713045043425, 8222.342212622976, 8250.298724608385, 8253.546054966975, 8453.619587118594, 8596.312295016383, 8596.828063438728, 8601.655933762673, 8604.0, 8432.072472028072, 8461.15388461152, 8467.703630372938, 8511.74464766058, 8522.87215691765, 8685.0, 8743.606537705818, 8778.517181555011, 8808.42745221565, 8860.158284962918, 40565.0, 40769.18461630751, 40791.59208407908, 40870.0, 40878.0, 3843.5387753469763, 3880.5343358797127, 3881.4565960765517, 3882.9805850970847, 3888.1446081861945, 33823.0, 33981.83009084963, 34076.6592334076, 34334.14164645879, 34372.82813585941, 5663.0, 5700.0, 5710.343310519302, 5720.256366672347, 5798.797042103548, 230531.0, 233560.0, 234441.0, 234656.0, 236029.0, 52920.0, 52962.20556691653, 52988.470115299126, 53061.734691326295, 56112.719436402556, 58414.70792646095, 59492.40507594955, 59513.70243148843, 59523.70238148781, 59624.70187649034, 18350.449486515427, 18419.355322563646, 18468.0, 18495.90752046231, 18553.072346382898, 14764.335604897806, 14852.70294594102, 14954.252287385587, 14964.251787410585, 14976.850231497763, 16274.837251627569, 16424.589385265226, 16469.258883350278, 16494.505164845075, 16538.58653533647, 6156.353582873734, 6168.884713219795, 6230.844228894314, 6265.4361107499635, 6279.340669229665, 1131.598282609678, 1134.7390100276818, 1141.783061218366, 1145.3585991844427, 1155.7168493719093, 26311.73688263093, 26496.60255096175, 26893.0, 27036.32409189786, 27195.456090878466, 1234.7407044520571, 1242.8011518157052, 1249.2379648414642, 1252.918560293578, 1274.0826604844683, 14199.929000354932, 14305.856941430453, 14338.426462941574, 14346.067505612102, 14466.132032078109, 297028.0, 299291.0, 299444.0, 299521.0, 300998.0, 61073.0, 61097.69451152716, 65535.672321638085, 65922.0, 65985.34014659889, 1568.114015581193, 1570.1599644190076, 1580.3836503763541, 1580.5337425459518, 1586.88098392621, 31374.686253137177, 31589.5261571072, 31943.0, 32564.51153232656, 32638.020859374257, 42584.78707606442, 42697.359539607554, 42746.14507709766, 42852.35721464243, 42867.142657147306, 258927.0, 259131.0, 261729.0, 262092.0, 262707.0, 38377.61622383852, 39157.280058394404, 39391.606083938794, 39421.0, 39468.40797387984, 47968.760156198994, 48095.75952120217, 48953.0, 49046.0, 49051.509484904695, 35598.82200589084, 35674.643253567134, 35990.46014309735, 35996.28007439889, 36629.63370366262, 34809.0, 35095.47356789599, 35450.64549354473, 35672.821635891654, 36037.0, 41701.0, 42188.578114218464, 42192.78903605462, 42595.0, 42730.0, 33868.605842517325, 33940.321193575495, 34022.0, 34483.65516344804, 35162.47256291106, 26037.349066272738, 26050.478990419706, 26492.337691557866, 26854.731452685224, 26888.32779180458], "value": 19555.571649550435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.0069501125375, 652.6555296090057, 655.2642716657955, 657.8553317228022, 665.1286814273302, 24644.0, 25358.492830143387, 25381.0, 25395.0, 25399.873000635016, 26711.732882671215, 27169.18492445225, 27185.0, 27203.319917002034, 27227.0, 6987.231404545496, 7154.213036565973, 7169.103862017248, 7177.318154775288, 7183.173934997464, 7015.473839462061, 7087.397571206454, 7113.217546069928, 7116.217216106224, 7123.643817809115, 6539.967300163493, 6869.450443964471, 6890.896636550456, 6892.448604111659, 6909.654517274142, 7004.08946836913, 7037.22590515043, 7044.401225895805, 7049.541779784297, 7055.365017148456, 6543.770968016144, 6545.5418120731565, 6549.541532092755, 6559.573627714183, 6565.704543295563, 29977.550336744967, 30516.542251866238, 30946.690533094607, 30996.845015775, 31090.0, 2338.707661542307, 2390.1395497620842, 2392.9042838286446, 2393.9281821545205, 2394.042383046778, 21226.363209103598, 21656.89171554148, 21801.0, 21814.345569632937, 21868.343949681534, 2586.5344238037146, 2632.907848225322, 2683.946321073587, 2695.353115252325, 2698.5412479878273, 139508.0, 145933.27033364872, 158661.0, 162796.0, 163635.0, 16393.59016024609, 16677.833221667872, 16745.162741863103, 16856.74714879278, 17412.477625670996, 27306.0, 27331.453370932868, 27343.589846152325, 27360.179194624194, 27367.589486157725, 11283.871612838815, 11358.94320528392, 11362.0, 11374.886251137383, 11589.029864922983, 10227.7443063924, 10419.218558608134, 10539.473026348653, 10547.367157970546, 10552.683419497427, 10036.749081272881, 10116.813203840766, 10180.694579162637, 10209.234307426972, 10357.326773759682, 2960.171152077422, 3022.0507772487063, 3030.575719399286, 3050.8965441481173, 3146.8269245191736, 1063.8988646750577, 1076.7792602516465, 1079.9514021869036, 1083.7832433513172, 1088.8475613414128, 21411.571768564543, 21457.248996285056, 21566.892165539073, 21669.133234670437, 21882.0, 1117.6814607836727, 1130.9660710178707, 1145.8281257811395, 1149.724066224117, 1160.785254727878, 12016.038716902627, 12040.795920408063, 12195.39023048844, 12226.572069977508, 12241.387930603434, 584233.0, 584471.0, 606636.0, 610779.0, 613897.0, 124294.0, 126791.0, 127163.36418317849, 128634.0, 129509.35245323714, 1247.2454165230088, 1250.5123002029216, 1291.754566632337, 1291.791037326164, 1293.7089154940063, 19219.021051737003, 19246.326378576683, 19372.515687107934, 19437.222511099397, 19732.112054957273, 62915.6854215726, 63584.68207658932, 64151.0, 64279.67860160669, 65017.0, 81103.59448202721, 81122.0, 81126.0, 81891.0, 82140.58929705313, 15831.920840396186, 16217.864749467895, 16310.347586096423, 16321.428749993693, 16363.2636531354, 24239.63640545358, 24366.75633243645, 24596.262112136665, 24647.0, 24862.12982545602, 19904.90047549753, 20138.798612014278, 20185.0, 20208.19167233294, 20216.292429765475, 15430.919835611849, 16053.67892642164, 16425.26086326142, 17263.3957811476, 17777.911110444365, 17745.822541774418, 17793.466196014142, 18355.265789368277, 18495.72256416128, 18533.629327413644, 15588.766168507254, 15720.842791571939, 15800.525984220492, 15878.52364429069, 15926.283317250984, 17458.650826983136, 19612.509687257363, 19677.31129410464, 19994.500137496678, 20076.09657565442], "value": 13139.131964850694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4378392426954, 1513.0619016209944, 1525.1916484263338, 1528.487956534561, 1533.7776022476735, 17348.82651173488, 18033.63932721345, 18039.0, 18040.90979545102, 18052.458426247234, 17795.82204177958, 17926.19332130054, 17942.641147177048, 17993.280268789233, 18058.187381567826, 3127.124405166557, 3175.174454641798, 3214.100051985436, 3222.7744057915957, 3223.081421794789, 3118.2516196112997, 3148.7166155046043, 3154.511050787132, 3155.532677305053, 3162.256869635634, 3068.401661675974, 3180.2367431816315, 3183.029176101288, 3183.840807959593, 3188.7449004079617, 3118.9688103118906, 3128.1084890806123, 3172.7779055466126, 3175.460171770793, 3184.45864203086, 3090.9072727817975, 3092.608326253195, 3124.453220686371, 3151.6375616803903, 3173.76196785242, 16914.830851691448, 17242.827571724247, 17253.0, 17281.395151169774, 17351.392701255394, 9251.491167985758, 9549.28380371468, 9608.087231712976, 9608.51957402134, 9617.0, 6204.937950620481, 6209.689515524251, 6220.751169953196, 6368.29948705642, 6418.293987661354, 1991.7211590377358, 2061.80412860778, 2074.8312666771294, 2106.694529293259, 2120.59708655355, 31414.371712565622, 31445.213869652984, 31544.211394715086, 31787.682123178936, 31790.205244868834, 7902.841943161105, 8038.718644847402, 8114.3102836258395, 8116.35069194463, 8315.875261871077, 20286.391408257776, 20359.898200508902, 20361.49096272605, 20403.693944590843, 20435.795642043686, 9147.496887671243, 9301.162895339452, 9339.486328252011, 9368.2973776967, 9403.4828084456, 8261.091279959199, 8292.58537073156, 8379.706710265233, 8585.484870907765, 8616.396852220285, 6159.3224745277985, 6181.258249010148, 6182.381761823782, 6215.782447614402, 6284.685765711696, 1677.505135984863, 1743.564108972757, 1840.1811194018533, 1858.4145994011842, 1922.7981061988569, 1014.6347314966606, 1023.411538365428, 1041.390786389955, 1044.8171569975225, 1052.7315534538643, 9241.306901982378, 9321.627134914663, 9339.719808405758, 9395.671151509665, 9402.717918462457, 1057.2652006855162, 1086.380762965118, 1092.3445932440632, 1099.274478843959, 1133.9319640821577, 5268.0, 5309.044372012998, 5322.600804939645, 5360.865978350573, 5419.241306217133, 25903.481930361664, 26662.0, 27110.864445677646, 27295.181144565693, 27402.725972740416, 26132.085377011714, 26230.606540901903, 26583.867080664473, 26808.0, 27063.729362706516, 12591.181573197897, 12692.80960785589, 12878.9356053221, 13017.934910325577, 13066.0200484964, 10101.646442374482, 10175.949120254352, 10261.28171028021, 10328.225383096447, 10423.270371073952, 22056.007479663775, 22075.116995320008, 22233.888830555745, 22455.88772056129, 22652.773472265726, 23212.651810223197, 23700.0, 23705.288841334786, 23817.52364952726, 23902.402439939142, 12238.08214383907, 12331.876681233072, 12334.75330493403, 12413.379331033593, 12418.130730848754, 15689.98015129013, 16027.118508482145, 16027.198640068184, 16057.394260573848, 16174.433894813625, 12653.557125500563, 12790.68023299425, 12852.357382130669, 12975.935120324339, 13153.276569788753, 12540.0, 12680.74638507243, 12705.491780328683, 12764.744705106032, 12803.167794093353, 11204.71988200269, 11257.099432045581, 11260.0, 11264.929831665979, 11357.48891299877, 8772.78068048304, 8842.91157088421, 8916.242119419921, 8977.506237157018, 9012.909870901207, 8280.58597070156, 8396.580170991303, 8478.83042339162, 8513.659453622033, 8528.658853645784], "value": 7771.6142779247475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3577557360182, 585.3707264690457, 598.3776872053065, 600.2646757721791, 624.5596854217777, 6430.839229019277, 6507.869842603145, 6515.511336649753, 6518.250401203863, 6558.573692709982, 6377.0, 6464.385883341075, 6473.773417930373, 6493.207920594143, 6509.9023514647315, 5279.128943724281, 5297.523222909937, 5308.389535203462, 5309.230161626562, 5310.0, 4969.801207951696, 5262.05283049051, 5262.868428289305, 5294.2852714883575, 5326.7869285228735, 5116.846494605168, 5131.127708289581, 5153.011253472995, 5170.276161337416, 5185.922211166836, 5123.641345105844, 5158.53573178412, 5163.948360516403, 5171.844844654629, 5201.115810312256, 4670.229412147026, 4677.7193368398, 4695.624350052022, 4702.600278976257, 4721.716696998157, 6356.4279214870885, 6390.88159572073, 6392.4886009119155, 6424.5502814802985, 6425.45383642391, 6122.816315510542, 6137.508999280047, 6137.877242455126, 6138.17134686816, 6170.413810688023, 6769.424598909099, 6805.672893785713, 6822.249552549216, 6823.590584564892, 6845.623490708009, 5037.899242015139, 5150.948490515084, 5181.404138524081, 5198.792048318062, 5237.502437268454, 6950.131233595801, 7020.1202821234965, 7177.677004534757, 7181.35367816899, 7198.712051517985, 5403.378611459732, 5436.456354364532, 5448.182772584065, 5459.808906688327, 5474.42518535556, 5454.727263636882, 5495.230667706524, 5518.392976772552, 5541.750621221974, 5555.250041244381, 6014.398560144038, 6048.304444988795, 6053.395850099727, 6063.939360606338, 6073.0, 6787.911500267366, 6922.619255940871, 6932.341427564374, 6977.7208911642965, 6992.79021629352, 1872.7733334665816, 1879.9060046997595, 1891.394753678837, 1901.4218198894885, 1921.7323558201456, 1285.0, 1335.9198448093146, 1355.5594431809702, 1355.627202519315, 1371.5611004478671, 6383.39357761012, 6420.454261387741, 6494.415502604788, 6504.837379065467, 6512.316206798313, 6833.282505336968, 6843.486738494633, 6958.582485050913, 7006.719731210695, 7031.226565077837, 6454.257760357619, 6457.935420645827, 6465.288818229991, 6475.870482590321, 6482.643454610042, 3627.1294889226924, 3713.628637136265, 3718.3307004738867, 3731.0, 3734.9439758403646, 7363.765834645101, 7374.410047196211, 7396.223396543285, 7403.85192296151, 7449.85100297991, 7250.709971601183, 7275.126984761862, 7283.380912622486, 7296.452766042462, 7304.707811687579, 7169.892451613126, 7319.158296795937, 7349.118105827228, 7383.335499805044, 7406.444516661272, 6789.367688286743, 6819.147606549182, 6907.309269073254, 6919.827004324731, 6998.440124790106, 6904.551204171713, 6910.861782764216, 6953.130858642669, 6969.1985421677155, 6975.96512017457, 7203.8559228816175, 7216.5206132743715, 7230.493865429369, 7286.234945330876, 7332.523385979895, 5418.891622167455, 5419.4038655747045, 5422.403535611158, 5435.211894275387, 5465.262189604353, 6574.737010519526, 6652.580260049076, 6809.319068093151, 7023.68393422287, 7091.574505529685, 6695.296993815579, 6747.797566073025, 6806.693698783468, 6811.523193376416, 6827.317268273133, 6574.934250657623, 6674.232463266592, 6676.766313179015, 6726.562773419712, 6778.3221677831825, 6601.504887133388, 6684.4318232950745, 6685.119862500499, 6718.0, 6741.348369649468, 6778.389944904982, 6846.760363387258, 6908.274631163656, 6909.481788865754, 6944.861102777815, 6651.933480665325, 6658.533902626769, 6658.600483970978, 6681.966590167018, 6687.164104486939], "value": 5381.86931034829, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1009.0666133826213, 1014.4674046125783, 1043.0, 1053.2469284461608, 1060.5068643080967, 20277.391678249638, 20636.17455301786, 21770.782292177075, 22032.669509957344, 22138.335849924486, 20351.796482035174, 20434.284800032, 20527.897360513176, 20546.48633784156, 20565.4858628534, 1018.4958445569436, 1033.7053939627208, 1034.2088302448633, 1034.8706411698538, 1036.7252678040325, 1038.392540363888, 1042.5777560088177, 1052.1057101463732, 1053.4943227250924, 1056.820340542106, 1092.4537731134433, 1102.8345748137763, 1122.483657517543, 1133.1784456269222, 1134.9489272982694, 1111.5498223219608, 1118.0217309853879, 1127.1208457403197, 1127.2729089737115, 1128.621911659595, 814.3729328417086, 819.49191501269, 820.4912953968518, 826.1449399871165, 826.7850358906668, 21251.8937405312, 21382.893085534473, 21631.134754609797, 21635.350939471842, 22465.663015054786, 18095.185716642784, 18527.073646317764, 18527.351542695942, 18550.814491855042, 18554.814451855444, 18919.621607567908, 19050.237990480364, 19143.234270629157, 19180.520486987938, 19220.231190752354, 4046.615571520701, 4080.9183816323803, 4113.0, 4119.114390406047, 4122.649574786146, 159819.0, 160274.1986290061, 161367.0, 161732.0, 162983.0, 16339.101349425659, 16379.918100409423, 16381.180940953143, 16516.50450486463, 16551.420700275434, 33339.66660333414, 33686.15784605405, 33994.660053399646, 34863.12842178966, 34972.0, 9290.581923813445, 9359.812803743887, 9433.339666223435, 9433.48115853621, 9472.715818525456, 4481.551844815493, 4520.660950428731, 4558.9772051139535, 4619.815207391666, 4653.7207767534055, 6262.843428914222, 6394.936050639527, 6417.7753778617525, 6431.839204019843, 6442.774502892376, 1079.8110330692255, 1123.6235860986499, 1127.4644543841773, 1131.4851742457163, 1135.0182092489936, 767.5279702982625, 770.4914756260841, 787.4212453846418, 800.7437619961556, 806.479820515764, 13443.395047222702, 13562.457501700019, 14256.85743142576, 14513.419463221353, 14589.124652520883, 787.8345547434989, 788.4835432791531, 793.2741541489588, 800.3597122302135, 805.2350267246139, 6471.935280647133, 6558.114654521579, 6565.573237739532, 6568.934310656928, 6579.210494740566, 146588.0, 147736.0, 147954.0, 150163.0, 150374.0, 125892.0, 126981.0, 127281.36359318144, 131262.0, 133554.0, 108204.0, 110513.44743276232, 111701.44149279202, 112648.43675781568, 112984.43507782574, 12563.434645440795, 12761.744765104831, 12777.16948398351, 12828.230306181658, 12838.935805320914, 56455.870882581294, 56853.44159512749, 57408.42591574031, 57854.421455786585, 59696.40303597082, 70596.64701676664, 72801.63599182182, 73168.26831731827, 74325.62837185779, 74750.8787368179, 16626.16869156513, 16970.575735606708, 17302.567435814206, 17605.82394176042, 17613.031283279543, 18706.438806835817, 18859.24563017464, 18871.905640472258, 18949.90525047366, 19123.90438047801, 17135.22891469862, 17279.222434990203, 17285.827141728423, 17350.30598776035, 17567.560810979827, 16973.151342432582, 17003.0, 17128.914355428144, 17152.313907444062, 17358.479245622653, 15664.92167539155, 15696.686066278839, 15927.522174334788, 15984.840151598335, 16006.919965400099, 11541.653750387502, 11755.529778808752, 11824.40877956116, 12141.514339426678, 12188.634340969786, 11834.46744896499, 11897.583584574499, 12038.939805300917, 12044.156909016285, 12092.879071209527], "value": 9876.097836014733, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1373.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 104.0, 106.0, 106.0, 110.0, 105.0, 107.0, 104.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 141.0, 115.0, 112.0, 113.0, 140.0, 115.0, 112.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 164.0, 162.0, 166.0, 163.0, 163.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 77.0, 75.0, 73.0, 73.0, 74.0, 81.0, 73.0, 72.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 78.0, 78.0, 78.0, 76.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 110.0, 116.0, 117.0, 113.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 150.0, 147.0, 149.0, 149.0, 148.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 42.0, 46.0, 47.0, 43.0, 43.0, 43.0, 43.0, 47.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 37.0, 37.0, 37.0, 37.0, 36.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 72.0, 73.0, 73.0, 84.0, 75.0, 70.0, 70.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 108.0, 109.0, 108.0, 104.0, 107.0, 108.0, 105.0, 105.0], "value": 106.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 143.0, 162.0, 151.0, 161.0, 151.0, 153.0, 154.0, 156.0, 170.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 59.0, 60.0, 59.0, 64.0, 65.0, 67.0, 64.0, 59.0], "value": 61.7, "unit": "score"}]}]} 08:48:51 INFO - Return code: 0 08:48:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:51 INFO - # TBPL SUCCESS # 08:48:51 INFO - Running post-action listener: _package_coverage_data 08:48:51 INFO - Running post-action listener: _resource_record_post_action 08:48:51 INFO - [mozharness: 2017-09-25 15:48:51.894398Z] Finished run-tests step (success) 08:48:51 INFO - Running post-run listener: _resource_record_post_run 08:48:51 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 12288; Write bytes: 289349632; Read time: 148; Write time: 332756 08:48:51 INFO - TinderboxPrint: CPU usage
13.1% 08:48:51 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 148 08:48:51 INFO - TinderboxPrint: I/O write bytes / time
289,349,632 / 332,756 08:48:51 INFO - TinderboxPrint: CPU idle
8,189.2 (86.9%) 08:48:51 INFO - TinderboxPrint: CPU user
1,179.6 (12.5%) 08:48:51 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 10014720; Read time: 0; Write time: 2244 08:48:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:48:51 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 12288; Write bytes: 279334912; Read time: 148; Write time: 330512 08:48:52 INFO - Running post-run listener: _upload_blobber_files 08:48:52 INFO - Blob upload gear active. 08:48:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:54 INFO - (blobuploader) - INFO - Done attempting. 08:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:48:54 INFO - (blobuploader) - INFO - Done attempting. 08:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:01 INFO - (blobuploader) - INFO - Done attempting. 08:49:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:49:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:02 INFO - (blobuploader) - INFO - Done attempting. 08:49:02 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:02 INFO - Return code: 0 08:49:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/818e399ea00534af6240a4cde05dc04b0a5f23cc2d1a42bbbae7efd30ffb5ea1af8b06e04505fc2b82d0c7ac746ee83f88b62969810c4a2e193a2724af94ac0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4914b644ed2aa41df59c50fc8820fe6a0ba3bb327bdc93ce54d39280451a5193cb50f54594a9f95c5df3f41d84f6de2664b1e0d630a959a807469100538b1ed", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/27c03d393b255c772b58489150c31d87d1e09a59d6cd8e9580400101bce7b7f7682a894a8f295f88ffa1a5aa04d42f0c71fa8c24cd02cfd8a63b2a4869d20f11", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73c8e314345fca296f4a8b378a70ab5dbd909b8913e9ce3b1bc6b3a1c038d7059e43f938e393c316eb18ef26a569629c9f9142f22aba28090d118eb777859ede"} 08:49:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:02 INFO - Contents: 08:49:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/818e399ea00534af6240a4cde05dc04b0a5f23cc2d1a42bbbae7efd30ffb5ea1af8b06e04505fc2b82d0c7ac746ee83f88b62969810c4a2e193a2724af94ac0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4914b644ed2aa41df59c50fc8820fe6a0ba3bb327bdc93ce54d39280451a5193cb50f54594a9f95c5df3f41d84f6de2664b1e0d630a959a807469100538b1ed", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/27c03d393b255c772b58489150c31d87d1e09a59d6cd8e9580400101bce7b7f7682a894a8f295f88ffa1a5aa04d42f0c71fa8c24cd02cfd8a63b2a4869d20f11", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73c8e314345fca296f4a8b378a70ab5dbd909b8913e9ce3b1bc6b3a1c038d7059e43f938e393c316eb18ef26a569629c9f9142f22aba28090d118eb777859ede"} 08:49:02 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:02 INFO - Copying logs to upload dir... 08:49:02 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.359154 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-25 08:49:02.705951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 08:49:02.713658) ========= 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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 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/818e399ea00534af6240a4cde05dc04b0a5f23cc2d1a42bbbae7efd30ffb5ea1af8b06e04505fc2b82d0c7ac746ee83f88b62969810c4a2e193a2724af94ac0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4914b644ed2aa41df59c50fc8820fe6a0ba3bb327bdc93ce54d39280451a5193cb50f54594a9f95c5df3f41d84f6de2664b1e0d630a959a807469100538b1ed", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/27c03d393b255c772b58489150c31d87d1e09a59d6cd8e9580400101bce7b7f7682a894a8f295f88ffa1a5aa04d42f0c71fa8c24cd02cfd8a63b2a4869d20f11", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73c8e314345fca296f4a8b378a70ab5dbd909b8913e9ce3b1bc6b3a1c038d7059e43f938e393c316eb18ef26a569629c9f9142f22aba28090d118eb777859ede"} build_url:https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/KsrMMmOkQwqsNvV8pBJuNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/818e399ea00534af6240a4cde05dc04b0a5f23cc2d1a42bbbae7efd30ffb5ea1af8b06e04505fc2b82d0c7ac746ee83f88b62969810c4a2e193a2724af94ac0e", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d4914b644ed2aa41df59c50fc8820fe6a0ba3bb327bdc93ce54d39280451a5193cb50f54594a9f95c5df3f41d84f6de2664b1e0d630a959a807469100538b1ed", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/27c03d393b255c772b58489150c31d87d1e09a59d6cd8e9580400101bce7b7f7682a894a8f295f88ffa1a5aa04d42f0c71fa8c24cd02cfd8a63b2a4869d20f11", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/73c8e314345fca296f4a8b378a70ab5dbd909b8913e9ce3b1bc6b3a1c038d7059e43f938e393c316eb18ef26a569629c9f9142f22aba28090d118eb777859ede"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 08:49:02.744621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:49:02.744950) ========= 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=836cfdc75598d54cb747368e000001a9-1506347998.838222-1914960127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 08:49:02.824229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 08:49:02.824539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 08:49:02.824884) ========= ========= Total master_lag: 0.21 =========