builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1505775506.38 results: success (0) revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.378808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.379212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.379500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.562779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.563089) ========= 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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 15:58:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2017-09-18 15:58:26 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.356364 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.951392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:26.951702) ========= 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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016049 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.011916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.012229) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --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 948dc86aabc97e16d51ad19ea90debab6f93a628 --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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 15:58:26,955 truncating revision to first 12 chars 2017-09-18 15:58:26,955 Setting DEBUG logging. 2017-09-18 15:58:26,955 attempt 1/10 2017-09-18 15:58:26,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/948dc86aabc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 15:58:27,218 unpacking tar archive at: mozilla-central-948dc86aabc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542625 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.597215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.597525) ========= script_repo_revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.597900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.598183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 15:58:27.622759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 15:58:27.623019) ========= /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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:27 INFO - MultiFileLogger online at 20170918 15:58:27 in /builds/slave/test 15:58:27 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 15:58:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:27 INFO - {'append_to_log': False, 15:58:27 INFO - 'base_work_dir': '/builds/slave/test', 15:58:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:58:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:27 INFO - 'branch': 'Firefox-Non-PGO', 15:58:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:27 INFO - 'code_coverage': False, 15:58:27 INFO - 'config_files': ('talos/linux_config.py',), 15:58:27 INFO - 'default_actions': ('clobber', 15:58:27 INFO - 'read-buildbot-config', 15:58:27 INFO - 'download-and-extract', 15:58:27 INFO - 'populate-webroot', 15:58:27 INFO - 'create-virtualenv', 15:58:27 INFO - 'install', 15:58:27 INFO - 'setup-mitmproxy', 15:58:27 INFO - 'run-tests'), 15:58:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:27 INFO - 'disable_ccov_upload': False, 15:58:27 INFO - 'disable_stylo': False, 15:58:27 INFO - 'download_minidump_stackwalk': True, 15:58:27 INFO - 'download_symbols': 'ondemand', 15:58:27 INFO - 'enable_stylo': False, 15:58:27 INFO - 'enable_webrender': False, 15:58:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:58:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:27 INFO - 'gecko_profile': False, 15:58:27 INFO - 'gecko_profile_interval': 0, 15:58:27 INFO - 'installer_path': 'installer.exe', 15:58:27 INFO - 'log_level': 'info', 15:58:27 INFO - 'log_name': 'talos', 15:58:27 INFO - 'log_to_console': True, 15:58:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:27 INFO - 'opt_config_files': (), 15:58:27 INFO - 'pip_index': False, 15:58:27 INFO - 'suite': 'dromaeojs-e10s', 15:58:27 INFO - 'system_bits': '32', 15:58:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:27 INFO - 'title': 'talos-linux64-ix-080', 15:58:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:27 INFO - 'use_talos_json': True, 15:58:27 INFO - 'verify': 'False', 15:58:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:27 INFO - 'work_dir': 'build'} 15:58:27 INFO - [mozharness: 2017-09-18 22:58:27.704550Z] Running clobber step. 15:58:27 INFO - Running pre-action listener: _resource_record_pre_action 15:58:27 INFO - Running main action method: clobber 15:58:27 INFO - rmtree: /builds/slave/test/build 15:58:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:28 INFO - Running post-action listener: _resource_record_post_action 15:58:28 INFO - [mozharness: 2017-09-18 22:58:28.713419Z] Finished clobber step (success) 15:58:28 INFO - [mozharness: 2017-09-18 22:58:28.713517Z] Running read-buildbot-config step. 15:58:28 INFO - Running pre-action listener: _resource_record_pre_action 15:58:28 INFO - Running main action method: read_buildbot_config 15:58:28 INFO - Using buildbot properties: 15:58:28 INFO - { 15:58:28 INFO - "project": "", 15:58:28 INFO - "product": "firefox", 15:58:28 INFO - "who": "kwierso@gmail.com", 15:58:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:58:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:58:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:58:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:58:28 INFO - "stage_platform": "linux64", 15:58:28 INFO - "basedir": "/builds/slave/test", 15:58:28 INFO - "buildnumber": 846, 15:58:28 INFO - "platform": "ubuntu64_hw", 15:58:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:28 INFO - "slavebuilddir": "test", 15:58:28 INFO - "taskId": "Xcz9mCjzT-CBDS58zgb65g", 15:58:28 INFO - "branch": "mozilla-central", 15:58:28 INFO - "script_repo_revision": "production", 15:58:28 INFO - "revision": "948dc86aabc97e16d51ad19ea90debab6f93a628", 15:58:28 INFO - "slavename": "talos-linux64-ix-080", 15:58:28 INFO - "repo_path": "mozilla-central" 15:58:28 INFO - } 15:58:28 INFO - Finding installer, test and symbols from parent task. 15:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xcz9mCjzT-CBDS58zgb65g'}, attempt #1 15:58:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xcz9mCjzT-CBDS58zgb65g'}, attempt #1 15:58:29 INFO - Task dependencies: TRftx86zRh69GCHnj0hY_Q 15:58:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q'}, attempt #1 15:58:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip 15:58:30 INFO - Running post-action listener: _resource_record_post_action 15:58:30 INFO - [mozharness: 2017-09-18 22:58:30.098663Z] Finished read-buildbot-config step (success) 15:58:30 INFO - [mozharness: 2017-09-18 22:58:30.098881Z] Running download-and-extract step. 15:58:30 INFO - Running pre-action listener: _resource_record_pre_action 15:58:30 INFO - Running main action method: download_and_extract 15:58:30 INFO - mkdir: /builds/slave/test/build/tests 15:58:30 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')]} 15:58:30 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json 15:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:58:30 INFO - Downloaded 989 bytes. 15:58:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:58:30 INFO - Using the following test package requirements: 15:58:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:58:30 INFO - u'common': [u'target.common.tests.zip'], 15:58:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:58:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:58:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:58:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:58:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:58:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:58:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:58:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:58:30 INFO - u'target.web-platform.tests.tar.gz'], 15:58:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:58:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip 15:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.common.tests.zip into memory 15:58:34 INFO - Content-Length response header: 54731251 15:58:34 INFO - Bytes received: 54731251 15:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip 15:58:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:58:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.talos.tests.zip into memory 15:58:46 INFO - Content-Length response header: 14508748 15:58:46 INFO - Bytes received: 14508748 15:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:46 INFO - trying https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:46 INFO - Downloading https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:58:51 INFO - Downloaded 61376718 bytes. 15:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - mkdir: /builds/slave/test/properties 15:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:51 INFO - Contents: 15:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - Running post-action listener: find_tests_for_verification 15:58:51 INFO - Running post-action listener: set_extra_try_arguments 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.245965Z] Finished download-and-extract step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.246193Z] Running populate-webroot step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: populate_webroot 15:58:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tresize', 15:58:51 INFO - 'tcanvasmark']}, 15:58:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_css', 15:58:51 INFO - 'kraken']}, 15:58:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['damp', 'tps']}, 15:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['dromaeo_dom']}, 15:58:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:58:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['basic_compositor_video', 15:58:51 INFO - 'glvideo']}, 15:58:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:58:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['ts_paint_webext', 15:58:51 INFO - 'tp5o_webext']}, 15:58:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['a11yr', 15:58:51 INFO - 'ts_paint', 15:58:51 INFO - 'tpaint', 15:58:51 INFO - 'sessionrestore', 15:58:51 INFO - 'sessionrestore_many_windows', 15:58:51 INFO - 'sessionrestore_no_auto_restore', 15:58:51 INFO - 'tabpaint']}, 15:58:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:58:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['perf_reftest_singletons']}, 15:58:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['bloom_basic']}, 15:58:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tsvgx', 15:58:51 INFO - 'tsvgr_opacity', 15:58:51 INFO - 'tart', 15:58:51 INFO - 'tscrollx', 15:58:51 INFO - 'tsvg_static']}, 15:58:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:58:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo'], 15:58:51 INFO - 'tests': ['tp5o']}, 15:58:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:58:51 INFO - 'talos_options': ['--stylo-threads=1', 15:58:51 INFO - '--mitmproxy', 15:58:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:58:51 INFO - '--firstNonBlankPaint'], 15:58:51 INFO - 'tests': ['tp6_google', 15:58:51 INFO - 'tp6_youtube', 15:58:51 INFO - 'tp6_amazon', 15:58:51 INFO - 'tp6_facebook']}, 15:58:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}, 15:58:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:58:51 INFO - 'talos_options': ['--disable-stylo', 15:58:51 INFO - '--xperf_path', 15:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:51 INFO - 'tests': ['tp5n']}}} 15:58:51 INFO - Running post-action listener: _resource_record_post_action 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.266144Z] Finished populate-webroot step (success) 15:58:51 INFO - [mozharness: 2017-09-18 22:58:51.266233Z] Running create-virtualenv step. 15:58:51 INFO - Running pre-action listener: _resource_record_pre_action 15:58:51 INFO - Running main action method: create_virtualenv 15:58:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:58:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:52 INFO - Installing pip...............done. 15:58:52 INFO - Return code: 0 15:58:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:58:52 INFO - Reading from file tmpfile_stdout 15:58:52 INFO - Output received: 15:58:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:58:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58:52 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 15:58:52 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 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:58:53 INFO - Downloading/unpacking pip>=1.5 15:58:53 INFO - Running setup.py egg_info for package pip 15:58:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:53 INFO - Installing collected packages: pip 15:58:53 INFO - Found existing installation: pip 1.1 15:58:53 INFO - Uninstalling pip: 15:58:53 INFO - Successfully uninstalled pip 15:58:53 INFO - Running setup.py install for pip 15:58:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:58:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:58:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:58:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:58:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:58:53 INFO - Successfully installed pip 15:58:53 INFO - Cleaning up... 15:58:53 INFO - Return code: 0 15:58:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:58:53 INFO - Using env: {'DISPLAY': ':0', 15:58:53 INFO - 'HOME': '/home/cltbld', 15:58:53 INFO - 'LANG': 'en_US.UTF-8', 15:58:53 INFO - 'LANGUAGE': 'en_US:en', 15:58:53 INFO - 'LOGNAME': 'cltbld', 15:58:53 INFO - 'MAIL': '/var/mail/cltbld', 15:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:53 INFO - 'MOZ_NO_REMOTE': '1', 15:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:53 INFO - 'NO_EM_RESTART': '1', 15:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:53 INFO - 'PWD': '/builds/slave/test', 15:58:53 INFO - 'SHELL': '/bin/bash', 15:58:53 INFO - 'SHLVL': '1', 15:58:53 INFO - 'TERM': 'linux', 15:58:53 INFO - 'TMOUT': '86400', 15:58:53 INFO - 'USER': 'cltbld', 15:58:53 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:53 INFO - '_': '/tools/buildbot/bin/python'} 15:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:53 INFO - Downloading/unpacking psutil>=3.1.1 15:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:54 INFO - Installing collected packages: psutil 15:58:54 INFO - Running setup.py install for psutil 15:58:54 INFO - building 'psutil._psutil_linux' extension 15:58:54 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 15:58:55 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 15:58:55 INFO - building 'psutil._psutil_posix' extension 15:58:55 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 15:58:55 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 15:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:55 INFO - Successfully installed psutil 15:58:55 INFO - Cleaning up... 15:58:55 INFO - Return code: 0 15:58:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:55 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58:55 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 15:58:55 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 15:58:55 INFO - Using env: {'DISPLAY': ':0', 15:58:55 INFO - 'HOME': '/home/cltbld', 15:58:55 INFO - 'LANG': 'en_US.UTF-8', 15:58:55 INFO - 'LANGUAGE': 'en_US:en', 15:58:55 INFO - 'LOGNAME': 'cltbld', 15:58:55 INFO - 'MAIL': '/var/mail/cltbld', 15:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:55 INFO - 'MOZ_NO_REMOTE': '1', 15:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:55 INFO - 'NO_EM_RESTART': '1', 15:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:55 INFO - 'PWD': '/builds/slave/test', 15:58:55 INFO - 'SHELL': '/bin/bash', 15:58:55 INFO - 'SHLVL': '1', 15:58:55 INFO - 'TERM': 'linux', 15:58:55 INFO - 'TMOUT': '86400', 15:58:55 INFO - 'USER': 'cltbld', 15:58:55 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:55 INFO - '_': '/tools/buildbot/bin/python'} 15:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:58:55 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 15:58:55 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 15:58:55 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 15:58:55 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 15:58:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:58:56 INFO - Installing collected packages: mozsystemmonitor 15:58:56 INFO - Running setup.py install for mozsystemmonitor 15:58:56 INFO - Successfully installed mozsystemmonitor 15:58:56 INFO - Cleaning up... 15:58:56 INFO - Return code: 0 15:58:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58: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')]} 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58: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', '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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:58: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 jsonschema==2.5.1 15:58:56 INFO - Using env: {'DISPLAY': ':0', 15:58:56 INFO - 'HOME': '/home/cltbld', 15:58:56 INFO - 'LANG': 'en_US.UTF-8', 15:58:56 INFO - 'LANGUAGE': 'en_US:en', 15:58:56 INFO - 'LOGNAME': 'cltbld', 15:58:56 INFO - 'MAIL': '/var/mail/cltbld', 15:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:56 INFO - 'MOZ_NO_REMOTE': '1', 15:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:56 INFO - 'NO_EM_RESTART': '1', 15:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:56 INFO - 'PWD': '/builds/slave/test', 15:58:56 INFO - 'SHELL': '/bin/bash', 15:58:56 INFO - 'SHLVL': '1', 15:58:56 INFO - 'TERM': 'linux', 15:58:56 INFO - 'TMOUT': '86400', 15:58:56 INFO - 'USER': 'cltbld', 15:58:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:56 INFO - '_': '/tools/buildbot/bin/python'} 15:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:58:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:58: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 15:58: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 15:58: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 15:58: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 15:58:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:58:58 INFO - warning: no files found matching '*.txt' 15:58:58 INFO - no previously-included directories found matching 'build' 15:58:58 INFO - no previously-included directories found matching 'dist' 15:58:58 INFO - no previously-included directories found matching '.git*' 15:58:58 INFO - Installing collected packages: jsonschema, functools32 15:58:58 INFO - Running setup.py install for functools32 15:58:58 INFO - warning: no files found matching '*.txt' 15:58:58 INFO - no previously-included directories found matching 'build' 15:58:58 INFO - no previously-included directories found matching 'dist' 15:58:58 INFO - no previously-included directories found matching '.git*' 15:58:58 INFO - Successfully installed jsonschema functools32 15:58:58 INFO - Cleaning up... 15:58:58 INFO - Return code: 0 15:58:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58: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')]} 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58: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', '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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:58: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 functools32==3.2.3-2 15:58:58 INFO - Using env: {'DISPLAY': ':0', 15:58:58 INFO - 'HOME': '/home/cltbld', 15:58:58 INFO - 'LANG': 'en_US.UTF-8', 15:58:58 INFO - 'LANGUAGE': 'en_US:en', 15:58:58 INFO - 'LOGNAME': 'cltbld', 15:58:58 INFO - 'MAIL': '/var/mail/cltbld', 15:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:58 INFO - 'MOZ_NO_REMOTE': '1', 15:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:58 INFO - 'NO_EM_RESTART': '1', 15:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:58 INFO - 'PWD': '/builds/slave/test', 15:58:58 INFO - 'SHELL': '/bin/bash', 15:58:58 INFO - 'SHLVL': '1', 15:58:58 INFO - 'TERM': 'linux', 15:58:58 INFO - 'TMOUT': '86400', 15:58:58 INFO - 'USER': 'cltbld', 15:58:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:58 INFO - '_': '/tools/buildbot/bin/python'} 15:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:58:58 INFO - Cleaning up... 15:58:58 INFO - Return code: 0 15:58:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58: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')]} 15:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:58:58 INFO - Using env: {'DISPLAY': ':0', 15:58:58 INFO - 'HOME': '/home/cltbld', 15:58:58 INFO - 'LANG': 'en_US.UTF-8', 15:58:58 INFO - 'LANGUAGE': 'en_US:en', 15:58:58 INFO - 'LOGNAME': 'cltbld', 15:58:58 INFO - 'MAIL': '/var/mail/cltbld', 15:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:58 INFO - 'MOZ_NO_REMOTE': '1', 15:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:58 INFO - 'NO_EM_RESTART': '1', 15:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:58 INFO - 'PWD': '/builds/slave/test', 15:58:58 INFO - 'SHELL': '/bin/bash', 15:58:58 INFO - 'SHLVL': '1', 15:58:58 INFO - 'TERM': 'linux', 15:58:58 INFO - 'TMOUT': '86400', 15:58:58 INFO - 'USER': 'cltbld', 15:58:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:58 INFO - '_': '/tools/buildbot/bin/python'} 15:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:59 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59: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 15:59: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 15:59: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 15:59: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 15:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59: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 15:59: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 15:59: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 15:59: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 15:59:00 INFO - Downloading docopt-0.6.1.tar.gz 15:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:00 INFO - Running setup.py install for blobuploader 15:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:00 INFO - Running setup.py install for requests 15:59:01 INFO - Running setup.py install for docopt 15:59:01 INFO - Successfully installed blobuploader requests docopt 15:59:01 INFO - Cleaning up... 15:59:01 INFO - Return code: 0 15:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59: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')]} 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:01 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:59:01 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 15:59:01 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 15:59:01 INFO - Using env: {'DISPLAY': ':0', 15:59:01 INFO - 'HOME': '/home/cltbld', 15:59:01 INFO - 'LANG': 'en_US.UTF-8', 15:59:01 INFO - 'LANGUAGE': 'en_US:en', 15:59:01 INFO - 'LOGNAME': 'cltbld', 15:59:01 INFO - 'MAIL': '/var/mail/cltbld', 15:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:01 INFO - 'MOZ_NO_REMOTE': '1', 15:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:01 INFO - 'NO_EM_RESTART': '1', 15:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:01 INFO - 'PWD': '/builds/slave/test', 15:59:01 INFO - 'SHELL': '/bin/bash', 15:59:01 INFO - 'SHLVL': '1', 15:59:01 INFO - 'TERM': 'linux', 15:59:01 INFO - 'TMOUT': '86400', 15:59:01 INFO - 'USER': 'cltbld', 15:59:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:01 INFO - '_': '/tools/buildbot/bin/python'} 15:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:01 INFO - Running setup.py (path:/tmp/pip-Ki3ZES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:01 INFO - Running setup.py (path:/tmp/pip-cRaz6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:01 INFO - Running setup.py (path:/tmp/pip-TGxvJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:01 INFO - Running setup.py (path:/tmp/pip-cxemaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Running setup.py (path:/tmp/pip-wZsJ4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Running setup.py (path:/tmp/pip-iwXr7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:01 INFO - Running setup.py (path:/tmp/pip-D5nd_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:02 INFO - Running setup.py (path:/tmp/pip-whKXXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:02 INFO - Running setup.py (path:/tmp/pip-uLjmqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:02 INFO - Running setup.py (path:/tmp/pip-dmV7LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:02 INFO - Running setup.py (path:/tmp/pip-cJ96FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:02 INFO - Running setup.py (path:/tmp/pip-vOWavU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:02 INFO - Running setup.py (path:/tmp/pip-18yqqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:02 INFO - Running setup.py (path:/tmp/pip-QV603a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:02 INFO - Running setup.py (path:/tmp/pip-1AZXsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:02 INFO - Running setup.py (path:/tmp/pip-f9QmGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:02 INFO - Running setup.py (path:/tmp/pip-Pdq8aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:02 INFO - Running setup.py install for manifestparser 15:59:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:02 INFO - Running setup.py install for mozcrash 15:59:02 INFO - Running setup.py install for mozdebug 15:59:03 INFO - Running setup.py install for mozdevice 15:59:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozfile 15:59:03 INFO - Running setup.py install for mozhttpd 15:59:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozinfo 15:59:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozInstall 15:59:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozleak 15:59:03 INFO - Running setup.py install for mozlog 15:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for moznetwork 15:59:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:03 INFO - Running setup.py install for mozprocess 15:59:03 INFO - Running setup.py install for mozprofile 15:59:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozrunner 15:59:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Running setup.py install for mozscreenshot 15:59:04 INFO - Running setup.py install for moztest 15:59:04 INFO - Running setup.py install for mozversion 15:59:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:04 INFO - Cleaning up... 15:59:04 INFO - Return code: 0 15:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:04 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')]} 15:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:04 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')]} 15:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:04 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:59:04 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 15:59:04 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 15:59:04 INFO - Using env: {'DISPLAY': ':0', 15:59:04 INFO - 'HOME': '/home/cltbld', 15:59:04 INFO - 'LANG': 'en_US.UTF-8', 15:59:04 INFO - 'LANGUAGE': 'en_US:en', 15:59:04 INFO - 'LOGNAME': 'cltbld', 15:59:04 INFO - 'MAIL': '/var/mail/cltbld', 15:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:04 INFO - 'MOZ_NO_REMOTE': '1', 15:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:04 INFO - 'NO_EM_RESTART': '1', 15:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:04 INFO - 'PWD': '/builds/slave/test', 15:59:04 INFO - 'SHELL': '/bin/bash', 15:59:04 INFO - 'SHLVL': '1', 15:59:04 INFO - 'TERM': 'linux', 15:59:04 INFO - 'TMOUT': '86400', 15:59:04 INFO - 'USER': 'cltbld', 15:59:04 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:04 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Running setup.py (path:/tmp/pip-0CNvw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Running setup.py (path:/tmp/pip-uJ3hcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Running setup.py (path:/tmp/pip-WA1qvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Running setup.py (path:/tmp/pip-TViDWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:04 INFO - Running setup.py (path:/tmp/pip-VmGc8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:05 INFO - Running setup.py (path:/tmp/pip-04BS2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:05 INFO - Running setup.py (path:/tmp/pip-Rkpf8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:05 INFO - Running setup.py (path:/tmp/pip-1HbQE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:05 INFO - Running setup.py (path:/tmp/pip-dR4fc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:05 INFO - Running setup.py (path:/tmp/pip-11Ti6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:05 INFO - Running setup.py (path:/tmp/pip-Vz9ik5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:05 INFO - Running setup.py (path:/tmp/pip-kFY38x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:05 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)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Running setup.py (path:/tmp/pip-ss7n9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Running setup.py (path:/tmp/pip-1YGRKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Running setup.py (path:/tmp/pip-cDptDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Running setup.py (path:/tmp/pip-WdDSoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Running setup.py (path:/tmp/pip-Z5QcjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59: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 15:59: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 15:59: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 15:59: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 15:59:07 INFO - Downloading blessings-1.6.tar.gz 15:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:07 INFO - Installing collected packages: blessings 15:59:07 INFO - Running setup.py install for blessings 15:59:07 INFO - Successfully installed blessings 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:07 INFO - Reading from file tmpfile_stdout 15:59:07 INFO - Current package versions: 15:59:07 INFO - argparse == 1.2.1 15:59:07 INFO - blessings == 1.6 15:59:07 INFO - blobuploader == 1.2.4 15:59:07 INFO - docopt == 0.6.1 15:59:07 INFO - functools32 == 3.2.3-2 15:59:07 INFO - jsonschema == 2.5.1 15:59:07 INFO - manifestparser == 1.1 15:59:07 INFO - mozInstall == 1.13 15:59:07 INFO - mozcrash == 1.0 15:59:07 INFO - mozdebug == 0.1 15:59:07 INFO - mozdevice == 0.51 15:59:07 INFO - mozfile == 1.2 15:59:07 INFO - mozhttpd == 0.7 15:59:07 INFO - mozinfo == 0.10 15:59:07 INFO - mozleak == 0.1 15:59:07 INFO - mozlog == 3.5 15:59:07 INFO - moznetwork == 0.27 15:59:07 INFO - mozprocess == 0.25 15:59:07 INFO - mozprofile == 0.28 15:59:07 INFO - mozrunner == 6.13 15:59:07 INFO - mozscreenshot == 0.1 15:59:07 INFO - mozsystemmonitor == 0.3 15:59:07 INFO - moztest == 0.8 15:59:07 INFO - mozversion == 1.4 15:59:07 INFO - psutil == 3.1.1 15:59:07 INFO - requests == 1.2.3 15:59:07 INFO - wsgiref == 0.1.2 15:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:07 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')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 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')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:59:07 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 15:59:07 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 15:59:07 INFO - Using env: {'DISPLAY': ':0', 15:59:07 INFO - 'HOME': '/home/cltbld', 15:59:07 INFO - 'LANG': 'en_US.UTF-8', 15:59:07 INFO - 'LANGUAGE': 'en_US:en', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MAIL': '/var/mail/cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SHLVL': '1', 15:59:07 INFO - 'TERM': 'linux', 15:59:07 INFO - 'TMOUT': '86400', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - '_': '/tools/buildbot/bin/python'} 15:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:59:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:59:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:08 INFO - Installing collected packages: simplejson 15:59:08 INFO - Running setup.py install for simplejson 15:59:08 INFO - building 'simplejson._speedups' extension 15:59:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:59:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:59:09 INFO - Successfully installed simplejson 15:59:09 INFO - Cleaning up... 15:59:10 INFO - Return code: 0 15:59:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:10 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')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 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')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 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 0x29b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d20a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, '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': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', '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 15:59:10 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 15:59:10 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 15:59:10 INFO - Using env: {'DISPLAY': ':0', 15:59:10 INFO - 'HOME': '/home/cltbld', 15:59:10 INFO - 'LANG': 'en_US.UTF-8', 15:59:10 INFO - 'LANGUAGE': 'en_US:en', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MAIL': '/var/mail/cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SHLVL': '1', 15:59:10 INFO - 'TERM': 'linux', 15:59:10 INFO - 'TMOUT': '86400', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - '_': '/tools/buildbot/bin/python'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:10 INFO - Cleaning up... 15:59:10 INFO - Return code: 0 15:59:10 INFO - Running post-action listener: _resource_record_post_action 15:59:10 INFO - Running post-action listener: _start_resource_monitoring 15:59:10 INFO - Starting resource monitoring. 15:59:10 INFO - [mozharness: 2017-09-18 22:59:10.252141Z] Finished create-virtualenv step (success) 15:59:10 INFO - [mozharness: 2017-09-18 22:59:10.252652Z] Running install step. 15:59:10 INFO - Running pre-action listener: _resource_record_pre_action 15:59:10 INFO - Running main action method: install 15:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:10 INFO - Reading from file tmpfile_stdout 15:59:10 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:10 INFO - Reading from file tmpfile_stdout 15:59:10 INFO - Output received: 15:59:10 INFO - Usage: mozinstall [options] installer 15:59:10 INFO - Options: 15:59:10 INFO - -h, --help show this help message and exit 15:59:10 INFO - -d DEST, --destination=DEST 15:59:10 INFO - Directory to install application into. [default: 15:59:10 INFO - "/builds/slave/test"] 15:59:10 INFO - --app=APP Application being installed. [default: firefox] 15:59:10 INFO - mkdir: /builds/slave/test/build/application 15:59:10 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'] 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:59:28 INFO - Reading from file tmpfile_stdout 15:59:28 INFO - Output received: 15:59:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:28 INFO - Running post-action listener: _resource_record_post_action 15:59:28 INFO - [mozharness: 2017-09-18 22:59:28.500067Z] Finished install step (success) 15:59:28 INFO - [mozharness: 2017-09-18 22:59:28.500317Z] Running setup-mitmproxy step. 15:59:28 INFO - Running pre-action listener: _resource_record_pre_action 15:59:28 INFO - Running main action method: setup_mitmproxy 15:59:28 INFO - Skipping: mitmproxy is not required 15:59:28 INFO - Running post-action listener: _resource_record_post_action 15:59:28 INFO - [mozharness: 2017-09-18 22:59:28.501420Z] Finished setup-mitmproxy step (success) 15:59:28 INFO - [mozharness: 2017-09-18 22:59:28.501640Z] Running run-tests step. 15:59:28 INFO - Running pre-action listener: _resource_record_pre_action 15:59:28 INFO - Running pre-action listener: _set_gcov_prefix 15:59:28 INFO - Running main action method: run_tests 15:59:28 WARNING - Try message not found. 15:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:28 INFO - Python 2.7.3 15:59:28 INFO - Return code: 0 15:59:28 INFO - grabbing minidump binary from tooltool 15:59:28 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')]} 15:59:28 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 0x2d24090>, '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 0x2d24d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:28 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 15:59:28 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 15:59:28 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 15:59:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:28 INFO - Return code: 0 15:59:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:28 INFO - ENV: RUST_BACKTRACE is now full 15:59:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:28 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/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 15:59:28 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/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 15:59:28 INFO - Using env: {'DISPLAY': ':0', 15:59:28 INFO - 'HOME': '/home/cltbld', 15:59:28 INFO - 'LANG': 'en_US.UTF-8', 15:59:28 INFO - 'LANGUAGE': 'en_US:en', 15:59:28 INFO - 'LOGNAME': 'cltbld', 15:59:28 INFO - 'MAIL': '/var/mail/cltbld', 15:59:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:28 INFO - 'MOZ_NO_REMOTE': '1', 15:59:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:28 INFO - 'NO_EM_RESTART': '1', 15:59:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:28 INFO - 'PWD': '/builds/slave/test', 15:59:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:28 INFO - 'RUST_BACKTRACE': 'full', 15:59:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:28 INFO - 'SHELL': '/bin/bash', 15:59:28 INFO - 'SHLVL': '1', 15:59:28 INFO - 'TERM': 'linux', 15:59:28 INFO - 'TMOUT': '86400', 15:59:28 INFO - 'USER': 'cltbld', 15:59:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:28 INFO - '_': '/tools/buildbot/bin/python'} 15:59:28 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/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 15:59:28 INFO - mozversion application_buildid: 20170918220821 15:59:28 INFO - mozversion application_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:28 INFO - mozversion application_display_name: Nightly 15:59:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:28 INFO - mozversion application_name: Firefox 15:59:28 INFO - mozversion application_remotingname: firefox 15:59:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:59:28 INFO - mozversion application_vendor: Mozilla 15:59:28 INFO - mozversion application_version: 57.0a1 15:59:28 INFO - mozversion platform_buildid: 20170918220821 15:59:28 INFO - mozversion platform_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 15:59:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:59:28 INFO - mozversion platform_version: 57.0a1 15:59:28 INFO - using testdate: 1505775568 15:59:28 INFO - actual date: 1505775568 15:59:28 INFO - starting webserver on 'localhost:43252' 15:59:28 INFO - SUITE-START | Running 2 tests 15:59:28 INFO - TEST-START | dromaeo_css 15:59:28 INFO - Initialising browser for dromaeo_css test... 15:59:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43252/getInfo.html -profile /tmp/tmp3RfwBS/profile 15:59:28 INFO - TEST-INFO | started process 29331 (/builds/slave/test/build/application/firefox/firefox http://localhost:43252/getInfo.html) 15:59:35 INFO - TEST-INFO | 29331: exit 0 15:59:35 INFO - Browser initialized. 15:59:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:35 INFO - Using env: {'DISPLAY': ':0', 15:59:35 INFO - 'HOME': '/home/cltbld', 15:59:35 INFO - 'JSGC_DISABLE_POISONING': '1', 15:59:35 INFO - 'LANG': 'en_US.UTF-8', 15:59:35 INFO - 'LANGUAGE': 'en_US:en', 15:59:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:59:35 INFO - 'LOGNAME': 'cltbld', 15:59:35 INFO - 'MAIL': '/var/mail/cltbld', 15:59:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:35 INFO - 'MOZ_CRASHREPORTER': '1', 15:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:59:35 INFO - 'MOZ_NO_REMOTE': '1', 15:59:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:35 INFO - 'NO_EM_RESTART': '1', 15:59:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:35 INFO - 'PWD': '/builds/slave/test', 15:59:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:35 INFO - 'RUST_BACKTRACE': 'full', 15:59:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:59:35 INFO - 'SHELL': '/bin/bash', 15:59:35 INFO - 'SHLVL': '1', 15:59:35 INFO - 'TERM': 'linux', 15:59:35 INFO - 'TMOUT': '86400', 15:59:35 INFO - 'USER': 'cltbld', 15:59:35 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 15:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:35 INFO - '_': '/tools/buildbot/bin/python'} 15:59:35 INFO - TEST-INFO | started process 29568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3RfwBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:36 INFO - PID 29568 | 15:59:36 INFO - PID 29568 | (/builds/slave/test/build/application/firefox/firefox:29617): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:59:36 INFO - PID 29568 | 15:59:46 INFO - PID 29568 | RSS: Main: 155074560 15:59:46 INFO - PID 29568 | 16:02:43 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43252/tests/dromaeo/cssquery-ext.html) 16:02:44 INFO - PID 29568 | RSS: Main: 155246592 16:02:44 INFO - PID 29568 | 16:05:46 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-ext.html (next: http://localhost:43252/tests/dromaeo/cssquery-jquery.html) 16:05:47 INFO - PID 29568 | RSS: Main: 154537984 16:05:47 INFO - PID 29568 | 16:08:49 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43252/tests/dromaeo/cssquery-mootools.html) 16:08:49 INFO - PID 29568 | RSS: Main: 157184000 16:08:49 INFO - PID 29568 | 16:11:51 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43252/tests/dromaeo/cssquery-prototype.html) 16:11:51 INFO - PID 29568 | RSS: Main: 156119040 16:11:51 INFO - PID 29568 | 16:14:55 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43252/tests/dromaeo/cssquery-yui.html) 16:14:55 INFO - PID 29568 | RSS: Main: 156618752 16:14:55 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | Cycle 1(1): loaded http://localhost:43252/tests/dromaeo/cssquery-yui.html (next: http://localhost:43252/tests/dromaeo/cssquery-dojo.html) 16:17:57 INFO - PID 29568 | RSS: Main: 159903744 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | __start_tp_report 16:17:57 INFO - PID 29568 | _x_x_mozilla_page_load 16:17:57 INFO - PID 29568 | _x_x_mozilla_page_load_details 16:17:57 INFO - PID 29568 | |i|pagename|runs| 16:17:57 INFO - PID 29568 | |0;dojo.html;3158.8104713717175;3166.208447888028;3179.4912813949772;3182.3158021025474;3185.155933677576;6261.186045814038;6312.747490100396;6374.171357723495;6434.034894765776;6457.160569126013;6336.493080553556;6372.044193370996;6378.3621637836195;6463.2244130704385;6483.870322593557;1252.2040718477006;5903.114532820068;5953.940460595392;5998.340182579913;6001.66990815505;5746.9712651436685;5827.912581311284;5886.499647529965;5957.404259574051;5969.88060238795;5792.097240171446;5805.158252053428;5844.970775146118;5887.1463637772285;5937.554683398763;5863.179154918314;5872.0898260769645;5934.97032514839;5946.464818166342;5950.196723442323;5821.162340216805;5836.708164591796;5920.615160014585;5924.170616113747;5928;6260.874782504325;6367.140436041168;6384.265809431929;6471.029345598198;6474.74101035958;6646.867062658768;6711.932880671179;6747.730090796363;6758.864822703567;6770.627615481147;6777.186737591521;6781.932180678179;6794.898076528856;6845.828854278633;6925.722971081151;6404.935950640481;6432.067350234237;6447.1296374989715;6448.903266451007;6460.160179176724;6973.3375329343635;7034.261402552761;7102.857942841218;7112.110986126734;7141.392981596518;6563.638999855054;6712.798616041527;6736.8989465158065;6797.150356205474;6809.693563789641;6753.358430949052;6795.150606174228;6870.725170993204;6888.690008949609;6893.310668933167;6762.526623136333;6792.015157802091;6804.183497980175;6820.93179068203;6832.111825462757;6733.124693789874;6821.386075253251;6821.863562728718;6823.658817059227;6828.9658551706925;5243.632945693841;5258;5333.173358129496;5339.946600534023;5375.838724838261;4581.702189357748;4583.197940360424;4655.906881862344;4680.9297860532115;4746.477887432379;5892.410758924159;5902.734376953047;5909.054551271776;5933.110033494924;5934.495567876779;6834.453243740489;6846.520743547904;6851.07510486078;6911.447084233349;6922.58464492132;5872.882542349129;5875.970620146872;5936.1986131871645;5939.227900372924;5948.10778383246;5704.515116215085;5792.275965504312;5826.854328641733;5879.2944846618675;5894.764209431661;6641.634710090895;6712.228093769279;6720.395164435126;6727.562708423937;6737.225219099768;6840.623765692835;6843.213030501556;6877.793666190022;6923.723051078001;6953.617551034539;6465.9331210349765;6583.63789991555;6586.275509693834;6587.209534855848;6624.867502650017;6671.099401580725;6679.799606011828;6683.164604424447;6687.398134167948;6690.866182676416;6785.253622101466;6802.693878775566;6814.2163651180745;6835.658217089225;6882.449404047764;6593.703283352164;6637.900431493435;6663.433608143362;6699;6747.527673063035;6483.610983341015;6640.037194606658;6644.235912870082;6728.461723062045;6735.528513004238;6468.967655161694;6557.049227861838;6613.140291762233;6622.470202383702;6627.569208001464;6748.493862960199;6767.661616919036;6778.4916131289365;6783.423409010092;6812;6476.805695829133;6477.125588045742;6551.181102362205;6566.868662626816;6569.24453687832 16:17:57 INFO - PID 29568 | |1;ext.html;835.6573804740057;885.1458342699295;888.0897080492495;890.7149712092133;890.8841850559427;39340;43207.135857282876;43334.34998475025;43341.56658433415;43364;40304.79847600765;40584;40647.39028914561;40671.38992915101;40723.18553628933;6978.685959131852;7057.223705392403;7106.715731370739;7693.30760231579;7902.091259505173;7719.343855772266;7808.570528620923;7809.41429392795;7810.765677029698;7813.96093019537;7822.452428330019;7885.487443316195;7885.684572617117;7889.684412623488;7891.881621775678;7803;7817.452778305521;7818.33544148748;7838.020247469095;7839.137694853562;7744.380449564022;7822.100458447295;7825.569593672346;7827.491213071132;7832.686692532292;38101.23797524062;38272.234555308736;38304.233915321536;38320.80839595784;38443.61556384428;3426.7601267911255;3454.3091381723502;3460.325236578868;3466.046837119787;3466.1507930556922;31383.686163138304;31433;31509.212269693213;31561;31573.21066973321;5160.200168973777;5184.922226166611;5216.7913283468615;5244.580433565306;5258.842234732964;183803;184131;184156;184771;184847;42477.57522424798;43376;48267;48491.75754121207;48505;50739.74630126826;51138;51360.74319628378;51374.22938655923;51411;15360;15411.537653870402;15513.767293490606;15559.766603500957;15576.844231557767;12524.373781310898;12573.057020723483;12600.621981340575;12631.810522842165;12811.487540498276;13943.442262309394;13968.930155349159;14105.647358815906;14142.222177780115;14217.36021879018;5727.914081288784;5917.171595976567;5970.970145149333;5996.700164991733;6010.158577799111;1012.099231683802;1025.5128813813378;1030.8144533983955;1041.2138835179542;1047.544318221576;23436.414089647897;23627.881860590587;23635.645465318034;23663.645045324334;23914.40213994664;1108.318384193715;1124.8706398764084;1128.1200663482496;1130.8190689489807;1140.9885901140883;12275.570355037531;12399.690007749878;12417.19288246261;12432.875671243171;12564.87435125637;217270;218823;219238;219434;220152;54198.72900635472;54222.186667200025;54261.45738542564;54345.1848222277;54604.45395546073;1439.9136051836924;1459.408939379553;1472.1829384691598;1473.5873955292536;1476.859698328657;22396.888015559816;22633.321000370015;23065.538689226458;23339.18312859042;23712.881435592713;36882;36929.63070369262;37053.629463705016;37275.44086838645;37457.62542374541;192040;192067;193087;193126;193475;34207.48688769621;36300.455493167094;36790.08024799402;36919.630803691616;36920.44619330658;47073.529264706915;47109.76445117752;47417.76291118522;47469.28796068131;47901.28148077851;33816.3236735259;33961.830190849876;34299.82850085833;34378.14054648654;34440.827795861864;33920.491192631634;34001.14997125092;34004.319913602085;34091.82954085214;34453.44959476779;37867.242655147296;38172.23655526929;38512;38525.4221186688;38802.223955521295;32703.34593308073;33059.834700826344;33100.33799324048;33515.497267540515;33771.66228337685;24728.57057165114;25109.87445062763;25128.12051578186;25232.495350093264;25508.872455637604 16:17:57 INFO - PID 29568 | |2;jquery.html;556.4741319453116;563.7322271920841;570.139089974139;574.130192757972;588.9322727886293;22359.217427390024;23102.768972310292;23142;23154.536909261806;23197.304080877602;24162.87918560409;24438.389040274003;24680.75319246807;25572.10497632583;25837.354066148357;6540.705668244928;6650.900236496456;6693.39759421652;6699.430548403391;6702.497312701543;6549.148610680629;6667.666616669171;6673.265940746514;6678.499112566553;6681.298463661318;6596.208454985408;6636.236832764222;6640.269570347258;6644.767433139841;6649.9667501662425;6142.600730952496;6549.181352330958;6573.244076931166;6639.136912201431;6649.035889795977;6069.0592958091565;6070.514358851281;6072.605280656743;6079.05774604937;6096.116063170815;29000.70999290022;29334;29365;29393.70606293931;29425.70574294251;2040.1635329514977;2075.1180748181964;2076.8338532917332;2076.865003774765;2077.1587507059667;18437.907810460994;18874.15066322019;19498.902505487524;19622.803771962383;19702.507437314038;2356.8350215484925;2420.4311986683115;2420.8305418620703;2428.344347026293;2491.700995880488;115938;117361.41319293434;122096.38951805273;122449;135913.32043339818;14530.924699703692;14961.476348327757;15198;15379.461718839786;15387.538373848802;22394.10423583071;22409.32772016842;22480.662790058162;22521.88739056327;22608.773912260665;10112.494375281207;10201.673782408388;10224.233182511192;10245.077942985166;10418.21863360251;9630.422174669542;9640.42157470554;9654.469004204695;9658.75853103678;9673.177779888647;8661;8893.73318800437;8940.195382415613;8958.328125390623;9026.45841249527;2586.314626623946;2632.2629663694197;2665.5735082386727;2701.9459610808067;2704.594310853388;1005.2008653120787;1023.3246057602096;1024.134606257711;1031.9174466042698;1035.1925498111484;19980.400587982385;20528.28151014737;20583.176672932914;20875.791242087384;21303.893480532497;1059.4755595980039;1066.8506409102731;1070.7590792071878;1076.0530732954949;1081.5457507846722;11210.215284929976;11249.43752812356;11298.887011129947;11299.209055366046;11358.148138889615;466801;467295;472343;474065;479054;108214.45892770485;109964;110781;112061;112735;1028.881678606955;1111.5609334313062;1142.8514293142005;1151.1826603111717;1213.2295992044938;21193.62495761329;21332.893335533223;21543.676844847654;21550.78449215488;21573.352799416043;53962.19056714231;54188.72905635447;54733;54736.452635473135;55399.16901246565;66343.33656663564;67476;67524.66237668977;67717.3228267711;68297.3170268291;14396.496122635657;14681.632959176106;14808.111513309235;14809.777853332424;14818.333175006936;23446.413839654146;23527.76472235324;23829.404264893517;23863.52272954566;23868.64197037011;18704.345347913302;18936.147873346006;18941.14764835558;18947.242110315434;19217.23131074797;16588.253528591;16971.406000789913;17297;17455.56361090983;17764;18323.63352732911;19101.713474298176;19131.713024304925;19319.22723091117;19334.419967401;14250.144991300554;14346.210958397389;14459.13245205291;14527.564173074825;14605.415783368971;18882.811171888105;18886.244550218387;18894.244230230637;18919.621607567497;19011.813641430857 16:17:57 INFO - PID 29568 | |3;mootools.html;1290.0904862072239;1363.379662253674;1382.4262930883672;1391.5964370332604;1391.9373628186731;14756;15113.848861511382;15243.009204401706;15282.694346113085;15375.461858834942;15076.396944122249;15237.16195609241;15269.083854968681;15276.770848437282;15289.92355038226;2763.6269103671048;2802.1033269353866;2846.0750256166725;2850.3586692994118;2852.2298979275583;2764.2121995231364;2782.1931639824425;2805.228562145406;2818.4504021715775;2818.943621127576;2690.9192724218306;2809.719028097184;2810.6205662235643;2811.6485439320086;2812.170409729135;2838.772898168152;2849.686534481216;2859.8856045758143;2860.3707184419395;2880.5535142053013;2727.7954153438573;2747.5054490191756;2769.141566114511;2775.3200465885784;2776.6667999839947;14880.181590012546;15235.162066086361;15257.465988690343;15350.539483815503;15369.846301536953;8092.676292948334;8490.150984901522;8492.15078492152;8502.23479886807;8505.74482765518;5564.4991950724225;5711.971440142815;5837.854053648651;5911.852203694942;5948.167256584082;1888.792232854385;1941.9223231070741;1950.0932066589105;1985.4738494299022;1995.102204008202;26257;26293.73706262932;26450.07424740144;26473;26530.867345663148;6861.656917154222;6867.2102708188195;7046.154461464657;7303.598302093435;7600.2779735925;16841.32634694623;16939.49181524556;16986.32054717822;17010.914945425193;17043.31826726917;8008.679652813938;8040.316573091352;8044.436889417684;8046.356291496666;8049.034115906012;7189.96405017982;7407.407407407394;7520.398368130536;7528.284812942762;7560.848783024308;5151.562117220078;5369.194620806832;5372.973135134299;5419.3225846769155;5425.13197888336;1577.8875892495762;1582.2088955522238;1583.9604009899845;1602.190893598725;1602.3670650093147;855.5337341149088;869.6347534035593;882.8101958079044;884.5135175653365;890.9599068041954;7333.596652184075;7334.266573342623;7412.110546734426;7446.888296675555;7485.887711684329;706.6819931031057;710.989335159973;715.4669771020623;717.3221305865907;724.1238101896658;4338.392625032435;4340.175366680321;4777.539567122934;5017.147084995559;5331.81338653153;21118.260860870105;21461.03425345863;21826.236081737065;22071.227507037496;22082;20611.175552977715;20704.792952070587;21064.473388165417;21254.574908501745;21256.574868502543;10892.61875834342;10981.286216395909;11179.273347232403;11210.934961178675;11216.214864959538;8036.67853285862;8089.797755056171;8255.463394879314;8278.379121566028;8434.325253979545;17981.190846412206;18356.449306520826;18383;18736.250549978395;18762.061896905372;18882.52793680169;18901.527461813566;19048.238070477026;19048.904755476135;19174;10997.34015959045;11252.043576296106;11312.15158863105;11329.660110196708;11332.263402878787;13701.246431446367;13849.37677804481;13859;14142.50501232452;14181.858181418054;11279.943600281946;11349;11432.599859004895;11433.59982400612;11745.17783755129;11002.064824489687;11329.490172942073;11372.658820235407;11440.199186056896;11594;9681.515924203903;9831.213502919893;9879.851802223116;9898.356606820533;9926.25553083536;7258.745943891939;7366.152892417441;7386.519876208029;7397.186309506058;7404.111506619241;6888.380045795902;6921.204061532988;6923.307669233036;7002.404795592432;7032.894506582507 16:17:57 INFO - PID 29568 | |4;prototype.html;487.6784838473853;522.386196219442;522.6210997027155;524.2634099090777;524.6117872774148;6283.214598175223;6316.168131379498;6345.968270158649;6356.9046464302955;6362.427381535661;6243.625382477043;6248.562600617958;6267.310595834466;6274.121622972787;6326.746930122801;5227.503387178212;5230.372355317368;5248.317718696583;5249.580033597322;5256.842294731155;4915.287283343913;5260.92108618371;5286.2070689396705;5299.443558426367;5306.893862122755;4909.950900490985;4988.42633097193;5021;5021.397432308128;5036.194208926572;4971.353724015891;5007.773095591567;5021.1213037718435;5048.6970781753025;5073.518015788531;4507.729536227836;4527.569880861313;4530.252508336121;4544.295634176675;4564.7032942858605;6144.170536977495;6153.138560601519;6183.165272688175;6189.257289125334;6205.7517699291975;5740.74166662497;5743.16724075011;5765.423457654243;5774.855628609276;5775.48020678141;6505.381988711065;6552.443042341407;6568.244651865049;6603.273639899608;6613.702383392759;4875.439324477695;4903.705777653352;4933.654644174873;4952.579030782388;4952.62855285855;6745.865082698368;6801.421879140328;6878.449724022066;6901.067701043716;6925.3074692530345;5029.974850125726;5056.974715126401;5059.367579052619;5061.670991385548;5066.873328166826;5101.642884998088;5116.641835071584;5135.974320128375;5143.922841157386;5155.097857874932;5580.469855363734;5734.254546908875;5738.2540269765495;5758.280214973129;5766.654000759968;6615.470762339001;6645.568038077509;6672.96663516689;6696;6717.261101278856;1723.9827601724073;1747.074050753103;1755.806861245262;1766.4788887278285;1773.0868602669636;1167.73142177298;1170.78925793358;1205.2888795610631;1211.7939950208486;1221.3526830779701;5775.306963164363;5826.446487583673;5839.5036421904615;5841.912371314434;5870.618409803349;6764.289749576322;6830.282820303896;6846.349596788297;6856.554323968926;6861.725530978805;5623;5638.981306637096;5684.403137670568;5690.146478028246;5721.971390143022;3532.2405682778326;3539.3629146753833;3575.4636804479014;3595.173110184672;3611.133328001313;6481.773137940149;6504.642244676588;6507.219133703891;6567.310432404529;6610.471162307004;6750;6819.454443644497;6853.931460685429;6870.27862074485;6924.480663950224;6508.9023664645065;6582.539222254396;6598.274189839018;6605.372489613479;6613.702383392662;6717.798466046026;6755.729770809113;6779.118714567075;6813.761518346834;6816.829579260559;6640.970649549327;6682.966585167043;6686.1642294713165;6745.460363170836;6818.420434263143;5867.765289388377;6213.65824879636;6244.531660125418;6433.517486188461;6480.805575832733;4948.307236986897;4964.230544265644;4994.675346102492;5000.974995125147;5022.974885125551;6706.228783689743;6711.127553418024;6716.429103526059;6723.596584204964;6793.286704895915;6528.2492513359675;6530.934690653033;6547.508936829661;6564.934350656432;6640.966795166187;6371.426571608577;6390.360963903572;6405.615663060231;6437.645929473924;6507.201903181677;6405.551611387158;6511.3628980263065;6520.152380190545;6527.9020814688765;6566.606003639797;6620.2386725527185;6633.9668301658185;6639.668016599054;6644.136262285871;6647.966760166169;6374.394432528902;6399.55203135776;6417.7753778617525;6446.806595802133;6489.610623362613 16:17:57 INFO - PID 29568 | |5;yui.html;908.5275656658542;909.354358405532;929.4980710416376;930.4556834251961;930.6556574067591;17701.380451684192;18246;18284.177212025457;18285.908570457163;18286.90856545717;18550.07249637516;18725.812741872578;18772;18804.34184803532;18811.90594047031;946.8011717539308;962.4610218277752;964.0889359555223;965.3628605120622;966.424977138605;984.4880662055726;985.4481490365382;987.1806400687412;987.3828856964398;989.0801554554262;948.1466679988032;1031.3708637730979;1032.896710328965;1038.4496217004962;1039.7348676087624;1019.8266294729914;1023.3603997501561;1024.7950409918046;1025.5846382215177;1026.1893104447477;728.9052423185005;756.0775853458772;756.2513112019061;758.6889375356078;758.9886151707728;20117;20381.79618203814;20405.489862753402;20408.081636326402;20408.489787755425;21178.152873885025;21245.362639120853;21608.459788505257;21774.673379899315;21814.454638634;16757.49727508177;16797.496075117644;17015.319387224496;17157.742633860504;17241.568960775956;3760.623937606245;3787.0153760022317;3787.5454945406727;3788.829502672359;3789.355809512362;99302.00697993;137235;137632;138164.30917845346;140211;15890.284937177854;16431.096289704183;16464.83535164657;16504.83495165057;16530.58673533147;25749.742502574736;27149.91400343964;27374.863125684245;27427.177184684493;27513.17460476189;8480.109588493242;8522.701705440404;8564.52895090776;8584.656613735506;8601.096884827128;4130.91738165235;4140.668746500272;4183.5398106208295;4241.512226094039;4245.5542168072525;5444;5525.336959564797;5534.695591742412;5562.499375056264;5573.080441727151;1090.3893819461127;1102.7904698107334;1114.4427786106946;1117.0784103114963;1120.2550304047718;654.8002859127917;677.7221339250883;679.1985457160499;681.6625770243761;696.7839969609437;11795.705107372385;11824.704382390337;12010.279383237033;12107.334096624594;12571.811422828665;670.1790306874137;681.6114814555755;683.9794806155824;684.900734321417;692.3491917597443;5491.2312276281355;5504.339479262514;5508.91736623943;5511.862203444946;5644.520215781622;122164.38917805532;123228;123974;125051;126304;107438.46280768546;108228.4588577052;110106;111916;112209;86757.13242867617;88672.5566372164;88758;90053.54973225092;92510.99999999865;9910.653127140515;9949.900500994898;9969.252306076929;10243.07812296897;10271.640492582725;43127;43909.341359878985;45325.773371132935;45397;46196;56608.43391566032;56686;57230;58459;59700.70149649224;15527.922360388126;15538.922305388402;15695;15754;15892.284847181674;16965.575860603585;17086.658266834842;17129.828701712824;17209.655806884042;17226.397076102276;15243.466478673194;15303.081815091131;15376.769348459558;15425.151616661191;15502;14330.426782928984;14624.853751462775;14727.116373017654;14812;14852;15231.923840380727;15348.309326080576;15398.307076181374;15429.22853857325;15513.612159696098;11455.541778328774;11481.425928703364;11781.410929453321;11803.055755539708;11805.763884722086;11938;12000.57997970067;12047.879521204675;12084.45619947087;12236.816447753468 16:17:57 INFO - PID 29568 | __end_tp_report 16:17:57 INFO - PID 29568 | __start_cc_report 16:17:57 INFO - PID 29568 | _x_x_mozilla_cycle_collect,280 16:17:57 INFO - PID 29568 | __end_cc_report 16:17:57 INFO - PID 29568 | __startTimestamp1505776677665__endTimestamp 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | ------- Summary: start ------- 16:17:57 INFO - PID 29568 | Number of tests: 6 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#0] dojo.html Cycles:165 Average:6257.01 Median:6563.64 stddev:854.34 (13.0%) stddev-sans-first:821.66 16:17:57 INFO - PID 29568 | Values: 3158.8 3166.2 3179.5 3182.3 3185.2 6261.2 6312.7 6374.2 6434.0 6457.2 6336.5 6372.0 6378.4 6463.2 6483.9 1252.2 5903.1 5953.9 5998.3 6001.7 5747.0 5827.9 5886.5 5957.4 5969.9 5792.1 5805.2 5845.0 5887.1 5937.6 5863.2 5872.1 5935.0 5946.5 5950.2 5821.2 5836.7 5920.6 5924.2 5928.0 6260.9 6367.1 6384.3 6471.0 6474.7 6646.9 6711.9 6747.7 6758.9 6770.6 6777.2 6781.9 6794.9 6845.8 6925.7 6404.9 6432.1 6447.1 6448.9 6460.2 6973.3 7034.3 7102.9 7112.1 7141.4 6563.6 6712.8 6736.9 6797.2 6809.7 6753.4 6795.2 6870.7 6888.7 6893.3 6762.5 6792.0 6804.2 6820.9 6832.1 6733.1 6821.4 6821.9 6823.7 6829.0 5243.6 5258.0 5333.2 5339.9 5375.8 4581.7 4583.2 4655.9 4680.9 4746.5 5892.4 5902.7 5909.1 5933.1 5934.5 6834.5 6846.5 6851.1 6911.4 6922.6 5872.9 5876.0 5936.2 5939.2 5948.1 5704.5 5792.3 5826.9 5879.3 5894.8 6641.6 6712.2 6720.4 6727.6 6737.2 6840.6 6843.2 6877.8 6923.7 6953.6 6465.9 6583.6 6586.3 6587.2 6624.9 6671.1 6679.8 6683.2 6687.4 6690.9 6785.3 6802.7 6814.2 6835.7 6882.4 6593.7 6637.9 6663.4 6699.0 6747.5 6483.6 6640.0 6644.2 6728.5 6735.5 6469.0 6557.0 6613.1 6622.5 6627.6 6748.5 6767.7 6778.5 6783.4 6812.0 6476.8 6477.1 6551.2 6566.9 6569.2 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#1] ext.html Cycles:180 Average:37375.51 Median:19883.30 stddev:51549.82 (259.3%) stddev-sans-first:51621.42 16:17:57 INFO - PID 29568 | Values: 835.7 885.1 888.1 890.7 890.9 39340.0 43207.1 43334.3 43341.6 43364.0 40304.8 40584.0 40647.4 40671.4 40723.2 6978.7 7057.2 7106.7 7693.3 7902.1 7719.3 7808.6 7809.4 7810.8 7814.0 7822.5 7885.5 7885.7 7889.7 7891.9 7803.0 7817.5 7818.3 7838.0 7839.1 7744.4 7822.1 7825.6 7827.5 7832.7 38101.2 38272.2 38304.2 38320.8 38443.6 3426.8 3454.3 3460.3 3466.0 3466.2 31383.7 31433.0 31509.2 31561.0 31573.2 5160.2 5184.9 5216.8 5244.6 5258.8 183803.0 184131.0 184156.0 184771.0 184847.0 42477.6 43376.0 48267.0 48491.8 48505.0 50739.7 51138.0 51360.7 51374.2 51411.0 15360.0 15411.5 15513.8 15559.8 15576.8 12524.4 12573.1 12600.6 12631.8 12811.5 13943.4 13968.9 14105.6 14142.2 14217.4 5727.9 5917.2 5971.0 5996.7 6010.2 1012.1 1025.5 1030.8 1041.2 1047.5 23436.4 23627.9 23635.6 23663.6 23914.4 1108.3 1124.9 1128.1 1130.8 1141.0 12275.6 12399.7 12417.2 12432.9 12564.9 217270.0 218823.0 219238.0 219434.0 220152.0 54198.7 54222.2 54261.5 54345.2 54604.5 1439.9 1459.4 1472.2 1473.6 1476.9 22396.9 22633.3 23065.5 23339.2 23712.9 36882.0 36929.6 37053.6 37275.4 37457.6 192040.0 192067.0 193087.0 193126.0 193475.0 34207.5 36300.5 36790.1 36919.6 36920.4 47073.5 47109.8 47417.8 47469.3 47901.3 33816.3 33961.8 34299.8 34378.1 34440.8 33920.5 34001.1 34004.3 34091.8 34453.4 37867.2 38172.2 38512.0 38525.4 38802.2 32703.3 33059.8 33100.3 33515.5 33771.7 24728.6 25109.9 25128.1 25232.5 25508.9 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#2] jquery.html Cycles:180 Average:33726.04 Median:22376.66 stddev:79047.04 (353.3%) stddev-sans-first:79229.55 16:17:57 INFO - PID 29568 | Values: 556.5 563.7 570.1 574.1 588.9 22359.2 23102.8 23142.0 23154.5 23197.3 24162.9 24438.4 24680.8 25572.1 25837.4 6540.7 6650.9 6693.4 6699.4 6702.5 6549.1 6667.7 6673.3 6678.5 6681.3 6596.2 6636.2 6640.3 6644.8 6650.0 6142.6 6549.2 6573.2 6639.1 6649.0 6069.1 6070.5 6072.6 6079.1 6096.1 29000.7 29334.0 29365.0 29393.7 29425.7 2040.2 2075.1 2076.8 2076.9 2077.2 18437.9 18874.2 19498.9 19622.8 19702.5 2356.8 2420.4 2420.8 2428.3 2491.7 115938.0 117361.4 122096.4 122449.0 135913.3 14530.9 14961.5 15198.0 15379.5 15387.5 22394.1 22409.3 22480.7 22521.9 22608.8 10112.5 10201.7 10224.2 10245.1 10418.2 9630.4 9640.4 9654.5 9658.8 9673.2 8661.0 8893.7 8940.2 8958.3 9026.5 2586.3 2632.3 2665.6 2701.9 2704.6 1005.2 1023.3 1024.1 1031.9 1035.2 19980.4 20528.3 20583.2 20875.8 21303.9 1059.5 1066.9 1070.8 1076.1 1081.5 11210.2 11249.4 11298.9 11299.2 11358.1 466801.0 467295.0 472343.0 474065.0 479054.0 108214.5 109964.0 110781.0 112061.0 112735.0 1028.9 1111.6 1142.9 1151.2 1213.2 21193.6 21332.9 21543.7 21550.8 21573.4 53962.2 54188.7 54733.0 54736.5 55399.2 66343.3 67476.0 67524.7 67717.3 68297.3 14396.5 14681.6 14808.1 14809.8 14818.3 23446.4 23527.8 23829.4 23863.5 23868.6 18704.3 18936.1 18941.1 18947.2 19217.2 16588.3 16971.4 17297.0 17455.6 17764.0 18323.6 19101.7 19131.7 19319.2 19334.4 14250.1 14346.2 14459.1 14527.6 14605.4 18882.8 18886.2 18894.2 18919.6 19011.8 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#3] mootools.html Cycles:180 Average:9317.63 Median:2772.23 stddev:6617.30 (238.7%) stddev-sans-first:6608.37 16:17:57 INFO - PID 29568 | Values: 1290.1 1363.4 1382.4 1391.6 1391.9 14756.0 15113.8 15243.0 15282.7 15375.5 15076.4 15237.2 15269.1 15276.8 15289.9 2763.6 2802.1 2846.1 2850.4 2852.2 2764.2 2782.2 2805.2 2818.5 2818.9 2690.9 2809.7 2810.6 2811.6 2812.2 2838.8 2849.7 2859.9 2860.4 2880.6 2727.8 2747.5 2769.1 2775.3 2776.7 14880.2 15235.2 15257.5 15350.5 15369.8 8092.7 8490.2 8492.2 8502.2 8505.7 5564.5 5712.0 5837.9 5911.9 5948.2 1888.8 1941.9 1950.1 1985.5 1995.1 26257.0 26293.7 26450.1 26473.0 26530.9 6861.7 6867.2 7046.2 7303.6 7600.3 16841.3 16939.5 16986.3 17010.9 17043.3 8008.7 8040.3 8044.4 8046.4 8049.0 7190.0 7407.4 7520.4 7528.3 7560.8 5151.6 5369.2 5373.0 5419.3 5425.1 1577.9 1582.2 1584.0 1602.2 1602.4 855.5 869.6 882.8 884.5 891.0 7333.6 7334.3 7412.1 7446.9 7485.9 706.7 711.0 715.5 717.3 724.1 4338.4 4340.2 4777.5 5017.1 5331.8 21118.3 21461.0 21826.2 22071.2 22082.0 20611.2 20704.8 21064.5 21254.6 21256.6 10892.6 10981.3 11179.3 11210.9 11216.2 8036.7 8089.8 8255.5 8278.4 8434.3 17981.2 18356.4 18383.0 18736.3 18762.1 18882.5 18901.5 19048.2 19048.9 19174.0 10997.3 11252.0 11312.2 11329.7 11332.3 13701.2 13849.4 13859.0 14142.5 14181.9 11279.9 11349.0 11432.6 11433.6 11745.2 11002.1 11329.5 11372.7 11440.2 11594.0 9681.5 9831.2 9879.9 9898.4 9926.3 7258.7 7366.2 7386.5 7397.2 7404.1 6888.4 6921.2 6923.3 7002.4 7032.9 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#4] prototype.html Cycles:180 Average:5550.11 Median:6209.71 stddev:1550.96 (25.0%) stddev-sans-first:1508.05 16:17:57 INFO - PID 29568 | Values: 487.7 522.4 522.6 524.3 524.6 6283.2 6316.2 6346.0 6356.9 6362.4 6243.6 6248.6 6267.3 6274.1 6326.7 5227.5 5230.4 5248.3 5249.6 5256.8 4915.3 5260.9 5286.2 5299.4 5306.9 4910.0 4988.4 5021.0 5021.4 5036.2 4971.4 5007.8 5021.1 5048.7 5073.5 4507.7 4527.6 4530.3 4544.3 4564.7 6144.2 6153.1 6183.2 6189.3 6205.8 5740.7 5743.2 5765.4 5774.9 5775.5 6505.4 6552.4 6568.2 6603.3 6613.7 4875.4 4903.7 4933.7 4952.6 4952.6 6745.9 6801.4 6878.4 6901.1 6925.3 5030.0 5057.0 5059.4 5061.7 5066.9 5101.6 5116.6 5136.0 5143.9 5155.1 5580.5 5734.3 5738.3 5758.3 5766.7 6615.5 6645.6 6673.0 6696.0 6717.3 1724.0 1747.1 1755.8 1766.5 1773.1 1167.7 1170.8 1205.3 1211.8 1221.4 5775.3 5826.4 5839.5 5841.9 5870.6 6764.3 6830.3 6846.3 6856.6 6861.7 5623.0 5639.0 5684.4 5690.1 5722.0 3532.2 3539.4 3575.5 3595.2 3611.1 6481.8 6504.6 6507.2 6567.3 6610.5 6750.0 6819.5 6853.9 6870.3 6924.5 6508.9 6582.5 6598.3 6605.4 6613.7 6717.8 6755.7 6779.1 6813.8 6816.8 6641.0 6683.0 6686.2 6745.5 6818.4 5867.8 6213.7 6244.5 6433.5 6480.8 4948.3 4964.2 4994.7 5001.0 5023.0 6706.2 6711.1 6716.4 6723.6 6793.3 6528.2 6530.9 6547.5 6564.9 6641.0 6371.4 6390.4 6405.6 6437.6 6507.2 6405.6 6511.4 6520.2 6527.9 6566.6 6620.2 6634.0 6639.7 6644.1 6648.0 6374.4 6399.6 6417.8 6446.8 6489.6 16:17:57 INFO - PID 29568 | 16:17:57 INFO - PID 29568 | [#5] yui.html Cycles:180 Average:23763.22 Median:20249.40 stddev:34482.14 (170.3%) stddev-sans-first:34536.17 16:17:57 INFO - PID 29568 | Values: 908.5 909.4 929.5 930.5 930.7 17701.4 18246.0 18284.2 18285.9 18286.9 18550.1 18725.8 18772.0 18804.3 18811.9 946.8 962.5 964.1 965.4 966.4 984.5 985.4 987.2 987.4 989.1 948.1 1031.4 1032.9 1038.4 1039.7 1019.8 1023.4 1024.8 1025.6 1026.2 728.9 756.1 756.3 758.7 759.0 20117.0 20381.8 20405.5 20408.1 20408.5 21178.2 21245.4 21608.5 21774.7 21814.5 16757.5 16797.5 17015.3 17157.7 17241.6 3760.6 3787.0 3787.5 3788.8 3789.4 99302.0 137235.0 137632.0 138164.3 140211.0 15890.3 16431.1 16464.8 16504.8 16530.6 25749.7 27149.9 27374.9 27427.2 27513.2 8480.1 8522.7 8564.5 8584.7 8601.1 4130.9 4140.7 4183.5 4241.5 4245.6 5444.0 5525.3 5534.7 5562.5 5573.1 1090.4 1102.8 1114.4 1117.1 1120.3 654.8 677.7 679.2 681.7 696.8 11795.7 11824.7 12010.3 12107.3 12571.8 670.2 681.6 684.0 684.9 692.3 5491.2 5504.3 5508.9 5511.9 5644.5 122164.4 123228.0 123974.0 125051.0 126304.0 107438.5 108228.5 110106.0 111916.0 112209.0 86757.1 88672.6 88758.0 90053.5 92511.0 9910.7 9949.9 9969.3 10243.1 10271.6 43127.0 43909.3 45325.8 45397.0 46196.0 56608.4 56686.0 57230.0 58459.0 59700.7 15527.9 15538.9 15695.0 15754.0 15892.3 16965.6 17086.7 17129.8 17209.7 17226.4 15243.5 15303.1 15376.8 15425.2 15502.0 14330.4 14624.9 14727.1 14812.0 14852.0 15231.9 15348.3 15398.3 15429.2 15513.6 11455.5 11481.4 11781.4 11803.1 11805.8 11938.0 12000.6 12047.9 12084.5 12236.8 16:17:57 INFO - PID 29568 | -------- Summary: end -------- 16:17:57 INFO - PID 29568 | 16:17:58 INFO - TEST-INFO | 29568: exit 0 16:17:58 INFO - TEST-OK | dromaeo_css | took 1109532ms 16:17:58 INFO - TEST-START | kraken 16:17:58 INFO - Initialising browser for kraken test... 16:17:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43252/getInfo.html -profile /tmp/tmpiCUG7f/profile 16:17:58 INFO - TEST-INFO | started process 29939 (/builds/slave/test/build/application/firefox/firefox http://localhost:43252/getInfo.html) 16:18:04 INFO - TEST-INFO | 29939: exit 0 16:18:04 INFO - Browser initialized. 16:18:04 INFO - Running cycle 1/1 for kraken test... 16:18:04 INFO - Using env: {'DISPLAY': ':0', 16:18:04 INFO - 'HOME': '/home/cltbld', 16:18:04 INFO - 'JSGC_DISABLE_POISONING': '1', 16:18:04 INFO - 'LANG': 'en_US.UTF-8', 16:18:04 INFO - 'LANGUAGE': 'en_US:en', 16:18:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:18:04 INFO - 'LOGNAME': 'cltbld', 16:18:04 INFO - 'MAIL': '/var/mail/cltbld', 16:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:18:04 INFO - 'MOZ_CRASHREPORTER': '1', 16:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:18:04 INFO - 'MOZ_NO_REMOTE': '1', 16:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:18:04 INFO - 'NO_EM_RESTART': '1', 16:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:04 INFO - 'PWD': '/builds/slave/test', 16:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:18:04 INFO - 'RUST_BACKTRACE': 'full', 16:18:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:18:04 INFO - 'SHELL': '/bin/bash', 16:18:04 INFO - 'SHLVL': '1', 16:18:04 INFO - 'TERM': 'linux', 16:18:04 INFO - 'TMOUT': '86400', 16:18:04 INFO - 'USER': 'cltbld', 16:18:04 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668', 16:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:04 INFO - '_': '/tools/buildbot/bin/python'} 16:18:04 INFO - TEST-INFO | started process 30173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiCUG7f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:05 INFO - PID 30173 | 16:18:05 INFO - PID 30173 | (/builds/slave/test/build/application/firefox/firefox:30222): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:18:05 INFO - PID 30173 | 16:18:15 INFO - PID 30173 | RSS: Main: 155127808 16:18:15 INFO - PID 30173 | 16:18:18 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43252/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:19 INFO - PID 30173 | RSS: Main: 161411072 16:18:19 INFO - PID 30173 | 16:18:21 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43252/tests/kraken/driver.html?testName=audio-dft) 16:18:22 INFO - PID 30173 | RSS: Main: 161538048 16:18:22 INFO - PID 30173 | 16:18:25 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43252/tests/kraken/driver.html?testName=audio-fft) 16:18:26 INFO - PID 30173 | RSS: Main: 156884992 16:18:26 INFO - PID 30173 | 16:18:28 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43252/tests/kraken/driver.html?testName=audio-oscillator) 16:18:28 INFO - PID 30173 | RSS: Main: 156975104 16:18:28 INFO - PID 30173 | 16:18:30 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:31 INFO - PID 30173 | RSS: Main: 157290496 16:18:31 INFO - PID 30173 | 16:18:34 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43252/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:35 INFO - PID 30173 | RSS: Main: 159776768 16:18:35 INFO - PID 30173 | 16:18:38 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43252/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:39 INFO - PID 30173 | RSS: Main: 160178176 16:18:39 INFO - PID 30173 | 16:18:42 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43252/tests/kraken/driver.html?testName=json-parse-financial) 16:18:43 INFO - PID 30173 | RSS: Main: 160403456 16:18:43 INFO - PID 30173 | 16:18:44 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:45 INFO - PID 30173 | RSS: Main: 159834112 16:18:45 INFO - PID 30173 | 16:18:47 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:47 INFO - PID 30173 | RSS: Main: 159965184 16:18:47 INFO - PID 30173 | 16:18:49 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:50 INFO - PID 30173 | RSS: Main: 156667904 16:18:50 INFO - PID 30173 | 16:18:53 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:53 INFO - PID 30173 | RSS: Main: 157364224 16:18:53 INFO - PID 30173 | 16:18:56 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:57 INFO - PID 30173 | RSS: Main: 158220288 16:18:57 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | Cycle 1(1): loaded http://localhost:43252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43252/tests/kraken/driver.html?testName=ai-astar) 16:18:59 INFO - PID 30173 | RSS: Main: 159113216 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | __start_tp_report 16:18:59 INFO - PID 30173 | _x_x_mozilla_page_load 16:18:59 INFO - PID 30173 | _x_x_mozilla_page_load_details 16:18:59 INFO - PID 30173 | |i|pagename|runs| 16:18:59 INFO - PID 30173 | |0;ai-astar;108;106;108;107;109;107;107;110;107;107 16:18:59 INFO - PID 30173 | |1;audio-beat-detection;119;119;116;116;117;115;119;115;115;116 16:18:59 INFO - PID 30173 | |2;audio-dft;164;163;162;164;162;162;162;164;165;168 16:18:59 INFO - PID 30173 | |3;audio-fft;75;73;74;74;75;74;73;74;73;74 16:18:59 INFO - PID 30173 | |4;audio-oscillator;79;79;85;80;78;78;78;79;78;79 16:18:59 INFO - PID 30173 | |5;imaging-gaussian-blur;116;113;113;114;114;113;114;114;112;114 16:18:59 INFO - PID 30173 | |6;imaging-darkroom;147;149;147;148;149;149;147;149;148;151 16:18:59 INFO - PID 30173 | |7;imaging-desaturate;93;94;96;94;94;94;94;94;95;93 16:18:59 INFO - PID 30173 | |8;json-parse-financial;54;58;57;60;53;54;55;55;53;55 16:18:59 INFO - PID 30173 | |9;json-stringify-tinderbox;38;38;38;37;38;38;38;39;37;38 16:18:59 INFO - PID 30173 | |10;stanford-crypto-aes;75;73;72;72;73;73;75;80;75;73 16:18:59 INFO - PID 30173 | |11;stanford-crypto-ccm;114;110;109;115;112;116;112;113;112;110 16:18:59 INFO - PID 30173 | |12;stanford-crypto-pbkdf2;178;166;168;173;175;173;174;176;168;167 16:18:59 INFO - PID 30173 | |13;stanford-crypto-sha256-iterative;69;67;68;64;62;65;71;69;67;64 16:18:59 INFO - PID 30173 | __end_tp_report 16:18:59 INFO - PID 30173 | __start_cc_report 16:18:59 INFO - PID 30173 | _x_x_mozilla_cycle_collect,766 16:18:59 INFO - PID 30173 | __end_cc_report 16:18:59 INFO - PID 30173 | __startTimestamp1505776739270__endTimestamp 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | ------- Summary: start ------- 16:18:59 INFO - PID 30173 | Number of tests: 14 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#0] ai-astar Cycles:10 Average:107.60 Median:107.50 stddev:1.17 (1.1%) stddev-sans-first:1.24 16:18:59 INFO - PID 30173 | Values: 108.0 106.0 108.0 107.0 109.0 107.0 107.0 110.0 107.0 107.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#1] audio-beat-detection Cycles:10 Average:116.70 Median:116.50 stddev:1.70 (1.5%) stddev-sans-first:1.59 16:18:59 INFO - PID 30173 | Values: 119.0 119.0 116.0 116.0 117.0 115.0 119.0 115.0 115.0 116.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 16:18:59 INFO - PID 30173 | Values: 164.0 163.0 162.0 164.0 162.0 162.0 162.0 164.0 165.0 168.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 16:18:59 INFO - PID 30173 | Values: 75.0 73.0 74.0 74.0 75.0 74.0 73.0 74.0 73.0 74.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:2.11 (2.7%) stddev-sans-first:2.24 16:18:59 INFO - PID 30173 | Values: 79.0 79.0 85.0 80.0 78.0 78.0 78.0 79.0 78.0 79.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.06 (0.9%) stddev-sans-first:0.73 16:18:59 INFO - PID 30173 | Values: 116.0 113.0 113.0 114.0 114.0 113.0 114.0 114.0 112.0 114.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 16:18:59 INFO - PID 30173 | Values: 147.0 149.0 147.0 148.0 149.0 149.0 147.0 149.0 148.0 151.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 16:18:59 INFO - PID 30173 | Values: 93.0 94.0 96.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.27 (4.1%) stddev-sans-first:2.35 16:18:59 INFO - PID 30173 | Values: 54.0 58.0 57.0 60.0 53.0 54.0 55.0 55.0 53.0 55.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 16:18:59 INFO - PID 30173 | Values: 38.0 38.0 38.0 37.0 38.0 38.0 38.0 39.0 37.0 38.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:2.38 (3.2%) stddev-sans-first:2.50 16:18:59 INFO - PID 30173 | Values: 75.0 73.0 72.0 72.0 73.0 73.0 75.0 80.0 75.0 73.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:112.50 stddev:2.26 (2.0%) stddev-sans-first:2.32 16:18:59 INFO - PID 30173 | Values: 114.0 110.0 109.0 115.0 112.0 116.0 112.0 113.0 112.0 110.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:173.50 stddev:4.21 (2.4%) stddev-sans-first:3.82 16:18:59 INFO - PID 30173 | Values: 178.0 166.0 168.0 173.0 175.0 173.0 174.0 176.0 168.0 167.0 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:2.80 (4.1%) stddev-sans-first:2.83 16:18:59 INFO - PID 30173 | Values: 69.0 67.0 68.0 64.0 62.0 65.0 71.0 69.0 67.0 64.0 16:18:59 INFO - PID 30173 | -------- Summary: end -------- 16:18:59 INFO - PID 30173 | 16:18:59 INFO - PID 30173 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:18:59 INFO - TEST-INFO | 30173: exit 0 16:19:00 INFO - TEST-OK | kraken | took 61595ms 16:19:00 INFO - SUITE-END | took 1171s 16:19:00 INFO - Completed test suite (00:19:31) 16:19:00 INFO - javascript benchmark 16:19:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.024244118744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.8104713717175, 3166.208447888028, 3179.4912813949772, 3182.3158021025474, 3185.155933677576, 6261.186045814038, 6312.747490100396, 6374.171357723495, 6434.034894765776, 6457.160569126013, 6336.493080553556, 6372.044193370996, 6378.3621637836195, 6463.2244130704385, 6483.870322593557, 1252.2040718477006, 5903.114532820068, 5953.940460595392, 5998.340182579913, 6001.66990815505, 5746.9712651436685, 5827.912581311284, 5886.499647529965, 5957.404259574051, 5969.88060238795, 5792.097240171446, 5805.158252053428, 5844.970775146118, 5887.1463637772285, 5937.554683398763, 5863.179154918314, 5872.0898260769645, 5934.97032514839, 5946.464818166342, 5950.196723442323, 5821.162340216805, 5836.708164591796, 5920.615160014585, 5924.170616113747, 5928.0, 6260.874782504325, 6367.140436041168, 6384.265809431929, 6471.029345598198, 6474.74101035958, 6646.867062658768, 6711.932880671179, 6747.730090796363, 6758.864822703567, 6770.627615481147, 6777.186737591521, 6781.932180678179, 6794.898076528856, 6845.828854278633, 6925.722971081151, 6404.935950640481, 6432.067350234237, 6447.1296374989715, 6448.903266451007, 6460.160179176724, 6973.3375329343635, 7034.261402552761, 7102.857942841218, 7112.110986126734, 7141.392981596518, 6563.638999855054, 6712.798616041527, 6736.8989465158065, 6797.150356205474, 6809.693563789641, 6753.358430949052, 6795.150606174228, 6870.725170993204, 6888.690008949609, 6893.310668933167, 6762.526623136333, 6792.015157802091, 6804.183497980175, 6820.93179068203, 6832.111825462757, 6733.124693789874, 6821.386075253251, 6821.863562728718, 6823.658817059227, 6828.9658551706925, 5243.632945693841, 5258.0, 5333.173358129496, 5339.946600534023, 5375.838724838261, 4581.702189357748, 4583.197940360424, 4655.906881862344, 4680.9297860532115, 4746.477887432379, 5892.410758924159, 5902.734376953047, 5909.054551271776, 5933.110033494924, 5934.495567876779, 6834.453243740489, 6846.520743547904, 6851.07510486078, 6911.447084233349, 6922.58464492132, 5872.882542349129, 5875.970620146872, 5936.1986131871645, 5939.227900372924, 5948.10778383246, 5704.515116215085, 5792.275965504312, 5826.854328641733, 5879.2944846618675, 5894.764209431661, 6641.634710090895, 6712.228093769279, 6720.395164435126, 6727.562708423937, 6737.225219099768, 6840.623765692835, 6843.213030501556, 6877.793666190022, 6923.723051078001, 6953.617551034539, 6465.9331210349765, 6583.63789991555, 6586.275509693834, 6587.209534855848, 6624.867502650017, 6671.099401580725, 6679.799606011828, 6683.164604424447, 6687.398134167948, 6690.866182676416, 6785.253622101466, 6802.693878775566, 6814.2163651180745, 6835.658217089225, 6882.449404047764, 6593.703283352164, 6637.900431493435, 6663.433608143362, 6699.0, 6747.527673063035, 6483.610983341015, 6640.037194606658, 6644.235912870082, 6728.461723062045, 6735.528513004238, 6468.967655161694, 6557.049227861838, 6613.140291762233, 6622.470202383702, 6627.569208001464, 6748.493862960199, 6767.661616919036, 6778.4916131289365, 6783.423409010092, 6812.0, 6476.805695829133, 6477.125588045742, 6551.181102362205, 6566.868662626816, 6569.24453687832], "value": 6194.329248648097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.6573804740057, 885.1458342699295, 888.0897080492495, 890.7149712092133, 890.8841850559427, 39340.0, 43207.135857282876, 43334.34998475025, 43341.56658433415, 43364.0, 40304.79847600765, 40584.0, 40647.39028914561, 40671.38992915101, 40723.18553628933, 6978.685959131852, 7057.223705392403, 7106.715731370739, 7693.30760231579, 7902.091259505173, 7719.343855772266, 7808.570528620923, 7809.41429392795, 7810.765677029698, 7813.96093019537, 7822.452428330019, 7885.487443316195, 7885.684572617117, 7889.684412623488, 7891.881621775678, 7803.0, 7817.452778305521, 7818.33544148748, 7838.020247469095, 7839.137694853562, 7744.380449564022, 7822.100458447295, 7825.569593672346, 7827.491213071132, 7832.686692532292, 38101.23797524062, 38272.234555308736, 38304.233915321536, 38320.80839595784, 38443.61556384428, 3426.7601267911255, 3454.3091381723502, 3460.325236578868, 3466.046837119787, 3466.1507930556922, 31383.686163138304, 31433.0, 31509.212269693213, 31561.0, 31573.21066973321, 5160.200168973777, 5184.922226166611, 5216.7913283468615, 5244.580433565306, 5258.842234732964, 183803.0, 184131.0, 184156.0, 184771.0, 184847.0, 42477.57522424798, 43376.0, 48267.0, 48491.75754121207, 48505.0, 50739.74630126826, 51138.0, 51360.74319628378, 51374.22938655923, 51411.0, 15360.0, 15411.537653870402, 15513.767293490606, 15559.766603500957, 15576.844231557767, 12524.373781310898, 12573.057020723483, 12600.621981340575, 12631.810522842165, 12811.487540498276, 13943.442262309394, 13968.930155349159, 14105.647358815906, 14142.222177780115, 14217.36021879018, 5727.914081288784, 5917.171595976567, 5970.970145149333, 5996.700164991733, 6010.158577799111, 1012.099231683802, 1025.5128813813378, 1030.8144533983955, 1041.2138835179542, 1047.544318221576, 23436.414089647897, 23627.881860590587, 23635.645465318034, 23663.645045324334, 23914.40213994664, 1108.318384193715, 1124.8706398764084, 1128.1200663482496, 1130.8190689489807, 1140.9885901140883, 12275.570355037531, 12399.690007749878, 12417.19288246261, 12432.875671243171, 12564.87435125637, 217270.0, 218823.0, 219238.0, 219434.0, 220152.0, 54198.72900635472, 54222.186667200025, 54261.45738542564, 54345.1848222277, 54604.45395546073, 1439.9136051836924, 1459.408939379553, 1472.1829384691598, 1473.5873955292536, 1476.859698328657, 22396.888015559816, 22633.321000370015, 23065.538689226458, 23339.18312859042, 23712.881435592713, 36882.0, 36929.63070369262, 37053.629463705016, 37275.44086838645, 37457.62542374541, 192040.0, 192067.0, 193087.0, 193126.0, 193475.0, 34207.48688769621, 36300.455493167094, 36790.08024799402, 36919.630803691616, 36920.44619330658, 47073.529264706915, 47109.76445117752, 47417.76291118522, 47469.28796068131, 47901.28148077851, 33816.3236735259, 33961.830190849876, 34299.82850085833, 34378.14054648654, 34440.827795861864, 33920.491192631634, 34001.14997125092, 34004.319913602085, 34091.82954085214, 34453.44959476779, 37867.242655147296, 38172.23655526929, 38512.0, 38525.4221186688, 38802.223955521295, 32703.34593308073, 33059.834700826344, 33100.33799324048, 33515.497267540515, 33771.66228337685, 24728.57057165114, 25109.87445062763, 25128.12051578186, 25232.495350093264, 25508.872455637604], "value": 17344.181126138516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4741319453116, 563.7322271920841, 570.139089974139, 574.130192757972, 588.9322727886293, 22359.217427390024, 23102.768972310292, 23142.0, 23154.536909261806, 23197.304080877602, 24162.87918560409, 24438.389040274003, 24680.75319246807, 25572.10497632583, 25837.354066148357, 6540.705668244928, 6650.900236496456, 6693.39759421652, 6699.430548403391, 6702.497312701543, 6549.148610680629, 6667.666616669171, 6673.265940746514, 6678.499112566553, 6681.298463661318, 6596.208454985408, 6636.236832764222, 6640.269570347258, 6644.767433139841, 6649.9667501662425, 6142.600730952496, 6549.181352330958, 6573.244076931166, 6639.136912201431, 6649.035889795977, 6069.0592958091565, 6070.514358851281, 6072.605280656743, 6079.05774604937, 6096.116063170815, 29000.70999290022, 29334.0, 29365.0, 29393.70606293931, 29425.70574294251, 2040.1635329514977, 2075.1180748181964, 2076.8338532917332, 2076.865003774765, 2077.1587507059667, 18437.907810460994, 18874.15066322019, 19498.902505487524, 19622.803771962383, 19702.507437314038, 2356.8350215484925, 2420.4311986683115, 2420.8305418620703, 2428.344347026293, 2491.700995880488, 115938.0, 117361.41319293434, 122096.38951805273, 122449.0, 135913.32043339818, 14530.924699703692, 14961.476348327757, 15198.0, 15379.461718839786, 15387.538373848802, 22394.10423583071, 22409.32772016842, 22480.662790058162, 22521.88739056327, 22608.773912260665, 10112.494375281207, 10201.673782408388, 10224.233182511192, 10245.077942985166, 10418.21863360251, 9630.422174669542, 9640.42157470554, 9654.469004204695, 9658.75853103678, 9673.177779888647, 8661.0, 8893.73318800437, 8940.195382415613, 8958.328125390623, 9026.45841249527, 2586.314626623946, 2632.2629663694197, 2665.5735082386727, 2701.9459610808067, 2704.594310853388, 1005.2008653120787, 1023.3246057602096, 1024.134606257711, 1031.9174466042698, 1035.1925498111484, 19980.400587982385, 20528.28151014737, 20583.176672932914, 20875.791242087384, 21303.893480532497, 1059.4755595980039, 1066.8506409102731, 1070.7590792071878, 1076.0530732954949, 1081.5457507846722, 11210.215284929976, 11249.43752812356, 11298.887011129947, 11299.209055366046, 11358.148138889615, 466801.0, 467295.0, 472343.0, 474065.0, 479054.0, 108214.45892770485, 109964.0, 110781.0, 112061.0, 112735.0, 1028.881678606955, 1111.5609334313062, 1142.8514293142005, 1151.1826603111717, 1213.2295992044938, 21193.62495761329, 21332.893335533223, 21543.676844847654, 21550.78449215488, 21573.352799416043, 53962.19056714231, 54188.72905635447, 54733.0, 54736.452635473135, 55399.16901246565, 66343.33656663564, 67476.0, 67524.66237668977, 67717.3228267711, 68297.3170268291, 14396.496122635657, 14681.632959176106, 14808.111513309235, 14809.777853332424, 14818.333175006936, 23446.413839654146, 23527.76472235324, 23829.404264893517, 23863.52272954566, 23868.64197037011, 18704.345347913302, 18936.147873346006, 18941.14764835558, 18947.242110315434, 19217.23131074797, 16588.253528591, 16971.406000789913, 17297.0, 17455.56361090983, 17764.0, 18323.63352732911, 19101.713474298176, 19131.713024304925, 19319.22723091117, 19334.419967401, 14250.144991300554, 14346.210958397389, 14459.13245205291, 14527.564173074825, 14605.415783368971, 18882.811171888105, 18886.244550218387, 18894.244230230637, 18919.621607567497, 19011.813641430857], "value": 12014.62788111729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.0904862072239, 1363.379662253674, 1382.4262930883672, 1391.5964370332604, 1391.9373628186731, 14756.0, 15113.848861511382, 15243.009204401706, 15282.694346113085, 15375.461858834942, 15076.396944122249, 15237.16195609241, 15269.083854968681, 15276.770848437282, 15289.92355038226, 2763.6269103671048, 2802.1033269353866, 2846.0750256166725, 2850.3586692994118, 2852.2298979275583, 2764.2121995231364, 2782.1931639824425, 2805.228562145406, 2818.4504021715775, 2818.943621127576, 2690.9192724218306, 2809.719028097184, 2810.6205662235643, 2811.6485439320086, 2812.170409729135, 2838.772898168152, 2849.686534481216, 2859.8856045758143, 2860.3707184419395, 2880.5535142053013, 2727.7954153438573, 2747.5054490191756, 2769.141566114511, 2775.3200465885784, 2776.6667999839947, 14880.181590012546, 15235.162066086361, 15257.465988690343, 15350.539483815503, 15369.846301536953, 8092.676292948334, 8490.150984901522, 8492.15078492152, 8502.23479886807, 8505.74482765518, 5564.4991950724225, 5711.971440142815, 5837.854053648651, 5911.852203694942, 5948.167256584082, 1888.792232854385, 1941.9223231070741, 1950.0932066589105, 1985.4738494299022, 1995.102204008202, 26257.0, 26293.73706262932, 26450.07424740144, 26473.0, 26530.867345663148, 6861.656917154222, 6867.2102708188195, 7046.154461464657, 7303.598302093435, 7600.2779735925, 16841.32634694623, 16939.49181524556, 16986.32054717822, 17010.914945425193, 17043.31826726917, 8008.679652813938, 8040.316573091352, 8044.436889417684, 8046.356291496666, 8049.034115906012, 7189.96405017982, 7407.407407407394, 7520.398368130536, 7528.284812942762, 7560.848783024308, 5151.562117220078, 5369.194620806832, 5372.973135134299, 5419.3225846769155, 5425.13197888336, 1577.8875892495762, 1582.2088955522238, 1583.9604009899845, 1602.190893598725, 1602.3670650093147, 855.5337341149088, 869.6347534035593, 882.8101958079044, 884.5135175653365, 890.9599068041954, 7333.596652184075, 7334.266573342623, 7412.110546734426, 7446.888296675555, 7485.887711684329, 706.6819931031057, 710.989335159973, 715.4669771020623, 717.3221305865907, 724.1238101896658, 4338.392625032435, 4340.175366680321, 4777.539567122934, 5017.147084995559, 5331.81338653153, 21118.260860870105, 21461.03425345863, 21826.236081737065, 22071.227507037496, 22082.0, 20611.175552977715, 20704.792952070587, 21064.473388165417, 21254.574908501745, 21256.574868502543, 10892.61875834342, 10981.286216395909, 11179.273347232403, 11210.934961178675, 11216.214864959538, 8036.67853285862, 8089.797755056171, 8255.463394879314, 8278.379121566028, 8434.325253979545, 17981.190846412206, 18356.449306520826, 18383.0, 18736.250549978395, 18762.061896905372, 18882.52793680169, 18901.527461813566, 19048.238070477026, 19048.904755476135, 19174.0, 10997.34015959045, 11252.043576296106, 11312.15158863105, 11329.660110196708, 11332.263402878787, 13701.246431446367, 13849.37677804481, 13859.0, 14142.50501232452, 14181.858181418054, 11279.943600281946, 11349.0, 11432.599859004895, 11433.59982400612, 11745.17783755129, 11002.064824489687, 11329.490172942073, 11372.658820235407, 11440.199186056896, 11594.0, 9681.515924203903, 9831.213502919893, 9879.851802223116, 9898.356606820533, 9926.25553083536, 7258.745943891939, 7366.152892417441, 7386.519876208029, 7397.186309506058, 7404.111506619241, 6888.380045795902, 6921.204061532988, 6923.307669233036, 7002.404795592432, 7032.894506582507], "value": 6653.533505889644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.6784838473853, 522.386196219442, 522.6210997027155, 524.2634099090777, 524.6117872774148, 6283.214598175223, 6316.168131379498, 6345.968270158649, 6356.9046464302955, 6362.427381535661, 6243.625382477043, 6248.562600617958, 6267.310595834466, 6274.121622972787, 6326.746930122801, 5227.503387178212, 5230.372355317368, 5248.317718696583, 5249.580033597322, 5256.842294731155, 4915.287283343913, 5260.92108618371, 5286.2070689396705, 5299.443558426367, 5306.893862122755, 4909.950900490985, 4988.42633097193, 5021.0, 5021.397432308128, 5036.194208926572, 4971.353724015891, 5007.773095591567, 5021.1213037718435, 5048.6970781753025, 5073.518015788531, 4507.729536227836, 4527.569880861313, 4530.252508336121, 4544.295634176675, 4564.7032942858605, 6144.170536977495, 6153.138560601519, 6183.165272688175, 6189.257289125334, 6205.7517699291975, 5740.74166662497, 5743.16724075011, 5765.423457654243, 5774.855628609276, 5775.48020678141, 6505.381988711065, 6552.443042341407, 6568.244651865049, 6603.273639899608, 6613.702383392759, 4875.439324477695, 4903.705777653352, 4933.654644174873, 4952.579030782388, 4952.62855285855, 6745.865082698368, 6801.421879140328, 6878.449724022066, 6901.067701043716, 6925.3074692530345, 5029.974850125726, 5056.974715126401, 5059.367579052619, 5061.670991385548, 5066.873328166826, 5101.642884998088, 5116.641835071584, 5135.974320128375, 5143.922841157386, 5155.097857874932, 5580.469855363734, 5734.254546908875, 5738.2540269765495, 5758.280214973129, 5766.654000759968, 6615.470762339001, 6645.568038077509, 6672.96663516689, 6696.0, 6717.261101278856, 1723.9827601724073, 1747.074050753103, 1755.806861245262, 1766.4788887278285, 1773.0868602669636, 1167.73142177298, 1170.78925793358, 1205.2888795610631, 1211.7939950208486, 1221.3526830779701, 5775.306963164363, 5826.446487583673, 5839.5036421904615, 5841.912371314434, 5870.618409803349, 6764.289749576322, 6830.282820303896, 6846.349596788297, 6856.554323968926, 6861.725530978805, 5623.0, 5638.981306637096, 5684.403137670568, 5690.146478028246, 5721.971390143022, 3532.2405682778326, 3539.3629146753833, 3575.4636804479014, 3595.173110184672, 3611.133328001313, 6481.773137940149, 6504.642244676588, 6507.219133703891, 6567.310432404529, 6610.471162307004, 6750.0, 6819.454443644497, 6853.931460685429, 6870.27862074485, 6924.480663950224, 6508.9023664645065, 6582.539222254396, 6598.274189839018, 6605.372489613479, 6613.702383392662, 6717.798466046026, 6755.729770809113, 6779.118714567075, 6813.761518346834, 6816.829579260559, 6640.970649549327, 6682.966585167043, 6686.1642294713165, 6745.460363170836, 6818.420434263143, 5867.765289388377, 6213.65824879636, 6244.531660125418, 6433.517486188461, 6480.805575832733, 4948.307236986897, 4964.230544265644, 4994.675346102492, 5000.974995125147, 5022.974885125551, 6706.228783689743, 6711.127553418024, 6716.429103526059, 6723.596584204964, 6793.286704895915, 6528.2492513359675, 6530.934690653033, 6547.508936829661, 6564.934350656432, 6640.966795166187, 6371.426571608577, 6390.360963903572, 6405.615663060231, 6437.645929473924, 6507.201903181677, 6405.551611387158, 6511.3628980263065, 6520.152380190545, 6527.9020814688765, 6566.606003639797, 6620.2386725527185, 6633.9668301658185, 6639.668016599054, 6644.136262285871, 6647.966760166169, 6374.394432528902, 6399.55203135776, 6417.7753778617525, 6446.806595802133, 6489.610623362613], "value": 5089.980888754104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.5275656658542, 909.354358405532, 929.4980710416376, 930.4556834251961, 930.6556574067591, 17701.380451684192, 18246.0, 18284.177212025457, 18285.908570457163, 18286.90856545717, 18550.07249637516, 18725.812741872578, 18772.0, 18804.34184803532, 18811.90594047031, 946.8011717539308, 962.4610218277752, 964.0889359555223, 965.3628605120622, 966.424977138605, 984.4880662055726, 985.4481490365382, 987.1806400687412, 987.3828856964398, 989.0801554554262, 948.1466679988032, 1031.3708637730979, 1032.896710328965, 1038.4496217004962, 1039.7348676087624, 1019.8266294729914, 1023.3603997501561, 1024.7950409918046, 1025.5846382215177, 1026.1893104447477, 728.9052423185005, 756.0775853458772, 756.2513112019061, 758.6889375356078, 758.9886151707728, 20117.0, 20381.79618203814, 20405.489862753402, 20408.081636326402, 20408.489787755425, 21178.152873885025, 21245.362639120853, 21608.459788505257, 21774.673379899315, 21814.454638634, 16757.49727508177, 16797.496075117644, 17015.319387224496, 17157.742633860504, 17241.568960775956, 3760.623937606245, 3787.0153760022317, 3787.5454945406727, 3788.829502672359, 3789.355809512362, 99302.00697993, 137235.0, 137632.0, 138164.30917845346, 140211.0, 15890.284937177854, 16431.096289704183, 16464.83535164657, 16504.83495165057, 16530.58673533147, 25749.742502574736, 27149.91400343964, 27374.863125684245, 27427.177184684493, 27513.17460476189, 8480.109588493242, 8522.701705440404, 8564.52895090776, 8584.656613735506, 8601.096884827128, 4130.91738165235, 4140.668746500272, 4183.5398106208295, 4241.512226094039, 4245.5542168072525, 5444.0, 5525.336959564797, 5534.695591742412, 5562.499375056264, 5573.080441727151, 1090.3893819461127, 1102.7904698107334, 1114.4427786106946, 1117.0784103114963, 1120.2550304047718, 654.8002859127917, 677.7221339250883, 679.1985457160499, 681.6625770243761, 696.7839969609437, 11795.705107372385, 11824.704382390337, 12010.279383237033, 12107.334096624594, 12571.811422828665, 670.1790306874137, 681.6114814555755, 683.9794806155824, 684.900734321417, 692.3491917597443, 5491.2312276281355, 5504.339479262514, 5508.91736623943, 5511.862203444946, 5644.520215781622, 122164.38917805532, 123228.0, 123974.0, 125051.0, 126304.0, 107438.46280768546, 108228.4588577052, 110106.0, 111916.0, 112209.0, 86757.13242867617, 88672.5566372164, 88758.0, 90053.54973225092, 92510.99999999865, 9910.653127140515, 9949.900500994898, 9969.252306076929, 10243.07812296897, 10271.640492582725, 43127.0, 43909.341359878985, 45325.773371132935, 45397.0, 46196.0, 56608.43391566032, 56686.0, 57230.0, 58459.0, 59700.70149649224, 15527.922360388126, 15538.922305388402, 15695.0, 15754.0, 15892.284847181674, 16965.575860603585, 17086.658266834842, 17129.828701712824, 17209.655806884042, 17226.397076102276, 15243.466478673194, 15303.081815091131, 15376.769348459558, 15425.151616661191, 15502.0, 14330.426782928984, 14624.853751462775, 14727.116373017654, 14812.0, 14852.0, 15231.923840380727, 15348.309326080576, 15398.307076181374, 15429.22853857325, 15513.612159696098, 11455.541778328774, 11481.425928703364, 11781.410929453321, 11803.055755539708, 11805.763884722086, 11938.0, 12000.57997970067, 12047.879521204675, 12084.45619947087, 12236.816447753468], "value": 8817.682384530692, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 108.0, 107.0, 109.0, 107.0, 107.0, 110.0, 107.0, 107.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 116.0, 116.0, 117.0, 115.0, 119.0, 115.0, 115.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 164.0, 162.0, 162.0, 162.0, 164.0, 165.0, 168.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 75.0, 74.0, 73.0, 74.0, 73.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 80.0, 78.0, 78.0, 78.0, 79.0, 78.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 112.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 149.0, 149.0, 147.0, 149.0, 148.0, 151.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 57.0, 60.0, 53.0, 54.0, 55.0, 55.0, 53.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 39.0, 37.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 72.0, 73.0, 73.0, 75.0, 80.0, 75.0, 73.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 109.0, 115.0, 112.0, 116.0, 112.0, 113.0, 112.0, 110.0], "value": 112.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 166.0, 168.0, 173.0, 175.0, 173.0, 174.0, 176.0, 168.0, 167.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 64.0, 62.0, 65.0, 71.0, 69.0, 67.0, 64.0], "value": 66.6, "unit": "score"}]}]} 16:19:00 INFO - Return code: 0 16:19:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:00 INFO - # TBPL SUCCESS # 16:19:00 INFO - Running post-action listener: _package_coverage_data 16:19:00 INFO - Running post-action listener: _resource_record_post_action 16:19:00 INFO - [mozharness: 2017-09-18 23:19:00.534825Z] Finished run-tests step (success) 16:19:00 INFO - Running post-run listener: _resource_record_post_run 16:19:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 717365248; Read time: 256; Write time: 893668 16:19:00 INFO - TinderboxPrint: CPU usage
13.1% 16:19:00 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 256 16:19:00 INFO - TinderboxPrint: I/O write bytes / time
717,365,248 / 893,668 16:19:00 INFO - TinderboxPrint: CPU idle
8,241.5 (86.9%) 16:19:00 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 16:19:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:19:00 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 322449408; Read time: 0; Write time: 474016 16:19:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:19:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 321916928; Read time: 240; Write time: 290872 16:19:01 INFO - Running post-run listener: _upload_blobber_files 16:19:01 INFO - Blob upload gear active. 16:19:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:01 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 16:19:01 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'] 16:19:01 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 16:19:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:02 INFO - (blobuploader) - INFO - Done attempting. 16:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:03 INFO - (blobuploader) - INFO - Done attempting. 16:19:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:19:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:04 INFO - (blobuploader) - INFO - Done attempting. 16:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:11 INFO - (blobuploader) - INFO - Done attempting. 16:19:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:11 INFO - Return code: 0 16:19:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79d67a363fc2ec63cb254c2e5029095926da541c0c686efeda3e6dbacdbe1a626446e2257e368763346701f365b61ca786cec06acff2bfcaf0456ff84735f71f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c1864a0ce3e1bce82d6d67f8c82dc6ae58bfbefea45c61702ea940ec74fdd2fe15c00dae94b2f328f1aee0187c9680408b90563a5c030aaa73c7424a6a156a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a5b978d831d5a99326b69d57e37d98f89bb40739cc903808b23cc1eaa870ace048949d012e3c16de010cf230ca8850c9f4e22930adef1c85426f8fba9adb272", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/960b45a69bcbb99c96544ec4770feacfec8143eb54dd7ddefd6791767e4c85d4affcca565aa0138426e4c0969a515c24c553ddb5e584d46e2f9cf43dc62e7a60"} 16:19:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:11 INFO - Contents: 16:19:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79d67a363fc2ec63cb254c2e5029095926da541c0c686efeda3e6dbacdbe1a626446e2257e368763346701f365b61ca786cec06acff2bfcaf0456ff84735f71f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c1864a0ce3e1bce82d6d67f8c82dc6ae58bfbefea45c61702ea940ec74fdd2fe15c00dae94b2f328f1aee0187c9680408b90563a5c030aaa73c7424a6a156a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a5b978d831d5a99326b69d57e37d98f89bb40739cc903808b23cc1eaa870ace048949d012e3c16de010cf230ca8850c9f4e22930adef1c85426f8fba9adb272", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/960b45a69bcbb99c96544ec4770feacfec8143eb54dd7ddefd6791767e4c85d4affcca565aa0138426e4c0969a515c24c553ddb5e584d46e2f9cf43dc62e7a60"} 16:19:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:11 INFO - Copying logs to upload dir... 16:19:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.670122 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-18 16:19:11.339963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:11.344674) ========= 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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79d67a363fc2ec63cb254c2e5029095926da541c0c686efeda3e6dbacdbe1a626446e2257e368763346701f365b61ca786cec06acff2bfcaf0456ff84735f71f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c1864a0ce3e1bce82d6d67f8c82dc6ae58bfbefea45c61702ea940ec74fdd2fe15c00dae94b2f328f1aee0187c9680408b90563a5c030aaa73c7424a6a156a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a5b978d831d5a99326b69d57e37d98f89bb40739cc903808b23cc1eaa870ace048949d012e3c16de010cf230ca8850c9f4e22930adef1c85426f8fba9adb272", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/960b45a69bcbb99c96544ec4770feacfec8143eb54dd7ddefd6791767e4c85d4affcca565aa0138426e4c0969a515c24c553ddb5e584d46e2f9cf43dc62e7a60"} build_url:https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/TRftx86zRh69GCHnj0hY_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/79d67a363fc2ec63cb254c2e5029095926da541c0c686efeda3e6dbacdbe1a626446e2257e368763346701f365b61ca786cec06acff2bfcaf0456ff84735f71f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c1864a0ce3e1bce82d6d67f8c82dc6ae58bfbefea45c61702ea940ec74fdd2fe15c00dae94b2f328f1aee0187c9680408b90563a5c030aaa73c7424a6a156a8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a5b978d831d5a99326b69d57e37d98f89bb40739cc903808b23cc1eaa870ace048949d012e3c16de010cf230ca8850c9f4e22930adef1c85426f8fba9adb272", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/960b45a69bcbb99c96544ec4770feacfec8143eb54dd7ddefd6791767e4c85d4affcca565aa0138426e4c0969a515c24c553ddb5e584d46e2f9cf43dc62e7a60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:11.377138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:11.377495) ========= 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=781b77c4c33858b1f599d705000001c1-1505775463.933694-415083668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:19:11.455141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:11.456486) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:19:11.456779) ========= ========= Total master_lag: 0.26 =========