builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1505731985.16 results: success (0) revision: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.163746) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.164168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.164439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.386350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.386720) ========= 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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 03:53:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 105M=0s 2017-09-18 03:53:05 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168408 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.602005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.605367) ========= 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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020000 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.659772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:05.663098) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 --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 ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 --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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 03:53:05,660 truncating revision to first 12 chars 2017-09-18 03:53:05,660 Setting DEBUG logging. 2017-09-18 03:53:05,660 attempt 1/10 2017-09-18 03:53:05,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ffe6cc09ccf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 03:53:06,214 unpacking tar archive at: mozilla-central-ffe6cc09ccf3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.854852 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:06.534133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:06.534429) ========= script_repo_revision: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:06.534800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:06.539093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 03:53:06.553006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-18 03:53:06.553412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:06 INFO - MultiFileLogger online at 20170918 03:53:06 in /builds/slave/test 03:53:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:53:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:06 INFO - {'append_to_log': False, 03:53:06 INFO - 'base_work_dir': '/builds/slave/test', 03:53:06 INFO - 'blob_upload_branch': 'Firefox', 03:53:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:06 INFO - 'branch': 'Firefox', 03:53:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:06 INFO - 'code_coverage': False, 03:53:06 INFO - 'config_files': ('talos/linux_config.py',), 03:53:06 INFO - 'default_actions': ('clobber', 03:53:06 INFO - 'read-buildbot-config', 03:53:06 INFO - 'download-and-extract', 03:53:06 INFO - 'populate-webroot', 03:53:06 INFO - 'create-virtualenv', 03:53:06 INFO - 'install', 03:53:06 INFO - 'setup-mitmproxy', 03:53:06 INFO - 'run-tests'), 03:53:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:06 INFO - 'disable_ccov_upload': False, 03:53:06 INFO - 'disable_stylo': False, 03:53:06 INFO - 'download_minidump_stackwalk': True, 03:53:06 INFO - 'download_symbols': 'ondemand', 03:53:06 INFO - 'enable_stylo': False, 03:53:06 INFO - 'enable_webrender': False, 03:53:06 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:53:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:06 INFO - 'gecko_profile': False, 03:53:06 INFO - 'gecko_profile_interval': 0, 03:53:06 INFO - 'installer_path': 'installer.exe', 03:53:06 INFO - 'log_level': 'info', 03:53:06 INFO - 'log_name': 'talos', 03:53:06 INFO - 'log_to_console': True, 03:53:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:06 INFO - 'opt_config_files': (), 03:53:06 INFO - 'pip_index': False, 03:53:06 INFO - 'suite': 'dromaeojs-e10s', 03:53:06 INFO - 'system_bits': '32', 03:53:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:06 INFO - 'title': 'talos-linux64-ix-048', 03:53:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:06 INFO - 'use_talos_json': True, 03:53:06 INFO - 'verify': 'False', 03:53:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:06 INFO - 'work_dir': 'build'} 03:53:06 INFO - [mozharness: 2017-09-18 10:53:06.692023Z] Running clobber step. 03:53:06 INFO - Running pre-action listener: _resource_record_pre_action 03:53:06 INFO - Running main action method: clobber 03:53:06 INFO - rmtree: /builds/slave/test/build 03:53:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:07 INFO - Running post-action listener: _resource_record_post_action 03:53:07 INFO - [mozharness: 2017-09-18 10:53:07.681472Z] Finished clobber step (success) 03:53:07 INFO - [mozharness: 2017-09-18 10:53:07.681568Z] Running read-buildbot-config step. 03:53:07 INFO - Running pre-action listener: _resource_record_pre_action 03:53:07 INFO - Running main action method: read_buildbot_config 03:53:07 INFO - Using buildbot properties: 03:53:07 INFO - { 03:53:07 INFO - "project": "", 03:53:07 INFO - "product": "firefox", 03:53:07 INFO - "who": "archaeopteryx@coole-files.de", 03:53:07 INFO - "installer_path": "public/build/target.tar.bz2", 03:53:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:53:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:53:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:53:07 INFO - "stage_platform": "linux64-pgo", 03:53:07 INFO - "basedir": "/builds/slave/test", 03:53:07 INFO - "buildnumber": 177, 03:53:07 INFO - "platform": "ubuntu64_hw", 03:53:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:53:07 INFO - "slavebuilddir": "test", 03:53:07 INFO - "taskId": "VY9f4aSgS0G3z5xpSRCggQ", 03:53:07 INFO - "branch": "mozilla-central", 03:53:07 INFO - "script_repo_revision": "production", 03:53:07 INFO - "revision": "ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71", 03:53:07 INFO - "slavename": "talos-linux64-ix-048", 03:53:07 INFO - "repo_path": "mozilla-central" 03:53:07 INFO - } 03:53:07 INFO - Finding installer, test and symbols from parent task. 03:53:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VY9f4aSgS0G3z5xpSRCggQ'}, attempt #1 03:53:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VY9f4aSgS0G3z5xpSRCggQ'}, attempt #1 03:53:08 INFO - Task dependencies: dezH6ewTQambwBP3-fZqzg 03:53:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg'}, attempt #1 03:53:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 03:53:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.test_packages.json 03:53:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.crashreporter-symbols.zip 03:53:09 INFO - Running post-action listener: _resource_record_post_action 03:53:09 INFO - [mozharness: 2017-09-18 10:53:09.046038Z] Finished read-buildbot-config step (success) 03:53:09 INFO - [mozharness: 2017-09-18 10:53:09.046251Z] Running download-and-extract step. 03:53:09 INFO - Running pre-action listener: _resource_record_pre_action 03:53:09 INFO - Running main action method: download_and_extract 03:53:09 INFO - mkdir: /builds/slave/test/build/tests 03:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:09 INFO - trying https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.test_packages.json 03:53:09 INFO - Downloading https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:53:09 INFO - Downloaded 989 bytes. 03:53:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:53:09 INFO - Using the following test package requirements: 03:53:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:53:09 INFO - u'common': [u'target.common.tests.zip'], 03:53:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:53:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:53:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:53:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:53:09 INFO - u'mozbase': [u'target.common.tests.zip'], 03:53:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:53:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:53:09 INFO - u'web-platform': [u'target.common.tests.zip', 03:53:09 INFO - u'target.web-platform.tests.tar.gz'], 03:53:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:53:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:53:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.common.tests.zip 03:53:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:09 INFO - Fetch https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.common.tests.zip into memory 03:53:12 INFO - Content-Length response header: 55318338 03:53:12 INFO - Bytes received: 55318338 03:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.talos.tests.zip 03:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.talos.tests.zip into memory 03:53:24 INFO - Content-Length response header: 14508748 03:53:24 INFO - Bytes received: 14508748 03:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:24 INFO - trying https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 03:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:26 INFO - Downloaded 62242364 bytes. 03:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 03:53:26 INFO - mkdir: /builds/slave/test/properties 03:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:26 INFO - Contents: 03:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 03:53:26 INFO - Running post-action listener: _resource_record_post_action 03:53:26 INFO - Running post-action listener: find_tests_for_verification 03:53:26 INFO - Running post-action listener: set_extra_try_arguments 03:53:26 INFO - [mozharness: 2017-09-18 10:53:26.958594Z] Finished download-and-extract step (success) 03:53:26 INFO - [mozharness: 2017-09-18 10:53:26.958708Z] Running populate-webroot step. 03:53:26 INFO - Running pre-action listener: _resource_record_pre_action 03:53:26 INFO - Running main action method: populate_webroot 03:53:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:26 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tresize', 03:53:26 INFO - 'tcanvasmark']}, 03:53:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:26 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['dromaeo_css', 03:53:26 INFO - 'kraken']}, 03:53:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:26 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['damp', 'tps']}, 03:53:26 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['damp', 'tps']}, 03:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:26 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['dromaeo_dom']}, 03:53:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:26 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['basic_compositor_video', 03:53:26 INFO - 'glvideo']}, 03:53:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:53:26 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['ts_paint_webext', 03:53:26 INFO - 'tp5o_webext']}, 03:53:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:26 INFO - 'ts_paint', 03:53:26 INFO - 'tpaint', 03:53:26 INFO - 'sessionrestore', 03:53:26 INFO - 'sessionrestore_many_windows', 03:53:26 INFO - 'sessionrestore_no_auto_restore', 03:53:26 INFO - 'tabpaint']}, 03:53:26 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['a11yr', 03:53:26 INFO - 'ts_paint', 03:53:26 INFO - 'tpaint', 03:53:26 INFO - 'sessionrestore', 03:53:26 INFO - 'sessionrestore_many_windows', 03:53:26 INFO - 'sessionrestore_no_auto_restore', 03:53:26 INFO - 'tabpaint']}, 03:53:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:53:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:53:26 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['perf_reftest_singletons']}, 03:53:26 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['bloom_basic']}, 03:53:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:26 INFO - 'tsvgr_opacity', 03:53:26 INFO - 'tart', 03:53:26 INFO - 'tscrollx', 03:53:26 INFO - 'tsvg_static']}, 03:53:26 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tsvgx', 03:53:26 INFO - 'tsvgr_opacity', 03:53:26 INFO - 'tart', 03:53:26 INFO - 'tscrollx', 03:53:26 INFO - 'tsvg_static']}, 03:53:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:26 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo'], 03:53:26 INFO - 'tests': ['tp5o']}, 03:53:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo', 03:53:26 INFO - '--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:26 INFO - 'talos_options': ['--stylo-threads=1', 03:53:26 INFO - '--mitmproxy', 03:53:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:26 INFO - '--firstNonBlankPaint'], 03:53:26 INFO - 'tests': ['tp6_google', 03:53:26 INFO - 'tp6_youtube', 03:53:26 INFO - 'tp6_amazon', 03:53:26 INFO - 'tp6_facebook']}, 03:53:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--xperf_path', 03:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:26 INFO - 'tests': ['tp5n']}, 03:53:26 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:53:26 INFO - 'talos_options': ['--disable-stylo', 03:53:26 INFO - '--xperf_path', 03:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:26 INFO - 'tests': ['tp5n']}}} 03:53:26 INFO - Running post-action listener: _resource_record_post_action 03:53:26 INFO - [mozharness: 2017-09-18 10:53:26.978139Z] Finished populate-webroot step (success) 03:53:26 INFO - [mozharness: 2017-09-18 10:53:26.978228Z] Running create-virtualenv step. 03:53:26 INFO - Running pre-action listener: _resource_record_pre_action 03:53:26 INFO - Running main action method: create_virtualenv 03:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:26 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:53:26 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:53:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:28 INFO - Installing pip...............done. 03:53:28 INFO - Return code: 0 03:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:28 INFO - Reading from file tmpfile_stdout 03:53:28 INFO - Output received: 03:53:28 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53: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')]} 03:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53: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')]} 03:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:28 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:28 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 03:53:28 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 03:53:28 INFO - Using env: {'DISPLAY': ':0', 03:53:28 INFO - 'HOME': '/home/cltbld', 03:53:28 INFO - 'LANG': 'en_US.UTF-8', 03:53:28 INFO - 'LANGUAGE': 'en_US:en', 03:53:28 INFO - 'LOGNAME': 'cltbld', 03:53:28 INFO - 'MAIL': '/var/mail/cltbld', 03:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:28 INFO - 'MOZ_NO_REMOTE': '1', 03:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:28 INFO - 'NO_EM_RESTART': '1', 03:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:28 INFO - 'PWD': '/builds/slave/test', 03:53:28 INFO - 'SHELL': '/bin/bash', 03:53:28 INFO - 'SHLVL': '1', 03:53:28 INFO - 'TERM': 'linux', 03:53:28 INFO - 'TMOUT': '86400', 03:53:28 INFO - 'USER': 'cltbld', 03:53:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:28 INFO - '_': '/tools/buildbot/bin/python'} 03:53:29 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:53:29 INFO - Downloading/unpacking pip>=1.5 03:53:29 INFO - Running setup.py egg_info for package pip 03:53:29 INFO - warning: no files found matching 'pip/cacert.pem' 03:53:29 INFO - warning: no files found matching '*.html' under directory 'docs' 03:53:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:53:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:53:29 INFO - Installing collected packages: pip 03:53:29 INFO - Found existing installation: pip 1.1 03:53:29 INFO - Uninstalling pip: 03:53:29 INFO - Successfully uninstalled pip 03:53:29 INFO - Running setup.py install for pip 03:53:29 INFO - warning: no files found matching 'pip/cacert.pem' 03:53:29 INFO - warning: no files found matching '*.html' under directory 'docs' 03:53:29 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:53:29 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:53:29 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:53:29 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:53:29 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:53:29 INFO - Successfully installed pip 03:53:29 INFO - Cleaning up... 03:53:29 INFO - Return code: 0 03:53:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:29 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:29 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 03:53:29 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 03:53:29 INFO - Using env: {'DISPLAY': ':0', 03:53:29 INFO - 'HOME': '/home/cltbld', 03:53:29 INFO - 'LANG': 'en_US.UTF-8', 03:53:29 INFO - 'LANGUAGE': 'en_US:en', 03:53:29 INFO - 'LOGNAME': 'cltbld', 03:53:29 INFO - 'MAIL': '/var/mail/cltbld', 03:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:29 INFO - 'MOZ_NO_REMOTE': '1', 03:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:29 INFO - 'NO_EM_RESTART': '1', 03:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:29 INFO - 'PWD': '/builds/slave/test', 03:53:29 INFO - 'SHELL': '/bin/bash', 03:53:29 INFO - 'SHLVL': '1', 03:53:29 INFO - 'TERM': 'linux', 03:53:29 INFO - 'TMOUT': '86400', 03:53:29 INFO - 'USER': 'cltbld', 03:53:29 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:29 INFO - '_': '/tools/buildbot/bin/python'} 03:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:29 INFO - Downloading/unpacking psutil>=3.1.1 03:53:29 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 03:53:29 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 03:53:29 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 03:53:29 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 03:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:30 INFO - Installing collected packages: psutil 03:53:30 INFO - Running setup.py install for psutil 03:53:30 INFO - building 'psutil._psutil_linux' extension 03:53:30 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 03:53:31 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 03:53:31 INFO - building 'psutil._psutil_posix' extension 03:53:31 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 03:53:31 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 03:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:31 INFO - Successfully installed psutil 03:53:31 INFO - Cleaning up... 03:53:31 INFO - Return code: 0 03:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:31 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')]} 03:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:31 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')]} 03:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:31 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:31 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 03:53:31 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 03:53:31 INFO - Using env: {'DISPLAY': ':0', 03:53:31 INFO - 'HOME': '/home/cltbld', 03:53:31 INFO - 'LANG': 'en_US.UTF-8', 03:53:31 INFO - 'LANGUAGE': 'en_US:en', 03:53:31 INFO - 'LOGNAME': 'cltbld', 03:53:31 INFO - 'MAIL': '/var/mail/cltbld', 03:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:31 INFO - 'MOZ_NO_REMOTE': '1', 03:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:31 INFO - 'NO_EM_RESTART': '1', 03:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:31 INFO - 'PWD': '/builds/slave/test', 03:53:31 INFO - 'SHELL': '/bin/bash', 03:53:31 INFO - 'SHLVL': '1', 03:53:31 INFO - 'TERM': 'linux', 03:53:31 INFO - 'TMOUT': '86400', 03:53:31 INFO - 'USER': 'cltbld', 03:53:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:31 INFO - '_': '/tools/buildbot/bin/python'} 03:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:31 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 03:53:31 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 03:53:31 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 03:53:31 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 03:53:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:32 INFO - Installing collected packages: mozsystemmonitor 03:53:32 INFO - Running setup.py install for mozsystemmonitor 03:53:33 INFO - Successfully installed mozsystemmonitor 03:53:33 INFO - Cleaning up... 03:53:33 INFO - Return code: 0 03:53:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:33 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:33 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 03:53:33 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 03:53:33 INFO - Using env: {'DISPLAY': ':0', 03:53:33 INFO - 'HOME': '/home/cltbld', 03:53:33 INFO - 'LANG': 'en_US.UTF-8', 03:53:33 INFO - 'LANGUAGE': 'en_US:en', 03:53:33 INFO - 'LOGNAME': 'cltbld', 03:53:33 INFO - 'MAIL': '/var/mail/cltbld', 03:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:33 INFO - 'MOZ_NO_REMOTE': '1', 03:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:33 INFO - 'NO_EM_RESTART': '1', 03:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:33 INFO - 'PWD': '/builds/slave/test', 03:53:33 INFO - 'SHELL': '/bin/bash', 03:53:33 INFO - 'SHLVL': '1', 03:53:33 INFO - 'TERM': 'linux', 03:53:33 INFO - 'TMOUT': '86400', 03:53:33 INFO - 'USER': 'cltbld', 03:53:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:33 INFO - '_': '/tools/buildbot/bin/python'} 03:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:35 INFO - warning: no files found matching '*.txt' 03:53:35 INFO - no previously-included directories found matching 'build' 03:53:35 INFO - no previously-included directories found matching 'dist' 03:53:35 INFO - no previously-included directories found matching '.git*' 03:53:35 INFO - Installing collected packages: jsonschema, functools32 03:53:35 INFO - Running setup.py install for functools32 03:53:36 INFO - warning: no files found matching '*.txt' 03:53:36 INFO - no previously-included directories found matching 'build' 03:53:36 INFO - no previously-included directories found matching 'dist' 03:53:36 INFO - no previously-included directories found matching '.git*' 03:53:36 INFO - Successfully installed jsonschema functools32 03:53:36 INFO - Cleaning up... 03:53:36 INFO - Return code: 0 03:53:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:53:36 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')]} 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:36 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')]} 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:36 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:36 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 03:53:36 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 03:53:36 INFO - Using env: {'DISPLAY': ':0', 03:53:36 INFO - 'HOME': '/home/cltbld', 03:53:36 INFO - 'LANG': 'en_US.UTF-8', 03:53:36 INFO - 'LANGUAGE': 'en_US:en', 03:53:36 INFO - 'LOGNAME': 'cltbld', 03:53:36 INFO - 'MAIL': '/var/mail/cltbld', 03:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:36 INFO - 'MOZ_NO_REMOTE': '1', 03:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:36 INFO - 'NO_EM_RESTART': '1', 03:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:36 INFO - 'PWD': '/builds/slave/test', 03:53:36 INFO - 'SHELL': '/bin/bash', 03:53:36 INFO - 'SHLVL': '1', 03:53:36 INFO - 'TERM': 'linux', 03:53:36 INFO - 'TMOUT': '86400', 03:53:36 INFO - 'USER': 'cltbld', 03:53:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:36 INFO - '_': '/tools/buildbot/bin/python'} 03:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:53:36 INFO - Cleaning up... 03:53:36 INFO - Return code: 0 03:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53:36 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')]} 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:36 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')]} 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:36 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:36 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 03:53:36 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 03:53:36 INFO - Using env: {'DISPLAY': ':0', 03:53:36 INFO - 'HOME': '/home/cltbld', 03:53:36 INFO - 'LANG': 'en_US.UTF-8', 03:53:36 INFO - 'LANGUAGE': 'en_US:en', 03:53:36 INFO - 'LOGNAME': 'cltbld', 03:53:36 INFO - 'MAIL': '/var/mail/cltbld', 03:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:36 INFO - 'MOZ_NO_REMOTE': '1', 03:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:36 INFO - 'NO_EM_RESTART': '1', 03:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:36 INFO - 'PWD': '/builds/slave/test', 03:53:36 INFO - 'SHELL': '/bin/bash', 03:53:36 INFO - 'SHLVL': '1', 03:53:36 INFO - 'TERM': 'linux', 03:53:36 INFO - 'TMOUT': '86400', 03:53:36 INFO - 'USER': 'cltbld', 03:53:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:36 INFO - '_': '/tools/buildbot/bin/python'} 03:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:36 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 03:53:36 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 03:53:36 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 03:53:36 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 03:53:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:38 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 03:53:38 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 03:53:38 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 03:53:38 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 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:38 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 03:53:38 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 03:53:38 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 03:53:38 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 03:53:38 INFO - Downloading docopt-0.6.1.tar.gz 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:38 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:38 INFO - Running setup.py install for blobuploader 03:53:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:38 INFO - Running setup.py install for requests 03:53:39 INFO - Running setup.py install for docopt 03:53:39 INFO - Successfully installed blobuploader requests docopt 03:53:39 INFO - Cleaning up... 03:53:39 INFO - Return code: 0 03:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:39 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:39 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 03:53:39 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 03:53:39 INFO - Using env: {'DISPLAY': ':0', 03:53:39 INFO - 'HOME': '/home/cltbld', 03:53:39 INFO - 'LANG': 'en_US.UTF-8', 03:53:39 INFO - 'LANGUAGE': 'en_US:en', 03:53:39 INFO - 'LOGNAME': 'cltbld', 03:53:39 INFO - 'MAIL': '/var/mail/cltbld', 03:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:39 INFO - 'MOZ_NO_REMOTE': '1', 03:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:39 INFO - 'NO_EM_RESTART': '1', 03:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:39 INFO - 'PWD': '/builds/slave/test', 03:53:39 INFO - 'SHELL': '/bin/bash', 03:53:39 INFO - 'SHLVL': '1', 03:53:39 INFO - 'TERM': 'linux', 03:53:39 INFO - 'TMOUT': '86400', 03:53:39 INFO - 'USER': 'cltbld', 03:53:39 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:39 INFO - '_': '/tools/buildbot/bin/python'} 03:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Running setup.py (path:/tmp/pip-KjdyX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Running setup.py (path:/tmp/pip-WZtywn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:39 INFO - Running setup.py (path:/tmp/pip-YLZ6ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:39 INFO - Running setup.py (path:/tmp/pip-_2Qxw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:39 INFO - Running setup.py (path:/tmp/pip-BNNY0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:39 INFO - Running setup.py (path:/tmp/pip-njlxC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:39 INFO - Running setup.py (path:/tmp/pip-EJfdFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:39 INFO - Running setup.py (path:/tmp/pip-2k7Uer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:39 INFO - Running setup.py (path:/tmp/pip-gNC1Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:40 INFO - Running setup.py (path:/tmp/pip-FmXDYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Running setup.py (path:/tmp/pip-fDCINh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Running setup.py (path:/tmp/pip-3i00cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Running setup.py (path:/tmp/pip-e7USdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Running setup.py (path:/tmp/pip-jysSgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Running setup.py (path:/tmp/pip-JP_Wvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Running setup.py (path:/tmp/pip-gWy5xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:40 INFO - Running setup.py (path:/tmp/pip-sfkbYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:40 INFO - Running setup.py install for manifestparser 03:53:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozcrash 03:53:40 INFO - Running setup.py install for mozdebug 03:53:40 INFO - Running setup.py install for mozdevice 03:53:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozfile 03:53:41 INFO - Running setup.py install for mozhttpd 03:53:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozinfo 03:53:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozInstall 03:53:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozleak 03:53:41 INFO - Running setup.py install for mozlog 03:53:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for moznetwork 03:53:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozprocess 03:53:41 INFO - Running setup.py install for mozprofile 03:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozrunner 03:53:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Running setup.py install for mozscreenshot 03:53:42 INFO - Running setup.py install for moztest 03:53:42 INFO - Running setup.py install for mozversion 03:53:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:42 INFO - Cleaning up... 03:53:42 INFO - Return code: 0 03:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:42 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:42 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 03:53:42 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 03:53:42 INFO - Using env: {'DISPLAY': ':0', 03:53:42 INFO - 'HOME': '/home/cltbld', 03:53:42 INFO - 'LANG': 'en_US.UTF-8', 03:53:42 INFO - 'LANGUAGE': 'en_US:en', 03:53:42 INFO - 'LOGNAME': 'cltbld', 03:53:42 INFO - 'MAIL': '/var/mail/cltbld', 03:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:42 INFO - 'MOZ_NO_REMOTE': '1', 03:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:42 INFO - 'NO_EM_RESTART': '1', 03:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:42 INFO - 'PWD': '/builds/slave/test', 03:53:42 INFO - 'SHELL': '/bin/bash', 03:53:42 INFO - 'SHLVL': '1', 03:53:42 INFO - 'TERM': 'linux', 03:53:42 INFO - 'TMOUT': '86400', 03:53:42 INFO - 'USER': 'cltbld', 03:53:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:42 INFO - '_': '/tools/buildbot/bin/python'} 03:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:42 INFO - Running setup.py (path:/tmp/pip-EMI1xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:42 INFO - Running setup.py (path:/tmp/pip-qiiZb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:42 INFO - Running setup.py (path:/tmp/pip-o9q0YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:42 INFO - Running setup.py (path:/tmp/pip-r4eMPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:42 INFO - Running setup.py (path:/tmp/pip-mWvbMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:42 INFO - Running setup.py (path:/tmp/pip-v1nm4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:43 INFO - Running setup.py (path:/tmp/pip-NPh5Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 INFO - Running setup.py (path:/tmp/pip-kd0d8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:43 INFO - Running setup.py (path:/tmp/pip-6eSXC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:43 INFO - Running setup.py (path:/tmp/pip-89KkdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 INFO - Running setup.py (path:/tmp/pip-vHopqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 INFO - Running setup.py (path:/tmp/pip-jlKjEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:43 INFO - Running setup.py (path:/tmp/pip-yz18As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:43 INFO - Running setup.py (path:/tmp/pip-JFk41g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:43 INFO - Running setup.py (path:/tmp/pip-4Ihj4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:43 INFO - Running setup.py (path:/tmp/pip-OQGCr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:43 INFO - Running setup.py (path:/tmp/pip-XBDrH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53:43 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 03:53:43 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 03:53:43 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 03:53:43 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 03:53:44 INFO - Downloading blessings-1.6.tar.gz 03:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:44 INFO - Installing collected packages: blessings 03:53:44 INFO - Running setup.py install for blessings 03:53:45 INFO - Successfully installed blessings 03:53:45 INFO - Cleaning up... 03:53:45 INFO - Return code: 0 03:53:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:45 INFO - Reading from file tmpfile_stdout 03:53:45 INFO - Current package versions: 03:53:45 INFO - argparse == 1.2.1 03:53:45 INFO - blessings == 1.6 03:53:45 INFO - blobuploader == 1.2.4 03:53:45 INFO - docopt == 0.6.1 03:53:45 INFO - functools32 == 3.2.3-2 03:53:45 INFO - jsonschema == 2.5.1 03:53:45 INFO - manifestparser == 1.1 03:53:45 INFO - mozInstall == 1.13 03:53:45 INFO - mozcrash == 1.0 03:53:45 INFO - mozdebug == 0.1 03:53:45 INFO - mozdevice == 0.51 03:53:45 INFO - mozfile == 1.2 03:53:45 INFO - mozhttpd == 0.7 03:53:45 INFO - mozinfo == 0.10 03:53:45 INFO - mozleak == 0.1 03:53:45 INFO - mozlog == 3.5 03:53:45 INFO - moznetwork == 0.27 03:53:45 INFO - mozprocess == 0.25 03:53:45 INFO - mozprofile == 0.28 03:53:45 INFO - mozrunner == 6.13 03:53:45 INFO - mozscreenshot == 0.1 03:53:45 INFO - mozsystemmonitor == 0.3 03:53:45 INFO - moztest == 0.8 03:53:45 INFO - mozversion == 1.4 03:53:45 INFO - psutil == 3.1.1 03:53:45 INFO - requests == 1.2.3 03:53:45 INFO - wsgiref == 0.1.2 03:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:45 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')]} 03:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:45 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')]} 03:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:45 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 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:45 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 03:53:45 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 03:53:45 INFO - Using env: {'DISPLAY': ':0', 03:53:45 INFO - 'HOME': '/home/cltbld', 03:53:45 INFO - 'LANG': 'en_US.UTF-8', 03:53:45 INFO - 'LANGUAGE': 'en_US:en', 03:53:45 INFO - 'LOGNAME': 'cltbld', 03:53:45 INFO - 'MAIL': '/var/mail/cltbld', 03:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:45 INFO - 'MOZ_NO_REMOTE': '1', 03:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:45 INFO - 'NO_EM_RESTART': '1', 03:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:45 INFO - 'PWD': '/builds/slave/test', 03:53:45 INFO - 'SHELL': '/bin/bash', 03:53:45 INFO - 'SHLVL': '1', 03:53:45 INFO - 'TERM': 'linux', 03:53:45 INFO - 'TMOUT': '86400', 03:53:45 INFO - 'USER': 'cltbld', 03:53:45 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:45 INFO - '_': '/tools/buildbot/bin/python'} 03:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:53:45 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 03:53:45 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 03:53:45 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 03:53:45 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 03:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:53:46 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)) 03:53:46 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)) 03:53:46 INFO - Installing collected packages: simplejson 03:53:46 INFO - Running setup.py install for simplejson 03:53:46 INFO - building 'simplejson._speedups' extension 03:53:46 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 03:53:47 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 03:53:47 INFO - Successfully installed simplejson 03:53:47 INFO - Cleaning up... 03:53:47 INFO - Return code: 0 03:53:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd751f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, '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': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', '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 03:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:53:47 INFO - Using env: {'DISPLAY': ':0', 03:53:47 INFO - 'HOME': '/home/cltbld', 03:53:47 INFO - 'LANG': 'en_US.UTF-8', 03:53:47 INFO - 'LANGUAGE': 'en_US:en', 03:53:47 INFO - 'LOGNAME': 'cltbld', 03:53:47 INFO - 'MAIL': '/var/mail/cltbld', 03:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:47 INFO - 'MOZ_NO_REMOTE': '1', 03:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:47 INFO - 'NO_EM_RESTART': '1', 03:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:47 INFO - 'PWD': '/builds/slave/test', 03:53:47 INFO - 'SHELL': '/bin/bash', 03:53:47 INFO - 'SHLVL': '1', 03:53:47 INFO - 'TERM': 'linux', 03:53:47 INFO - 'TMOUT': '86400', 03:53:47 INFO - 'USER': 'cltbld', 03:53:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:47 INFO - '_': '/tools/buildbot/bin/python'} 03:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:48 INFO - Cleaning up... 03:53:48 INFO - Return code: 0 03:53:48 INFO - Running post-action listener: _resource_record_post_action 03:53:48 INFO - Running post-action listener: _start_resource_monitoring 03:53:48 INFO - Starting resource monitoring. 03:53:48 INFO - [mozharness: 2017-09-18 10:53:48.108711Z] Finished create-virtualenv step (success) 03:53:48 INFO - [mozharness: 2017-09-18 10:53:48.109216Z] Running install step. 03:53:48 INFO - Running pre-action listener: _resource_record_pre_action 03:53:48 INFO - Running main action method: install 03:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:48 INFO - Reading from file tmpfile_stdout 03:53:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:48 INFO - Reading from file tmpfile_stdout 03:53:48 INFO - Output received: 03:53:48 INFO - Usage: mozinstall [options] installer 03:53:48 INFO - Options: 03:53:48 INFO - -h, --help show this help message and exit 03:53:48 INFO - -d DEST, --destination=DEST 03:53:48 INFO - Directory to install application into. [default: 03:53:48 INFO - "/builds/slave/test"] 03:53:48 INFO - --app=APP Application being installed. [default: firefox] 03:53:48 INFO - mkdir: /builds/slave/test/build/application 03:53:48 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'] 03:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:54:06 INFO - Reading from file tmpfile_stdout 03:54:06 INFO - Output received: 03:54:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:06 INFO - Running post-action listener: _resource_record_post_action 03:54:06 INFO - [mozharness: 2017-09-18 10:54:06.364649Z] Finished install step (success) 03:54:06 INFO - [mozharness: 2017-09-18 10:54:06.364901Z] Running setup-mitmproxy step. 03:54:06 INFO - Running pre-action listener: _resource_record_pre_action 03:54:06 INFO - Running main action method: setup_mitmproxy 03:54:06 INFO - Skipping: mitmproxy is not required 03:54:06 INFO - Running post-action listener: _resource_record_post_action 03:54:06 INFO - [mozharness: 2017-09-18 10:54:06.366022Z] Finished setup-mitmproxy step (success) 03:54:06 INFO - [mozharness: 2017-09-18 10:54:06.366240Z] Running run-tests step. 03:54:06 INFO - Running pre-action listener: _resource_record_pre_action 03:54:06 INFO - Running pre-action listener: _set_gcov_prefix 03:54:06 INFO - Running main action method: run_tests 03:54:06 WARNING - Try message not found. 03:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:06 INFO - Python 2.7.3 03:54:06 INFO - Return code: 0 03:54:06 INFO - grabbing minidump binary from tooltool 03:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:06 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 0x10e5090>, '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 0x10e5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:06 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 03:54:06 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 03:54:06 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 03:54:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:06 INFO - Return code: 0 03:54:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:06 INFO - ENV: RUST_BACKTRACE is now full 03:54:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 03:54:06 INFO - Using env: {'DISPLAY': ':0', 03:54:06 INFO - 'HOME': '/home/cltbld', 03:54:06 INFO - 'LANG': 'en_US.UTF-8', 03:54:06 INFO - 'LANGUAGE': 'en_US:en', 03:54:06 INFO - 'LOGNAME': 'cltbld', 03:54:06 INFO - 'MAIL': '/var/mail/cltbld', 03:54:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:06 INFO - 'MOZ_NO_REMOTE': '1', 03:54:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:06 INFO - 'NO_EM_RESTART': '1', 03:54:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:06 INFO - 'PWD': '/builds/slave/test', 03:54:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:06 INFO - 'RUST_BACKTRACE': 'full', 03:54:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:06 INFO - 'SHELL': '/bin/bash', 03:54:06 INFO - 'SHLVL': '1', 03:54:06 INFO - 'TERM': 'linux', 03:54:06 INFO - 'TMOUT': '86400', 03:54:06 INFO - 'USER': 'cltbld', 03:54:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:06 INFO - '_': '/tools/buildbot/bin/python'} 03:54:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 03:54:06 INFO - mozversion application_buildid: 20170918093516 03:54:06 INFO - mozversion application_changeset: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 03:54:06 INFO - mozversion application_display_name: Nightly 03:54:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:06 INFO - mozversion application_name: Firefox 03:54:06 INFO - mozversion application_remotingname: firefox 03:54:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:06 INFO - mozversion application_vendor: Mozilla 03:54:06 INFO - mozversion application_version: 57.0a1 03:54:06 INFO - mozversion platform_buildid: 20170918093516 03:54:06 INFO - mozversion platform_changeset: ffe6cc09ccf38cca6f0e727837bbc6cb722d1e71 03:54:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:06 INFO - mozversion platform_version: 57.0a1 03:54:06 INFO - using testdate: 1505732046 03:54:06 INFO - actual date: 1505732046 03:54:06 INFO - starting webserver on 'localhost:37826' 03:54:06 INFO - SUITE-START | Running 2 tests 03:54:06 INFO - TEST-START | dromaeo_css 03:54:06 INFO - Initialising browser for dromaeo_css test... 03:54:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37826/getInfo.html -profile /tmp/tmpmtwMyC/profile 03:54:06 INFO - TEST-INFO | started process 13293 (/builds/slave/test/build/application/firefox/firefox http://localhost:37826/getInfo.html) 03:54:12 INFO - TEST-INFO | 13293: exit 0 03:54:12 INFO - Browser initialized. 03:54:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:12 INFO - Using env: {'DISPLAY': ':0', 03:54:12 INFO - 'HOME': '/home/cltbld', 03:54:12 INFO - 'JSGC_DISABLE_POISONING': '1', 03:54:12 INFO - 'LANG': 'en_US.UTF-8', 03:54:12 INFO - 'LANGUAGE': 'en_US:en', 03:54:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:54:12 INFO - 'LOGNAME': 'cltbld', 03:54:12 INFO - 'MAIL': '/var/mail/cltbld', 03:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:12 INFO - 'MOZ_CRASHREPORTER': '1', 03:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:54:12 INFO - 'MOZ_NO_REMOTE': '1', 03:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:12 INFO - 'NO_EM_RESTART': '1', 03:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:12 INFO - 'PWD': '/builds/slave/test', 03:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:12 INFO - 'RUST_BACKTRACE': 'full', 03:54:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:12 INFO - 'SHELL': '/bin/bash', 03:54:12 INFO - 'SHLVL': '1', 03:54:12 INFO - 'TERM': 'linux', 03:54:12 INFO - 'TMOUT': '86400', 03:54:12 INFO - 'USER': 'cltbld', 03:54:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 03:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:12 INFO - '_': '/tools/buildbot/bin/python'} 03:54:12 INFO - TEST-INFO | started process 13534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtwMyC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:13 INFO - PID 13534 | 03:54:13 INFO - PID 13534 | (/builds/slave/test/build/application/firefox/firefox:13583): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:13 INFO - PID 13534 | 03:54:23 INFO - PID 13534 | RSS: Main: 147836928 03:54:23 INFO - PID 13534 | 03:57:20 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37826/tests/dromaeo/cssquery-ext.html) 03:57:21 INFO - PID 13534 | RSS: Main: 149123072 03:57:21 INFO - PID 13534 | 04:00:23 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-ext.html (next: http://localhost:37826/tests/dromaeo/cssquery-jquery.html) 04:00:23 INFO - PID 13534 | RSS: Main: 147722240 04:00:23 INFO - PID 13534 | 04:03:25 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37826/tests/dromaeo/cssquery-mootools.html) 04:03:25 INFO - PID 13534 | RSS: Main: 150773760 04:03:25 INFO - PID 13534 | 04:06:27 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37826/tests/dromaeo/cssquery-prototype.html) 04:06:28 INFO - PID 13534 | RSS: Main: 149499904 04:06:28 INFO - PID 13534 | 04:09:31 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37826/tests/dromaeo/cssquery-yui.html) 04:09:31 INFO - PID 13534 | RSS: Main: 150749184 04:09:31 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | Cycle 1(1): loaded http://localhost:37826/tests/dromaeo/cssquery-yui.html (next: http://localhost:37826/tests/dromaeo/cssquery-dojo.html) 04:12:33 INFO - PID 13534 | RSS: Main: 153198592 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | __start_tp_report 04:12:33 INFO - PID 13534 | _x_x_mozilla_page_load 04:12:33 INFO - PID 13534 | _x_x_mozilla_page_load_details 04:12:33 INFO - PID 13534 | |i|pagename|runs| 04:12:33 INFO - PID 13534 | |0;dojo.html;3805.8477660893564;3906.9023274418155;3910.804459777012;3912.4913761211037;3920.411938209269;6215.316315205335;6317.77887773928;6352.650604216767;6378.075179099028;6411.326810684881;6261.7182226799905;6296.559240853142;6334.968325158367;6336.303006669263;6400.103985442041;5618.887622247573;5727.770889164449;5756.079027355624;5767.5962682612235;5782.24830771999;186.89648011629117;5638.774449022034;5651.604387692863;5729.570282228829;5744.655320680772;5630.183623374588;5633.464820842013;5712.971435142839;5714.228579141804;5714.857128571777;5576.581756368248;5623.493885550321;5682.914756278659;5693.857653558653;5721.113227449752;5592.748326325284;5624.859378515529;5704.77180912763;5705.4579814917515;5724.112762521816;6222.968885155546;6253.187085678878;6277.560570760049;6282.560220784547;6318.368163183645;6750.514886724913;6753.696083676246;6784.7964561063245;6883.346082122191;6885.621290829003;6763.492738044617;6885.449164066863;6889.655517224119;6918.688659010306;6976.023356730062;6389.105525226472;6422.807315780534;6425.261094974091;6432.163818703585;6444.323346048691;7019.017337572744;7020.438364930793;7115.750948716874;7119.932010198511;7123.679434425359;6646.6676666166495;6752.122224110834;6766.526343156031;6832.350926661959;6841.144856892888;6734.932650673529;6801.42187914023;6813.0121132435515;6814.693338799766;6821.010953411727;6773.93226067733;6844.2129155147795;6845.623490708059;6846.520743548003;6851.862962740717;6726.3609957054005;6762.797116086525;6766.763163289262;6801.557898736566;6883.518153729191;4905.607551395879;4942.728149951788;4943.604511639061;4949.678270912379;4967.726775027409;4452.888677783081;4475.731456112644;4521.59305662492;4525.117602067565;4526.049529598821;6134.079888016833;6229.844253893689;6264.185655864709;6294.402031806971;6329.240491141;6865.759698410531;6875.278095799969;6913.446924246149;6913.481488888354;6915.654217289115;6233.158523599347;6234.314225435199;6300.558960872787;6325.462335701517;6331.176946996861;5415.83752487426;5496.065668836308;5497.945020549823;5560.110382338807;5576.553875689935;7054.435645148375;7110.4667149962925;7119.857602847914;7122.5726456412785;7140.107486564179;6686.933130668631;6696.665166741546;6720;6773.966130169416;6784.253732089367;6946.8610627788175;6947.826304342432;7047.295270472911;7060.752873649398;7102.964485177541;6548.1814773153355;6776.390124888783;6776.661166941732;6835.58986460814;6847.383735463832;6845.623490708059;6874.450043996569;6885.965570172117;6944.131983502062;6974;6533.575317604341;6587.703553340016;6632.204135503771;6649.667516624246;6672.599644021374;6606.570572912745;6673;6677.232118306457;6678.065070890177;6699.263081061177;6522.249941256816;6526.282108968105;6587.736490540325;6593.439557637655;6597.736090556324;6550.934490655032;6624.403803657694;6697;6701.66491675424;6726.192856857208;6348.111264422892;6387.329330420424;6504.544681872224;6506.544541882212;6511.38141876521 04:12:33 INFO - PID 13534 | |1;ext.html;929.1498279074647;957.640884668249;963.9518024098793;995.5022488755623;999.1058003087237;42403.363949540784;43981;44192.77903610482;44313;44399;40784.79607601965;41020.58979410205;41068.99999999993;41094;41175;7169.318914703108;7225;7234.095738032746;7237.782866513987;7238.384737297336;7078.893816592756;7085.114360704912;7095.254998225189;7095.432365410755;7113.573185608854;7087.326703963141;7103.786886393391;8107.432479726392;8214.548199849007;8260.215279548464;8119;8182.631781569814;8202.425830191889;8207.671693132268;8212.219839115274;8098.51408915467;8143.226393492609;8145.877811832827;8149.307308878752;8151.918480815175;39679.801600991814;39968;40145.79927100346;40184.19631607352;40304.395434068516;3717.9070523237137;3721.348763966322;3758.906027349311;3762.6613604775703;3771.830267637963;33314.500282495785;33390.49914251288;33498.497522536934;33567.3286534268;33665.6633433665;5418.566514678816;5491.615586908918;5497.120460726264;5522.254495643077;5536.390996990328;216898;216932;218035;218186;218807.9999999984;51812;51964.740176298874;51977.48022519802;51977.7401112992;52020.479795201565;54417.72791136019;54419.45580544223;54531.72734136304;54662.18006729902;54665.1800222997;16421.343146274015;16862.24119914607;16862.57843553921;16878.57803554921;16897;13893.722125557431;13904.304784760721;13939.860601393857;13946.232957187452;13950.581482555539;15176.544703658908;15311.61720956985;15514.9224253878;15564.84435155634;15652;5872.941270587325;6100.511959043266;6139.109829074849;6256.249250089927;6280.842978925472;1051.4847724614883;1080.8811030786608;1082.101855459982;1090.095220966596;1109.1293334732197;25228.495430091294;25461.236162915142;25641.61537576938;25757.3560660985;25812.612810807852;1190.3036723516666;1190.3215167354524;1193.4927655746274;1209.8548174218975;1218.147296892179;13199.358993500377;13485.393157307944;13592.728145437035;13680.110792798436;13766;264273;264738;265895;265991;266445;55747.442525574224;60557;60872.69563652154;61397.07904381438;61554.0766888497;1504.4659146003012;1508.781226722119;1523.223156190351;1524.1997951075773;1548.2955255358784;29803;30171.245718857204;30233;30384.84807575948;30515;40572.1885562293;40858.79570602128;40887.795561022;40892.1821563573;40932.79533602432;255191;256570;256793;257849;257896;37130.257394852495;37314.44028339631;37624.62375376211;37793.2441351177;37819.24361512809;45794.54205458036;45960.31059534177;47009.76495117503;47332;47403.52596474129;34369.656303437645;34651.826740866134;34804.65195348014;35277.64722352846;35332.82333588316;34441.82779086089;34689.47965780465;34830.47754283637;34868.302633947686;35622.643773562966;39280.80359598184;39712.404313934734;40004.999875003356;40089.1982160361;40424.1915161701;33613.495797562566;33813.830930845186;33974.15064623404;34005;34435.82782086074;25386.74613253844;25633.231003069937;25692.229233123035;25987.090451834094;26027.73972260253 04:12:33 INFO - PID 13534 | |2;jquery.html;584.2434047907959;584.4418580255856;587.6562211106502;606.4541912278949;613.8311964209845;23347.766522334772;24314.87842560787;24377.878110609465;24400.87799561004;24401.511969760595;23920.16279430216;24983;25118;25343;25420.491590168185;6783.491238157133;6854.040434339172;6884.7934561962975;6897.3447522485285;6903.447724182079;6470.644114573696;6580.80257592273;6720.6975686094;6729.663516824164;6818.693158807866;6532;6533.93466065338;6537.836554086139;6604.57070290432;6736.966315168417;6516.902246466307;6539.117219175398;6539.378759017909;6548.67256637171;6579.671016449182;6102.725377357985;6197.628142311476;6314.273858506284;6318.178636777236;6352.301246862841;29752.553711694127;30263.243418914484;30323.69676303231;30338.69661303403;30356.241093972607;2186.967195492053;2213.2143089203264;2216.1910902520626;2218.0905828610353;2220.2562141682556;19932;20108.095135718926;20424.183032678677;20590.897045514677;20710.68933965992;2472.765087316702;2521.394865232331;2567.5250078735307;2581.664383630135;2584.2505673354704;139356.2128757419;146514;154962;161741.19129404397;163476.18261908615;15545.611359716098;16469.752953705705;16604.66790664204;16652.916735416246;16895.577610559834;25364.873175634373;25422.618660720105;25426.364340891254;25438.491230175292;25448.363790905376;9883.45640989738;9981.550830212658;10031.949840250752;10063.144632706302;10112.443815590213;8907.465552066897;8916.643334266557;8927.866082008644;8932.240759535513;8997.685081022133;9551.90448095524;9605.759856003517;9955.651552195639;10014.599416023277;10128.59485620567;2869.8852045918347;2929.1798296477023;2947.204254851178;2969.4654962106597;2971.4799910016095;1012.6455740490769;1038.1227862456212;1042.5464922758624;1047.225053460449;1058.3539705713895;20648.17407303691;20983.265585704732;21088.261910833047;21244;21408.143674253166;1095.3209010413595;1101.2731597145846;1115.1859142825783;1117.3631030312645;1117.804384232756;11391;11616.94191529037;11774.764504709858;11776.411179440993;11814.586489472827;583408;584951;590669;603176;612327;122938;124778;125998.37000814937;126391.3680431592;132358;1221.1207930290177;1233.6792433967053;1241.975160496785;1245.9626211213679;1256.340421278836;18557.628847422708;18610.44168674942;18823.247070117042;18934.242630294633;19061.523461913563;58091.70954145202;58525.707371464574;58878.705606471696;58978;60769;74094.62952685202;74224;74367;74818;75142.24857751353;15144.242787860783;15431.922840385727;15572.766408504109;15629.296681649126;15643;23642.290731278088;24302;24394.634080488453;24706.629400559366;24803.50392992094;19359.3224237151;19556.315528956417;19904.50238744043;19929;19980.800191997892;17279.136043198043;17561.473155805346;17570.472885813448;17897.552561186076;18234.635307294044;19667.803321966596;19768.802311976695;19858.50353741168;20069;20334.89832550828;15194.164320962453;15255.466058687893;15312.081275123528;15333.76999345033;15366.385344586091;19082.33211837579;19112.33106841254;19754.90122549378;19977.400677979684;20037 04:12:33 INFO - PID 13534 | |3;mootools.html;1395.6650403903063;1458.8614081662245;1467.8311994120666;1472.6097584140205;1480.2746654139469;15955.999999999985;16668.249928753205;16795.580110497245;16801.243944022517;16827.15864206791;16184.595385115377;16203.918980405082;16286.51140465785;16296;16387.508374748748;2784.8886044558194;2802.999999999995;2858.9428211435757;2859.299471629454;2868.813527120741;2814.2542226310043;2822.5625028120676;2828.4484525517532;2869.526528122857;2871.956920646192;2739.876705548255;2837.6878543360317;2839.034728192414;2839.304370429237;2841;2766.4743698697184;2768.5985532097834;2778.9027384041665;2788.2332358601343;2788.721127887205;2733.139061195717;2770.2381844992588;2773.292810333352;2781.3324802047564;2782.290515918448;15786.210689465595;16156.59608509785;16159.192040397933;16165.110918899456;16631.584210394714;8185.181481851827;8421.326293896474;8430.409871309012;8439.620217090245;8448.493090414595;5353.732313384354;5435.483629055233;5537.723113844332;5598.412166722517;5615.859603509904;1991.4523506035812;2027.3816485971772;2033.9389818305474;2062.6596611559075;2069.286096296775;31046.534301985488;31588.368232635217;32429.189270268194;32433.189170270696;32480;7233.8553228935125;7262.782116536512;7353.1911489736085;7501.137369202503;7501.137369202612;19465.221391144478;19685.11416986239;20662.07020684073;20710.68933965992;20721.171153154006;8338.082810890797;8576.271016963503;8639.611217495101;8641.265492433087;8653.437526560754;7780.338671212897;7798.454108212484;7905.486143400661;7918.485298455582;7929.563873986871;5357.785688572491;5551.8056868010235;5578.0517312057045;5604.271444712243;5609.943900561024;1518.293993293124;1539.622792415843;1540.3915453395846;1548.41934274647;1556.898801577894;937.1659223291276;962.225408546113;970.189891440655;970.5923512124924;975.4196253229317;8208.906793664097;8301.626426810808;8308.958455207807;8315.168483151636;8541.615627296787;786.2726977545748;786.7639708087551;788.9447738658354;790.9841803163904;807.7576726981882;5612.719364031782;5777.913331300034;5837.883242335214;5861.443162899518;5968.940310596925;25228.369290767878;25950.87024564903;26236.60645090325;26373.73626263713;26385.340366490993;25002.74997250004;25251.74748252531;25373.61939570908;25950.480990380085;25982.22053338403;12806.551770687982;12842.422091005927;12861.292628905312;12892.419841107172;13000.67498312531;8586.871196931927;9170.266378689555;9270.53647317645;9288.674896378594;9308.348415611114;20667.4833129173;20783.376498705064;20863.165473380894;20960.47598809981;21279.78720212778;21782;21863.56272874502;21884.343469695934;22158.335249942527;22400;11947.462364193805;12137.878621213675;12186.329751863732;12268.079894008164;12269.079819013432;15270.160141191896;15294.847051529343;15502.457413990456;15531.922340388226;15655.060696358254;12348.691282718004;12552.93723531413;12875.613731588068;12997.415116319977;13068.085234033526;11700.239484433485;11766.411679416165;11829.349385783864;12217.69455763613;12226.694332641398;10854.077403420797;11035.779284414106;11059.115270778157;11073.833892491459;11078.390688512209;7647.694092236471;7678.616069196406;7781.649825757741;7810.843783124419;7814.257645523666;7105;7161.641917904188;7187.137543494814;7200.135983681992;7249.746258880914 04:12:33 INFO - PID 13534 | |4;prototype.html;534.3827878799985;549.8460431079297;570.4808624152021;577.4380301285024;584.6053913608313;6321.968390158055;6327.019312006646;6331.2085989251345;6372.39462251086;6433.485321174307;6301.495880329574;6307.684615769204;6325.746970121189;6351.523635727316;6351.7459301628;5114.693118412889;5138.46046165151;5167.483251674821;5191.118928994407;5195.792168313263;5093.414257360414;5122.641415100945;5167.302414174076;5171.482851714836;5182.611304152185;4877.268409738532;4938.950610493885;4944.505549445044;5006.424261209952;5009.874753131183;4951.811565224356;4959.504049595066;4977.377827771528;4993.800247990076;5020.874478138076;4505.5269196734525;4530.168644597127;4532.252178390561;4545.36364908913;4546.52261512543;6156.138140660311;6213;6229.719662615194;6231.096491008823;6261.591141993061;5862.618929769594;5876.500497457721;5883.17635531026;5893.44012318829;5903.940960590425;6596.703148358335;6601.834954126137;6619.900701489481;6632.8673426531195;6732.966335168342;4869.293952376921;5050.570701490377;5063.594912406998;5063.594912406998;5068.949310506885;6827.99999999995;6841.93158068418;6856.114568493704;6872.347127022925;6961.825954351131;5152.149895267314;5177.844664660066;5199.792008319625;5199.818006369835;5203.453637368022;5237.869053273623;5283.471652834763;5285.656432331963;5292.417834038252;5309.867253318698;5873.177755114288;5886.175935369051;5898.587098903035;5913.58604897653;5918.378570250062;6689.163854518185;6721.630310332881;6736.8989465158065;6739.93260067393;6763.289854565298;1771.353455988555;1795.4075155198752;1797.1553369916119;1834.412987843904;1839.6872531669649;1231.9199252048588;1276.5595869425033;1294.4886769725906;1309.3322405573226;1311.9147255428365;6165.691715414211;6193.969030154821;6195.16365290689;6196.752129914843;6275.121482992385;6426.678666066678;6547.5416720830035;6699.564528305742;6709.329067093252;6725.5203855151785;6114.2662880453745;6130.6628135452975;6133.693315334215;6145.170401995762;6160.983437732813;3513.6823691115833;3522.4716292556323;3575.2491976685187;3581.122624956902;3583.4445660922597;6966.9303306967295;6979.790606281819;7006.4394848412;7052.506324557335;7090.574565526085;6922.169339679271;6960.582365058011;6974.9651251744435;6985.62488753816;7039.964800176069;6964.338387853146;6977.511574189758;7044.119485064367;7075.292470752884;7093.184283807325;6580.21037475506;6635.184768757887;6654.600723956578;6775.830604234933;6786.253512113565;6546.214454265519;6646.667666616747;6662.267150613332;6676.198856137295;6718;6855.177378714586;6861.4853885957755;6911.516193866381;6998.265182156004;7000;5138.434772175133;5145.176771716508;5151.433342332265;5152.716600587004;5209.53114219722;6657.367550082734;6670.866582668416;6724.361185687352;6735.562188457735;6748.561343512656;6238.097380299052;6496.317886621837;6549.7882891665195;6557.508186885907;6576.145101136822;6497.285298617243;6611.206655201214;6660.433863121495;6670.231853780627;6691.431228345645;6507.917466410892;6591.5056370773345;6602;6611.504137189634;6611.702473388806;6560.901586476302;6694.698738556874;6717.865642687217;6727.040102354948;6744.932550674431;6400.647559659476;6435.613863168225;6456.354364563506;6464.41820236181;6514.283428822731 04:12:33 INFO - PID 13534 | |5;yui.html;981.8036392721458;997.7029861180465;1014.19878296146;1016.3089099412401;1022.8261195596746;21042.57914841704;21440.78559214411;21515;21541.353759387224;21553.137874485023;18744.531386715338;18830.81169188308;19052.904735476302;19118.566107541956;19159.808401915976;1060.3107979813126;1073.1093192650083;1075.4676435164604;1076.7200527862774;1079.5142186016285;1065.2915810985724;1081.3944191252924;1081.6430577909312;1082.7888561730465;1083.1930211992078;1151.291955447398;1151.3207207747428;1151.476078384333;1152.0495591137303;1162.2213117211447;1151.0618845640777;1151.176908510419;1151.9193656444052;1152.5677870798493;1162.534986005596;839.6599377252222;840.1094839470181;840.5755093677653;844.5270648436895;855.6064210463195;19782.109805058662;19913.701294480594;19950.301739439194;20100.195992160297;20101.597968040704;22850.31449056531;23572.528549428916;23594.410139746473;23618.881905590362;23846.642300365507;18257.360992365204;18313.450596482126;18774.906125469286;18898.52753681155;18909.81090189094;3977.164795392971;3999.7200195986293;4007.479027726377;4008.719389642726;4018.3168861293652;156458;163993;167503.16248418923;168890.1555492227;170542;18742.812571874107;19052.809471905104;19181.32865349706;19261.518462038563;19367.80632193688;33095.66904330974;33941;33991.4901276481;34030.65969340324;34060;9727.367721098106;9903.108720215216;10018.699439016842;10115.241356898263;10155.136813370798;4409.669274804402;4441.111777644484;4486.641068714495;4493.078918821634;4500.662450316174;5634.915476267859;5708.143778433268;5729.627574207663;5846.766129354864;5852.853678658068;1197.7484728207;1214.392803598201;1218.6648671615376;1221.2001139253803;1222.0712258683286;693.5284006875373;707.5706079939615;708.5394493579112;717.1107826295356;735.9668814903342;13437;13472.663183420296;13685.931570342284;13726.45094196241;13767.38046787897;689.9586024838526;697.3619138488327;710.346481237263;710.3819676881043;723.4646361692415;6355.396237357444;6357.1735674362035;6502.622185886086;6524.575902566318;6584.176977877765;137566;139252;140103;141299;141747;126927.36536317444;130259.34870325588;132268.33865830608;134974;136722;108453;112191;112885;117915.41042294905;121661.39169304274;13069.542566010145;13498;13513.189208647513;13613.251271180181;13815.309234538434;52202.754128449764;54216.72891635517;54736;55116;56382.7180864093;67636.32363676497;67933.3206667927;69165.3083469179;85992.14007859842;95554;19636.705449417983;19802;19867.60264794667;20053.29813456522;20077.49806254855;20768.792312076686;21750.56498869982;22078.77921220767;22293.888530557244;22961.65557516672;19283.90358048201;19855;19995.60008799845;20262.59474810525;20412.693809592573;19265.51836204106;19338.323158689378;19376.8062319375;19972.70040949358;20464.69302960427;18393.08034598238;19060.904695476434;19245;19263.22947082101;19371.225150993803;14465.204413757345;14547.927260363631;14673.706525869637;14749.557513274618;14955.252237388304;14922.403103875724;15342.846571534143;15637.374505019672;15660;15720.528384148494 04:12:33 INFO - PID 13534 | __end_tp_report 04:12:33 INFO - PID 13534 | __start_cc_report 04:12:33 INFO - PID 13534 | _x_x_mozilla_cycle_collect,284 04:12:33 INFO - PID 13534 | __end_cc_report 04:12:33 INFO - PID 13534 | __startTimestamp1505733153530__endTimestamp 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | ------- Summary: start ------- 04:12:33 INFO - PID 13534 | Number of tests: 6 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#0] dojo.html Cycles:165 Average:6254.80 Median:6533.58 stddev:886.68 (13.6%) stddev-sans-first:868.33 04:12:33 INFO - PID 13534 | Values: 3805.8 3906.9 3910.8 3912.5 3920.4 6215.3 6317.8 6352.7 6378.1 6411.3 6261.7 6296.6 6335.0 6336.3 6400.1 5618.9 5727.8 5756.1 5767.6 5782.2 186.9 5638.8 5651.6 5729.6 5744.7 5630.2 5633.5 5713.0 5714.2 5714.9 5576.6 5623.5 5682.9 5693.9 5721.1 5592.7 5624.9 5704.8 5705.5 5724.1 6223.0 6253.2 6277.6 6282.6 6318.4 6750.5 6753.7 6784.8 6883.3 6885.6 6763.5 6885.4 6889.7 6918.7 6976.0 6389.1 6422.8 6425.3 6432.2 6444.3 7019.0 7020.4 7115.8 7119.9 7123.7 6646.7 6752.1 6766.5 6832.4 6841.1 6734.9 6801.4 6813.0 6814.7 6821.0 6773.9 6844.2 6845.6 6846.5 6851.9 6726.4 6762.8 6766.8 6801.6 6883.5 4905.6 4942.7 4943.6 4949.7 4967.7 4452.9 4475.7 4521.6 4525.1 4526.0 6134.1 6229.8 6264.2 6294.4 6329.2 6865.8 6875.3 6913.4 6913.5 6915.7 6233.2 6234.3 6300.6 6325.5 6331.2 5415.8 5496.1 5497.9 5560.1 5576.6 7054.4 7110.5 7119.9 7122.6 7140.1 6686.9 6696.7 6720.0 6774.0 6784.3 6946.9 6947.8 7047.3 7060.8 7103.0 6548.2 6776.4 6776.7 6835.6 6847.4 6845.6 6874.5 6886.0 6944.1 6974.0 6533.6 6587.7 6632.2 6649.7 6672.6 6606.6 6673.0 6677.2 6678.1 6699.3 6522.2 6526.3 6587.7 6593.4 6597.7 6550.9 6624.4 6697.0 6701.7 6726.2 6348.1 6387.3 6504.5 6506.5 6511.4 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#1] ext.html Cycles:180 Average:42598.39 Median:20693.64 stddev:64322.00 (310.8%) stddev-sans-first:64426.35 04:12:33 INFO - PID 13534 | Values: 929.1 957.6 964.0 995.5 999.1 42403.4 43981.0 44192.8 44313.0 44399.0 40784.8 41020.6 41069.0 41094.0 41175.0 7169.3 7225.0 7234.1 7237.8 7238.4 7078.9 7085.1 7095.3 7095.4 7113.6 7087.3 7103.8 8107.4 8214.5 8260.2 8119.0 8182.6 8202.4 8207.7 8212.2 8098.5 8143.2 8145.9 8149.3 8151.9 39679.8 39968.0 40145.8 40184.2 40304.4 3717.9 3721.3 3758.9 3762.7 3771.8 33314.5 33390.5 33498.5 33567.3 33665.7 5418.6 5491.6 5497.1 5522.3 5536.4 216898.0 216932.0 218035.0 218186.0 218808.0 51812.0 51964.7 51977.5 51977.7 52020.5 54417.7 54419.5 54531.7 54662.2 54665.2 16421.3 16862.2 16862.6 16878.6 16897.0 13893.7 13904.3 13939.9 13946.2 13950.6 15176.5 15311.6 15514.9 15564.8 15652.0 5872.9 6100.5 6139.1 6256.2 6280.8 1051.5 1080.9 1082.1 1090.1 1109.1 25228.5 25461.2 25641.6 25757.4 25812.6 1190.3 1190.3 1193.5 1209.9 1218.1 13199.4 13485.4 13592.7 13680.1 13766.0 264273.0 264738.0 265895.0 265991.0 266445.0 55747.4 60557.0 60872.7 61397.1 61554.1 1504.5 1508.8 1523.2 1524.2 1548.3 29803.0 30171.2 30233.0 30384.8 30515.0 40572.2 40858.8 40887.8 40892.2 40932.8 255191.0 256570.0 256793.0 257849.0 257896.0 37130.3 37314.4 37624.6 37793.2 37819.2 45794.5 45960.3 47009.8 47332.0 47403.5 34369.7 34651.8 34804.7 35277.6 35332.8 34441.8 34689.5 34830.5 34868.3 35622.6 39280.8 39712.4 40005.0 40089.2 40424.2 33613.5 33813.8 33974.2 34005.0 34435.8 25386.7 25633.2 25692.2 25987.1 26027.7 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#2] jquery.html Cycles:180 Average:39077.95 Median:23495.03 stddev:99598.12 (423.9%) stddev-sans-first:99835.58 04:12:33 INFO - PID 13534 | Values: 584.2 584.4 587.7 606.5 613.8 23347.8 24314.9 24377.9 24400.9 24401.5 23920.2 24983.0 25118.0 25343.0 25420.5 6783.5 6854.0 6884.8 6897.3 6903.4 6470.6 6580.8 6720.7 6729.7 6818.7 6532.0 6533.9 6537.8 6604.6 6737.0 6516.9 6539.1 6539.4 6548.7 6579.7 6102.7 6197.6 6314.3 6318.2 6352.3 29752.6 30263.2 30323.7 30338.7 30356.2 2187.0 2213.2 2216.2 2218.1 2220.3 19932.0 20108.1 20424.2 20590.9 20710.7 2472.8 2521.4 2567.5 2581.7 2584.3 139356.2 146514.0 154962.0 161741.2 163476.2 15545.6 16469.8 16604.7 16652.9 16895.6 25364.9 25422.6 25426.4 25438.5 25448.4 9883.5 9981.6 10031.9 10063.1 10112.4 8907.5 8916.6 8927.9 8932.2 8997.7 9551.9 9605.8 9955.7 10014.6 10128.6 2869.9 2929.2 2947.2 2969.5 2971.5 1012.6 1038.1 1042.5 1047.2 1058.4 20648.2 20983.3 21088.3 21244.0 21408.1 1095.3 1101.3 1115.2 1117.4 1117.8 11391.0 11616.9 11774.8 11776.4 11814.6 583408.0 584951.0 590669.0 603176.0 612327.0 122938.0 124778.0 125998.4 126391.4 132358.0 1221.1 1233.7 1242.0 1246.0 1256.3 18557.6 18610.4 18823.2 18934.2 19061.5 58091.7 58525.7 58878.7 58978.0 60769.0 74094.6 74224.0 74367.0 74818.0 75142.2 15144.2 15431.9 15572.8 15629.3 15643.0 23642.3 24302.0 24394.6 24706.6 24803.5 19359.3 19556.3 19904.5 19929.0 19980.8 17279.1 17561.5 17570.5 17897.6 18234.6 19667.8 19768.8 19858.5 20069.0 20334.9 15194.2 15255.5 15312.1 15333.8 15366.4 19082.3 19112.3 19754.9 19977.4 20037.0 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#3] mootools.html Cycles:180 Average:10396.69 Median:2776.10 stddev:7920.21 (285.3%) stddev-sans-first:7913.57 04:12:33 INFO - PID 13534 | Values: 1395.7 1458.9 1467.8 1472.6 1480.3 15956.0 16668.2 16795.6 16801.2 16827.2 16184.6 16203.9 16286.5 16296.0 16387.5 2784.9 2803.0 2858.9 2859.3 2868.8 2814.3 2822.6 2828.4 2869.5 2872.0 2739.9 2837.7 2839.0 2839.3 2841.0 2766.5 2768.6 2778.9 2788.2 2788.7 2733.1 2770.2 2773.3 2781.3 2782.3 15786.2 16156.6 16159.2 16165.1 16631.6 8185.2 8421.3 8430.4 8439.6 8448.5 5353.7 5435.5 5537.7 5598.4 5615.9 1991.5 2027.4 2033.9 2062.7 2069.3 31046.5 31588.4 32429.2 32433.2 32480.0 7233.9 7262.8 7353.2 7501.1 7501.1 19465.2 19685.1 20662.1 20710.7 20721.2 8338.1 8576.3 8639.6 8641.3 8653.4 7780.3 7798.5 7905.5 7918.5 7929.6 5357.8 5551.8 5578.1 5604.3 5609.9 1518.3 1539.6 1540.4 1548.4 1556.9 937.2 962.2 970.2 970.6 975.4 8208.9 8301.6 8309.0 8315.2 8541.6 786.3 786.8 788.9 791.0 807.8 5612.7 5777.9 5837.9 5861.4 5968.9 25228.4 25950.9 26236.6 26373.7 26385.3 25002.7 25251.7 25373.6 25950.5 25982.2 12806.6 12842.4 12861.3 12892.4 13000.7 8586.9 9170.3 9270.5 9288.7 9308.3 20667.5 20783.4 20863.2 20960.5 21279.8 21782.0 21863.6 21884.3 22158.3 22400.0 11947.5 12137.9 12186.3 12268.1 12269.1 15270.2 15294.8 15502.5 15531.9 15655.1 12348.7 12552.9 12875.6 12997.4 13068.1 11700.2 11766.4 11829.3 12217.7 12226.7 10854.1 11035.8 11059.1 11073.8 11078.4 7647.7 7678.6 7781.6 7810.8 7814.3 7105.0 7161.6 7187.1 7200.1 7249.7 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#4] prototype.html Cycles:180 Average:5648.92 Median:6288.31 stddev:1576.33 (25.1%) stddev-sans-first:1533.29 04:12:33 INFO - PID 13534 | Values: 534.4 549.8 570.5 577.4 584.6 6322.0 6327.0 6331.2 6372.4 6433.5 6301.5 6307.7 6325.7 6351.5 6351.7 5114.7 5138.5 5167.5 5191.1 5195.8 5093.4 5122.6 5167.3 5171.5 5182.6 4877.3 4939.0 4944.5 5006.4 5009.9 4951.8 4959.5 4977.4 4993.8 5020.9 4505.5 4530.2 4532.3 4545.4 4546.5 6156.1 6213.0 6229.7 6231.1 6261.6 5862.6 5876.5 5883.2 5893.4 5903.9 6596.7 6601.8 6619.9 6632.9 6733.0 4869.3 5050.6 5063.6 5063.6 5068.9 6828.0 6841.9 6856.1 6872.3 6961.8 5152.1 5177.8 5199.8 5199.8 5203.5 5237.9 5283.5 5285.7 5292.4 5309.9 5873.2 5886.2 5898.6 5913.6 5918.4 6689.2 6721.6 6736.9 6739.9 6763.3 1771.4 1795.4 1797.2 1834.4 1839.7 1231.9 1276.6 1294.5 1309.3 1311.9 6165.7 6194.0 6195.2 6196.8 6275.1 6426.7 6547.5 6699.6 6709.3 6725.5 6114.3 6130.7 6133.7 6145.2 6161.0 3513.7 3522.5 3575.2 3581.1 3583.4 6966.9 6979.8 7006.4 7052.5 7090.6 6922.2 6960.6 6975.0 6985.6 7040.0 6964.3 6977.5 7044.1 7075.3 7093.2 6580.2 6635.2 6654.6 6775.8 6786.3 6546.2 6646.7 6662.3 6676.2 6718.0 6855.2 6861.5 6911.5 6998.3 7000.0 5138.4 5145.2 5151.4 5152.7 5209.5 6657.4 6670.9 6724.4 6735.6 6748.6 6238.1 6496.3 6549.8 6557.5 6576.1 6497.3 6611.2 6660.4 6670.2 6691.4 6507.9 6591.5 6602.0 6611.5 6611.7 6560.9 6694.7 6717.9 6727.0 6744.9 6400.6 6435.6 6456.4 6464.4 6514.3 04:12:33 INFO - PID 13534 | 04:12:33 INFO - PID 13534 | [#5] yui.html Cycles:180 Average:28805.32 Median:19311.11 stddev:42137.93 (218.2%) stddev-sans-first:42204.35 04:12:33 INFO - PID 13534 | Values: 981.8 997.7 1014.2 1016.3 1022.8 21042.6 21440.8 21515.0 21541.4 21553.1 18744.5 18830.8 19052.9 19118.6 19159.8 1060.3 1073.1 1075.5 1076.7 1079.5 1065.3 1081.4 1081.6 1082.8 1083.2 1151.3 1151.3 1151.5 1152.0 1162.2 1151.1 1151.2 1151.9 1152.6 1162.5 839.7 840.1 840.6 844.5 855.6 19782.1 19913.7 19950.3 20100.2 20101.6 22850.3 23572.5 23594.4 23618.9 23846.6 18257.4 18313.5 18774.9 18898.5 18909.8 3977.2 3999.7 4007.5 4008.7 4018.3 156458.0 163993.0 167503.2 168890.2 170542.0 18742.8 19052.8 19181.3 19261.5 19367.8 33095.7 33941.0 33991.5 34030.7 34060.0 9727.4 9903.1 10018.7 10115.2 10155.1 4409.7 4441.1 4486.6 4493.1 4500.7 5634.9 5708.1 5729.6 5846.8 5852.9 1197.7 1214.4 1218.7 1221.2 1222.1 693.5 707.6 708.5 717.1 736.0 13437.0 13472.7 13685.9 13726.5 13767.4 690.0 697.4 710.3 710.4 723.5 6355.4 6357.2 6502.6 6524.6 6584.2 137566.0 139252.0 140103.0 141299.0 141747.0 126927.4 130259.3 132268.3 134974.0 136722.0 108453.0 112191.0 112885.0 117915.4 121661.4 13069.5 13498.0 13513.2 13613.3 13815.3 52202.8 54216.7 54736.0 55116.0 56382.7 67636.3 67933.3 69165.3 85992.1 95554.0 19636.7 19802.0 19867.6 20053.3 20077.5 20768.8 21750.6 22078.8 22293.9 22961.7 19283.9 19855.0 19995.6 20262.6 20412.7 19265.5 19338.3 19376.8 19972.7 20464.7 18393.1 19060.9 19245.0 19263.2 19371.2 14465.2 14547.9 14673.7 14749.6 14955.3 14922.4 15342.8 15637.4 15660.0 15720.5 04:12:33 INFO - PID 13534 | -------- Summary: end -------- 04:12:33 INFO - PID 13534 | 04:12:34 INFO - TEST-INFO | 13534: exit 0 04:12:34 INFO - TEST-OK | dromaeo_css | took 1107514ms 04:12:34 INFO - TEST-START | kraken 04:12:34 INFO - Initialising browser for kraken test... 04:12:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37826/getInfo.html -profile /tmp/tmpOO9Uv_/profile 04:12:34 INFO - TEST-INFO | started process 13910 (/builds/slave/test/build/application/firefox/firefox http://localhost:37826/getInfo.html) 04:12:40 INFO - TEST-INFO | 13910: exit 0 04:12:40 INFO - Browser initialized. 04:12:40 INFO - Running cycle 1/1 for kraken test... 04:12:40 INFO - Using env: {'DISPLAY': ':0', 04:12:40 INFO - 'HOME': '/home/cltbld', 04:12:40 INFO - 'JSGC_DISABLE_POISONING': '1', 04:12:40 INFO - 'LANG': 'en_US.UTF-8', 04:12:40 INFO - 'LANGUAGE': 'en_US:en', 04:12:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:12:40 INFO - 'LOGNAME': 'cltbld', 04:12:40 INFO - 'MAIL': '/var/mail/cltbld', 04:12:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:12:40 INFO - 'MOZ_CRASHREPORTER': '1', 04:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:12:40 INFO - 'MOZ_NO_REMOTE': '1', 04:12:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:40 INFO - 'NO_EM_RESTART': '1', 04:12:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:40 INFO - 'PWD': '/builds/slave/test', 04:12:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:40 INFO - 'RUST_BACKTRACE': 'full', 04:12:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:12:40 INFO - 'SHELL': '/bin/bash', 04:12:40 INFO - 'SHLVL': '1', 04:12:40 INFO - 'TERM': 'linux', 04:12:40 INFO - 'TMOUT': '86400', 04:12:40 INFO - 'USER': 'cltbld', 04:12:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960', 04:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:40 INFO - '_': '/tools/buildbot/bin/python'} 04:12:40 INFO - TEST-INFO | started process 14146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOO9Uv_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:41 INFO - PID 14146 | 04:12:41 INFO - PID 14146 | (/builds/slave/test/build/application/firefox/firefox:14196): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:12:41 INFO - PID 14146 | 04:12:51 INFO - PID 14146 | RSS: Main: 144412672 04:12:51 INFO - PID 14146 | 04:12:53 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:54 INFO - PID 14146 | RSS: Main: 150163456 04:12:54 INFO - PID 14146 | 04:12:57 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-dft) 04:12:57 INFO - PID 14146 | RSS: Main: 150278144 04:12:57 INFO - PID 14146 | 04:13:00 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-fft) 04:13:01 INFO - PID 14146 | RSS: Main: 146735104 04:13:01 INFO - PID 14146 | 04:13:03 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37826/tests/kraken/driver.html?testName=audio-oscillator) 04:13:04 INFO - PID 14146 | RSS: Main: 147730432 04:13:04 INFO - PID 14146 | 04:13:06 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:06 INFO - PID 14146 | RSS: Main: 147390464 04:13:06 INFO - PID 14146 | 04:13:09 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:10 INFO - PID 14146 | RSS: Main: 147734528 04:13:10 INFO - PID 14146 | 04:13:14 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37826/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:14 INFO - PID 14146 | RSS: Main: 148828160 04:13:14 INFO - PID 14146 | 04:13:17 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37826/tests/kraken/driver.html?testName=json-parse-financial) 04:13:18 INFO - PID 14146 | RSS: Main: 150413312 04:13:18 INFO - PID 14146 | 04:13:19 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:20 INFO - PID 14146 | RSS: Main: 149929984 04:13:20 INFO - PID 14146 | 04:13:21 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:22 INFO - PID 14146 | RSS: Main: 150163456 04:13:22 INFO - PID 14146 | 04:13:24 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:25 INFO - PID 14146 | RSS: Main: 150122496 04:13:25 INFO - PID 14146 | 04:13:27 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:28 INFO - PID 14146 | RSS: Main: 150425600 04:13:28 INFO - PID 14146 | 04:13:30 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:31 INFO - PID 14146 | RSS: Main: 151040000 04:13:31 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | Cycle 1(1): loaded http://localhost:37826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37826/tests/kraken/driver.html?testName=ai-astar) 04:13:33 INFO - PID 14146 | RSS: Main: 152510464 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | __start_tp_report 04:13:33 INFO - PID 14146 | _x_x_mozilla_page_load 04:13:33 INFO - PID 14146 | _x_x_mozilla_page_load_details 04:13:33 INFO - PID 14146 | |i|pagename|runs| 04:13:33 INFO - PID 14146 | |0;ai-astar;105;105;106;107;107;111;108;106;106;105 04:13:33 INFO - PID 14146 | |1;audio-beat-detection;112;114;115;112;111;112;114;119;113;151 04:13:33 INFO - PID 14146 | |2;audio-dft;162;164;162;162;162;164;161;162;165;168 04:13:33 INFO - PID 14146 | |3;audio-fft;75;73;83;73;73;73;73;73;74;76 04:13:33 INFO - PID 14146 | |4;audio-oscillator;78;79;77;77;77;78;78;78;81;78 04:13:33 INFO - PID 14146 | |5;imaging-gaussian-blur;114;113;113;113;114;114;113;114;113;114 04:13:33 INFO - PID 14146 | |6;imaging-darkroom;149;149;165;161;150;150;150;150;150;150 04:13:33 INFO - PID 14146 | |7;imaging-desaturate;94;95;94;95;94;94;94;94;95;95 04:13:33 INFO - PID 14146 | |8;json-parse-financial;44;45;45;45;45;45;46;45;44;44 04:13:33 INFO - PID 14146 | |9;json-stringify-tinderbox;38;39;38;38;38;38;38;38;38;38 04:13:33 INFO - PID 14146 | |10;stanford-crypto-aes;70;71;71;71;69;72;72;69;74;71 04:13:33 INFO - PID 14146 | |11;stanford-crypto-ccm;108;106;111;105;116;112;104;113;104;103 04:13:33 INFO - PID 14146 | |12;stanford-crypto-pbkdf2;151;151;166;163;162;161;155;154;160;150 04:13:33 INFO - PID 14146 | |13;stanford-crypto-sha256-iterative;61;62;59;67;60;62;62;59;60;59 04:13:33 INFO - PID 14146 | __end_tp_report 04:13:33 INFO - PID 14146 | __start_cc_report 04:13:33 INFO - PID 14146 | _x_x_mozilla_cycle_collect,689 04:13:33 INFO - PID 14146 | __end_cc_report 04:13:33 INFO - PID 14146 | __startTimestamp1505733213416__endTimestamp 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | ------- Summary: start ------- 04:13:33 INFO - PID 14146 | Number of tests: 14 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#0] ai-astar Cycles:10 Average:106.60 Median:106.50 stddev:1.84 (1.7%) stddev-sans-first:1.86 04:13:33 INFO - PID 14146 | Values: 105.0 105.0 106.0 107.0 107.0 111.0 108.0 106.0 106.0 105.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:114.00 stddev:12.06 (10.6%) stddev-sans-first:12.63 04:13:33 INFO - PID 14146 | Values: 112.0 114.0 115.0 112.0 111.0 112.0 114.0 119.0 113.0 151.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.18 04:13:33 INFO - PID 14146 | Values: 162.0 164.0 162.0 162.0 162.0 164.0 161.0 162.0 165.0 168.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#3] audio-fft Cycles:10 Average:74.60 Median:73.50 stddev:3.13 (4.3%) stddev-sans-first:3.32 04:13:33 INFO - PID 14146 | Values: 75.0 73.0 83.0 73.0 73.0 73.0 73.0 73.0 74.0 76.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:1.20 (1.5%) stddev-sans-first:1.27 04:13:33 INFO - PID 14146 | Values: 78.0 79.0 77.0 77.0 77.0 78.0 78.0 78.0 81.0 78.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:13:33 INFO - PID 14146 | Values: 114.0 113.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 114.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:150.00 stddev:5.68 (3.8%) stddev-sans-first:5.89 04:13:33 INFO - PID 14146 | Values: 149.0 149.0 165.0 161.0 150.0 150.0 150.0 150.0 150.0 150.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:13:33 INFO - PID 14146 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:0.63 (1.4%) stddev-sans-first:0.60 04:13:33 INFO - PID 14146 | Values: 44.0 45.0 45.0 45.0 45.0 45.0 46.0 45.0 44.0 44.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 04:13:33 INFO - PID 14146 | Values: 38.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#10] stanford-crypto-aes Cycles:10 Average:71.00 Median:71.00 stddev:1.49 (2.1%) stddev-sans-first:1.54 04:13:33 INFO - PID 14146 | Values: 70.0 71.0 71.0 71.0 69.0 72.0 72.0 69.0 74.0 71.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#11] stanford-crypto-ccm Cycles:10 Average:108.20 Median:109.50 stddev:4.52 (4.1%) stddev-sans-first:4.79 04:13:33 INFO - PID 14146 | Values: 108.0 106.0 111.0 105.0 116.0 112.0 104.0 113.0 104.0 103.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:160.50 stddev:5.77 (3.6%) stddev-sans-first:5.66 04:13:33 INFO - PID 14146 | Values: 151.0 151.0 166.0 163.0 162.0 161.0 155.0 154.0 160.0 150.0 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:2.42 (3.9%) stddev-sans-first:2.57 04:13:33 INFO - PID 14146 | Values: 61.0 62.0 59.0 67.0 60.0 62.0 62.0 59.0 60.0 59.0 04:13:33 INFO - PID 14146 | -------- Summary: end -------- 04:13:33 INFO - PID 14146 | 04:13:33 INFO - PID 14146 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:13:33 INFO - TEST-INFO | 14146: exit 0 04:13:34 INFO - TEST-OK | kraken | took 59765ms 04:13:34 INFO - SUITE-END | took 1167s 04:13:34 INFO - Completed test suite (00:19:27) 04:13:34 INFO - javascript benchmark 04:13:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9065.592559465078, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3805.8477660893564, 3906.9023274418155, 3910.804459777012, 3912.4913761211037, 3920.411938209269, 6215.316315205335, 6317.77887773928, 6352.650604216767, 6378.075179099028, 6411.326810684881, 6261.7182226799905, 6296.559240853142, 6334.968325158367, 6336.303006669263, 6400.103985442041, 5618.887622247573, 5727.770889164449, 5756.079027355624, 5767.5962682612235, 5782.24830771999, 186.89648011629117, 5638.774449022034, 5651.604387692863, 5729.570282228829, 5744.655320680772, 5630.183623374588, 5633.464820842013, 5712.971435142839, 5714.228579141804, 5714.857128571777, 5576.581756368248, 5623.493885550321, 5682.914756278659, 5693.857653558653, 5721.113227449752, 5592.748326325284, 5624.859378515529, 5704.77180912763, 5705.4579814917515, 5724.112762521816, 6222.968885155546, 6253.187085678878, 6277.560570760049, 6282.560220784547, 6318.368163183645, 6750.514886724913, 6753.696083676246, 6784.7964561063245, 6883.346082122191, 6885.621290829003, 6763.492738044617, 6885.449164066863, 6889.655517224119, 6918.688659010306, 6976.023356730062, 6389.105525226472, 6422.807315780534, 6425.261094974091, 6432.163818703585, 6444.323346048691, 7019.017337572744, 7020.438364930793, 7115.750948716874, 7119.932010198511, 7123.679434425359, 6646.6676666166495, 6752.122224110834, 6766.526343156031, 6832.350926661959, 6841.144856892888, 6734.932650673529, 6801.42187914023, 6813.0121132435515, 6814.693338799766, 6821.010953411727, 6773.93226067733, 6844.2129155147795, 6845.623490708059, 6846.520743548003, 6851.862962740717, 6726.3609957054005, 6762.797116086525, 6766.763163289262, 6801.557898736566, 6883.518153729191, 4905.607551395879, 4942.728149951788, 4943.604511639061, 4949.678270912379, 4967.726775027409, 4452.888677783081, 4475.731456112644, 4521.59305662492, 4525.117602067565, 4526.049529598821, 6134.079888016833, 6229.844253893689, 6264.185655864709, 6294.402031806971, 6329.240491141, 6865.759698410531, 6875.278095799969, 6913.446924246149, 6913.481488888354, 6915.654217289115, 6233.158523599347, 6234.314225435199, 6300.558960872787, 6325.462335701517, 6331.176946996861, 5415.83752487426, 5496.065668836308, 5497.945020549823, 5560.110382338807, 5576.553875689935, 7054.435645148375, 7110.4667149962925, 7119.857602847914, 7122.5726456412785, 7140.107486564179, 6686.933130668631, 6696.665166741546, 6720.0, 6773.966130169416, 6784.253732089367, 6946.8610627788175, 6947.826304342432, 7047.295270472911, 7060.752873649398, 7102.964485177541, 6548.1814773153355, 6776.390124888783, 6776.661166941732, 6835.58986460814, 6847.383735463832, 6845.623490708059, 6874.450043996569, 6885.965570172117, 6944.131983502062, 6974.0, 6533.575317604341, 6587.703553340016, 6632.204135503771, 6649.667516624246, 6672.599644021374, 6606.570572912745, 6673.0, 6677.232118306457, 6678.065070890177, 6699.263081061177, 6522.249941256816, 6526.282108968105, 6587.736490540325, 6593.439557637655, 6597.736090556324, 6550.934490655032, 6624.403803657694, 6697.0, 6701.66491675424, 6726.192856857208, 6348.111264422892, 6387.329330420424, 6504.544681872224, 6506.544541882212, 6511.38141876521], "value": 6196.3717746558905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.1498279074647, 957.640884668249, 963.9518024098793, 995.5022488755623, 999.1058003087237, 42403.363949540784, 43981.0, 44192.77903610482, 44313.0, 44399.0, 40784.79607601965, 41020.58979410205, 41068.99999999993, 41094.0, 41175.0, 7169.318914703108, 7225.0, 7234.095738032746, 7237.782866513987, 7238.384737297336, 7078.893816592756, 7085.114360704912, 7095.254998225189, 7095.432365410755, 7113.573185608854, 7087.326703963141, 7103.786886393391, 8107.432479726392, 8214.548199849007, 8260.215279548464, 8119.0, 8182.631781569814, 8202.425830191889, 8207.671693132268, 8212.219839115274, 8098.51408915467, 8143.226393492609, 8145.877811832827, 8149.307308878752, 8151.918480815175, 39679.801600991814, 39968.0, 40145.79927100346, 40184.19631607352, 40304.395434068516, 3717.9070523237137, 3721.348763966322, 3758.906027349311, 3762.6613604775703, 3771.830267637963, 33314.500282495785, 33390.49914251288, 33498.497522536934, 33567.3286534268, 33665.6633433665, 5418.566514678816, 5491.615586908918, 5497.120460726264, 5522.254495643077, 5536.390996990328, 216898.0, 216932.0, 218035.0, 218186.0, 218807.9999999984, 51812.0, 51964.740176298874, 51977.48022519802, 51977.7401112992, 52020.479795201565, 54417.72791136019, 54419.45580544223, 54531.72734136304, 54662.18006729902, 54665.1800222997, 16421.343146274015, 16862.24119914607, 16862.57843553921, 16878.57803554921, 16897.0, 13893.722125557431, 13904.304784760721, 13939.860601393857, 13946.232957187452, 13950.581482555539, 15176.544703658908, 15311.61720956985, 15514.9224253878, 15564.84435155634, 15652.0, 5872.941270587325, 6100.511959043266, 6139.109829074849, 6256.249250089927, 6280.842978925472, 1051.4847724614883, 1080.8811030786608, 1082.101855459982, 1090.095220966596, 1109.1293334732197, 25228.495430091294, 25461.236162915142, 25641.61537576938, 25757.3560660985, 25812.612810807852, 1190.3036723516666, 1190.3215167354524, 1193.4927655746274, 1209.8548174218975, 1218.147296892179, 13199.358993500377, 13485.393157307944, 13592.728145437035, 13680.110792798436, 13766.0, 264273.0, 264738.0, 265895.0, 265991.0, 266445.0, 55747.442525574224, 60557.0, 60872.69563652154, 61397.07904381438, 61554.0766888497, 1504.4659146003012, 1508.781226722119, 1523.223156190351, 1524.1997951075773, 1548.2955255358784, 29803.0, 30171.245718857204, 30233.0, 30384.84807575948, 30515.0, 40572.1885562293, 40858.79570602128, 40887.795561022, 40892.1821563573, 40932.79533602432, 255191.0, 256570.0, 256793.0, 257849.0, 257896.0, 37130.257394852495, 37314.44028339631, 37624.62375376211, 37793.2441351177, 37819.24361512809, 45794.54205458036, 45960.31059534177, 47009.76495117503, 47332.0, 47403.52596474129, 34369.656303437645, 34651.826740866134, 34804.65195348014, 35277.64722352846, 35332.82333588316, 34441.82779086089, 34689.47965780465, 34830.47754283637, 34868.302633947686, 35622.643773562966, 39280.80359598184, 39712.404313934734, 40004.999875003356, 40089.1982160361, 40424.1915161701, 33613.495797562566, 33813.830930845186, 33974.15064623404, 34005.0, 34435.82782086074, 25386.74613253844, 25633.231003069937, 25692.229233123035, 25987.090451834094, 26027.73972260253], "value": 18541.20320706837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2434047907959, 584.4418580255856, 587.6562211106502, 606.4541912278949, 613.8311964209845, 23347.766522334772, 24314.87842560787, 24377.878110609465, 24400.87799561004, 24401.511969760595, 23920.16279430216, 24983.0, 25118.0, 25343.0, 25420.491590168185, 6783.491238157133, 6854.040434339172, 6884.7934561962975, 6897.3447522485285, 6903.447724182079, 6470.644114573696, 6580.80257592273, 6720.6975686094, 6729.663516824164, 6818.693158807866, 6532.0, 6533.93466065338, 6537.836554086139, 6604.57070290432, 6736.966315168417, 6516.902246466307, 6539.117219175398, 6539.378759017909, 6548.67256637171, 6579.671016449182, 6102.725377357985, 6197.628142311476, 6314.273858506284, 6318.178636777236, 6352.301246862841, 29752.553711694127, 30263.243418914484, 30323.69676303231, 30338.69661303403, 30356.241093972607, 2186.967195492053, 2213.2143089203264, 2216.1910902520626, 2218.0905828610353, 2220.2562141682556, 19932.0, 20108.095135718926, 20424.183032678677, 20590.897045514677, 20710.68933965992, 2472.765087316702, 2521.394865232331, 2567.5250078735307, 2581.664383630135, 2584.2505673354704, 139356.2128757419, 146514.0, 154962.0, 161741.19129404397, 163476.18261908615, 15545.611359716098, 16469.752953705705, 16604.66790664204, 16652.916735416246, 16895.577610559834, 25364.873175634373, 25422.618660720105, 25426.364340891254, 25438.491230175292, 25448.363790905376, 9883.45640989738, 9981.550830212658, 10031.949840250752, 10063.144632706302, 10112.443815590213, 8907.465552066897, 8916.643334266557, 8927.866082008644, 8932.240759535513, 8997.685081022133, 9551.90448095524, 9605.759856003517, 9955.651552195639, 10014.599416023277, 10128.59485620567, 2869.8852045918347, 2929.1798296477023, 2947.204254851178, 2969.4654962106597, 2971.4799910016095, 1012.6455740490769, 1038.1227862456212, 1042.5464922758624, 1047.225053460449, 1058.3539705713895, 20648.17407303691, 20983.265585704732, 21088.261910833047, 21244.0, 21408.143674253166, 1095.3209010413595, 1101.2731597145846, 1115.1859142825783, 1117.3631030312645, 1117.804384232756, 11391.0, 11616.94191529037, 11774.764504709858, 11776.411179440993, 11814.586489472827, 583408.0, 584951.0, 590669.0, 603176.0, 612327.0, 122938.0, 124778.0, 125998.37000814937, 126391.3680431592, 132358.0, 1221.1207930290177, 1233.6792433967053, 1241.975160496785, 1245.9626211213679, 1256.340421278836, 18557.628847422708, 18610.44168674942, 18823.247070117042, 18934.242630294633, 19061.523461913563, 58091.70954145202, 58525.707371464574, 58878.705606471696, 58978.0, 60769.0, 74094.62952685202, 74224.0, 74367.0, 74818.0, 75142.24857751353, 15144.242787860783, 15431.922840385727, 15572.766408504109, 15629.296681649126, 15643.0, 23642.290731278088, 24302.0, 24394.634080488453, 24706.629400559366, 24803.50392992094, 19359.3224237151, 19556.315528956417, 19904.50238744043, 19929.0, 19980.800191997892, 17279.136043198043, 17561.473155805346, 17570.472885813448, 17897.552561186076, 18234.635307294044, 19667.803321966596, 19768.802311976695, 19858.50353741168, 20069.0, 20334.89832550828, 15194.164320962453, 15255.466058687893, 15312.081275123528, 15333.76999345033, 15366.385344586091, 19082.33211837579, 19112.33106841254, 19754.90122549378, 19977.400677979684, 20037.0], "value": 12625.079259662123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.6650403903063, 1458.8614081662245, 1467.8311994120666, 1472.6097584140205, 1480.2746654139469, 15955.999999999985, 16668.249928753205, 16795.580110497245, 16801.243944022517, 16827.15864206791, 16184.595385115377, 16203.918980405082, 16286.51140465785, 16296.0, 16387.508374748748, 2784.8886044558194, 2802.999999999995, 2858.9428211435757, 2859.299471629454, 2868.813527120741, 2814.2542226310043, 2822.5625028120676, 2828.4484525517532, 2869.526528122857, 2871.956920646192, 2739.876705548255, 2837.6878543360317, 2839.034728192414, 2839.304370429237, 2841.0, 2766.4743698697184, 2768.5985532097834, 2778.9027384041665, 2788.2332358601343, 2788.721127887205, 2733.139061195717, 2770.2381844992588, 2773.292810333352, 2781.3324802047564, 2782.290515918448, 15786.210689465595, 16156.59608509785, 16159.192040397933, 16165.110918899456, 16631.584210394714, 8185.181481851827, 8421.326293896474, 8430.409871309012, 8439.620217090245, 8448.493090414595, 5353.732313384354, 5435.483629055233, 5537.723113844332, 5598.412166722517, 5615.859603509904, 1991.4523506035812, 2027.3816485971772, 2033.9389818305474, 2062.6596611559075, 2069.286096296775, 31046.534301985488, 31588.368232635217, 32429.189270268194, 32433.189170270696, 32480.0, 7233.8553228935125, 7262.782116536512, 7353.1911489736085, 7501.137369202503, 7501.137369202612, 19465.221391144478, 19685.11416986239, 20662.07020684073, 20710.68933965992, 20721.171153154006, 8338.082810890797, 8576.271016963503, 8639.611217495101, 8641.265492433087, 8653.437526560754, 7780.338671212897, 7798.454108212484, 7905.486143400661, 7918.485298455582, 7929.563873986871, 5357.785688572491, 5551.8056868010235, 5578.0517312057045, 5604.271444712243, 5609.943900561024, 1518.293993293124, 1539.622792415843, 1540.3915453395846, 1548.41934274647, 1556.898801577894, 937.1659223291276, 962.225408546113, 970.189891440655, 970.5923512124924, 975.4196253229317, 8208.906793664097, 8301.626426810808, 8308.958455207807, 8315.168483151636, 8541.615627296787, 786.2726977545748, 786.7639708087551, 788.9447738658354, 790.9841803163904, 807.7576726981882, 5612.719364031782, 5777.913331300034, 5837.883242335214, 5861.443162899518, 5968.940310596925, 25228.369290767878, 25950.87024564903, 26236.60645090325, 26373.73626263713, 26385.340366490993, 25002.74997250004, 25251.74748252531, 25373.61939570908, 25950.480990380085, 25982.22053338403, 12806.551770687982, 12842.422091005927, 12861.292628905312, 12892.419841107172, 13000.67498312531, 8586.871196931927, 9170.266378689555, 9270.53647317645, 9288.674896378594, 9308.348415611114, 20667.4833129173, 20783.376498705064, 20863.165473380894, 20960.47598809981, 21279.78720212778, 21782.0, 21863.56272874502, 21884.343469695934, 22158.335249942527, 22400.0, 11947.462364193805, 12137.878621213675, 12186.329751863732, 12268.079894008164, 12269.079819013432, 15270.160141191896, 15294.847051529343, 15502.457413990456, 15531.922340388226, 15655.060696358254, 12348.691282718004, 12552.93723531413, 12875.613731588068, 12997.415116319977, 13068.085234033526, 11700.239484433485, 11766.411679416165, 11829.349385783864, 12217.69455763613, 12226.694332641398, 10854.077403420797, 11035.779284414106, 11059.115270778157, 11073.833892491459, 11078.390688512209, 7647.694092236471, 7678.616069196406, 7781.649825757741, 7810.843783124419, 7814.257645523666, 7105.0, 7161.641917904188, 7187.137543494814, 7200.135983681992, 7249.746258880914], "value": 7183.424720624865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.3827878799985, 549.8460431079297, 570.4808624152021, 577.4380301285024, 584.6053913608313, 6321.968390158055, 6327.019312006646, 6331.2085989251345, 6372.39462251086, 6433.485321174307, 6301.495880329574, 6307.684615769204, 6325.746970121189, 6351.523635727316, 6351.7459301628, 5114.693118412889, 5138.46046165151, 5167.483251674821, 5191.118928994407, 5195.792168313263, 5093.414257360414, 5122.641415100945, 5167.302414174076, 5171.482851714836, 5182.611304152185, 4877.268409738532, 4938.950610493885, 4944.505549445044, 5006.424261209952, 5009.874753131183, 4951.811565224356, 4959.504049595066, 4977.377827771528, 4993.800247990076, 5020.874478138076, 4505.5269196734525, 4530.168644597127, 4532.252178390561, 4545.36364908913, 4546.52261512543, 6156.138140660311, 6213.0, 6229.719662615194, 6231.096491008823, 6261.591141993061, 5862.618929769594, 5876.500497457721, 5883.17635531026, 5893.44012318829, 5903.940960590425, 6596.703148358335, 6601.834954126137, 6619.900701489481, 6632.8673426531195, 6732.966335168342, 4869.293952376921, 5050.570701490377, 5063.594912406998, 5063.594912406998, 5068.949310506885, 6827.99999999995, 6841.93158068418, 6856.114568493704, 6872.347127022925, 6961.825954351131, 5152.149895267314, 5177.844664660066, 5199.792008319625, 5199.818006369835, 5203.453637368022, 5237.869053273623, 5283.471652834763, 5285.656432331963, 5292.417834038252, 5309.867253318698, 5873.177755114288, 5886.175935369051, 5898.587098903035, 5913.58604897653, 5918.378570250062, 6689.163854518185, 6721.630310332881, 6736.8989465158065, 6739.93260067393, 6763.289854565298, 1771.353455988555, 1795.4075155198752, 1797.1553369916119, 1834.412987843904, 1839.6872531669649, 1231.9199252048588, 1276.5595869425033, 1294.4886769725906, 1309.3322405573226, 1311.9147255428365, 6165.691715414211, 6193.969030154821, 6195.16365290689, 6196.752129914843, 6275.121482992385, 6426.678666066678, 6547.5416720830035, 6699.564528305742, 6709.329067093252, 6725.5203855151785, 6114.2662880453745, 6130.6628135452975, 6133.693315334215, 6145.170401995762, 6160.983437732813, 3513.6823691115833, 3522.4716292556323, 3575.2491976685187, 3581.122624956902, 3583.4445660922597, 6966.9303306967295, 6979.790606281819, 7006.4394848412, 7052.506324557335, 7090.574565526085, 6922.169339679271, 6960.582365058011, 6974.9651251744435, 6985.62488753816, 7039.964800176069, 6964.338387853146, 6977.511574189758, 7044.119485064367, 7075.292470752884, 7093.184283807325, 6580.21037475506, 6635.184768757887, 6654.600723956578, 6775.830604234933, 6786.253512113565, 6546.214454265519, 6646.667666616747, 6662.267150613332, 6676.198856137295, 6718.0, 6855.177378714586, 6861.4853885957755, 6911.516193866381, 6998.265182156004, 7000.0, 5138.434772175133, 5145.176771716508, 5151.433342332265, 5152.716600587004, 5209.53114219722, 6657.367550082734, 6670.866582668416, 6724.361185687352, 6735.562188457735, 6748.561343512656, 6238.097380299052, 6496.317886621837, 6549.7882891665195, 6557.508186885907, 6576.145101136822, 6497.285298617243, 6611.206655201214, 6660.433863121495, 6670.231853780627, 6691.431228345645, 6507.917466410892, 6591.5056370773345, 6602.0, 6611.504137189634, 6611.702473388806, 6560.901586476302, 6694.698738556874, 6717.865642687217, 6727.040102354948, 6744.932550674431, 6400.647559659476, 6435.613863168225, 6456.354364563506, 6464.41820236181, 6514.283428822731], "value": 5194.22235900466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [981.8036392721458, 997.7029861180465, 1014.19878296146, 1016.3089099412401, 1022.8261195596746, 21042.57914841704, 21440.78559214411, 21515.0, 21541.353759387224, 21553.137874485023, 18744.531386715338, 18830.81169188308, 19052.904735476302, 19118.566107541956, 19159.808401915976, 1060.3107979813126, 1073.1093192650083, 1075.4676435164604, 1076.7200527862774, 1079.5142186016285, 1065.2915810985724, 1081.3944191252924, 1081.6430577909312, 1082.7888561730465, 1083.1930211992078, 1151.291955447398, 1151.3207207747428, 1151.476078384333, 1152.0495591137303, 1162.2213117211447, 1151.0618845640777, 1151.176908510419, 1151.9193656444052, 1152.5677870798493, 1162.534986005596, 839.6599377252222, 840.1094839470181, 840.5755093677653, 844.5270648436895, 855.6064210463195, 19782.109805058662, 19913.701294480594, 19950.301739439194, 20100.195992160297, 20101.597968040704, 22850.31449056531, 23572.528549428916, 23594.410139746473, 23618.881905590362, 23846.642300365507, 18257.360992365204, 18313.450596482126, 18774.906125469286, 18898.52753681155, 18909.81090189094, 3977.164795392971, 3999.7200195986293, 4007.479027726377, 4008.719389642726, 4018.3168861293652, 156458.0, 163993.0, 167503.16248418923, 168890.1555492227, 170542.0, 18742.812571874107, 19052.809471905104, 19181.32865349706, 19261.518462038563, 19367.80632193688, 33095.66904330974, 33941.0, 33991.4901276481, 34030.65969340324, 34060.0, 9727.367721098106, 9903.108720215216, 10018.699439016842, 10115.241356898263, 10155.136813370798, 4409.669274804402, 4441.111777644484, 4486.641068714495, 4493.078918821634, 4500.662450316174, 5634.915476267859, 5708.143778433268, 5729.627574207663, 5846.766129354864, 5852.853678658068, 1197.7484728207, 1214.392803598201, 1218.6648671615376, 1221.2001139253803, 1222.0712258683286, 693.5284006875373, 707.5706079939615, 708.5394493579112, 717.1107826295356, 735.9668814903342, 13437.0, 13472.663183420296, 13685.931570342284, 13726.45094196241, 13767.38046787897, 689.9586024838526, 697.3619138488327, 710.346481237263, 710.3819676881043, 723.4646361692415, 6355.396237357444, 6357.1735674362035, 6502.622185886086, 6524.575902566318, 6584.176977877765, 137566.0, 139252.0, 140103.0, 141299.0, 141747.0, 126927.36536317444, 130259.34870325588, 132268.33865830608, 134974.0, 136722.0, 108453.0, 112191.0, 112885.0, 117915.41042294905, 121661.39169304274, 13069.542566010145, 13498.0, 13513.189208647513, 13613.251271180181, 13815.309234538434, 52202.754128449764, 54216.72891635517, 54736.0, 55116.0, 56382.7180864093, 67636.32363676497, 67933.3206667927, 69165.3083469179, 85992.14007859842, 95554.0, 19636.705449417983, 19802.0, 19867.60264794667, 20053.29813456522, 20077.49806254855, 20768.792312076686, 21750.56498869982, 22078.77921220767, 22293.888530557244, 22961.65557516672, 19283.90358048201, 19855.0, 19995.60008799845, 20262.59474810525, 20412.693809592573, 19265.51836204106, 19338.323158689378, 19376.8062319375, 19972.70040949358, 20464.69302960427, 18393.08034598238, 19060.904695476434, 19245.0, 19263.22947082101, 19371.225150993803, 14465.204413757345, 14547.927260363631, 14673.706525869637, 14749.557513274618, 14955.252237388304, 14922.403103875724, 15342.846571534143, 15637.374505019672, 15660.0, 15720.528384148494], "value": 10256.252841313364, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 106.0, 107.0, 107.0, 111.0, 108.0, 106.0, 106.0, 105.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 112.0, 111.0, 112.0, 114.0, 119.0, 113.0, 151.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 164.0, 161.0, 162.0, 165.0, 168.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 83.0, 73.0, 73.0, 73.0, 73.0, 73.0, 74.0, 76.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 77.0, 77.0, 78.0, 78.0, 78.0, 81.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 165.0, 161.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 45.0, 45.0, 45.0, 46.0, 45.0, 44.0, 44.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 71.0, 69.0, 72.0, 72.0, 69.0, 74.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 111.0, 105.0, 116.0, 112.0, 104.0, 113.0, 104.0, 103.0], "value": 108.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 166.0, 163.0, 162.0, 161.0, 155.0, 154.0, 160.0, 150.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 59.0, 67.0, 60.0, 62.0, 62.0, 59.0, 60.0, 59.0], "value": 61.1, "unit": "score"}]}]} 04:13:34 INFO - Return code: 0 04:13:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:34 INFO - # TBPL SUCCESS # 04:13:34 INFO - Running post-action listener: _package_coverage_data 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - [mozharness: 2017-09-18 11:13:34.212095Z] Finished run-tests step (success) 04:13:34 INFO - Running post-run listener: _resource_record_post_run 04:13:34 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 337440768; Read time: 260; Write time: 285236 04:13:34 INFO - TinderboxPrint: CPU usage
13.1% 04:13:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 260 04:13:34 INFO - TinderboxPrint: I/O write bytes / time
337,440,768 / 285,236 04:13:34 INFO - TinderboxPrint: CPU idle
8,219.5 (86.9%) 04:13:34 INFO - TinderboxPrint: CPU user
1,186.0 (12.5%) 04:13:34 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10407936; Read time: 0; Write time: 1096 04:13:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:13:34 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327032832; Read time: 244; Write time: 284116 04:13:34 INFO - Running post-run listener: _upload_blobber_files 04:13:34 INFO - Blob upload gear active. 04:13:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:34 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 04:13:34 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:34 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:35 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:36 INFO - (blobuploader) - INFO - Done attempting. 04:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:37 INFO - (blobuploader) - INFO - Done attempting. 04:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:44 INFO - (blobuploader) - INFO - Done attempting. 04:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:45 INFO - (blobuploader) - INFO - Done attempting. 04:13:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:45 INFO - Return code: 0 04:13:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0291e46abfe1f48c952d5af7ab31d037716db242d0541000e8b480f37721e59db5a5bfa5ec3b7098dc2974adca9ce356624989d7996b72d32e719afcf9d9989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd3eb5d3165166d2030f93c28c6c68d23bdc9eba08e111a911320bf8ccd5b61947dc37e33decee131debafc99c12c92aecb5d884cf7fafffaacc2610e643e7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474613db46c7e54b0f72be6ae79dc786b83958c162e0c289eb68010b2c5fe87061fbd34315c8a837b79ba8a143d3687176911996cce49f635c17f2375819908", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4c1551d06b70e0d363f0b04fa30dd19599f3b2e7a78249bf5375abf1bbc2df18814105e5c6bc82197d6570119c37225b84a235b5b935d4625c6f966ac0c3cc"} 04:13:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:45 INFO - Contents: 04:13:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0291e46abfe1f48c952d5af7ab31d037716db242d0541000e8b480f37721e59db5a5bfa5ec3b7098dc2974adca9ce356624989d7996b72d32e719afcf9d9989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd3eb5d3165166d2030f93c28c6c68d23bdc9eba08e111a911320bf8ccd5b61947dc37e33decee131debafc99c12c92aecb5d884cf7fafffaacc2610e643e7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474613db46c7e54b0f72be6ae79dc786b83958c162e0c289eb68010b2c5fe87061fbd34315c8a837b79ba8a143d3687176911996cce49f635c17f2375819908", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4c1551d06b70e0d363f0b04fa30dd19599f3b2e7a78249bf5375abf1bbc2df18814105e5c6bc82197d6570119c37225b84a235b5b935d4625c6f966ac0c3cc"} 04:13:45 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:45 INFO - Copying logs to upload dir... 04:13:45 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.042493 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-18 04:13:45.666255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:13:45.674524) ========= 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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 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/sha512/c0291e46abfe1f48c952d5af7ab31d037716db242d0541000e8b480f37721e59db5a5bfa5ec3b7098dc2974adca9ce356624989d7996b72d32e719afcf9d9989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd3eb5d3165166d2030f93c28c6c68d23bdc9eba08e111a911320bf8ccd5b61947dc37e33decee131debafc99c12c92aecb5d884cf7fafffaacc2610e643e7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474613db46c7e54b0f72be6ae79dc786b83958c162e0c289eb68010b2c5fe87061fbd34315c8a837b79ba8a143d3687176911996cce49f635c17f2375819908", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4c1551d06b70e0d363f0b04fa30dd19599f3b2e7a78249bf5375abf1bbc2df18814105e5c6bc82197d6570119c37225b84a235b5b935d4625c6f966ac0c3cc"} build_url:https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/dezH6ewTQambwBP3-fZqzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0291e46abfe1f48c952d5af7ab31d037716db242d0541000e8b480f37721e59db5a5bfa5ec3b7098dc2974adca9ce356624989d7996b72d32e719afcf9d9989", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bd3eb5d3165166d2030f93c28c6c68d23bdc9eba08e111a911320bf8ccd5b61947dc37e33decee131debafc99c12c92aecb5d884cf7fafffaacc2610e643e7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474613db46c7e54b0f72be6ae79dc786b83958c162e0c289eb68010b2c5fe87061fbd34315c8a837b79ba8a143d3687176911996cce49f635c17f2375819908", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4c1551d06b70e0d363f0b04fa30dd19599f3b2e7a78249bf5375abf1bbc2df18814105e5c6bc82197d6570119c37225b84a235b5b935d4625c6f966ac0c3cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 04:13:45.702683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:13:45.703002) ========= 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=fa44defc139c4ba8574fe040000001db-1505731210.15562-80125960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 04:13:45.788050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:13:45.788362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 04:13:45.788667) ========= ========= Total master_lag: 0.27 =========