builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1505506595.1 results: success (0) revision: 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.099061) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.099456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.099725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.117170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.117470) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 13:16:35-- 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% 45.9M=0s 2017-09-15 13:16:35 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094248 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.228385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.228706) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.283985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:35.284343) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 --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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 13:16:35,604 truncating revision to first 12 chars 2017-09-15 13:16:35,604 Setting DEBUG logging. 2017-09-15 13:16:35,604 attempt 1/10 2017-09-15 13:16:35,604 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b39f8dcc5cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 13:16:35,978 unpacking tar archive at: mozilla-central-5b39f8dcc5cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:36.200911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:36.201228) ========= script_repo_revision: 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:36.201638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:36.201916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 13:16:36.215354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-15 13:16:36.215722) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:16:36 INFO - MultiFileLogger online at 20170915 13:16:36 in /builds/slave/test 13:16:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:16:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:36 INFO - {'append_to_log': False, 13:16:36 INFO - 'base_work_dir': '/builds/slave/test', 13:16:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:16:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:36 INFO - 'branch': 'Firefox-Non-PGO', 13:16:36 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:36 INFO - 'code_coverage': False, 13:16:36 INFO - 'config_files': ('talos/linux_config.py',), 13:16:36 INFO - 'default_actions': ('clobber', 13:16:36 INFO - 'read-buildbot-config', 13:16:36 INFO - 'download-and-extract', 13:16:36 INFO - 'populate-webroot', 13:16:36 INFO - 'create-virtualenv', 13:16:36 INFO - 'install', 13:16:36 INFO - 'setup-mitmproxy', 13:16:36 INFO - 'run-tests'), 13:16:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:36 INFO - 'disable_ccov_upload': False, 13:16:36 INFO - 'disable_stylo': False, 13:16:36 INFO - 'download_minidump_stackwalk': True, 13:16:36 INFO - 'download_symbols': 'ondemand', 13:16:36 INFO - 'enable_stylo': False, 13:16:36 INFO - 'enable_webrender': False, 13:16:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:16:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:36 INFO - 'gecko_profile': False, 13:16:36 INFO - 'gecko_profile_interval': 0, 13:16:36 INFO - 'installer_path': 'installer.exe', 13:16:36 INFO - 'log_level': 'info', 13:16:36 INFO - 'log_name': 'talos', 13:16:36 INFO - 'log_to_console': True, 13:16:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:16:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:16:36 INFO - 'opt_config_files': (), 13:16:36 INFO - 'pip_index': False, 13:16:36 INFO - 'suite': 'dromaeojs-e10s', 13:16:36 INFO - 'system_bits': '32', 13:16:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:36 INFO - 'title': 'talos-linux64-ix-036', 13:16:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:36 INFO - 'use_talos_json': True, 13:16:36 INFO - 'verify': 'False', 13:16:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:36 INFO - 'work_dir': 'build'} 13:16:36 INFO - [mozharness: 2017-09-15 20:16:36.688885Z] Running clobber step. 13:16:36 INFO - Running pre-action listener: _resource_record_pre_action 13:16:36 INFO - Running main action method: clobber 13:16:36 INFO - rmtree: /builds/slave/test/build 13:16:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:37 INFO - Running post-action listener: _resource_record_post_action 13:16:37 INFO - [mozharness: 2017-09-15 20:16:37.808612Z] Finished clobber step (success) 13:16:37 INFO - [mozharness: 2017-09-15 20:16:37.808707Z] Running read-buildbot-config step. 13:16:37 INFO - Running pre-action listener: _resource_record_pre_action 13:16:37 INFO - Running main action method: read_buildbot_config 13:16:37 INFO - Using buildbot properties: 13:16:37 INFO - { 13:16:37 INFO - "project": "", 13:16:37 INFO - "product": "firefox", 13:16:37 INFO - "who": "archaeopteryx@coole-files.de", 13:16:37 INFO - "installer_path": "public/build/target.tar.bz2", 13:16:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:16:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:16:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:16:37 INFO - "stage_platform": "linux64", 13:16:37 INFO - "basedir": "/builds/slave/test", 13:16:37 INFO - "buildnumber": 830, 13:16:37 INFO - "platform": "ubuntu64_hw", 13:16:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:16:37 INFO - "slavebuilddir": "test", 13:16:37 INFO - "taskId": "f2oUp37KRzyq-ei7C6ytsQ", 13:16:37 INFO - "branch": "mozilla-central", 13:16:37 INFO - "script_repo_revision": "production", 13:16:37 INFO - "revision": "5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639", 13:16:37 INFO - "slavename": "talos-linux64-ix-036", 13:16:37 INFO - "repo_path": "mozilla-central" 13:16:37 INFO - } 13:16:37 INFO - Finding installer, test and symbols from parent task. 13:16:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2oUp37KRzyq-ei7C6ytsQ'}, attempt #1 13:16:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2oUp37KRzyq-ei7C6ytsQ'}, attempt #1 13:16:38 INFO - Task dependencies: Y6QodXyFSlC9NvyQ7Y-KNQ 13:16:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ'}, attempt #1 13:16:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 13:16:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.test_packages.json 13:16:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.crashreporter-symbols.zip 13:16:39 INFO - Running post-action listener: _resource_record_post_action 13:16:39 INFO - [mozharness: 2017-09-15 20:16:39.207094Z] Finished read-buildbot-config step (success) 13:16:39 INFO - [mozharness: 2017-09-15 20:16:39.207310Z] Running download-and-extract step. 13:16:39 INFO - Running pre-action listener: _resource_record_pre_action 13:16:39 INFO - Running main action method: download_and_extract 13:16:39 INFO - mkdir: /builds/slave/test/build/tests 13:16:39 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')]} 13:16:39 INFO - trying https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.test_packages.json 13:16:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:16:39 INFO - Downloaded 989 bytes. 13:16:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:16:39 INFO - Using the following test package requirements: 13:16:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:16:39 INFO - u'common': [u'target.common.tests.zip'], 13:16:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:16:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:16:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:16:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:16:39 INFO - u'mozbase': [u'target.common.tests.zip'], 13:16:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:16:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:16:39 INFO - u'web-platform': [u'target.common.tests.zip', 13:16:39 INFO - u'target.web-platform.tests.tar.gz'], 13:16:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:16:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:16:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.common.tests.zip 13:16:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:16:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.common.tests.zip into memory 13:16:41 INFO - Content-Length response header: 54734819 13:16:41 INFO - Bytes received: 54734819 13:16:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.talos.tests.zip 13:16:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:16:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.talos.tests.zip into memory 13:16:53 INFO - Content-Length response header: 14508749 13:16:53 INFO - Bytes received: 14508749 13:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:54 INFO - trying https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 13:16:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:16:55 INFO - Downloaded 61465141 bytes. 13:16:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 13:16:55 INFO - mkdir: /builds/slave/test/properties 13:16:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:16:55 INFO - Writing to file /builds/slave/test/properties/build_url 13:16:55 INFO - Contents: 13:16:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 13:16:55 INFO - Running post-action listener: _resource_record_post_action 13:16:55 INFO - Running post-action listener: find_tests_for_verification 13:16:55 INFO - Running post-action listener: set_extra_try_arguments 13:16:55 INFO - [mozharness: 2017-09-15 20:16:55.582278Z] Finished download-and-extract step (success) 13:16:55 INFO - [mozharness: 2017-09-15 20:16:55.582385Z] Running populate-webroot step. 13:16:55 INFO - Running pre-action listener: _resource_record_pre_action 13:16:55 INFO - Running main action method: populate_webroot 13:16:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:16:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['tresize', 13:16:55 INFO - 'tcanvasmark']}, 13:16:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:16:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['dromaeo_css', 13:16:55 INFO - 'kraken']}, 13:16:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:16:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'tests': ['damp', 'tps']}, 13:16:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['damp', 'tps']}, 13:16:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:16:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['dromaeo_dom']}, 13:16:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:16:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['basic_compositor_video', 13:16:55 INFO - 'glvideo']}, 13:16:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:16:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['ts_paint_webext', 13:16:55 INFO - 'tp5o_webext']}, 13:16:55 INFO - 'other-e10s': {'tests': ['a11yr', 13:16:55 INFO - 'ts_paint', 13:16:55 INFO - 'tpaint', 13:16:55 INFO - 'sessionrestore', 13:16:55 INFO - 'sessionrestore_many_windows', 13:16:55 INFO - 'sessionrestore_no_auto_restore', 13:16:55 INFO - 'tabpaint']}, 13:16:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['a11yr', 13:16:55 INFO - 'ts_paint', 13:16:55 INFO - 'tpaint', 13:16:55 INFO - 'sessionrestore', 13:16:55 INFO - 'sessionrestore_many_windows', 13:16:55 INFO - 'sessionrestore_no_auto_restore', 13:16:55 INFO - 'tabpaint']}, 13:16:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:16:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:16:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['perf_reftest_singletons']}, 13:16:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['bloom_basic']}, 13:16:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:16:55 INFO - 'tsvgr_opacity', 13:16:55 INFO - 'tart', 13:16:55 INFO - 'tscrollx', 13:16:55 INFO - 'tsvg_static']}, 13:16:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['tsvgx', 13:16:55 INFO - 'tsvgr_opacity', 13:16:55 INFO - 'tart', 13:16:55 INFO - 'tscrollx', 13:16:55 INFO - 'tsvg_static']}, 13:16:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:16:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo'], 13:16:55 INFO - 'tests': ['tp5o']}, 13:16:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:16:55 INFO - 'talos_options': ['--mitmproxy', 13:16:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:16:55 INFO - '--firstNonBlankPaint'], 13:16:55 INFO - 'tests': ['tp6_google', 13:16:55 INFO - 'tp6_youtube', 13:16:55 INFO - 'tp6_amazon', 13:16:55 INFO - 'tp6_facebook']}, 13:16:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo', 13:16:55 INFO - '--mitmproxy', 13:16:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:16:55 INFO - '--firstNonBlankPaint'], 13:16:55 INFO - 'tests': ['tp6_google', 13:16:55 INFO - 'tp6_youtube', 13:16:55 INFO - 'tp6_amazon', 13:16:55 INFO - 'tp6_facebook']}, 13:16:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:16:55 INFO - 'talos_options': ['--stylo-threads=1', 13:16:55 INFO - '--mitmproxy', 13:16:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:16:55 INFO - '--firstNonBlankPaint'], 13:16:55 INFO - 'tests': ['tp6_google', 13:16:55 INFO - 'tp6_youtube', 13:16:55 INFO - 'tp6_amazon', 13:16:55 INFO - 'tp6_facebook']}, 13:16:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--xperf_path', 13:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:55 INFO - 'tests': ['tp5n']}, 13:16:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:16:55 INFO - 'talos_options': ['--disable-stylo', 13:16:55 INFO - '--xperf_path', 13:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:16:55 INFO - 'tests': ['tp5n']}}} 13:16:55 INFO - Running post-action listener: _resource_record_post_action 13:16:55 INFO - [mozharness: 2017-09-15 20:16:55.598295Z] Finished populate-webroot step (success) 13:16:55 INFO - [mozharness: 2017-09-15 20:16:55.598394Z] Running create-virtualenv step. 13:16:55 INFO - Running pre-action listener: _resource_record_pre_action 13:16:55 INFO - Running main action method: create_virtualenv 13:16:55 INFO - Creating virtualenv /builds/slave/test/build/venv 13:16:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:16:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:16:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:16:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:16:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:16:56 INFO - Installing distribute.............................................................................................................................................................................................done. 13:16:56 INFO - Installing pip...............done. 13:16:56 INFO - Return code: 0 13:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:16:56 INFO - Reading from file tmpfile_stdout 13:16:56 INFO - Output received: 13:16:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:16:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:16:56 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')]} 13:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:56 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')]} 13:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:56 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:16:56 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 13:16:56 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 13:16:56 INFO - Using env: {'DISPLAY': ':0', 13:16:56 INFO - 'HOME': '/home/cltbld', 13:16:56 INFO - 'LANG': 'en_US.UTF-8', 13:16:56 INFO - 'LANGUAGE': 'en_US:en', 13:16:56 INFO - 'LOGNAME': 'cltbld', 13:16:56 INFO - 'MAIL': '/var/mail/cltbld', 13:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:56 INFO - 'MOZ_NO_REMOTE': '1', 13:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:56 INFO - 'NO_EM_RESTART': '1', 13:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:56 INFO - 'PWD': '/builds/slave/test', 13:16:56 INFO - 'SHELL': '/bin/bash', 13:16:56 INFO - 'SHLVL': '1', 13:16:56 INFO - 'TERM': 'linux', 13:16:56 INFO - 'TMOUT': '86400', 13:16:56 INFO - 'USER': 'cltbld', 13:16:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:56 INFO - '_': '/tools/buildbot/bin/python'} 13:16:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:16:58 INFO - Downloading/unpacking pip>=1.5 13:16:58 INFO - Running setup.py egg_info for package pip 13:16:58 INFO - warning: no files found matching 'pip/cacert.pem' 13:16:58 INFO - warning: no files found matching '*.html' under directory 'docs' 13:16:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:16:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:16:58 INFO - Installing collected packages: pip 13:16:58 INFO - Found existing installation: pip 1.1 13:16:58 INFO - Uninstalling pip: 13:16:58 INFO - Successfully uninstalled pip 13:16:58 INFO - Running setup.py install for pip 13:16:58 INFO - warning: no files found matching 'pip/cacert.pem' 13:16:58 INFO - warning: no files found matching '*.html' under directory 'docs' 13:16:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:16:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:16:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:16:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:16:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:16:58 INFO - Successfully installed pip 13:16:58 INFO - Cleaning up... 13:16:58 INFO - Return code: 0 13:16:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:16: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')]} 13:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16: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')]} 13:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16: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', '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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:16: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 psutil>=3.1.1 13:16:58 INFO - Using env: {'DISPLAY': ':0', 13:16:58 INFO - 'HOME': '/home/cltbld', 13:16:58 INFO - 'LANG': 'en_US.UTF-8', 13:16:58 INFO - 'LANGUAGE': 'en_US:en', 13:16:58 INFO - 'LOGNAME': 'cltbld', 13:16:58 INFO - 'MAIL': '/var/mail/cltbld', 13:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:58 INFO - 'MOZ_NO_REMOTE': '1', 13:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:58 INFO - 'NO_EM_RESTART': '1', 13:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:58 INFO - 'PWD': '/builds/slave/test', 13:16:58 INFO - 'SHELL': '/bin/bash', 13:16:58 INFO - 'SHLVL': '1', 13:16:58 INFO - 'TERM': 'linux', 13:16:58 INFO - 'TMOUT': '86400', 13:16:58 INFO - 'USER': 'cltbld', 13:16:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:58 INFO - '_': '/tools/buildbot/bin/python'} 13:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:58 INFO - Downloading/unpacking psutil>=3.1.1 13:16: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 13:16: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 13:16: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 13:16: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 13:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:16:59 INFO - Installing collected packages: psutil 13:16:59 INFO - Running setup.py install for psutil 13:16:59 INFO - building 'psutil._psutil_linux' extension 13:16:59 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 13:16:59 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 13:16:59 INFO - building 'psutil._psutil_posix' extension 13:16:59 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 13:17:00 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 13:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:00 INFO - Successfully installed psutil 13:17:00 INFO - Cleaning up... 13:17:00 INFO - Return code: 0 13:17:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17: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')]} 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:17:00 INFO - Using env: {'DISPLAY': ':0', 13:17:00 INFO - 'HOME': '/home/cltbld', 13:17:00 INFO - 'LANG': 'en_US.UTF-8', 13:17:00 INFO - 'LANGUAGE': 'en_US:en', 13:17:00 INFO - 'LOGNAME': 'cltbld', 13:17:00 INFO - 'MAIL': '/var/mail/cltbld', 13:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:00 INFO - 'MOZ_NO_REMOTE': '1', 13:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:00 INFO - 'NO_EM_RESTART': '1', 13:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:00 INFO - 'PWD': '/builds/slave/test', 13:17:00 INFO - 'SHELL': '/bin/bash', 13:17:00 INFO - 'SHLVL': '1', 13:17:00 INFO - 'TERM': 'linux', 13:17:00 INFO - 'TMOUT': '86400', 13:17:00 INFO - 'USER': 'cltbld', 13:17:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:00 INFO - '_': '/tools/buildbot/bin/python'} 13:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:01 INFO - Installing collected packages: mozsystemmonitor 13:17:01 INFO - Running setup.py install for mozsystemmonitor 13:17:01 INFO - Successfully installed mozsystemmonitor 13:17:01 INFO - Cleaning up... 13:17:01 INFO - Return code: 0 13:17:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:01 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')]} 13:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:01 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')]} 13:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:01 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:01 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 13:17:01 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 13:17:01 INFO - Using env: {'DISPLAY': ':0', 13:17:01 INFO - 'HOME': '/home/cltbld', 13:17:01 INFO - 'LANG': 'en_US.UTF-8', 13:17:01 INFO - 'LANGUAGE': 'en_US:en', 13:17:01 INFO - 'LOGNAME': 'cltbld', 13:17:01 INFO - 'MAIL': '/var/mail/cltbld', 13:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:01 INFO - 'MOZ_NO_REMOTE': '1', 13:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:01 INFO - 'NO_EM_RESTART': '1', 13:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:01 INFO - 'PWD': '/builds/slave/test', 13:17:01 INFO - 'SHELL': '/bin/bash', 13:17:01 INFO - 'SHLVL': '1', 13:17:01 INFO - 'TERM': 'linux', 13:17:01 INFO - 'TMOUT': '86400', 13:17:01 INFO - 'USER': 'cltbld', 13:17:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:01 INFO - '_': '/tools/buildbot/bin/python'} 13:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:01 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:02 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 13:17:02 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 13:17:02 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 13:17:02 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 13:17:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:03 INFO - warning: no files found matching '*.txt' 13:17:03 INFO - no previously-included directories found matching 'build' 13:17:03 INFO - no previously-included directories found matching 'dist' 13:17:03 INFO - no previously-included directories found matching '.git*' 13:17:03 INFO - Installing collected packages: jsonschema, functools32 13:17:03 INFO - Running setup.py install for functools32 13:17:03 INFO - warning: no files found matching '*.txt' 13:17:03 INFO - no previously-included directories found matching 'build' 13:17:03 INFO - no previously-included directories found matching 'dist' 13:17:03 INFO - no previously-included directories found matching '.git*' 13:17:03 INFO - Successfully installed jsonschema functools32 13:17:03 INFO - Cleaning up... 13:17:03 INFO - Return code: 0 13:17:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17: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')]} 13:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:03 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:03 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 13:17:03 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 13:17:03 INFO - Using env: {'DISPLAY': ':0', 13:17:03 INFO - 'HOME': '/home/cltbld', 13:17:03 INFO - 'LANG': 'en_US.UTF-8', 13:17:03 INFO - 'LANGUAGE': 'en_US:en', 13:17:03 INFO - 'LOGNAME': 'cltbld', 13:17:03 INFO - 'MAIL': '/var/mail/cltbld', 13:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:03 INFO - 'MOZ_NO_REMOTE': '1', 13:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:03 INFO - 'NO_EM_RESTART': '1', 13:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:03 INFO - 'PWD': '/builds/slave/test', 13:17:03 INFO - 'SHELL': '/bin/bash', 13:17:03 INFO - 'SHLVL': '1', 13:17:03 INFO - 'TERM': 'linux', 13:17:03 INFO - 'TMOUT': '86400', 13:17:03 INFO - 'USER': 'cltbld', 13:17:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:03 INFO - '_': '/tools/buildbot/bin/python'} 13:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:17:03 INFO - Cleaning up... 13:17:03 INFO - Return code: 0 13:17:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17: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')]} 13:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:03 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:03 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 13:17:03 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 13:17:03 INFO - Using env: {'DISPLAY': ':0', 13:17:03 INFO - 'HOME': '/home/cltbld', 13:17:03 INFO - 'LANG': 'en_US.UTF-8', 13:17:03 INFO - 'LANGUAGE': 'en_US:en', 13:17:03 INFO - 'LOGNAME': 'cltbld', 13:17:03 INFO - 'MAIL': '/var/mail/cltbld', 13:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:03 INFO - 'MOZ_NO_REMOTE': '1', 13:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:03 INFO - 'NO_EM_RESTART': '1', 13:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:03 INFO - 'PWD': '/builds/slave/test', 13:17:03 INFO - 'SHELL': '/bin/bash', 13:17:03 INFO - 'SHLVL': '1', 13:17:03 INFO - 'TERM': 'linux', 13:17:03 INFO - 'TMOUT': '86400', 13:17:03 INFO - 'USER': 'cltbld', 13:17:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:03 INFO - '_': '/tools/buildbot/bin/python'} 13:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:03 INFO - Downloading/unpacking blobuploader==1.2.4 13:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17: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 13:17: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 13:17: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 13:17: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 13:17:05 INFO - Downloading docopt-0.6.1.tar.gz 13:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:05 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:05 INFO - Running setup.py install for blobuploader 13:17:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:05 INFO - Running setup.py install for requests 13:17:05 INFO - Running setup.py install for docopt 13:17:06 INFO - Successfully installed blobuploader requests docopt 13:17:06 INFO - Cleaning up... 13:17:06 INFO - Return code: 0 13:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17: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')]} 13:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:06 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:06 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 13:17:06 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 13:17:06 INFO - Using env: {'DISPLAY': ':0', 13:17:06 INFO - 'HOME': '/home/cltbld', 13:17:06 INFO - 'LANG': 'en_US.UTF-8', 13:17:06 INFO - 'LANGUAGE': 'en_US:en', 13:17:06 INFO - 'LOGNAME': 'cltbld', 13:17:06 INFO - 'MAIL': '/var/mail/cltbld', 13:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:06 INFO - 'MOZ_NO_REMOTE': '1', 13:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:06 INFO - 'NO_EM_RESTART': '1', 13:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:06 INFO - 'PWD': '/builds/slave/test', 13:17:06 INFO - 'SHELL': '/bin/bash', 13:17:06 INFO - 'SHLVL': '1', 13:17:06 INFO - 'TERM': 'linux', 13:17:06 INFO - 'TMOUT': '86400', 13:17:06 INFO - 'USER': 'cltbld', 13:17:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:06 INFO - '_': '/tools/buildbot/bin/python'} 13:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:06 INFO - Running setup.py (path:/tmp/pip-3qvekg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:06 INFO - Running setup.py (path:/tmp/pip-o36M50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:06 INFO - Running setup.py (path:/tmp/pip-UIrwYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:06 INFO - Running setup.py (path:/tmp/pip-cbJguh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:06 INFO - Running setup.py (path:/tmp/pip-KlIcq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:06 INFO - Running setup.py (path:/tmp/pip-Sodtkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:06 INFO - Running setup.py (path:/tmp/pip-kADtzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:06 INFO - Running setup.py (path:/tmp/pip-O4zu1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:06 INFO - Running setup.py (path:/tmp/pip-LZ9j1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:06 INFO - Running setup.py (path:/tmp/pip-qAH_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:07 INFO - Running setup.py (path:/tmp/pip-cDLuPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:07 INFO - Running setup.py (path:/tmp/pip-QuTCJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:07 INFO - Running setup.py (path:/tmp/pip-IZjeav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:07 INFO - Running setup.py (path:/tmp/pip-32XUyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:07 INFO - Running setup.py (path:/tmp/pip-RRPwxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:07 INFO - Running setup.py (path:/tmp/pip-IjFrot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:07 INFO - Running setup.py (path:/tmp/pip-s4Hm_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:07 INFO - Running setup.py install for manifestparser 13:17:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:07 INFO - Running setup.py install for mozcrash 13:17:07 INFO - Running setup.py install for mozdebug 13:17:07 INFO - Running setup.py install for mozdevice 13:17:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:07 INFO - Running setup.py install for mozfile 13:17:08 INFO - Running setup.py install for mozhttpd 13:17:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozinfo 13:17:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozInstall 13:17:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozleak 13:17:08 INFO - Running setup.py install for mozlog 13:17:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for moznetwork 13:17:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozprocess 13:17:08 INFO - Running setup.py install for mozprofile 13:17:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozrunner 13:17:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:08 INFO - Running setup.py install for mozscreenshot 13:17:09 INFO - Running setup.py install for moztest 13:17:09 INFO - Running setup.py install for mozversion 13:17:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:09 INFO - Cleaning up... 13:17:09 INFO - Return code: 0 13:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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')]} 13:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17: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')]} 13:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:09 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:09 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 13:17:09 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 13:17:09 INFO - Using env: {'DISPLAY': ':0', 13:17:09 INFO - 'HOME': '/home/cltbld', 13:17:09 INFO - 'LANG': 'en_US.UTF-8', 13:17:09 INFO - 'LANGUAGE': 'en_US:en', 13:17:09 INFO - 'LOGNAME': 'cltbld', 13:17:09 INFO - 'MAIL': '/var/mail/cltbld', 13:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:09 INFO - 'MOZ_NO_REMOTE': '1', 13:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:09 INFO - 'NO_EM_RESTART': '1', 13:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:09 INFO - 'PWD': '/builds/slave/test', 13:17:09 INFO - 'SHELL': '/bin/bash', 13:17:09 INFO - 'SHLVL': '1', 13:17:09 INFO - 'TERM': 'linux', 13:17:09 INFO - 'TMOUT': '86400', 13:17:09 INFO - 'USER': 'cltbld', 13:17:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:09 INFO - '_': '/tools/buildbot/bin/python'} 13:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:09 INFO - Running setup.py (path:/tmp/pip-ZTHUid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:09 INFO - Running setup.py (path:/tmp/pip-VMB1KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:09 INFO - Running setup.py (path:/tmp/pip-vKMXOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:09 INFO - Running setup.py (path:/tmp/pip-wYXCdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:09 INFO - Running setup.py (path:/tmp/pip-HmpOCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:09 INFO - Running setup.py (path:/tmp/pip-_1a6C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:09 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)) 13:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:09 INFO - Running setup.py (path:/tmp/pip-cNT5pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:10 INFO - Running setup.py (path:/tmp/pip-y3q7fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:10 INFO - Running setup.py (path:/tmp/pip-5LSAvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:10 INFO - Running setup.py (path:/tmp/pip-DHF7kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:10 INFO - Running setup.py (path:/tmp/pip-mR1Yxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:10 INFO - Running setup.py (path:/tmp/pip-kT0Y1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:10 INFO - Running setup.py (path:/tmp/pip-7E9M99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:10 INFO - Running setup.py (path:/tmp/pip-uB5DRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:10 INFO - Running setup.py (path:/tmp/pip-5Gm8Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:10 INFO - Running setup.py (path:/tmp/pip-MtnzW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:10 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)) 13:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:10 INFO - Running setup.py (path:/tmp/pip-4mXLC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:10 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)) 13:17:10 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)) 13:17:10 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)) 13:17:10 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)) 13:17:10 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)) 13:17:10 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)) 13:17:10 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)) 13:17:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:10 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 13:17:10 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 13:17:10 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 13:17:10 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 13:17:11 INFO - Downloading blessings-1.6.tar.gz 13:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:11 INFO - Installing collected packages: blessings 13:17:11 INFO - Running setup.py install for blessings 13:17:12 INFO - Successfully installed blessings 13:17:12 INFO - Cleaning up... 13:17:12 INFO - Return code: 0 13:17:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:12 INFO - Reading from file tmpfile_stdout 13:17:12 INFO - Current package versions: 13:17:12 INFO - argparse == 1.2.1 13:17:12 INFO - blessings == 1.6 13:17:12 INFO - blobuploader == 1.2.4 13:17:12 INFO - docopt == 0.6.1 13:17:12 INFO - functools32 == 3.2.3-2 13:17:12 INFO - jsonschema == 2.5.1 13:17:12 INFO - manifestparser == 1.1 13:17:12 INFO - mozInstall == 1.13 13:17:12 INFO - mozcrash == 1.0 13:17:12 INFO - mozdebug == 0.1 13:17:12 INFO - mozdevice == 0.51 13:17:12 INFO - mozfile == 1.2 13:17:12 INFO - mozhttpd == 0.7 13:17:12 INFO - mozinfo == 0.10 13:17:12 INFO - mozleak == 0.1 13:17:12 INFO - mozlog == 3.5 13:17:12 INFO - moznetwork == 0.27 13:17:12 INFO - mozprocess == 0.25 13:17:12 INFO - mozprofile == 0.28 13:17:12 INFO - mozrunner == 6.13 13:17:12 INFO - mozscreenshot == 0.1 13:17:12 INFO - mozsystemmonitor == 0.3 13:17:12 INFO - moztest == 0.8 13:17:12 INFO - mozversion == 1.4 13:17:12 INFO - psutil == 3.1.1 13:17:12 INFO - requests == 1.2.3 13:17:12 INFO - wsgiref == 0.1.2 13:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:12 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')]} 13:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:12 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')]} 13:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:12 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:12 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 13:17:12 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 13:17:12 INFO - Using env: {'DISPLAY': ':0', 13:17:12 INFO - 'HOME': '/home/cltbld', 13:17:12 INFO - 'LANG': 'en_US.UTF-8', 13:17:12 INFO - 'LANGUAGE': 'en_US:en', 13:17:12 INFO - 'LOGNAME': 'cltbld', 13:17:12 INFO - 'MAIL': '/var/mail/cltbld', 13:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:12 INFO - 'MOZ_NO_REMOTE': '1', 13:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:12 INFO - 'NO_EM_RESTART': '1', 13:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:12 INFO - 'PWD': '/builds/slave/test', 13:17:12 INFO - 'SHELL': '/bin/bash', 13:17:12 INFO - 'SHLVL': '1', 13:17:12 INFO - 'TERM': 'linux', 13:17:12 INFO - 'TMOUT': '86400', 13:17:12 INFO - 'USER': 'cltbld', 13:17:12 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:12 INFO - '_': '/tools/buildbot/bin/python'} 13:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 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)) 13:17:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:17:12 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 13:17:12 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 13:17:12 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 13:17:12 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 13:17:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:17:13 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)) 13:17:13 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)) 13:17:13 INFO - Installing collected packages: simplejson 13:17:13 INFO - Running setup.py install for simplejson 13:17:13 INFO - building 'simplejson._speedups' extension 13:17:13 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 13:17:14 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 13:17:14 INFO - Successfully installed simplejson 13:17:14 INFO - Cleaning up... 13:17:14 INFO - Return code: 0 13:17:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17:14 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')]} 13:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:14 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')]} 13:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:14 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 0xd9d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf66a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1109a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', '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 13:17:14 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 13:17:14 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 13:17:14 INFO - Using env: {'DISPLAY': ':0', 13:17:14 INFO - 'HOME': '/home/cltbld', 13:17:14 INFO - 'LANG': 'en_US.UTF-8', 13:17:14 INFO - 'LANGUAGE': 'en_US:en', 13:17:14 INFO - 'LOGNAME': 'cltbld', 13:17:14 INFO - 'MAIL': '/var/mail/cltbld', 13:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:14 INFO - 'MOZ_NO_REMOTE': '1', 13:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:14 INFO - 'NO_EM_RESTART': '1', 13:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:14 INFO - 'PWD': '/builds/slave/test', 13:17:14 INFO - 'SHELL': '/bin/bash', 13:17:14 INFO - 'SHLVL': '1', 13:17:14 INFO - 'TERM': 'linux', 13:17:14 INFO - 'TMOUT': '86400', 13:17:14 INFO - 'USER': 'cltbld', 13:17:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:14 INFO - '_': '/tools/buildbot/bin/python'} 13:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:15 INFO - Cleaning up... 13:17:15 INFO - Return code: 0 13:17:15 INFO - Running post-action listener: _resource_record_post_action 13:17:15 INFO - Running post-action listener: _start_resource_monitoring 13:17:15 INFO - Starting resource monitoring. 13:17:15 INFO - [mozharness: 2017-09-15 20:17:15.194229Z] Finished create-virtualenv step (success) 13:17:15 INFO - [mozharness: 2017-09-15 20:17:15.194741Z] Running install step. 13:17:15 INFO - Running pre-action listener: _resource_record_pre_action 13:17:15 INFO - Running main action method: install 13:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:15 INFO - Reading from file tmpfile_stdout 13:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:15 INFO - Reading from file tmpfile_stdout 13:17:15 INFO - Output received: 13:17:15 INFO - Usage: mozinstall [options] installer 13:17:15 INFO - Options: 13:17:15 INFO - -h, --help show this help message and exit 13:17:15 INFO - -d DEST, --destination=DEST 13:17:15 INFO - Directory to install application into. [default: 13:17:15 INFO - "/builds/slave/test"] 13:17:15 INFO - --app=APP Application being installed. [default: firefox] 13:17:15 INFO - mkdir: /builds/slave/test/build/application 13:17:15 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'] 13:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:17:33 INFO - Reading from file tmpfile_stdout 13:17:33 INFO - Output received: 13:17:33 INFO - /builds/slave/test/build/application/firefox/firefox 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - [mozharness: 2017-09-15 20:17:33.311240Z] Finished install step (success) 13:17:33 INFO - [mozharness: 2017-09-15 20:17:33.311385Z] Running setup-mitmproxy step. 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running main action method: setup_mitmproxy 13:17:33 INFO - Skipping: mitmproxy is not required 13:17:33 INFO - Running post-action listener: _resource_record_post_action 13:17:33 INFO - [mozharness: 2017-09-15 20:17:33.311912Z] Finished setup-mitmproxy step (success) 13:17:33 INFO - [mozharness: 2017-09-15 20:17:33.312017Z] Running run-tests step. 13:17:33 INFO - Running pre-action listener: _resource_record_pre_action 13:17:33 INFO - Running pre-action listener: _set_gcov_prefix 13:17:33 INFO - Running main action method: run_tests 13:17:33 WARNING - Try message not found. 13:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:17:33 INFO - Python 2.7.3 13:17:33 INFO - Return code: 0 13:17:33 INFO - grabbing minidump binary from tooltool 13:17:33 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')]} 13:17:33 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 0x110d090>, '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 0x110dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1107f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:17:33 INFO - Return code: 0 13:17:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:17:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:17:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:17:33 INFO - ENV: RUST_BACKTRACE is now full 13:17:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:17:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 13:17:33 INFO - Using env: {'DISPLAY': ':0', 13:17:33 INFO - 'HOME': '/home/cltbld', 13:17:33 INFO - 'LANG': 'en_US.UTF-8', 13:17:33 INFO - 'LANGUAGE': 'en_US:en', 13:17:33 INFO - 'LOGNAME': 'cltbld', 13:17:33 INFO - 'MAIL': '/var/mail/cltbld', 13:17:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:33 INFO - 'MOZ_NO_REMOTE': '1', 13:17:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:33 INFO - 'NO_EM_RESTART': '1', 13:17:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:33 INFO - 'PWD': '/builds/slave/test', 13:17:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:33 INFO - 'RUST_BACKTRACE': 'full', 13:17:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:17:33 INFO - 'SHELL': '/bin/bash', 13:17:33 INFO - 'SHLVL': '1', 13:17:33 INFO - 'TERM': 'linux', 13:17:33 INFO - 'TMOUT': '86400', 13:17:33 INFO - 'USER': 'cltbld', 13:17:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:33 INFO - '_': '/tools/buildbot/bin/python'} 13:17:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 13:17:33 INFO - mozversion application_buildid: 20170915192121 13:17:33 INFO - mozversion application_changeset: 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 13:17:33 INFO - mozversion application_display_name: Nightly 13:17:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:17:33 INFO - mozversion application_name: Firefox 13:17:33 INFO - mozversion application_remotingname: firefox 13:17:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:17:33 INFO - mozversion application_vendor: Mozilla 13:17:33 INFO - mozversion application_version: 57.0a1 13:17:33 INFO - mozversion platform_buildid: 20170915192121 13:17:33 INFO - mozversion platform_changeset: 5b39f8dcc5cd6a38fe99564a9cfc90eedfad1639 13:17:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:17:33 INFO - mozversion platform_version: 57.0a1 13:17:33 INFO - using testdate: 1505506653 13:17:33 INFO - actual date: 1505506653 13:17:33 INFO - starting webserver on 'localhost:50877' 13:17:33 INFO - SUITE-START | Running 2 tests 13:17:33 INFO - TEST-START | dromaeo_css 13:17:33 INFO - Initialising browser for dromaeo_css test... 13:17:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50877/getInfo.html -profile /tmp/tmp3Ucq2S/profile 13:17:33 INFO - TEST-INFO | started process 9522 (/builds/slave/test/build/application/firefox/firefox http://localhost:50877/getInfo.html) 13:17:39 INFO - TEST-INFO | 9522: exit 0 13:17:39 INFO - Browser initialized. 13:17:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:17:39 INFO - Using env: {'DISPLAY': ':0', 13:17:39 INFO - 'HOME': '/home/cltbld', 13:17:39 INFO - 'JSGC_DISABLE_POISONING': '1', 13:17:39 INFO - 'LANG': 'en_US.UTF-8', 13:17:39 INFO - 'LANGUAGE': 'en_US:en', 13:17:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:17:39 INFO - 'LOGNAME': 'cltbld', 13:17:39 INFO - 'MAIL': '/var/mail/cltbld', 13:17:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:17:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:17:39 INFO - 'MOZ_CRASHREPORTER': '1', 13:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:17:39 INFO - 'MOZ_NO_REMOTE': '1', 13:17:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:17:39 INFO - 'NO_EM_RESTART': '1', 13:17:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:39 INFO - 'PWD': '/builds/slave/test', 13:17:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:17:39 INFO - 'RUST_BACKTRACE': 'full', 13:17:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:17:39 INFO - 'SHELL': '/bin/bash', 13:17:39 INFO - 'SHLVL': '1', 13:17:39 INFO - 'TERM': 'linux', 13:17:39 INFO - 'TMOUT': '86400', 13:17:39 INFO - 'USER': 'cltbld', 13:17:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:39 INFO - '_': '/tools/buildbot/bin/python'} 13:17:39 INFO - TEST-INFO | started process 9752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Ucq2S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:40 INFO - PID 9752 | 13:17:40 INFO - PID 9752 | (/builds/slave/test/build/application/firefox/firefox:9801): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:17:40 INFO - PID 9752 | 13:17:50 INFO - PID 9752 | RSS: Main: 173973504 13:17:50 INFO - PID 9752 | 13:20:47 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50877/tests/dromaeo/cssquery-ext.html) 13:20:48 INFO - PID 9752 | RSS: Main: 175886336 13:20:48 INFO - PID 9752 | 13:23:49 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-ext.html (next: http://localhost:50877/tests/dromaeo/cssquery-jquery.html) 13:23:50 INFO - PID 9752 | RSS: Main: 171159552 13:23:50 INFO - PID 9752 | 13:26:52 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50877/tests/dromaeo/cssquery-mootools.html) 13:26:52 INFO - PID 9752 | RSS: Main: 173408256 13:26:52 INFO - PID 9752 | 13:29:54 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50877/tests/dromaeo/cssquery-prototype.html) 13:29:55 INFO - PID 9752 | RSS: Main: 173232128 13:29:55 INFO - PID 9752 | 13:32:58 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50877/tests/dromaeo/cssquery-yui.html) 13:32:59 INFO - PID 9752 | RSS: Main: 173314048 13:32:59 INFO - PID 9752 | 13:36:00 INFO - PID 9752 | Cycle 1(1): loaded http://localhost:50877/tests/dromaeo/cssquery-yui.html (next: http://localhost:50877/tests/dromaeo/cssquery-dojo.html) 13:36:01 INFO - PID 9752 | RSS: Main: 177504256 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | __start_tp_report 13:36:01 INFO - PID 9752 | _x_x_mozilla_page_load 13:36:01 INFO - PID 9752 | _x_x_mozilla_page_load_details 13:36:01 INFO - PID 9752 | |i|pagename|runs| 13:36:01 INFO - PID 9752 | |0;dojo.html;3115.314630781227;3119.7660175486835;3133.4516459619563;3139.2151962009507;3150.322680623667;6120.14317995481;6144.109104179891;6184.1342212090285;6233.501319894403;6301.6849157542165;6200.751969921209;6202.379762023796;6239.906401403971;6258.937410625892;6276.717547710353;5789.247397838275;5848.356680765123;5875.823725288248;5895.528357731393;5913.940860591382;38.06285093531818;5790.392008839053;5856.180134781112;5856.267966504187;5893.38119497453;5353.678779273237;5712.685802280873;5717.42825717427;5738.856528586777;5797.188393624875;5741.971290143564;5807.448292412214;5819.621724587888;5823.2138661280605;5828.737706803204;5722.341930677983;5738.684372359518;5798.130280457923;5818.738156782955;5821.883562328772;6160.969195154041;6226.937730622726;6236.937630623681;6311.463525600329;6338;6577.967110164419;6609.173853268341;6733.124693789825;6776;6812.931870681279;6673.232578253466;6694.732210711566;6695.46436285096;6696.263411024832;6702.865942681119;5939;6017.736275382175;6056.303525094627;6122.47958923492;6168.475679567242;6907.378335949788;6917.169939607179;6988.301169883021;7007.124109486314;7008.719651213996;6562.901556476657;6586;6608.339166083353;6665.733370665216;6683.064370988066;6434.195725534309;6548.246951600531;6677.198736151693;6692.732290708414;6718;6592.472602191909;6638.369354911276;6641.66791660415;6645.435138013227;6672.599644021374;6669.899951500732;6676.899846502306;6728.899066514006;6747.257801641816;6770.390664840188;4976.129177393942;5050.696958182521;5111.386633603917;5111.923321150186;5113.1563292057135;4469.061497085649;4481.484629267611;4489.259272220047;4493.707908985905;4578.427696537933;5789.131630255495;5801.564882633819;5801.854953626109;5809.186713860063;5813.447722466359;6559.409653131241;6625.503087268377;6652.966735166293;6725.495587830932;6773.45812335012;5683.54531637468;5694.487496125285;5759.8560035999435;5783.855403614859;5786.594938354359;5653.547716182696;5665.065264231355;5666.490015898589;5682.516986056149;5685.118806584986;6515.609063456208;6533.640649764308;6611.471082313404;6630.204375474974;6659.467242620579;6631.801045968628;6732.158480189976;6759.256481787;6846.178458585002;6850.21222559412;6337.7781777637565;6576.375244351779;6595.340465953366;6686.933130668631;6690.799276021728;6521.836954076186;6569.605823650596;6579.342065793382;6587.440067594308;6593;6598.60408375499;6656.467482601283;6670.199576050905;6672.466202703869;6748.493862960396;6437.227532696106;6441;6450.580712253689;6528.988006858945;6541.934580654132;6309.432151106423;6437.25971513282;6442.484601231797;6531.379518945692;6546.509011824037;6349.555531112777;6392.137061496638;6408.711607977745;6443.96778016107;6451.258105317948;6508.381703738138;6584.7036883341325;6599.67001649906;6618.536702430783;6629.43649789754;6220.595661282002;6301.6219026858535;6336.239651241881;6399.200099987502;6412.871742565029 13:36:01 INFO - PID 9752 | |1;ext.html;822.2271065198717;858.9613467393968;886.6630680341469;888.9022207557172;892.7321803458963;40281.59718402815;41915.37126943098;42310.576894231046;42404.78797606016;42428.363574546405;38287.425688614625;38390.04024899379;38497.80751096248;38543;38606.22787544248;6988.056612357343;7053.294670532957;7095.113110861143;7099.787006389816;7104.040954471157;6922.896156557656;6978.720851165947;6987.7204911803465;6989.650517474131;6991.68537415815;6995.65021748913;7003.894941575881;7006.474514411414;7014.719411223545;7019.5086343955945;7699.268569485918;7850.057993040843;7854.921450785505;7857.057153141603;7860.68557257709;7646.885296720554;7733.806654833618;7739.458237923292;7814.648340824677;7826.921730782733;38594.61405385967;38988.41517377242;38999.220015599814;39131.8043409784;39198;3518.3315170117853;3534.5228394166716;3554.2713743682484;3563.1804684922613;3573.249617580311;31871.362572748414;31962.680373196436;31965.840170798998;31987.200319991953;32007.83996080028;5190.584753219733;5197.8960420791755;5231.084560201987;5233.136532472137;5239.345081864767;183375;184734.07632961884;185141.07429462767;185335;187105;46403.76798115988;46766;47062.29406558904;47191.292130618065;47246.291305630446;50230;50357.49642503601;50522.242166367534;50691.49308506868;50863.74568127136;15137.318820653098;15253.237338133049;15289.159096249814;15295.847041529665;15330.080195188324;12330.691732706755;12346.259224446561;12354;12367.381630918419;12375.69060773488;14269.78595321071;14349.497767578294;14351.64120896965;14390.28048597566;14546.12723236588;5600.607957443021;5625.703835843097;5691.8292451226525;5695.857603559944;5736.254286942671;1002.0580654185043;1002.9247806414402;1009.1472705563787;1016.1819735113157;1019.0879163149089;22562.32313030612;22717;22733;23013.7698623015;23157.88421057884;1081.2809481694742;1103.9503222355013;1111.9332840029624;1117.8882111788755;1134.0587312530579;11902.345371004505;11965;12008.63974080779;12076.637700868989;12086.15396922207;228204;229648;229802;230582;231184;44492.55507444884;45363.54636453659;51680;52594.73702631462;52759.736201319516;1405.3043743346905;1425.7861320801755;1426.3866537389022;1440.164704471404;1446.240723620108;26990.865045674647;27374.17877463679;27646.585301220097;27696.03063892754;27864;37037.44443833291;37067.25865482729;37073.07317317089;37073.814630926674;37094.8145259272;207094;208245;208409;208487;208699;32287.838560807046;33523.497147542315;33675;33784.1553961153;34198.31603367869;42866.142677146905;43027.56972430361;43122.56877431311;43219.35170972375;43518.56481435145;31516.266605336925;31582.842085789423;32133.517997229592;32143.839280803448;32445.35109297848;32000;32006;32021.519677204393;32040.679593204703;32371.676283236866;36289.09277267984;36355.09112272109;36447.663630439514;36475.08812279714;36683.44974825326;31792.205194870312;31818.84090579532;31823.840880795447;31872.203194920312;32798.836005819816;22832.429189270402;23480.029382517376;23559;23661.171858984853;23917.521649567258 13:36:01 INFO - PID 9752 | |2;jquery.html;571.7512881896378;575.5309422820403;577.6072270855819;578.3840210176162;582.5427039773779;21869.562608747816;22264.66603000952;22674;22719.318420447373;22720.65919011216;26063.087791927286;26557.601635975476;26690.466190676176;26691;26706.19881403556;6940.895886561706;7079.185893622248;7087.149542054961;7107.111611048619;7108.431325493974;6543.705533251015;7144.821379465503;7167.4266058715175;7171.9641401792915;7178.5692858428665;7153.535020223695;7154.964225178893;7164.498485106044;7164.892526612079;7193.208747037822;7157.6063316517575;7174.820629484252;7184.568925864439;7192.568445893263;7208.24313447091;7019.087518622547;7052.541584796972;7055.964720176417;7073.610951397671;7082.079329687159;29341.26646833825;29850.10449686513;30697.386052279053;30735.846320768254;30802.075937721904;2031.8780873147512;2056.8251698605636;2061.2476446097216;2070.037432593851;2073.6474799284156;19652.50868728279;20086.09612567438;20127.698084528743;20207.69688454674;20254.49363765903;2536.644869718241;2571.7171111177754;2653.044903834618;2655.402534429738;2663.3474798674256;134238;137118.31440842833;137400;137725.3113734435;139772.3011384947;19697.606047878962;20464.69302960457;21068.683969740465;21195.364139075853;22457.438564035703;41521.792391038456;41737.79131104325;42030.579694203276;42192.789036055234;42198;11544.595939142258;11592.6522204334;11861.644150675493;11862.406879655982;11974.161808673309;8386.119457457002;8778.385513014155;9858.45778482176;9871.358361706467;9973;10621.84067238992;11112.22214444981;11187.832182517268;11446.599369022044;11448.141389395829;3679.411294192916;3917.3536366499206;3988.3419235825763;4165.91668166635;4174.979125104416;952.7951490429591;980.352967041749;986.7483791633088;989.8020395920701;1009.7526106103904;19732.50668733293;19817.504562385766;19822.70265946012;19859.404217873485;20540.691889621667;1035.3270374256792;1038.787048655024;1055.9788804223872;1062.9893701063045;1068.647346375694;10702.785944281071;10754.193435492369;11008.174386921013;11032.613858514913;11175.161862860317;494586;503028;519063;523712;526113;110993.89006109997;111516;111832;113430;113809;1130.7173206698326;1135.3074624479061;1135.65362564417;1156.4622450560362;1165.7726743285148;17001;17036;17367.652646947245;17615.471535853943;17718.645627087128;53333.733331334646;53454.73272633612;54221;54801.45198547964;55198;65130.348696514324;65243;65294;65663;65734.67132664498;19605.50986225356;20060.89969550143;20221;20272.695909561662;20588.58822823565;21991.450213744145;22666.886665566566;22745.772542274364;22997.88501057484;23136.884315578314;17735.82264177342;18104;18496;18626.627467450304;18732.250709971995;16137;16675.49973500797;16836.494905152864;16946.915265423595;17171.656566868343;18177.454676359732;18487.16807743628;18595.72106418432;18862.811371886106;18930.33743819015;19595;19643.410697679094;19719;19839.900800495907;19891.502712432306;18087.638247235245;18138.183781730117;18260.726089108408;18342;18347.63304733871 13:36:01 INFO - PID 9752 | |3;mootools.html;1319.3535167767793;1380.8757211850932;1385.9584212473626;1392.881605063569;1394.8744612984842;14847.40610375585;15447.073175609472;15500.06999580026;15508.22458877056;15520.30158642861;14884.62788430287;15253.466128685499;15258.160801155933;15275.770863437057;15304.923475382635;2627.2381009507267;2751.0371370020434;2751.4497100579965;2751.614773931641;2752.683441404244;2602.8438293702343;2739.328864428218;2788.3726161613577;2811.5642075478336;2812.620296259999;2782.8191167574146;2812.4234531920906;2816.943661126776;2818.196813908037;2825.858707064649;2747.587861820723;2766.681831589373;2773.6948935617065;2775.861206939645;2780.207640822356;2637.129747183444;2657.601359796046;2659.986700066487;2666.240121565364;2668.7731542818883;14567.562973110824;15001.3249403776;15011.474598389113;15013.024153430102;15019.173945432996;7755.961220193863;8102.311303539206;8141.51150930946;8147.592620368958;8171.142030086815;5451.2640793492765;5474.644148130359;5566.248556444909;5629.802956896489;5696.060150075233;1629.1528405229215;1708.4105983435818;1868.6262747450564;1873.5222518257892;1911.8279354857991;25228.747712522825;26712.19863404101;26717.866410668015;26738.73261267382;26785.330366740793;6579.013148027739;6618.933810661832;6716.294789047178;6852.349026842442;6942.409895158968;16753.91623041877;16853;16878;16910.239039243017;16910.74633880493;7961.72133975308;8106.2299081588335;8121.75634730959;8141.9185808141165;8150.103488616248;7446.7021319146625;7457.664405101784;7492.887606685904;7523.962380188064;7548.509346892544;5197.792088316501;5311.814086507031;5330.413654498002;5354.330708661418;5377.139657654757;1566.8433156684468;1570.3090640118312;1574.4882913053304;1581.9604509887115;1584.5800862771375;859.656137544987;860.9870851937226;872.3500991761051;886.0342226972631;888.6800751729372;7234.168070671835;7245.094363204599;7252.456065795086;7263.89104163438;7363.042804435497;699.919509256442;703.3845385287873;703.711478293897;720.1358369956074;723.2767232767233;4961.404631444249;5117.181250999822;5143.048536020848;5164.173732202829;5251.002309561171;21208;21487.57024859494;21702.348929532138;21963.890180548995;22036;21064.789352106283;21457.14171433125;22167.889160554096;22194.223202187844;22199.778002220093;9857.162141217934;10227.02843229892;10684.717833859831;11373.431328433546;11454.54181832734;8419.536925469158;8473.57632118404;8612.913870861212;8619.051904290649;8623.95688021581;18470.630587388445;18837.15232814554;18915.810841891405;19036.33372831944;19450.61098777988;18959.336423225122;19267.036648167254;19632.607347852678;19738.80261197427;19786.20855165777;10769.569217231223;10882.075023623082;10898.291611045574;10901.182411319025;10906.454677266263;13512.59462216135;13548.458061677422;13582.25297608641;13653.658658533615;13684.384202710702;10835.891641083488;10910.781784364426;11053.834192486958;11085.722856928318;11386.658400248005;11374.715632109264;11418.200725949437;11421.942890285496;11436.485358159069;11554.537818487166;9364.906350936404;9408.012158723235;9411.152996230372;9418.199453046567;9463.101005404476;7381.298776616213;7469.327760501581;7471.9626401867645;7534.623268836426;7599.16409194977;6832.111825462658;6918.654067296716;6944.756933507303;7029.753958611424;7064.046353742385 13:36:01 INFO - PID 9752 | |4;prototype.html;487.48570258377396;503.3808415648752;511.5038412739644;515.5308669111108;521.1063026908853;6087.756489740405;6149.0177264027025;6209.640336672064;6217.052171870861;6248;6068.817935461932;6097.634141951486;6111.969440152793;6198;6201.28685201202;5097.133487307148;5106.897862042757;5116.718580478072;5132.435432102466;5151.150060240056;4728.196206644861;5079.288899554065;5079.695218286896;5128.461511541291;5142.837155149594;4825.565699087081;4857.465678775332;4886.144924638174;4892.192788189945;4904.5831104356175;4863.951360486385;4868.196747536687;4887.462379138292;4889.315495830587;4905.975470122645;4392.407025051609;4398.692091553593;4399.274119770266;4415.161119387306;4423.424954755861;6036.5170786336985;6038.698065096728;6061.757529698807;6061.787837425713;6082.878342433127;5517.724113794295;5526.171074338841;5569.916451253234;5571;5614.831555053355;6361.300256971729;6379.968100159516;6398.872022559569;6437.678116094176;6451.322611125811;4475.932861007088;4675.555822196886;4739.857804265877;4746.762661866893;4748.620110391161;6346.509419819081;6591.340865913418;6630.569013014138;6688.665566721645;6729.255874608439;4823.300621409876;4831.51684831514;4840.177169881058;4846.878828029327;4870.147724148331;4886.902261954741;4925.285833554115;4927.384076990376;4951.3810773653295;4968.478309777493;5502.532284755841;5507.531859791882;5541.667499950016;5544.22380866679;5552.833414997556;6429.7749578764515;6470.450011749054;6476.449501792306;6479.5788273763;6523.380278873499;1687.5190570687296;1698.7961444626724;1708.863290936722;1718.9140542972802;1725.4564812084154;1126.442411006557;1168.7896178687747;1177.3465726521863;1205.5961252980173;1208.6857417071624;5627.999999999918;5635.380108188096;5646.71766411686;5673.6028478006965;5690.601657883908;6503.772367967098;6567.047778072249;6600.372964568358;6618.536702430783;6621.834454138589;5571.721413929368;5587.217789509472;5592.636478628876;5637.830865074055;5679.290088738908;3433.828308584561;3456.5679290088738;3459.844307006191;3460.6193318735423;3486.564179477565;6413.518986075969;6422.903656445157;6433.356664333529;6433.388828061326;6481.592517088331;6653.733850646016;6666.799996000031;6672.399484046362;6689.5986240825705;6718.865622687519;6236.220472440945;6312.400321969498;6406.679666016774;6424.357564243632;6425.421712045938;6532.738690452328;6570.8357291068105;6581.177352830896;6617.834554136185;6632.867342653217;5831.94168058314;6314.431701146918;6402.871942561216;6528.747582084174;6542.411182993554;6278.497720182466;6319.146915166578;6362.045693146065;6374;6381.234251889803;4768;4807.807687692453;4844.304493427272;4855.295982082649;4870.0746858096845;6362.491000720024;6559.868802623825;6581.539292249497;6608.207015158212;6656.600603963778;6123.571350005457;6362.554621176473;6376.681165941777;6389.68051597409;6389.904151437825;6364.268109167319;6364.554481186273;6375.968120159369;6400.807975760735;6462.7091780870915;6282.1519094921605;6309.747610095545;6310.7791227306825;6320.810375688737;6327.683615819098;6271.43557079865;6490.448311893542;6492.954719263417;6497.415232629086;6509.1863517060365;6148.723307451086;6183.690815459299;6189.1025801257665;6196.566240363311;6222.346653601488 13:36:01 INFO - PID 9752 | |5;yui.html;881.2333270055053;897.8563429851223;915.7939463620686;917.0279503726051;927.6984979881538;17391.91304043481;17849.375271865487;17850.642987140265;17860.732089018675;18023.549411264692;17762.467125986208;17890;17906.910465447687;17932.55168620785;18779.43661690148;950.273041123541;974.4640447753743;976.7509285132281;977.7115750853516;978.4911845840159;948.8197242523933;972.9027097290285;973.7224890906093;975.8292298847708;978.9265805064613;1058.3544038136731;1059.8410238464214;1069;1069.5240617925026;1070.058348653184;962.711186644004;1000.494750151169;1043.118564812732;1050.144132531988;1052.2108418686023;743.4758495260828;745.9962700186464;746.3991486853081;746.4066067476369;747.4095464582973;19669.508262293413;19815.900920495304;19819.207231710716;19891.90054049735;19910;20354.89822550878;21055.157793688235;21423.571528569497;21584.244551440624;21585;16620.58448538796;17001.40495082666;17216.569585760455;17375.47873563795;17422.912885435617;3689.8708545201057;3703.759255648374;3708.2583483303447;3724.0317517445387;3734.589195188527;138925.3053734735;140719.99999999898;141551;143563;146064;15239.61900952463;15649.530514084596;15816.920915395349;15823.920880395524;15852.44516441919;27461;27603;28678.13965580994;28738.712612873605;29142.27144321409;8253.13342099083;8283.710070147516;8364.832703346021;8411.915880841236;8436.620352084172;3931.8427262909736;4048.8380464781667;4056.51321841375;4064.878053658395;4126.5667104953545;5478.369987451414;5524.640898341595;5565.1374037024325;5583.218349431002;5584.804531841366;1013.5084484025242;1024.4007255755319;1043.7703705184847;1046.7644779924456;1049.7795462952713;681.4276008153175;700.4921431961787;701.9578825270501;716.6774951271949;719.5718547464251;10692.946535267429;11639.127065470124;11855;11857.407129643656;12111.75776484483;671.7648822912039;677.5494296293009;685.0683071023404;691.1878542712293;701.1936273285762;5316.202569614588;5341.412444631165;5458.781648734006;5563.610547261734;5599.860003499945;108697.4565127185;112788;115052.42473787577;116020.41989789998;117037;101165;103519.4824025875;104637.47681261545;105686.47156764167;106589.46705266424;87399.56300218585;87957.24085518382;91379.54310228539;92306;92808;10239.590416383262;10240.948795255976;10641.521131549254;10643.680689579325;10732.302400343953;44080.33879491746;44380.556194437646;45844.31233531566;46221.306680399146;47427;56783;58449.70775146097;59873;60240.69879650749;60387.698061509414;15195.544133676007;15331.386744530093;15405;15421.537353879401;15474.5357639271;15861.127637980022;16105.597360066093;16141.435049773201;16204.67590648204;16311.510654680378;14972.401103956156;15029.774553381489;15070.849291507384;15090.54728358151;15278.236088195768;15596.220188990279;15667.29497172607;15824.762628560811;15859;15956.202189890691;14656;14749.410023598935;14815.18516481604;14828.851711482746;15025.398984040516;11881.762364752483;11951.103667225167;12163.695907602381;12201.450934708137;12227.14409991292;12261.632151035483;12367.62897113088;12446.37768111609;12478.688032799253;12658.367081645696 13:36:01 INFO - PID 9752 | __end_tp_report 13:36:01 INFO - PID 9752 | __start_cc_report 13:36:01 INFO - PID 9752 | _x_x_mozilla_cycle_collect,380 13:36:01 INFO - PID 9752 | __end_cc_report 13:36:01 INFO - PID 9752 | __startTimestamp1505507761040__endTimestamp 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | ------- Summary: start ------- 13:36:01 INFO - PID 9752 | Number of tests: 6 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#0] dojo.html Cycles:165 Average:6106.81 Median:6399.20 stddev:889.36 (13.9%) stddev-sans-first:860.57 13:36:01 INFO - PID 9752 | Values: 3115.3 3119.8 3133.5 3139.2 3150.3 6120.1 6144.1 6184.1 6233.5 6301.7 6200.8 6202.4 6239.9 6258.9 6276.7 5789.2 5848.4 5875.8 5895.5 5913.9 38.1 5790.4 5856.2 5856.3 5893.4 5353.7 5712.7 5717.4 5738.9 5797.2 5742.0 5807.4 5819.6 5823.2 5828.7 5722.3 5738.7 5798.1 5818.7 5821.9 6161.0 6226.9 6236.9 6311.5 6338.0 6578.0 6609.2 6733.1 6776.0 6812.9 6673.2 6694.7 6695.5 6696.3 6702.9 5939.0 6017.7 6056.3 6122.5 6168.5 6907.4 6917.2 6988.3 7007.1 7008.7 6562.9 6586.0 6608.3 6665.7 6683.1 6434.2 6548.2 6677.2 6692.7 6718.0 6592.5 6638.4 6641.7 6645.4 6672.6 6669.9 6676.9 6728.9 6747.3 6770.4 4976.1 5050.7 5111.4 5111.9 5113.2 4469.1 4481.5 4489.3 4493.7 4578.4 5789.1 5801.6 5801.9 5809.2 5813.4 6559.4 6625.5 6653.0 6725.5 6773.5 5683.5 5694.5 5759.9 5783.9 5786.6 5653.5 5665.1 5666.5 5682.5 5685.1 6515.6 6533.6 6611.5 6630.2 6659.5 6631.8 6732.2 6759.3 6846.2 6850.2 6337.8 6576.4 6595.3 6686.9 6690.8 6521.8 6569.6 6579.3 6587.4 6593.0 6598.6 6656.5 6670.2 6672.5 6748.5 6437.2 6441.0 6450.6 6529.0 6541.9 6309.4 6437.3 6442.5 6531.4 6546.5 6349.6 6392.1 6408.7 6444.0 6451.3 6508.4 6584.7 6599.7 6618.5 6629.4 6220.6 6301.6 6336.2 6399.2 6412.9 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#1] ext.html Cycles:180 Average:37524.85 Median:3526.43 stddev:54010.86 (1531.6%) stddev-sans-first:54092.07 13:36:01 INFO - PID 9752 | Values: 822.2 859.0 886.7 888.9 892.7 40281.6 41915.4 42310.6 42404.8 42428.4 38287.4 38390.0 38497.8 38543.0 38606.2 6988.1 7053.3 7095.1 7099.8 7104.0 6922.9 6978.7 6987.7 6989.7 6991.7 6995.7 7003.9 7006.5 7014.7 7019.5 7699.3 7850.1 7854.9 7857.1 7860.7 7646.9 7733.8 7739.5 7814.6 7826.9 38594.6 38988.4 38999.2 39131.8 39198.0 3518.3 3534.5 3554.3 3563.2 3573.2 31871.4 31962.7 31965.8 31987.2 32007.8 5190.6 5197.9 5231.1 5233.1 5239.3 183375.0 184734.1 185141.1 185335.0 187105.0 46403.8 46766.0 47062.3 47191.3 47246.3 50230.0 50357.5 50522.2 50691.5 50863.7 15137.3 15253.2 15289.2 15295.8 15330.1 12330.7 12346.3 12354.0 12367.4 12375.7 14269.8 14349.5 14351.6 14390.3 14546.1 5600.6 5625.7 5691.8 5695.9 5736.3 1002.1 1002.9 1009.1 1016.2 1019.1 22562.3 22717.0 22733.0 23013.8 23157.9 1081.3 1104.0 1111.9 1117.9 1134.1 11902.3 11965.0 12008.6 12076.6 12086.2 228204.0 229648.0 229802.0 230582.0 231184.0 44492.6 45363.5 51680.0 52594.7 52759.7 1405.3 1425.8 1426.4 1440.2 1446.2 26990.9 27374.2 27646.6 27696.0 27864.0 37037.4 37067.3 37073.1 37073.8 37094.8 207094.0 208245.0 208409.0 208487.0 208699.0 32287.8 33523.5 33675.0 33784.2 34198.3 42866.1 43027.6 43122.6 43219.4 43518.6 31516.3 31582.8 32133.5 32143.8 32445.4 32000.0 32006.0 32021.5 32040.7 32371.7 36289.1 36355.1 36447.7 36475.1 36683.4 31792.2 31818.8 31823.8 31872.2 32798.8 22832.4 23480.0 23559.0 23661.2 23917.5 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#2] jquery.html Cycles:180 Average:36326.18 Median:21930.51 stddev:85806.76 (391.3%) stddev-sans-first:86005.48 13:36:01 INFO - PID 9752 | Values: 571.8 575.5 577.6 578.4 582.5 21869.6 22264.7 22674.0 22719.3 22720.7 26063.1 26557.6 26690.5 26691.0 26706.2 6940.9 7079.2 7087.1 7107.1 7108.4 6543.7 7144.8 7167.4 7172.0 7178.6 7153.5 7155.0 7164.5 7164.9 7193.2 7157.6 7174.8 7184.6 7192.6 7208.2 7019.1 7052.5 7056.0 7073.6 7082.1 29341.3 29850.1 30697.4 30735.8 30802.1 2031.9 2056.8 2061.2 2070.0 2073.6 19652.5 20086.1 20127.7 20207.7 20254.5 2536.6 2571.7 2653.0 2655.4 2663.3 134238.0 137118.3 137400.0 137725.3 139772.3 19697.6 20464.7 21068.7 21195.4 22457.4 41521.8 41737.8 42030.6 42192.8 42198.0 11544.6 11592.7 11861.6 11862.4 11974.2 8386.1 8778.4 9858.5 9871.4 9973.0 10621.8 11112.2 11187.8 11446.6 11448.1 3679.4 3917.4 3988.3 4165.9 4175.0 952.8 980.4 986.7 989.8 1009.8 19732.5 19817.5 19822.7 19859.4 20540.7 1035.3 1038.8 1056.0 1063.0 1068.6 10702.8 10754.2 11008.2 11032.6 11175.2 494586.0 503028.0 519063.0 523712.0 526113.0 110993.9 111516.0 111832.0 113430.0 113809.0 1130.7 1135.3 1135.7 1156.5 1165.8 17001.0 17036.0 17367.7 17615.5 17718.6 53333.7 53454.7 54221.0 54801.5 55198.0 65130.3 65243.0 65294.0 65663.0 65734.7 19605.5 20060.9 20221.0 20272.7 20588.6 21991.5 22666.9 22745.8 22997.9 23136.9 17735.8 18104.0 18496.0 18626.6 18732.3 16137.0 16675.5 16836.5 16946.9 17171.7 18177.5 18487.2 18595.7 18862.8 18930.3 19595.0 19643.4 19719.0 19839.9 19891.5 18087.6 18138.2 18260.7 18342.0 18347.6 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#3] mootools.html Cycles:180 Average:9291.98 Median:14762.33 stddev:6694.88 (45.4%) stddev-sans-first:6686.87 13:36:01 INFO - PID 9752 | Values: 1319.4 1380.9 1386.0 1392.9 1394.9 14847.4 15447.1 15500.1 15508.2 15520.3 14884.6 15253.5 15258.2 15275.8 15304.9 2627.2 2751.0 2751.4 2751.6 2752.7 2602.8 2739.3 2788.4 2811.6 2812.6 2782.8 2812.4 2816.9 2818.2 2825.9 2747.6 2766.7 2773.7 2775.9 2780.2 2637.1 2657.6 2660.0 2666.2 2668.8 14567.6 15001.3 15011.5 15013.0 15019.2 7756.0 8102.3 8141.5 8147.6 8171.1 5451.3 5474.6 5566.2 5629.8 5696.1 1629.2 1708.4 1868.6 1873.5 1911.8 25228.7 26712.2 26717.9 26738.7 26785.3 6579.0 6618.9 6716.3 6852.3 6942.4 16753.9 16853.0 16878.0 16910.2 16910.7 7961.7 8106.2 8121.8 8141.9 8150.1 7446.7 7457.7 7492.9 7524.0 7548.5 5197.8 5311.8 5330.4 5354.3 5377.1 1566.8 1570.3 1574.5 1582.0 1584.6 859.7 861.0 872.4 886.0 888.7 7234.2 7245.1 7252.5 7263.9 7363.0 699.9 703.4 703.7 720.1 723.3 4961.4 5117.2 5143.0 5164.2 5251.0 21208.0 21487.6 21702.3 21963.9 22036.0 21064.8 21457.1 22167.9 22194.2 22199.8 9857.2 10227.0 10684.7 11373.4 11454.5 8419.5 8473.6 8612.9 8619.1 8624.0 18470.6 18837.2 18915.8 19036.3 19450.6 18959.3 19267.0 19632.6 19738.8 19786.2 10769.6 10882.1 10898.3 10901.2 10906.5 13512.6 13548.5 13582.3 13653.7 13684.4 10835.9 10910.8 11053.8 11085.7 11386.7 11374.7 11418.2 11421.9 11436.5 11554.5 9364.9 9408.0 9411.2 9418.2 9463.1 7381.3 7469.3 7472.0 7534.6 7599.2 6832.1 6918.7 6944.8 7029.8 7064.0 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#4] prototype.html Cycles:180 Average:5394.46 Median:6075.85 stddev:1510.95 (24.9%) stddev-sans-first:1469.62 13:36:01 INFO - PID 9752 | Values: 487.5 503.4 511.5 515.5 521.1 6087.8 6149.0 6209.6 6217.1 6248.0 6068.8 6097.6 6112.0 6198.0 6201.3 5097.1 5106.9 5116.7 5132.4 5151.2 4728.2 5079.3 5079.7 5128.5 5142.8 4825.6 4857.5 4886.1 4892.2 4904.6 4864.0 4868.2 4887.5 4889.3 4906.0 4392.4 4398.7 4399.3 4415.2 4423.4 6036.5 6038.7 6061.8 6061.8 6082.9 5517.7 5526.2 5569.9 5571.0 5614.8 6361.3 6380.0 6398.9 6437.7 6451.3 4475.9 4675.6 4739.9 4746.8 4748.6 6346.5 6591.3 6630.6 6688.7 6729.3 4823.3 4831.5 4840.2 4846.9 4870.1 4886.9 4925.3 4927.4 4951.4 4968.5 5502.5 5507.5 5541.7 5544.2 5552.8 6429.8 6470.5 6476.4 6479.6 6523.4 1687.5 1698.8 1708.9 1718.9 1725.5 1126.4 1168.8 1177.3 1205.6 1208.7 5628.0 5635.4 5646.7 5673.6 5690.6 6503.8 6567.0 6600.4 6618.5 6621.8 5571.7 5587.2 5592.6 5637.8 5679.3 3433.8 3456.6 3459.8 3460.6 3486.6 6413.5 6422.9 6433.4 6433.4 6481.6 6653.7 6666.8 6672.4 6689.6 6718.9 6236.2 6312.4 6406.7 6424.4 6425.4 6532.7 6570.8 6581.2 6617.8 6632.9 5831.9 6314.4 6402.9 6528.7 6542.4 6278.5 6319.1 6362.0 6374.0 6381.2 4768.0 4807.8 4844.3 4855.3 4870.1 6362.5 6559.9 6581.5 6608.2 6656.6 6123.6 6362.6 6376.7 6389.7 6389.9 6364.3 6364.6 6376.0 6400.8 6462.7 6282.2 6309.7 6310.8 6320.8 6327.7 6271.4 6490.4 6493.0 6497.4 6509.2 6148.7 6183.7 6189.1 6196.6 6222.3 13:36:01 INFO - PID 9752 | 13:36:01 INFO - PID 9752 | [#5] yui.html Cycles:180 Average:23682.29 Median:17919.73 stddev:34408.43 (192.0%) stddev-sans-first:34462.36 13:36:01 INFO - PID 9752 | Values: 881.2 897.9 915.8 917.0 927.7 17391.9 17849.4 17850.6 17860.7 18023.5 17762.5 17890.0 17906.9 17932.6 18779.4 950.3 974.5 976.8 977.7 978.5 948.8 972.9 973.7 975.8 978.9 1058.4 1059.8 1069.0 1069.5 1070.1 962.7 1000.5 1043.1 1050.1 1052.2 743.5 746.0 746.4 746.4 747.4 19669.5 19815.9 19819.2 19891.9 19910.0 20354.9 21055.2 21423.6 21584.2 21585.0 16620.6 17001.4 17216.6 17375.5 17422.9 3689.9 3703.8 3708.3 3724.0 3734.6 138925.3 140720.0 141551.0 143563.0 146064.0 15239.6 15649.5 15816.9 15823.9 15852.4 27461.0 27603.0 28678.1 28738.7 29142.3 8253.1 8283.7 8364.8 8411.9 8436.6 3931.8 4048.8 4056.5 4064.9 4126.6 5478.4 5524.6 5565.1 5583.2 5584.8 1013.5 1024.4 1043.8 1046.8 1049.8 681.4 700.5 702.0 716.7 719.6 10692.9 11639.1 11855.0 11857.4 12111.8 671.8 677.5 685.1 691.2 701.2 5316.2 5341.4 5458.8 5563.6 5599.9 108697.5 112788.0 115052.4 116020.4 117037.0 101165.0 103519.5 104637.5 105686.5 106589.5 87399.6 87957.2 91379.5 92306.0 92808.0 10239.6 10240.9 10641.5 10643.7 10732.3 44080.3 44380.6 45844.3 46221.3 47427.0 56783.0 58449.7 59873.0 60240.7 60387.7 15195.5 15331.4 15405.0 15421.5 15474.5 15861.1 16105.6 16141.4 16204.7 16311.5 14972.4 15029.8 15070.8 15090.5 15278.2 15596.2 15667.3 15824.8 15859.0 15956.2 14656.0 14749.4 14815.2 14828.9 15025.4 11881.8 11951.1 12163.7 12201.5 12227.1 12261.6 12367.6 12446.4 12478.7 12658.4 13:36:01 INFO - PID 9752 | -------- Summary: end -------- 13:36:01 INFO - PID 9752 | 13:36:01 INFO - TEST-INFO | 9752: exit 0 13:36:01 INFO - TEST-OK | dromaeo_css | took 1108123ms 13:36:01 INFO - TEST-START | kraken 13:36:01 INFO - Initialising browser for kraken test... 13:36:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50877/getInfo.html -profile /tmp/tmpCa7uIp/profile 13:36:01 INFO - TEST-INFO | started process 10122 (/builds/slave/test/build/application/firefox/firefox http://localhost:50877/getInfo.html) 13:36:07 INFO - TEST-INFO | 10122: exit 0 13:36:07 INFO - Browser initialized. 13:36:07 INFO - Running cycle 1/1 for kraken test... 13:36:07 INFO - Using env: {'DISPLAY': ':0', 13:36:07 INFO - 'HOME': '/home/cltbld', 13:36:07 INFO - 'JSGC_DISABLE_POISONING': '1', 13:36:07 INFO - 'LANG': 'en_US.UTF-8', 13:36:07 INFO - 'LANGUAGE': 'en_US:en', 13:36:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:36:07 INFO - 'LOGNAME': 'cltbld', 13:36:07 INFO - 'MAIL': '/var/mail/cltbld', 13:36:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:36:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:36:07 INFO - 'MOZ_CRASHREPORTER': '1', 13:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:36:07 INFO - 'MOZ_NO_REMOTE': '1', 13:36:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:36:07 INFO - 'NO_EM_RESTART': '1', 13:36:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:07 INFO - 'PWD': '/builds/slave/test', 13:36:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:36:07 INFO - 'RUST_BACKTRACE': 'full', 13:36:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:36:07 INFO - 'SHELL': '/bin/bash', 13:36:07 INFO - 'SHLVL': '1', 13:36:07 INFO - 'TERM': 'linux', 13:36:07 INFO - 'TMOUT': '86400', 13:36:07 INFO - 'USER': 'cltbld', 13:36:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117', 13:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:07 INFO - '_': '/tools/buildbot/bin/python'} 13:36:07 INFO - TEST-INFO | started process 10347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCa7uIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:36:08 INFO - PID 10347 | 13:36:08 INFO - PID 10347 | (/builds/slave/test/build/application/firefox/firefox:10395): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:36:08 INFO - PID 10347 | 13:36:18 INFO - PID 10347 | RSS: Main: 174108672 13:36:18 INFO - PID 10347 | 13:36:21 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50877/tests/kraken/driver.html?testName=audio-beat-detection) 13:36:22 INFO - PID 10347 | RSS: Main: 179945472 13:36:22 INFO - PID 10347 | 13:36:24 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50877/tests/kraken/driver.html?testName=audio-dft) 13:36:25 INFO - PID 10347 | RSS: Main: 180379648 13:36:25 INFO - PID 10347 | 13:36:28 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50877/tests/kraken/driver.html?testName=audio-fft) 13:36:29 INFO - PID 10347 | RSS: Main: 175165440 13:36:29 INFO - PID 10347 | 13:36:31 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50877/tests/kraken/driver.html?testName=audio-oscillator) 13:36:31 INFO - PID 10347 | RSS: Main: 175693824 13:36:31 INFO - PID 10347 | 13:36:34 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50877/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:36:34 INFO - PID 10347 | RSS: Main: 175865856 13:36:34 INFO - PID 10347 | 13:36:37 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50877/tests/kraken/driver.html?testName=imaging-darkroom) 13:36:38 INFO - PID 10347 | RSS: Main: 178155520 13:36:38 INFO - PID 10347 | 13:36:42 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50877/tests/kraken/driver.html?testName=imaging-desaturate) 13:36:42 INFO - PID 10347 | RSS: Main: 178118656 13:36:42 INFO - PID 10347 | 13:36:45 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50877/tests/kraken/driver.html?testName=json-parse-financial) 13:36:46 INFO - PID 10347 | RSS: Main: 178753536 13:36:46 INFO - PID 10347 | 13:36:48 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50877/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:36:48 INFO - PID 10347 | RSS: Main: 178978816 13:36:48 INFO - PID 10347 | 13:36:50 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:36:51 INFO - PID 10347 | RSS: Main: 179113984 13:36:51 INFO - PID 10347 | 13:36:53 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:53 INFO - PID 10347 | RSS: Main: 176103424 13:36:53 INFO - PID 10347 | 13:36:56 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:57 INFO - PID 10347 | RSS: Main: 176070656 13:36:57 INFO - PID 10347 | 13:37:00 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:00 INFO - PID 10347 | RSS: Main: 176685056 13:37:00 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | Cycle 1(1): loaded http://localhost:50877/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50877/tests/kraken/driver.html?testName=ai-astar) 13:37:02 INFO - PID 10347 | RSS: Main: 177852416 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | __start_tp_report 13:37:02 INFO - PID 10347 | _x_x_mozilla_page_load 13:37:02 INFO - PID 10347 | _x_x_mozilla_page_load_details 13:37:02 INFO - PID 10347 | |i|pagename|runs| 13:37:02 INFO - PID 10347 | |0;ai-astar;109;107;107;105;109;108;110;107;107;107 13:37:02 INFO - PID 10347 | |1;audio-beat-detection;117;120;116;116;117;115;116;143;118;116 13:37:02 INFO - PID 10347 | |2;audio-dft;162;163;162;161;160;161;164;165;166;161 13:37:02 INFO - PID 10347 | |3;audio-fft;73;75;76;73;73;75;75;73;73;73 13:37:02 INFO - PID 10347 | |4;audio-oscillator;88;81;79;79;78;78;78;79;81;80 13:37:02 INFO - PID 10347 | |5;imaging-gaussian-blur;112;113;113;110;114;114;113;114;115;114 13:37:02 INFO - PID 10347 | |6;imaging-darkroom;156;151;149;150;149;150;149;150;147;149 13:37:02 INFO - PID 10347 | |7;imaging-desaturate;101;94;94;94;94;94;94;95;94;94 13:37:02 INFO - PID 10347 | |8;json-parse-financial;54;55;56;55;55;62;58;57;56;54 13:37:02 INFO - PID 10347 | |9;json-stringify-tinderbox;37;37;39;38;38;39;38;38;37;38 13:37:02 INFO - PID 10347 | |10;stanford-crypto-aes;73;75;80;78;80;76;74;74;75;76 13:37:02 INFO - PID 10347 | |11;stanford-crypto-ccm;121;114;121;118;117;125;120;114;110;116 13:37:02 INFO - PID 10347 | |12;stanford-crypto-pbkdf2;180;174;182;171;166;174;171;170;171;168 13:37:02 INFO - PID 10347 | |13;stanford-crypto-sha256-iterative;66;68;65;67;66;66;65;65;65;68 13:37:02 INFO - PID 10347 | __end_tp_report 13:37:02 INFO - PID 10347 | __start_cc_report 13:37:02 INFO - PID 10347 | _x_x_mozilla_cycle_collect,1007 13:37:02 INFO - PID 10347 | __end_cc_report 13:37:02 INFO - PID 10347 | __startTimestamp1505507822813__endTimestamp 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | ------- Summary: start ------- 13:37:02 INFO - PID 10347 | Number of tests: 14 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#0] ai-astar Cycles:10 Average:107.60 Median:107.50 stddev:1.43 (1.3%) stddev-sans-first:1.42 13:37:02 INFO - PID 10347 | Values: 109.0 107.0 107.0 105.0 109.0 108.0 110.0 107.0 107.0 107.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:117.00 stddev:8.41 (7.2%) stddev-sans-first:8.87 13:37:02 INFO - PID 10347 | Values: 117.0 120.0 116.0 116.0 117.0 115.0 116.0 143.0 118.0 116.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.96 (1.2%) stddev-sans-first:2.07 13:37:02 INFO - PID 10347 | Values: 162.0 163.0 162.0 161.0 160.0 161.0 164.0 165.0 166.0 161.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:1.20 (1.6%) stddev-sans-first:1.22 13:37:02 INFO - PID 10347 | Values: 73.0 75.0 76.0 73.0 73.0 75.0 75.0 73.0 73.0 73.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:79.50 stddev:3.00 (3.8%) stddev-sans-first:1.20 13:37:02 INFO - PID 10347 | Values: 88.0 81.0 79.0 79.0 78.0 78.0 78.0 79.0 81.0 80.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.40 (1.2%) stddev-sans-first:1.41 13:37:02 INFO - PID 10347 | Values: 112.0 113.0 113.0 110.0 114.0 114.0 113.0 114.0 115.0 114.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:2.36 (1.6%) stddev-sans-first:1.12 13:37:02 INFO - PID 10347 | Values: 156.0 151.0 149.0 150.0 149.0 150.0 149.0 150.0 147.0 149.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.20 (2.3%) stddev-sans-first:0.33 13:37:02 INFO - PID 10347 | Values: 101.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.39 (4.3%) stddev-sans-first:2.40 13:37:02 INFO - PID 10347 | Values: 54.0 55.0 56.0 55.0 55.0 62.0 58.0 57.0 56.0 54.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.74 (1.9%) stddev-sans-first:0.71 13:37:02 INFO - PID 10347 | Values: 37.0 37.0 39.0 38.0 38.0 39.0 38.0 38.0 37.0 38.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:2.47 (3.2%) stddev-sans-first:2.35 13:37:02 INFO - PID 10347 | Values: 73.0 75.0 80.0 78.0 80.0 76.0 74.0 74.0 75.0 76.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:119.00 stddev:4.35 (3.7%) stddev-sans-first:4.44 13:37:02 INFO - PID 10347 | Values: 121.0 114.0 121.0 118.0 117.0 125.0 120.0 114.0 110.0 116.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.50 stddev:5.01 (2.9%) stddev-sans-first:4.57 13:37:02 INFO - PID 10347 | Values: 180.0 174.0 182.0 171.0 166.0 174.0 171.0 170.0 171.0 168.0 13:37:02 INFO - PID 10347 | 13:37:02 INFO - PID 10347 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 13:37:02 INFO - PID 10347 | Values: 66.0 68.0 65.0 67.0 66.0 66.0 65.0 65.0 65.0 68.0 13:37:02 INFO - PID 10347 | -------- Summary: end -------- 13:37:02 INFO - PID 10347 | 13:37:03 INFO - PID 10347 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:37:03 INFO - TEST-INFO | 10347: exit 0 13:37:03 INFO - TEST-OK | kraken | took 61838ms 13:37:03 INFO - SUITE-END | took 1169s 13:37:03 INFO - Completed test suite (00:19:30) 13:37:03 INFO - javascript benchmark 13:37:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8512.479686559589, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.314630781227, 3119.7660175486835, 3133.4516459619563, 3139.2151962009507, 3150.322680623667, 6120.14317995481, 6144.109104179891, 6184.1342212090285, 6233.501319894403, 6301.6849157542165, 6200.751969921209, 6202.379762023796, 6239.906401403971, 6258.937410625892, 6276.717547710353, 5789.247397838275, 5848.356680765123, 5875.823725288248, 5895.528357731393, 5913.940860591382, 38.06285093531818, 5790.392008839053, 5856.180134781112, 5856.267966504187, 5893.38119497453, 5353.678779273237, 5712.685802280873, 5717.42825717427, 5738.856528586777, 5797.188393624875, 5741.971290143564, 5807.448292412214, 5819.621724587888, 5823.2138661280605, 5828.737706803204, 5722.341930677983, 5738.684372359518, 5798.130280457923, 5818.738156782955, 5821.883562328772, 6160.969195154041, 6226.937730622726, 6236.937630623681, 6311.463525600329, 6338.0, 6577.967110164419, 6609.173853268341, 6733.124693789825, 6776.0, 6812.931870681279, 6673.232578253466, 6694.732210711566, 6695.46436285096, 6696.263411024832, 6702.865942681119, 5939.0, 6017.736275382175, 6056.303525094627, 6122.47958923492, 6168.475679567242, 6907.378335949788, 6917.169939607179, 6988.301169883021, 7007.124109486314, 7008.719651213996, 6562.901556476657, 6586.0, 6608.339166083353, 6665.733370665216, 6683.064370988066, 6434.195725534309, 6548.246951600531, 6677.198736151693, 6692.732290708414, 6718.0, 6592.472602191909, 6638.369354911276, 6641.66791660415, 6645.435138013227, 6672.599644021374, 6669.899951500732, 6676.899846502306, 6728.899066514006, 6747.257801641816, 6770.390664840188, 4976.129177393942, 5050.696958182521, 5111.386633603917, 5111.923321150186, 5113.1563292057135, 4469.061497085649, 4481.484629267611, 4489.259272220047, 4493.707908985905, 4578.427696537933, 5789.131630255495, 5801.564882633819, 5801.854953626109, 5809.186713860063, 5813.447722466359, 6559.409653131241, 6625.503087268377, 6652.966735166293, 6725.495587830932, 6773.45812335012, 5683.54531637468, 5694.487496125285, 5759.8560035999435, 5783.855403614859, 5786.594938354359, 5653.547716182696, 5665.065264231355, 5666.490015898589, 5682.516986056149, 5685.118806584986, 6515.609063456208, 6533.640649764308, 6611.471082313404, 6630.204375474974, 6659.467242620579, 6631.801045968628, 6732.158480189976, 6759.256481787, 6846.178458585002, 6850.21222559412, 6337.7781777637565, 6576.375244351779, 6595.340465953366, 6686.933130668631, 6690.799276021728, 6521.836954076186, 6569.605823650596, 6579.342065793382, 6587.440067594308, 6593.0, 6598.60408375499, 6656.467482601283, 6670.199576050905, 6672.466202703869, 6748.493862960396, 6437.227532696106, 6441.0, 6450.580712253689, 6528.988006858945, 6541.934580654132, 6309.432151106423, 6437.25971513282, 6442.484601231797, 6531.379518945692, 6546.509011824037, 6349.555531112777, 6392.137061496638, 6408.711607977745, 6443.96778016107, 6451.258105317948, 6508.381703738138, 6584.7036883341325, 6599.67001649906, 6618.536702430783, 6629.43649789754, 6220.595661282002, 6301.6219026858535, 6336.239651241881, 6399.200099987502, 6412.871742565029], "value": 6043.007153733898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.2271065198717, 858.9613467393968, 886.6630680341469, 888.9022207557172, 892.7321803458963, 40281.59718402815, 41915.37126943098, 42310.576894231046, 42404.78797606016, 42428.363574546405, 38287.425688614625, 38390.04024899379, 38497.80751096248, 38543.0, 38606.22787544248, 6988.056612357343, 7053.294670532957, 7095.113110861143, 7099.787006389816, 7104.040954471157, 6922.896156557656, 6978.720851165947, 6987.7204911803465, 6989.650517474131, 6991.68537415815, 6995.65021748913, 7003.894941575881, 7006.474514411414, 7014.719411223545, 7019.5086343955945, 7699.268569485918, 7850.057993040843, 7854.921450785505, 7857.057153141603, 7860.68557257709, 7646.885296720554, 7733.806654833618, 7739.458237923292, 7814.648340824677, 7826.921730782733, 38594.61405385967, 38988.41517377242, 38999.220015599814, 39131.8043409784, 39198.0, 3518.3315170117853, 3534.5228394166716, 3554.2713743682484, 3563.1804684922613, 3573.249617580311, 31871.362572748414, 31962.680373196436, 31965.840170798998, 31987.200319991953, 32007.83996080028, 5190.584753219733, 5197.8960420791755, 5231.084560201987, 5233.136532472137, 5239.345081864767, 183375.0, 184734.07632961884, 185141.07429462767, 185335.0, 187105.0, 46403.76798115988, 46766.0, 47062.29406558904, 47191.292130618065, 47246.291305630446, 50230.0, 50357.49642503601, 50522.242166367534, 50691.49308506868, 50863.74568127136, 15137.318820653098, 15253.237338133049, 15289.159096249814, 15295.847041529665, 15330.080195188324, 12330.691732706755, 12346.259224446561, 12354.0, 12367.381630918419, 12375.69060773488, 14269.78595321071, 14349.497767578294, 14351.64120896965, 14390.28048597566, 14546.12723236588, 5600.607957443021, 5625.703835843097, 5691.8292451226525, 5695.857603559944, 5736.254286942671, 1002.0580654185043, 1002.9247806414402, 1009.1472705563787, 1016.1819735113157, 1019.0879163149089, 22562.32313030612, 22717.0, 22733.0, 23013.7698623015, 23157.88421057884, 1081.2809481694742, 1103.9503222355013, 1111.9332840029624, 1117.8882111788755, 1134.0587312530579, 11902.345371004505, 11965.0, 12008.63974080779, 12076.637700868989, 12086.15396922207, 228204.0, 229648.0, 229802.0, 230582.0, 231184.0, 44492.55507444884, 45363.54636453659, 51680.0, 52594.73702631462, 52759.736201319516, 1405.3043743346905, 1425.7861320801755, 1426.3866537389022, 1440.164704471404, 1446.240723620108, 26990.865045674647, 27374.17877463679, 27646.585301220097, 27696.03063892754, 27864.0, 37037.44443833291, 37067.25865482729, 37073.07317317089, 37073.814630926674, 37094.8145259272, 207094.0, 208245.0, 208409.0, 208487.0, 208699.0, 32287.838560807046, 33523.497147542315, 33675.0, 33784.1553961153, 34198.31603367869, 42866.142677146905, 43027.56972430361, 43122.56877431311, 43219.35170972375, 43518.56481435145, 31516.266605336925, 31582.842085789423, 32133.517997229592, 32143.839280803448, 32445.35109297848, 32000.0, 32006.0, 32021.519677204393, 32040.679593204703, 32371.676283236866, 36289.09277267984, 36355.09112272109, 36447.663630439514, 36475.08812279714, 36683.44974825326, 31792.205194870312, 31818.84090579532, 31823.840880795447, 31872.203194920312, 32798.836005819816, 22832.429189270402, 23480.029382517376, 23559.0, 23661.171858984853, 23917.521649567258], "value": 16999.169101663934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.7512881896378, 575.5309422820403, 577.6072270855819, 578.3840210176162, 582.5427039773779, 21869.562608747816, 22264.66603000952, 22674.0, 22719.318420447373, 22720.65919011216, 26063.087791927286, 26557.601635975476, 26690.466190676176, 26691.0, 26706.19881403556, 6940.895886561706, 7079.185893622248, 7087.149542054961, 7107.111611048619, 7108.431325493974, 6543.705533251015, 7144.821379465503, 7167.4266058715175, 7171.9641401792915, 7178.5692858428665, 7153.535020223695, 7154.964225178893, 7164.498485106044, 7164.892526612079, 7193.208747037822, 7157.6063316517575, 7174.820629484252, 7184.568925864439, 7192.568445893263, 7208.24313447091, 7019.087518622547, 7052.541584796972, 7055.964720176417, 7073.610951397671, 7082.079329687159, 29341.26646833825, 29850.10449686513, 30697.386052279053, 30735.846320768254, 30802.075937721904, 2031.8780873147512, 2056.8251698605636, 2061.2476446097216, 2070.037432593851, 2073.6474799284156, 19652.50868728279, 20086.09612567438, 20127.698084528743, 20207.69688454674, 20254.49363765903, 2536.644869718241, 2571.7171111177754, 2653.044903834618, 2655.402534429738, 2663.3474798674256, 134238.0, 137118.31440842833, 137400.0, 137725.3113734435, 139772.3011384947, 19697.606047878962, 20464.69302960457, 21068.683969740465, 21195.364139075853, 22457.438564035703, 41521.792391038456, 41737.79131104325, 42030.579694203276, 42192.789036055234, 42198.0, 11544.595939142258, 11592.6522204334, 11861.644150675493, 11862.406879655982, 11974.161808673309, 8386.119457457002, 8778.385513014155, 9858.45778482176, 9871.358361706467, 9973.0, 10621.84067238992, 11112.22214444981, 11187.832182517268, 11446.599369022044, 11448.141389395829, 3679.411294192916, 3917.3536366499206, 3988.3419235825763, 4165.91668166635, 4174.979125104416, 952.7951490429591, 980.352967041749, 986.7483791633088, 989.8020395920701, 1009.7526106103904, 19732.50668733293, 19817.504562385766, 19822.70265946012, 19859.404217873485, 20540.691889621667, 1035.3270374256792, 1038.787048655024, 1055.9788804223872, 1062.9893701063045, 1068.647346375694, 10702.785944281071, 10754.193435492369, 11008.174386921013, 11032.613858514913, 11175.161862860317, 494586.0, 503028.0, 519063.0, 523712.0, 526113.0, 110993.89006109997, 111516.0, 111832.0, 113430.0, 113809.0, 1130.7173206698326, 1135.3074624479061, 1135.65362564417, 1156.4622450560362, 1165.7726743285148, 17001.0, 17036.0, 17367.652646947245, 17615.471535853943, 17718.645627087128, 53333.733331334646, 53454.73272633612, 54221.0, 54801.45198547964, 55198.0, 65130.348696514324, 65243.0, 65294.0, 65663.0, 65734.67132664498, 19605.50986225356, 20060.89969550143, 20221.0, 20272.695909561662, 20588.58822823565, 21991.450213744145, 22666.886665566566, 22745.772542274364, 22997.88501057484, 23136.884315578314, 17735.82264177342, 18104.0, 18496.0, 18626.627467450304, 18732.250709971995, 16137.0, 16675.49973500797, 16836.494905152864, 16946.915265423595, 17171.656566868343, 18177.454676359732, 18487.16807743628, 18595.72106418432, 18862.811371886106, 18930.33743819015, 19595.0, 19643.410697679094, 19719.0, 19839.900800495907, 19891.502712432306, 18087.638247235245, 18138.183781730117, 18260.726089108408, 18342.0, 18347.63304733871], "value": 12931.491976403668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.3535167767793, 1380.8757211850932, 1385.9584212473626, 1392.881605063569, 1394.8744612984842, 14847.40610375585, 15447.073175609472, 15500.06999580026, 15508.22458877056, 15520.30158642861, 14884.62788430287, 15253.466128685499, 15258.160801155933, 15275.770863437057, 15304.923475382635, 2627.2381009507267, 2751.0371370020434, 2751.4497100579965, 2751.614773931641, 2752.683441404244, 2602.8438293702343, 2739.328864428218, 2788.3726161613577, 2811.5642075478336, 2812.620296259999, 2782.8191167574146, 2812.4234531920906, 2816.943661126776, 2818.196813908037, 2825.858707064649, 2747.587861820723, 2766.681831589373, 2773.6948935617065, 2775.861206939645, 2780.207640822356, 2637.129747183444, 2657.601359796046, 2659.986700066487, 2666.240121565364, 2668.7731542818883, 14567.562973110824, 15001.3249403776, 15011.474598389113, 15013.024153430102, 15019.173945432996, 7755.961220193863, 8102.311303539206, 8141.51150930946, 8147.592620368958, 8171.142030086815, 5451.2640793492765, 5474.644148130359, 5566.248556444909, 5629.802956896489, 5696.060150075233, 1629.1528405229215, 1708.4105983435818, 1868.6262747450564, 1873.5222518257892, 1911.8279354857991, 25228.747712522825, 26712.19863404101, 26717.866410668015, 26738.73261267382, 26785.330366740793, 6579.013148027739, 6618.933810661832, 6716.294789047178, 6852.349026842442, 6942.409895158968, 16753.91623041877, 16853.0, 16878.0, 16910.239039243017, 16910.74633880493, 7961.72133975308, 8106.2299081588335, 8121.75634730959, 8141.9185808141165, 8150.103488616248, 7446.7021319146625, 7457.664405101784, 7492.887606685904, 7523.962380188064, 7548.509346892544, 5197.792088316501, 5311.814086507031, 5330.413654498002, 5354.330708661418, 5377.139657654757, 1566.8433156684468, 1570.3090640118312, 1574.4882913053304, 1581.9604509887115, 1584.5800862771375, 859.656137544987, 860.9870851937226, 872.3500991761051, 886.0342226972631, 888.6800751729372, 7234.168070671835, 7245.094363204599, 7252.456065795086, 7263.89104163438, 7363.042804435497, 699.919509256442, 703.3845385287873, 703.711478293897, 720.1358369956074, 723.2767232767233, 4961.404631444249, 5117.181250999822, 5143.048536020848, 5164.173732202829, 5251.002309561171, 21208.0, 21487.57024859494, 21702.348929532138, 21963.890180548995, 22036.0, 21064.789352106283, 21457.14171433125, 22167.889160554096, 22194.223202187844, 22199.778002220093, 9857.162141217934, 10227.02843229892, 10684.717833859831, 11373.431328433546, 11454.54181832734, 8419.536925469158, 8473.57632118404, 8612.913870861212, 8619.051904290649, 8623.95688021581, 18470.630587388445, 18837.15232814554, 18915.810841891405, 19036.33372831944, 19450.61098777988, 18959.336423225122, 19267.036648167254, 19632.607347852678, 19738.80261197427, 19786.20855165777, 10769.569217231223, 10882.075023623082, 10898.291611045574, 10901.182411319025, 10906.454677266263, 13512.59462216135, 13548.458061677422, 13582.25297608641, 13653.658658533615, 13684.384202710702, 10835.891641083488, 10910.781784364426, 11053.834192486958, 11085.722856928318, 11386.658400248005, 11374.715632109264, 11418.200725949437, 11421.942890285496, 11436.485358159069, 11554.537818487166, 9364.906350936404, 9408.012158723235, 9411.152996230372, 9418.199453046567, 9463.101005404476, 7381.298776616213, 7469.327760501581, 7471.9626401867645, 7534.623268836426, 7599.16409194977, 6832.111825462658, 6918.654067296716, 6944.756933507303, 7029.753958611424, 7064.046353742385], "value": 6595.851792207384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.48570258377396, 503.3808415648752, 511.5038412739644, 515.5308669111108, 521.1063026908853, 6087.756489740405, 6149.0177264027025, 6209.640336672064, 6217.052171870861, 6248.0, 6068.817935461932, 6097.634141951486, 6111.969440152793, 6198.0, 6201.28685201202, 5097.133487307148, 5106.897862042757, 5116.718580478072, 5132.435432102466, 5151.150060240056, 4728.196206644861, 5079.288899554065, 5079.695218286896, 5128.461511541291, 5142.837155149594, 4825.565699087081, 4857.465678775332, 4886.144924638174, 4892.192788189945, 4904.5831104356175, 4863.951360486385, 4868.196747536687, 4887.462379138292, 4889.315495830587, 4905.975470122645, 4392.407025051609, 4398.692091553593, 4399.274119770266, 4415.161119387306, 4423.424954755861, 6036.5170786336985, 6038.698065096728, 6061.757529698807, 6061.787837425713, 6082.878342433127, 5517.724113794295, 5526.171074338841, 5569.916451253234, 5571.0, 5614.831555053355, 6361.300256971729, 6379.968100159516, 6398.872022559569, 6437.678116094176, 6451.322611125811, 4475.932861007088, 4675.555822196886, 4739.857804265877, 4746.762661866893, 4748.620110391161, 6346.509419819081, 6591.340865913418, 6630.569013014138, 6688.665566721645, 6729.255874608439, 4823.300621409876, 4831.51684831514, 4840.177169881058, 4846.878828029327, 4870.147724148331, 4886.902261954741, 4925.285833554115, 4927.384076990376, 4951.3810773653295, 4968.478309777493, 5502.532284755841, 5507.531859791882, 5541.667499950016, 5544.22380866679, 5552.833414997556, 6429.7749578764515, 6470.450011749054, 6476.449501792306, 6479.5788273763, 6523.380278873499, 1687.5190570687296, 1698.7961444626724, 1708.863290936722, 1718.9140542972802, 1725.4564812084154, 1126.442411006557, 1168.7896178687747, 1177.3465726521863, 1205.5961252980173, 1208.6857417071624, 5627.999999999918, 5635.380108188096, 5646.71766411686, 5673.6028478006965, 5690.601657883908, 6503.772367967098, 6567.047778072249, 6600.372964568358, 6618.536702430783, 6621.834454138589, 5571.721413929368, 5587.217789509472, 5592.636478628876, 5637.830865074055, 5679.290088738908, 3433.828308584561, 3456.5679290088738, 3459.844307006191, 3460.6193318735423, 3486.564179477565, 6413.518986075969, 6422.903656445157, 6433.356664333529, 6433.388828061326, 6481.592517088331, 6653.733850646016, 6666.799996000031, 6672.399484046362, 6689.5986240825705, 6718.865622687519, 6236.220472440945, 6312.400321969498, 6406.679666016774, 6424.357564243632, 6425.421712045938, 6532.738690452328, 6570.8357291068105, 6581.177352830896, 6617.834554136185, 6632.867342653217, 5831.94168058314, 6314.431701146918, 6402.871942561216, 6528.747582084174, 6542.411182993554, 6278.497720182466, 6319.146915166578, 6362.045693146065, 6374.0, 6381.234251889803, 4768.0, 4807.807687692453, 4844.304493427272, 4855.295982082649, 4870.0746858096845, 6362.491000720024, 6559.868802623825, 6581.539292249497, 6608.207015158212, 6656.600603963778, 6123.571350005457, 6362.554621176473, 6376.681165941777, 6389.68051597409, 6389.904151437825, 6364.268109167319, 6364.554481186273, 6375.968120159369, 6400.807975760735, 6462.7091780870915, 6282.1519094921605, 6309.747610095545, 6310.7791227306825, 6320.810375688737, 6327.683615819098, 6271.43557079865, 6490.448311893542, 6492.954719263417, 6497.415232629086, 6509.1863517060365, 6148.723307451086, 6183.690815459299, 6189.1025801257665, 6196.566240363311, 6222.346653601488], "value": 4948.98476498409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.2333270055053, 897.8563429851223, 915.7939463620686, 917.0279503726051, 927.6984979881538, 17391.91304043481, 17849.375271865487, 17850.642987140265, 17860.732089018675, 18023.549411264692, 17762.467125986208, 17890.0, 17906.910465447687, 17932.55168620785, 18779.43661690148, 950.273041123541, 974.4640447753743, 976.7509285132281, 977.7115750853516, 978.4911845840159, 948.8197242523933, 972.9027097290285, 973.7224890906093, 975.8292298847708, 978.9265805064613, 1058.3544038136731, 1059.8410238464214, 1069.0, 1069.5240617925026, 1070.058348653184, 962.711186644004, 1000.494750151169, 1043.118564812732, 1050.144132531988, 1052.2108418686023, 743.4758495260828, 745.9962700186464, 746.3991486853081, 746.4066067476369, 747.4095464582973, 19669.508262293413, 19815.900920495304, 19819.207231710716, 19891.90054049735, 19910.0, 20354.89822550878, 21055.157793688235, 21423.571528569497, 21584.244551440624, 21585.0, 16620.58448538796, 17001.40495082666, 17216.569585760455, 17375.47873563795, 17422.912885435617, 3689.8708545201057, 3703.759255648374, 3708.2583483303447, 3724.0317517445387, 3734.589195188527, 138925.3053734735, 140719.99999999898, 141551.0, 143563.0, 146064.0, 15239.61900952463, 15649.530514084596, 15816.920915395349, 15823.920880395524, 15852.44516441919, 27461.0, 27603.0, 28678.13965580994, 28738.712612873605, 29142.27144321409, 8253.13342099083, 8283.710070147516, 8364.832703346021, 8411.915880841236, 8436.620352084172, 3931.8427262909736, 4048.8380464781667, 4056.51321841375, 4064.878053658395, 4126.5667104953545, 5478.369987451414, 5524.640898341595, 5565.1374037024325, 5583.218349431002, 5584.804531841366, 1013.5084484025242, 1024.4007255755319, 1043.7703705184847, 1046.7644779924456, 1049.7795462952713, 681.4276008153175, 700.4921431961787, 701.9578825270501, 716.6774951271949, 719.5718547464251, 10692.946535267429, 11639.127065470124, 11855.0, 11857.407129643656, 12111.75776484483, 671.7648822912039, 677.5494296293009, 685.0683071023404, 691.1878542712293, 701.1936273285762, 5316.202569614588, 5341.412444631165, 5458.781648734006, 5563.610547261734, 5599.860003499945, 108697.4565127185, 112788.0, 115052.42473787577, 116020.41989789998, 117037.0, 101165.0, 103519.4824025875, 104637.47681261545, 105686.47156764167, 106589.46705266424, 87399.56300218585, 87957.24085518382, 91379.54310228539, 92306.0, 92808.0, 10239.590416383262, 10240.948795255976, 10641.521131549254, 10643.680689579325, 10732.302400343953, 44080.33879491746, 44380.556194437646, 45844.31233531566, 46221.306680399146, 47427.0, 56783.0, 58449.70775146097, 59873.0, 60240.69879650749, 60387.698061509414, 15195.544133676007, 15331.386744530093, 15405.0, 15421.537353879401, 15474.5357639271, 15861.127637980022, 16105.597360066093, 16141.435049773201, 16204.67590648204, 16311.510654680378, 14972.401103956156, 15029.774553381489, 15070.849291507384, 15090.54728358151, 15278.236088195768, 15596.220188990279, 15667.29497172607, 15824.762628560811, 15859.0, 15956.202189890691, 14656.0, 14749.410023598935, 14815.18516481604, 14828.851711482746, 15025.398984040516, 11881.762364752483, 11951.103667225167, 12163.695907602381, 12201.450934708137, 12227.14409991292, 12261.632151035483, 12367.62897113088, 12446.37768111609, 12478.688032799253, 12658.367081645696], "value": 8773.888498878485, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 107.0, 105.0, 109.0, 108.0, 110.0, 107.0, 107.0, 107.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 116.0, 116.0, 117.0, 115.0, 116.0, 143.0, 118.0, 116.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 160.0, 161.0, 164.0, 165.0, 166.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 73.0, 73.0, 75.0, 75.0, 73.0, 73.0, 73.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0, 81.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 110.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 147.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 55.0, 62.0, 58.0, 57.0, 56.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 39.0, 38.0, 38.0, 39.0, 38.0, 38.0, 37.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 80.0, 78.0, 80.0, 76.0, 74.0, 74.0, 75.0, 76.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 114.0, 121.0, 118.0, 117.0, 125.0, 120.0, 114.0, 110.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 182.0, 171.0, 166.0, 174.0, 171.0, 170.0, 171.0, 168.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 68.0], "value": 66.1, "unit": "score"}]}]} 13:37:04 INFO - Return code: 0 13:37:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:04 INFO - # TBPL SUCCESS # 13:37:04 INFO - Running post-action listener: _package_coverage_data 13:37:04 INFO - Running post-action listener: _resource_record_post_action 13:37:04 INFO - [mozharness: 2017-09-15 20:37:04.097309Z] Finished run-tests step (success) 13:37:04 INFO - Running post-run listener: _resource_record_post_run 13:37:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 16384; Write bytes: 458399744; Read time: 264; Write time: 400752 13:37:04 INFO - TinderboxPrint: CPU usage
13.1% 13:37:04 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 264 13:37:04 INFO - TinderboxPrint: I/O write bytes / time
458,399,744 / 400,752 13:37:04 INFO - TinderboxPrint: CPU idle
8,228.5 (86.9%) 13:37:04 INFO - TinderboxPrint: CPU user
1,193.1 (12.6%) 13:37:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:37:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 142548992; Read time: 0; Write time: 185464 13:37:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:37:04 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 315850752; Read time: 248; Write time: 215288 13:37:04 INFO - Running post-run listener: _upload_blobber_files 13:37:04 INFO - Blob upload gear active. 13:37:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:37:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:06 INFO - (blobuploader) - INFO - Done attempting. 13:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:07 INFO - (blobuploader) - INFO - Done attempting. 13:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:08 INFO - (blobuploader) - INFO - Done attempting. 13:37:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:15 INFO - (blobuploader) - INFO - Done attempting. 13:37:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:15 INFO - Return code: 0 13:37:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/303a694777fc1ddeff2eb42202e1c253fd195f6df8e5a0c9e7a6530e73bb7432bb67431b48a9e200b45874455c7d80c2bf21e310f1875ec64513ad96858acd54", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c03ab246664045b73448cbc590f1a75085eee6c43a1e68fd7fa6dce6168ed4bf6f19e3a197943940a66d6600706e7701b0e10f3a5a112fda3971dfdd6dcd332", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/491e4af23ee6ba36b250b033d72a8d0acab21ec79cb842985c46947e41a8df0d28cb9e047fc75a3081b0f694e8467ed6aeb4e8af211e413569bec8e3bc15c7a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dc8c777a68d2ebb0b79639788838ae092ed2421f5a04627144bfaf6275edc9f8d205b15bb99b479ecdf715b314d4cc49c9da8f68c8d4c80dec5c41f7adb0a3d"} 13:37:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:15 INFO - Contents: 13:37:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/303a694777fc1ddeff2eb42202e1c253fd195f6df8e5a0c9e7a6530e73bb7432bb67431b48a9e200b45874455c7d80c2bf21e310f1875ec64513ad96858acd54", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c03ab246664045b73448cbc590f1a75085eee6c43a1e68fd7fa6dce6168ed4bf6f19e3a197943940a66d6600706e7701b0e10f3a5a112fda3971dfdd6dcd332", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/491e4af23ee6ba36b250b033d72a8d0acab21ec79cb842985c46947e41a8df0d28cb9e047fc75a3081b0f694e8467ed6aeb4e8af211e413569bec8e3bc15c7a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dc8c777a68d2ebb0b79639788838ae092ed2421f5a04627144bfaf6275edc9f8d205b15bb99b479ecdf715b314d4cc49c9da8f68c8d4c80dec5c41f7adb0a3d"} 13:37:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:15 INFO - Copying logs to upload dir... 13:37:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.290762 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-15 13:37:15.532815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:37:15.540171) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/303a694777fc1ddeff2eb42202e1c253fd195f6df8e5a0c9e7a6530e73bb7432bb67431b48a9e200b45874455c7d80c2bf21e310f1875ec64513ad96858acd54", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c03ab246664045b73448cbc590f1a75085eee6c43a1e68fd7fa6dce6168ed4bf6f19e3a197943940a66d6600706e7701b0e10f3a5a112fda3971dfdd6dcd332", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/491e4af23ee6ba36b250b033d72a8d0acab21ec79cb842985c46947e41a8df0d28cb9e047fc75a3081b0f694e8467ed6aeb4e8af211e413569bec8e3bc15c7a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dc8c777a68d2ebb0b79639788838ae092ed2421f5a04627144bfaf6275edc9f8d205b15bb99b479ecdf715b314d4cc49c9da8f68c8d4c80dec5c41f7adb0a3d"} build_url:https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/Y6QodXyFSlC9NvyQ7Y-KNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/303a694777fc1ddeff2eb42202e1c253fd195f6df8e5a0c9e7a6530e73bb7432bb67431b48a9e200b45874455c7d80c2bf21e310f1875ec64513ad96858acd54", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c03ab246664045b73448cbc590f1a75085eee6c43a1e68fd7fa6dce6168ed4bf6f19e3a197943940a66d6600706e7701b0e10f3a5a112fda3971dfdd6dcd332", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/491e4af23ee6ba36b250b033d72a8d0acab21ec79cb842985c46947e41a8df0d28cb9e047fc75a3081b0f694e8467ed6aeb4e8af211e413569bec8e3bc15c7a6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dc8c777a68d2ebb0b79639788838ae092ed2421f5a04627144bfaf6275edc9f8d205b15bb99b479ecdf715b314d4cc49c9da8f68c8d4c80dec5c41f7adb0a3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 13:37:15.570067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:37:15.570419) ========= 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=14ef55db36f7623abb31b9cf000001d5-1505506594.264464-78398117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 13:37:15.655615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:37:15.658937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 13:37:15.659250) ========= ========= Total master_lag: 0.20 =========