builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1505673026.13 results: success (0) revision: 0408418cdef3a7ed4f72cdaaf5540b07b70021fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.134019) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.134533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.134814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.277382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.277778) ========= 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=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 11:30:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 76.8K=0.2s 2017-09-17 11:30:26 (76.8 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.297056 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.616884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.617343) ========= 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=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018509 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.691457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:26.691856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0408418cdef3a7ed4f72cdaaf5540b07b70021fd --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 0408418cdef3a7ed4f72cdaaf5540b07b70021fd --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=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 11:30:26,702 truncating revision to first 12 chars 2017-09-17 11:30:26,702 Setting DEBUG logging. 2017-09-17 11:30:26,702 attempt 1/10 2017-09-17 11:30:26,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0408418cdef3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 11:30:27,055 unpacking tar archive at: mozilla-central-0408418cdef3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627008 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:27.346476) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:27.346834) ========= script_repo_revision: 0408418cdef3a7ed4f72cdaaf5540b07b70021fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:27.347224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:27.347506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 11:30:27.564245) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-17 11:30:27.564533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:27 INFO - MultiFileLogger online at 20170917 11:30:27 in /builds/slave/test 11:30:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:30:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:30:27 INFO - {'append_to_log': False, 11:30:27 INFO - 'base_work_dir': '/builds/slave/test', 11:30:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:30:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:30:27 INFO - 'branch': 'Firefox-Non-PGO', 11:30:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:27 INFO - 'code_coverage': False, 11:30:27 INFO - 'config_files': ('talos/linux_config.py',), 11:30:27 INFO - 'default_actions': ('clobber', 11:30:27 INFO - 'read-buildbot-config', 11:30:27 INFO - 'download-and-extract', 11:30:27 INFO - 'populate-webroot', 11:30:27 INFO - 'create-virtualenv', 11:30:27 INFO - 'install', 11:30:27 INFO - 'setup-mitmproxy', 11:30:27 INFO - 'run-tests'), 11:30:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:27 INFO - 'disable_ccov_upload': False, 11:30:27 INFO - 'disable_stylo': False, 11:30:27 INFO - 'download_minidump_stackwalk': True, 11:30:27 INFO - 'download_symbols': 'ondemand', 11:30:27 INFO - 'enable_stylo': False, 11:30:27 INFO - 'enable_webrender': False, 11:30:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:30:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:27 INFO - 'gecko_profile': False, 11:30:27 INFO - 'gecko_profile_interval': 0, 11:30:27 INFO - 'installer_path': 'installer.exe', 11:30:27 INFO - 'log_level': 'info', 11:30:27 INFO - 'log_name': 'talos', 11:30:27 INFO - 'log_to_console': True, 11:30:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:27 INFO - 'opt_config_files': (), 11:30:27 INFO - 'pip_index': False, 11:30:27 INFO - 'suite': 'dromaeojs-e10s', 11:30:27 INFO - 'system_bits': '32', 11:30:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:27 INFO - 'title': 'talos-linux64-ix-018', 11:30:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:27 INFO - 'use_talos_json': True, 11:30:27 INFO - 'verify': 'False', 11:30:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:30:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:27 INFO - 'work_dir': 'build'} 11:30:27 INFO - [mozharness: 2017-09-17 18:30:27.794874Z] Running clobber step. 11:30:27 INFO - Running pre-action listener: _resource_record_pre_action 11:30:27 INFO - Running main action method: clobber 11:30:27 INFO - rmtree: /builds/slave/test/build 11:30:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:30:28 INFO - Running post-action listener: _resource_record_post_action 11:30:28 INFO - [mozharness: 2017-09-17 18:30:28.748674Z] Finished clobber step (success) 11:30:28 INFO - [mozharness: 2017-09-17 18:30:28.748769Z] Running read-buildbot-config step. 11:30:28 INFO - Running pre-action listener: _resource_record_pre_action 11:30:28 INFO - Running main action method: read_buildbot_config 11:30:28 INFO - Using buildbot properties: 11:30:28 INFO - { 11:30:28 INFO - "project": "", 11:30:28 INFO - "product": "firefox", 11:30:28 INFO - "who": "ffxbld@noreply.mozilla.org", 11:30:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:30:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:30:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:30:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:30:28 INFO - "stage_platform": "linux64", 11:30:28 INFO - "basedir": "/builds/slave/test", 11:30:28 INFO - "buildnumber": 841, 11:30:28 INFO - "platform": "ubuntu64_hw", 11:30:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:30:28 INFO - "slavebuilddir": "test", 11:30:28 INFO - "taskId": "NbMKo__qSW-lSHBl0lidvw", 11:30:28 INFO - "branch": "mozilla-central", 11:30:28 INFO - "script_repo_revision": "production", 11:30:28 INFO - "revision": "0408418cdef3a7ed4f72cdaaf5540b07b70021fd", 11:30:28 INFO - "slavename": "talos-linux64-ix-018", 11:30:28 INFO - "repo_path": "mozilla-central" 11:30:28 INFO - } 11:30:28 INFO - Finding installer, test and symbols from parent task. 11:30:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NbMKo__qSW-lSHBl0lidvw'}, attempt #1 11:30:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NbMKo__qSW-lSHBl0lidvw'}, attempt #1 11:30:29 INFO - Task dependencies: BAsmZyBYTdem8SXBoYX9ag 11:30:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag'}, attempt #1 11:30:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 11:30:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.test_packages.json 11:30:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.crashreporter-symbols.zip 11:30:30 INFO - Running post-action listener: _resource_record_post_action 11:30:30 INFO - [mozharness: 2017-09-17 18:30:30.136232Z] Finished read-buildbot-config step (success) 11:30:30 INFO - [mozharness: 2017-09-17 18:30:30.136447Z] Running download-and-extract step. 11:30:30 INFO - Running pre-action listener: _resource_record_pre_action 11:30:30 INFO - Running main action method: download_and_extract 11:30:30 INFO - mkdir: /builds/slave/test/build/tests 11:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:30 INFO - trying https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.test_packages.json 11:30:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:30:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:30:30 INFO - Downloaded 989 bytes. 11:30:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:30:30 INFO - Using the following test package requirements: 11:30:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:30:30 INFO - u'common': [u'target.common.tests.zip'], 11:30:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:30:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:30:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:30:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:30:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:30:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:30:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:30:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:30:30 INFO - u'target.web-platform.tests.tar.gz'], 11:30:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:30:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:30:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.common.tests.zip 11:30:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:30:30 INFO - Fetch https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.common.tests.zip into memory 11:30:32 INFO - Content-Length response header: 54731159 11:30:32 INFO - Bytes received: 54731159 11:30:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.talos.tests.zip 11:30:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:30:43 INFO - Fetch https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.talos.tests.zip into memory 11:30:43 INFO - Content-Length response header: 14508748 11:30:43 INFO - Bytes received: 14508748 11:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:44 INFO - trying https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 11:30:44 INFO - Downloading https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:30:48 INFO - Downloaded 61409685 bytes. 11:30:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 11:30:48 INFO - mkdir: /builds/slave/test/properties 11:30:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:30:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:30:48 INFO - Contents: 11:30:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 11:30:48 INFO - Running post-action listener: _resource_record_post_action 11:30:48 INFO - Running post-action listener: find_tests_for_verification 11:30:48 INFO - Running post-action listener: set_extra_try_arguments 11:30:48 INFO - [mozharness: 2017-09-17 18:30:48.373498Z] Finished download-and-extract step (success) 11:30:48 INFO - [mozharness: 2017-09-17 18:30:48.373728Z] Running populate-webroot step. 11:30:48 INFO - Running pre-action listener: _resource_record_pre_action 11:30:48 INFO - Running main action method: populate_webroot 11:30:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:30:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['tresize', 11:30:48 INFO - 'tcanvasmark']}, 11:30:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:30:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['dromaeo_css', 11:30:48 INFO - 'kraken']}, 11:30:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'tests': ['damp', 'tps']}, 11:30:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['damp', 'tps']}, 11:30:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['dromaeo_dom']}, 11:30:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:30:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['basic_compositor_video', 11:30:48 INFO - 'glvideo']}, 11:30:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:30:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['ts_paint_webext', 11:30:48 INFO - 'tp5o_webext']}, 11:30:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:30:48 INFO - 'ts_paint', 11:30:48 INFO - 'tpaint', 11:30:48 INFO - 'sessionrestore', 11:30:48 INFO - 'sessionrestore_many_windows', 11:30:48 INFO - 'sessionrestore_no_auto_restore', 11:30:48 INFO - 'tabpaint']}, 11:30:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['a11yr', 11:30:48 INFO - 'ts_paint', 11:30:48 INFO - 'tpaint', 11:30:48 INFO - 'sessionrestore', 11:30:48 INFO - 'sessionrestore_many_windows', 11:30:48 INFO - 'sessionrestore_no_auto_restore', 11:30:48 INFO - 'tabpaint']}, 11:30:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:30:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:30:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:30:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['bloom_basic']}, 11:30:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:30:48 INFO - 'tsvgr_opacity', 11:30:48 INFO - 'tart', 11:30:48 INFO - 'tscrollx', 11:30:48 INFO - 'tsvg_static']}, 11:30:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['tsvgx', 11:30:48 INFO - 'tsvgr_opacity', 11:30:48 INFO - 'tart', 11:30:48 INFO - 'tscrollx', 11:30:48 INFO - 'tsvg_static']}, 11:30:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:30:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo'], 11:30:48 INFO - 'tests': ['tp5o']}, 11:30:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:48 INFO - 'talos_options': ['--mitmproxy', 11:30:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:48 INFO - '--firstNonBlankPaint'], 11:30:48 INFO - 'tests': ['tp6_google', 11:30:48 INFO - 'tp6_youtube', 11:30:48 INFO - 'tp6_amazon', 11:30:48 INFO - 'tp6_facebook']}, 11:30:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo', 11:30:48 INFO - '--mitmproxy', 11:30:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:48 INFO - '--firstNonBlankPaint'], 11:30:48 INFO - 'tests': ['tp6_google', 11:30:48 INFO - 'tp6_youtube', 11:30:48 INFO - 'tp6_amazon', 11:30:48 INFO - 'tp6_facebook']}, 11:30:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:30:48 INFO - 'talos_options': ['--stylo-threads=1', 11:30:48 INFO - '--mitmproxy', 11:30:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:30:48 INFO - '--firstNonBlankPaint'], 11:30:48 INFO - 'tests': ['tp6_google', 11:30:48 INFO - 'tp6_youtube', 11:30:48 INFO - 'tp6_amazon', 11:30:48 INFO - 'tp6_facebook']}, 11:30:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--xperf_path', 11:30:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:48 INFO - 'tests': ['tp5n']}, 11:30:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:30:48 INFO - 'talos_options': ['--disable-stylo', 11:30:48 INFO - '--xperf_path', 11:30:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:48 INFO - 'tests': ['tp5n']}}} 11:30:48 INFO - Running post-action listener: _resource_record_post_action 11:30:48 INFO - [mozharness: 2017-09-17 18:30:48.391877Z] Finished populate-webroot step (success) 11:30:48 INFO - [mozharness: 2017-09-17 18:30:48.391979Z] Running create-virtualenv step. 11:30:48 INFO - Running pre-action listener: _resource_record_pre_action 11:30:48 INFO - Running main action method: create_virtualenv 11:30:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:30:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:30:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:30:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:30:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:30:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:50 INFO - Installing pip...............done. 11:30:50 INFO - Return code: 0 11:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:30:50 INFO - Reading from file tmpfile_stdout 11:30:50 INFO - Output received: 11:30:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:30:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:30:50 INFO - Using env: {'DISPLAY': ':0', 11:30:50 INFO - 'HOME': '/home/cltbld', 11:30:50 INFO - 'LANG': 'en_US.UTF-8', 11:30:50 INFO - 'LANGUAGE': 'en_US:en', 11:30:50 INFO - 'LOGNAME': 'cltbld', 11:30:50 INFO - 'MAIL': '/var/mail/cltbld', 11:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:50 INFO - 'MOZ_NO_REMOTE': '1', 11:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:50 INFO - 'NO_EM_RESTART': '1', 11:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:50 INFO - 'PWD': '/builds/slave/test', 11:30:50 INFO - 'SHELL': '/bin/bash', 11:30:50 INFO - 'SHLVL': '1', 11:30:50 INFO - 'TERM': 'linux', 11:30:50 INFO - 'TMOUT': '86400', 11:30:50 INFO - 'USER': 'cltbld', 11:30:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:50 INFO - '_': '/tools/buildbot/bin/python'} 11:30:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:30:52 INFO - Downloading/unpacking pip>=1.5 11:30:52 INFO - Running setup.py egg_info for package pip 11:30:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:30:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:30:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:30:52 INFO - Installing collected packages: pip 11:30:52 INFO - Found existing installation: pip 1.1 11:30:52 INFO - Uninstalling pip: 11:30:52 INFO - Successfully uninstalled pip 11:30:52 INFO - Running setup.py install for pip 11:30:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:30:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:30:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:30:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:30:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:30:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:30:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:30:52 INFO - Successfully installed pip 11:30:52 INFO - Cleaning up... 11:30:52 INFO - Return code: 0 11:30:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:30:52 INFO - Using env: {'DISPLAY': ':0', 11:30:52 INFO - 'HOME': '/home/cltbld', 11:30:52 INFO - 'LANG': 'en_US.UTF-8', 11:30:52 INFO - 'LANGUAGE': 'en_US:en', 11:30:52 INFO - 'LOGNAME': 'cltbld', 11:30:52 INFO - 'MAIL': '/var/mail/cltbld', 11:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:52 INFO - 'MOZ_NO_REMOTE': '1', 11:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:52 INFO - 'NO_EM_RESTART': '1', 11:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:52 INFO - 'PWD': '/builds/slave/test', 11:30:52 INFO - 'SHELL': '/bin/bash', 11:30:52 INFO - 'SHLVL': '1', 11:30:52 INFO - 'TERM': 'linux', 11:30:52 INFO - 'TMOUT': '86400', 11:30:52 INFO - 'USER': 'cltbld', 11:30:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:52 INFO - '_': '/tools/buildbot/bin/python'} 11:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:52 INFO - Downloading/unpacking psutil>=3.1.1 11:30:52 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 11:30:52 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 11:30:52 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 11:30:52 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 11:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:53 INFO - Installing collected packages: psutil 11:30:53 INFO - Running setup.py install for psutil 11:30:53 INFO - building 'psutil._psutil_linux' extension 11:30:53 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 11:30:54 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 11:30:55 INFO - building 'psutil._psutil_posix' extension 11:30:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:30:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:30:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:55 INFO - Successfully installed psutil 11:30:55 INFO - Cleaning up... 11:30:55 INFO - Return code: 0 11:30:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:30:55 INFO - Using env: {'DISPLAY': ':0', 11:30:55 INFO - 'HOME': '/home/cltbld', 11:30:55 INFO - 'LANG': 'en_US.UTF-8', 11:30:55 INFO - 'LANGUAGE': 'en_US:en', 11:30:55 INFO - 'LOGNAME': 'cltbld', 11:30:55 INFO - 'MAIL': '/var/mail/cltbld', 11:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:55 INFO - 'MOZ_NO_REMOTE': '1', 11:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:55 INFO - 'NO_EM_RESTART': '1', 11:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:55 INFO - 'PWD': '/builds/slave/test', 11:30:55 INFO - 'SHELL': '/bin/bash', 11:30:55 INFO - 'SHLVL': '1', 11:30:55 INFO - 'TERM': 'linux', 11:30:55 INFO - 'TMOUT': '86400', 11:30:55 INFO - 'USER': 'cltbld', 11:30:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:55 INFO - '_': '/tools/buildbot/bin/python'} 11:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:30:56 INFO - Installing collected packages: mozsystemmonitor 11:30:56 INFO - Running setup.py install for mozsystemmonitor 11:30:56 INFO - Successfully installed mozsystemmonitor 11:30:56 INFO - Cleaning up... 11:30:56 INFO - Return code: 0 11:30:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:30:56 INFO - Using env: {'DISPLAY': ':0', 11:30:56 INFO - 'HOME': '/home/cltbld', 11:30:56 INFO - 'LANG': 'en_US.UTF-8', 11:30:56 INFO - 'LANGUAGE': 'en_US:en', 11:30:56 INFO - 'LOGNAME': 'cltbld', 11:30:56 INFO - 'MAIL': '/var/mail/cltbld', 11:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:56 INFO - 'MOZ_NO_REMOTE': '1', 11:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:56 INFO - 'NO_EM_RESTART': '1', 11:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:56 INFO - 'PWD': '/builds/slave/test', 11:30:56 INFO - 'SHELL': '/bin/bash', 11:30:56 INFO - 'SHLVL': '1', 11:30:56 INFO - 'TERM': 'linux', 11:30:56 INFO - 'TMOUT': '86400', 11:30:56 INFO - 'USER': 'cltbld', 11:30:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:56 INFO - '_': '/tools/buildbot/bin/python'} 11:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:58 INFO - warning: no files found matching '*.txt' 11:30:58 INFO - no previously-included directories found matching 'build' 11:30:58 INFO - no previously-included directories found matching 'dist' 11:30:58 INFO - no previously-included directories found matching '.git*' 11:30:58 INFO - Installing collected packages: jsonschema, functools32 11:30:58 INFO - Running setup.py install for functools32 11:30:58 INFO - warning: no files found matching '*.txt' 11:30:58 INFO - no previously-included directories found matching 'build' 11:30:58 INFO - no previously-included directories found matching 'dist' 11:30:58 INFO - no previously-included directories found matching '.git*' 11:30:58 INFO - Successfully installed jsonschema functools32 11:30:58 INFO - Cleaning up... 11:30:58 INFO - Return code: 0 11:30:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:30:58 INFO - Using env: {'DISPLAY': ':0', 11:30:58 INFO - 'HOME': '/home/cltbld', 11:30:58 INFO - 'LANG': 'en_US.UTF-8', 11:30:58 INFO - 'LANGUAGE': 'en_US:en', 11:30:58 INFO - 'LOGNAME': 'cltbld', 11:30:58 INFO - 'MAIL': '/var/mail/cltbld', 11:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:58 INFO - 'MOZ_NO_REMOTE': '1', 11:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:58 INFO - 'NO_EM_RESTART': '1', 11:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:58 INFO - 'PWD': '/builds/slave/test', 11:30:58 INFO - 'SHELL': '/bin/bash', 11:30:58 INFO - 'SHLVL': '1', 11:30:58 INFO - 'TERM': 'linux', 11:30:58 INFO - 'TMOUT': '86400', 11:30:58 INFO - 'USER': 'cltbld', 11:30:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:58 INFO - '_': '/tools/buildbot/bin/python'} 11:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:30:58 INFO - Cleaning up... 11:30:58 INFO - Return code: 0 11:30:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:30:58 INFO - Using env: {'DISPLAY': ':0', 11:30:58 INFO - 'HOME': '/home/cltbld', 11:30:58 INFO - 'LANG': 'en_US.UTF-8', 11:30:58 INFO - 'LANGUAGE': 'en_US:en', 11:30:58 INFO - 'LOGNAME': 'cltbld', 11:30:58 INFO - 'MAIL': '/var/mail/cltbld', 11:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:58 INFO - 'MOZ_NO_REMOTE': '1', 11:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:58 INFO - 'NO_EM_RESTART': '1', 11:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:58 INFO - 'PWD': '/builds/slave/test', 11:30:58 INFO - 'SHELL': '/bin/bash', 11:30:58 INFO - 'SHLVL': '1', 11:30:58 INFO - 'TERM': 'linux', 11:30:58 INFO - 'TMOUT': '86400', 11:30:58 INFO - 'USER': 'cltbld', 11:30:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:58 INFO - '_': '/tools/buildbot/bin/python'} 11:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:00 INFO - Downloading docopt-0.6.1.tar.gz 11:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:00 INFO - Running setup.py install for blobuploader 11:31:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:00 INFO - Running setup.py install for requests 11:31:01 INFO - Running setup.py install for docopt 11:31:01 INFO - Successfully installed blobuploader requests docopt 11:31:01 INFO - Cleaning up... 11:31:01 INFO - Return code: 0 11:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:01 INFO - Using env: {'DISPLAY': ':0', 11:31:01 INFO - 'HOME': '/home/cltbld', 11:31:01 INFO - 'LANG': 'en_US.UTF-8', 11:31:01 INFO - 'LANGUAGE': 'en_US:en', 11:31:01 INFO - 'LOGNAME': 'cltbld', 11:31:01 INFO - 'MAIL': '/var/mail/cltbld', 11:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:01 INFO - 'MOZ_NO_REMOTE': '1', 11:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:01 INFO - 'NO_EM_RESTART': '1', 11:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:01 INFO - 'PWD': '/builds/slave/test', 11:31:01 INFO - 'SHELL': '/bin/bash', 11:31:01 INFO - 'SHLVL': '1', 11:31:01 INFO - 'TERM': 'linux', 11:31:01 INFO - 'TMOUT': '86400', 11:31:01 INFO - 'USER': 'cltbld', 11:31:01 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:01 INFO - '_': '/tools/buildbot/bin/python'} 11:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:01 INFO - Running setup.py (path:/tmp/pip-MW53oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:01 INFO - Running setup.py (path:/tmp/pip-UvGzem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:01 INFO - Running setup.py (path:/tmp/pip-cIoeFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:01 INFO - Running setup.py (path:/tmp/pip-xfj54P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:01 INFO - Running setup.py (path:/tmp/pip-Kg09QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:02 INFO - Running setup.py (path:/tmp/pip-3GAytp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:02 INFO - Running setup.py (path:/tmp/pip-rY4Bd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:02 INFO - Running setup.py (path:/tmp/pip-g_KqO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:02 INFO - Running setup.py (path:/tmp/pip-8iKjhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:02 INFO - Running setup.py (path:/tmp/pip-rUzaHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:02 INFO - Running setup.py (path:/tmp/pip-wF_osy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:02 INFO - Running setup.py (path:/tmp/pip-q5d_xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:02 INFO - Running setup.py (path:/tmp/pip-yLDOzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:02 INFO - Running setup.py (path:/tmp/pip-f1zOMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:02 INFO - Running setup.py (path:/tmp/pip-n5DIbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:02 INFO - Running setup.py (path:/tmp/pip-PlDLiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:02 INFO - Running setup.py (path:/tmp/pip-I5_D3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:02 INFO - Running setup.py install for manifestparser 11:31:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:02 INFO - Running setup.py install for mozcrash 11:31:03 INFO - Running setup.py install for mozdebug 11:31:03 INFO - Running setup.py install for mozdevice 11:31:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozfile 11:31:03 INFO - Running setup.py install for mozhttpd 11:31:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozinfo 11:31:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozInstall 11:31:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozleak 11:31:03 INFO - Running setup.py install for mozlog 11:31:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for moznetwork 11:31:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:03 INFO - Running setup.py install for mozprocess 11:31:04 INFO - Running setup.py install for mozprofile 11:31:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozrunner 11:31:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Running setup.py install for mozscreenshot 11:31:04 INFO - Running setup.py install for moztest 11:31:04 INFO - Running setup.py install for mozversion 11:31:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:04 INFO - Cleaning up... 11:31:04 INFO - Return code: 0 11:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:04 INFO - Using env: {'DISPLAY': ':0', 11:31:04 INFO - 'HOME': '/home/cltbld', 11:31:04 INFO - 'LANG': 'en_US.UTF-8', 11:31:04 INFO - 'LANGUAGE': 'en_US:en', 11:31:04 INFO - 'LOGNAME': 'cltbld', 11:31:04 INFO - 'MAIL': '/var/mail/cltbld', 11:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:04 INFO - 'MOZ_NO_REMOTE': '1', 11:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:04 INFO - 'NO_EM_RESTART': '1', 11:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:04 INFO - 'PWD': '/builds/slave/test', 11:31:04 INFO - 'SHELL': '/bin/bash', 11:31:04 INFO - 'SHLVL': '1', 11:31:04 INFO - 'TERM': 'linux', 11:31:04 INFO - 'TMOUT': '86400', 11:31:04 INFO - 'USER': 'cltbld', 11:31:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:04 INFO - '_': '/tools/buildbot/bin/python'} 11:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:04 INFO - Running setup.py (path:/tmp/pip-p0gfd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:04 INFO - Running setup.py (path:/tmp/pip-A7DY3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:04 INFO - Running setup.py (path:/tmp/pip-8rM6gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:05 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)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:05 INFO - Running setup.py (path:/tmp/pip-DrvF7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:05 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)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:05 INFO - Running setup.py (path:/tmp/pip-lZLyDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:05 INFO - Running setup.py (path:/tmp/pip-PAeAjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:05 INFO - Running setup.py (path:/tmp/pip-i9E_0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:05 INFO - Running setup.py (path:/tmp/pip-6xCIy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:05 INFO - Running setup.py (path:/tmp/pip-Omn8tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:05 INFO - Running setup.py (path:/tmp/pip-ZzMDq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:05 INFO - Running setup.py (path:/tmp/pip-__OSIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:05 INFO - Running setup.py (path:/tmp/pip-TOjr3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:05 INFO - Running setup.py (path:/tmp/pip-penaTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:05 INFO - Running setup.py (path:/tmp/pip-I7_qRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:05 INFO - Running setup.py (path:/tmp/pip-894c42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:05 INFO - Running setup.py (path:/tmp/pip-Oc_N9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:05 INFO - Running setup.py (path:/tmp/pip-3P84XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:06 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)) 11:31:06 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)) 11:31:06 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)) 11:31:06 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)) 11:31:06 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)) 11:31:06 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)) 11:31:06 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)) 11:31:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:06 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 11:31:06 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 11:31:06 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 11:31:06 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 11:31:07 INFO - Downloading blessings-1.6.tar.gz 11:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:07 INFO - Installing collected packages: blessings 11:31:07 INFO - Running setup.py install for blessings 11:31:07 INFO - Successfully installed blessings 11:31:07 INFO - Cleaning up... 11:31:07 INFO - Return code: 0 11:31:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:07 INFO - Reading from file tmpfile_stdout 11:31:07 INFO - Current package versions: 11:31:07 INFO - argparse == 1.2.1 11:31:07 INFO - blessings == 1.6 11:31:07 INFO - blobuploader == 1.2.4 11:31:07 INFO - docopt == 0.6.1 11:31:07 INFO - functools32 == 3.2.3-2 11:31:07 INFO - jsonschema == 2.5.1 11:31:07 INFO - manifestparser == 1.1 11:31:07 INFO - mozInstall == 1.13 11:31:07 INFO - mozcrash == 1.0 11:31:07 INFO - mozdebug == 0.1 11:31:07 INFO - mozdevice == 0.51 11:31:07 INFO - mozfile == 1.2 11:31:07 INFO - mozhttpd == 0.7 11:31:07 INFO - mozinfo == 0.10 11:31:07 INFO - mozleak == 0.1 11:31:07 INFO - mozlog == 3.5 11:31:07 INFO - moznetwork == 0.27 11:31:07 INFO - mozprocess == 0.25 11:31:07 INFO - mozprofile == 0.28 11:31:07 INFO - mozrunner == 6.13 11:31:07 INFO - mozscreenshot == 0.1 11:31:07 INFO - mozsystemmonitor == 0.3 11:31:07 INFO - moztest == 0.8 11:31:07 INFO - mozversion == 1.4 11:31:07 INFO - psutil == 3.1.1 11:31:07 INFO - requests == 1.2.3 11:31:07 INFO - wsgiref == 0.1.2 11:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:07 INFO - Using env: {'DISPLAY': ':0', 11:31:07 INFO - 'HOME': '/home/cltbld', 11:31:07 INFO - 'LANG': 'en_US.UTF-8', 11:31:07 INFO - 'LANGUAGE': 'en_US:en', 11:31:07 INFO - 'LOGNAME': 'cltbld', 11:31:07 INFO - 'MAIL': '/var/mail/cltbld', 11:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:07 INFO - 'MOZ_NO_REMOTE': '1', 11:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:07 INFO - 'NO_EM_RESTART': '1', 11:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:07 INFO - 'PWD': '/builds/slave/test', 11:31:07 INFO - 'SHELL': '/bin/bash', 11:31:07 INFO - 'SHLVL': '1', 11:31:07 INFO - 'TERM': 'linux', 11:31:07 INFO - 'TMOUT': '86400', 11:31:07 INFO - 'USER': 'cltbld', 11:31:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:07 INFO - '_': '/tools/buildbot/bin/python'} 11:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:31:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:31:09 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)) 11:31:09 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)) 11:31:09 INFO - Installing collected packages: simplejson 11:31:09 INFO - Running setup.py install for simplejson 11:31:09 INFO - building 'simplejson._speedups' extension 11:31:09 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 11:31:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:31:10 INFO - Successfully installed simplejson 11:31:10 INFO - Cleaning up... 11:31:10 INFO - Return code: 0 11:31:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2594a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, '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': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', '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 11:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:31:10 INFO - Using env: {'DISPLAY': ':0', 11:31:10 INFO - 'HOME': '/home/cltbld', 11:31:10 INFO - 'LANG': 'en_US.UTF-8', 11:31:10 INFO - 'LANGUAGE': 'en_US:en', 11:31:10 INFO - 'LOGNAME': 'cltbld', 11:31:10 INFO - 'MAIL': '/var/mail/cltbld', 11:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:10 INFO - 'MOZ_NO_REMOTE': '1', 11:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:10 INFO - 'NO_EM_RESTART': '1', 11:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:10 INFO - 'PWD': '/builds/slave/test', 11:31:10 INFO - 'SHELL': '/bin/bash', 11:31:10 INFO - 'SHLVL': '1', 11:31:10 INFO - 'TERM': 'linux', 11:31:10 INFO - 'TMOUT': '86400', 11:31:10 INFO - 'USER': 'cltbld', 11:31:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:10 INFO - '_': '/tools/buildbot/bin/python'} 11:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:31:10 INFO - Cleaning up... 11:31:10 INFO - Return code: 0 11:31:10 INFO - Running post-action listener: _resource_record_post_action 11:31:10 INFO - Running post-action listener: _start_resource_monitoring 11:31:10 INFO - Starting resource monitoring. 11:31:10 INFO - [mozharness: 2017-09-17 18:31:10.332146Z] Finished create-virtualenv step (success) 11:31:10 INFO - [mozharness: 2017-09-17 18:31:10.333181Z] Running install step. 11:31:10 INFO - Running pre-action listener: _resource_record_pre_action 11:31:10 INFO - Running main action method: install 11:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:10 INFO - Reading from file tmpfile_stdout 11:31:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:10 INFO - Reading from file tmpfile_stdout 11:31:10 INFO - Output received: 11:31:10 INFO - Usage: mozinstall [options] installer 11:31:10 INFO - Options: 11:31:10 INFO - -h, --help show this help message and exit 11:31:10 INFO - -d DEST, --destination=DEST 11:31:10 INFO - Directory to install application into. [default: 11:31:10 INFO - "/builds/slave/test"] 11:31:10 INFO - --app=APP Application being installed. [default: firefox] 11:31:10 INFO - mkdir: /builds/slave/test/build/application 11:31:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:31:28 INFO - Reading from file tmpfile_stdout 11:31:28 INFO - Output received: 11:31:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:31:28 INFO - Running post-action listener: _resource_record_post_action 11:31:28 INFO - [mozharness: 2017-09-17 18:31:28.391969Z] Finished install step (success) 11:31:28 INFO - [mozharness: 2017-09-17 18:31:28.392111Z] Running setup-mitmproxy step. 11:31:28 INFO - Running pre-action listener: _resource_record_pre_action 11:31:28 INFO - Running main action method: setup_mitmproxy 11:31:28 INFO - Skipping: mitmproxy is not required 11:31:28 INFO - Running post-action listener: _resource_record_post_action 11:31:28 INFO - [mozharness: 2017-09-17 18:31:28.392640Z] Finished setup-mitmproxy step (success) 11:31:28 INFO - [mozharness: 2017-09-17 18:31:28.392742Z] Running run-tests step. 11:31:28 INFO - Running pre-action listener: _resource_record_pre_action 11:31:28 INFO - Running pre-action listener: _set_gcov_prefix 11:31:28 INFO - Running main action method: run_tests 11:31:28 WARNING - Try message not found. 11:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:31:28 INFO - Python 2.7.3 11:31:28 INFO - Return code: 0 11:31:28 INFO - grabbing minidump binary from tooltool 11:31: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')]} 11:31:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2598090>, '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 0x2598d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2592f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:31:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:31:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:31:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:31:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:28 INFO - Return code: 0 11:31:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:31:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:31:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:31:28 INFO - ENV: RUST_BACKTRACE is now full 11:31:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:31:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 11:31:28 INFO - Using env: {'DISPLAY': ':0', 11:31:28 INFO - 'HOME': '/home/cltbld', 11:31:28 INFO - 'LANG': 'en_US.UTF-8', 11:31:28 INFO - 'LANGUAGE': 'en_US:en', 11:31:28 INFO - 'LOGNAME': 'cltbld', 11:31:28 INFO - 'MAIL': '/var/mail/cltbld', 11:31:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:28 INFO - 'MOZ_NO_REMOTE': '1', 11:31:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:28 INFO - 'NO_EM_RESTART': '1', 11:31:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:28 INFO - 'PWD': '/builds/slave/test', 11:31:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:28 INFO - 'RUST_BACKTRACE': 'full', 11:31:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:31:28 INFO - 'SHELL': '/bin/bash', 11:31:28 INFO - 'SHLVL': '1', 11:31:28 INFO - 'TERM': 'linux', 11:31:28 INFO - 'TMOUT': '86400', 11:31:28 INFO - 'USER': 'cltbld', 11:31:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:28 INFO - '_': '/tools/buildbot/bin/python'} 11:31:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 11:31:28 INFO - mozversion application_buildid: 20170917174109 11:31:28 INFO - mozversion application_changeset: 0408418cdef3a7ed4f72cdaaf5540b07b70021fd 11:31:28 INFO - mozversion application_display_name: Nightly 11:31:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:28 INFO - mozversion application_name: Firefox 11:31:28 INFO - mozversion application_remotingname: firefox 11:31:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:31:28 INFO - mozversion application_vendor: Mozilla 11:31:28 INFO - mozversion application_version: 57.0a1 11:31:28 INFO - mozversion platform_buildid: 20170917174109 11:31:28 INFO - mozversion platform_changeset: 0408418cdef3a7ed4f72cdaaf5540b07b70021fd 11:31:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:31:28 INFO - mozversion platform_version: 57.0a1 11:31:28 INFO - using testdate: 1505673088 11:31:28 INFO - actual date: 1505673088 11:31:28 INFO - starting webserver on 'localhost:47430' 11:31:28 INFO - SUITE-START | Running 2 tests 11:31:28 INFO - TEST-START | dromaeo_css 11:31:28 INFO - Initialising browser for dromaeo_css test... 11:31:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47430/getInfo.html -profile /tmp/tmp8ZDjfz/profile 11:31:28 INFO - TEST-INFO | started process 3552 (/builds/slave/test/build/application/firefox/firefox http://localhost:47430/getInfo.html) 11:31:38 INFO - TEST-INFO | 3552: exit 0 11:31:38 INFO - Browser initialized. 11:31:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:38 INFO - Using env: {'DISPLAY': ':0', 11:31:38 INFO - 'HOME': '/home/cltbld', 11:31:38 INFO - 'JSGC_DISABLE_POISONING': '1', 11:31:38 INFO - 'LANG': 'en_US.UTF-8', 11:31:38 INFO - 'LANGUAGE': 'en_US:en', 11:31:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:31:38 INFO - 'LOGNAME': 'cltbld', 11:31:38 INFO - 'MAIL': '/var/mail/cltbld', 11:31:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:31:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:31:38 INFO - 'MOZ_CRASHREPORTER': '1', 11:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:31:38 INFO - 'MOZ_NO_REMOTE': '1', 11:31:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:38 INFO - 'NO_EM_RESTART': '1', 11:31:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:38 INFO - 'PWD': '/builds/slave/test', 11:31:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:31:38 INFO - 'RUST_BACKTRACE': 'full', 11:31:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:31:38 INFO - 'SHELL': '/bin/bash', 11:31:38 INFO - 'SHLVL': '1', 11:31:38 INFO - 'TERM': 'linux', 11:31:38 INFO - 'TMOUT': '86400', 11:31:38 INFO - 'USER': 'cltbld', 11:31:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:38 INFO - '_': '/tools/buildbot/bin/python'} 11:31:38 INFO - TEST-INFO | started process 3787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZDjfz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:39 INFO - PID 3787 | 11:31:39 INFO - PID 3787 | (/builds/slave/test/build/application/firefox/firefox:3837): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:31:39 INFO - PID 3787 | 11:31:50 INFO - PID 3787 | RSS: Main: 150929408 11:31:50 INFO - PID 3787 | 11:34:46 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47430/tests/dromaeo/cssquery-ext.html) 11:34:47 INFO - PID 3787 | RSS: Main: 154689536 11:34:47 INFO - PID 3787 | 11:37:49 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-ext.html (next: http://localhost:47430/tests/dromaeo/cssquery-jquery.html) 11:37:50 INFO - PID 3787 | RSS: Main: 155353088 11:37:50 INFO - PID 3787 | 11:40:51 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47430/tests/dromaeo/cssquery-mootools.html) 11:40:52 INFO - PID 3787 | RSS: Main: 156889088 11:40:52 INFO - PID 3787 | 11:43:54 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47430/tests/dromaeo/cssquery-prototype.html) 11:43:54 INFO - PID 3787 | RSS: Main: 155615232 11:43:54 INFO - PID 3787 | 11:46:57 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47430/tests/dromaeo/cssquery-yui.html) 11:46:58 INFO - PID 3787 | RSS: Main: 156516352 11:46:58 INFO - PID 3787 | 11:49:59 INFO - PID 3787 | Cycle 1(1): loaded http://localhost:47430/tests/dromaeo/cssquery-yui.html (next: http://localhost:47430/tests/dromaeo/cssquery-dojo.html) 11:50:00 INFO - PID 3787 | RSS: Main: 158920704 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | __start_tp_report 11:50:00 INFO - PID 3787 | _x_x_mozilla_page_load 11:50:00 INFO - PID 3787 | _x_x_mozilla_page_load_details 11:50:00 INFO - PID 3787 | |i|pagename|runs| 11:50:00 INFO - PID 3787 | |0;dojo.html;3147.763917706172;3148.165736079939;3167.049885034489;3170.0172946386615;3170.3817755537666;6185.350538193492;6230.252369715629;6236.438720515159;6303.495720342373;6350.904736428945;6166.938330616693;6214.5649804513705;6215.3784621537825;6218.502519798417;6243.937560624392;5762.711864406784;5829.475347218749;5850.824475265749;5853.443922827325;5863.325717542473;48.89234261240796;5793.420657934215;5850.853728656796;5873.7356818943035;5882.617629854046;5352.759125839327;5689.345725241609;5691.658500489963;5848.91226631603;5854.97072514639;5743.540516758691;5785.537157027427;5839.328477225088;5856.76572937082;5858.209141765849;5724;5731.627444216113;5803.129530570406;5816;5818.912716309259;6191.504679625619;6194.287656919467;6229.190205273331;6283.088952101965;6350.26971898233;6714.160729908762;6715.6977935993;6771.085903403076;6784.8303792405095;6815.693293801791;6622.569532980389;6731.427828634572;6733.259341472434;6739.6293203873765;6739.6293203873765;6115.847103822395;6146.446819786196;6192.318844927055;6196.1944947157035;6201.658908760016;6897.172339319314;6956.373926346653;6986.615736134561;6986.965065174743;6989.825254368579;6582.144321238304;6585.078089067534;6636.170478690164;6658.334166583303;6667.233268174125;6519.771807986698;6661.733530658719;6662.600243985376;6698.732050718014;6784.3554862288;6619.404253617197;6679.0315404267085;6697.464202863759;6697.6986035628515;6699.497537684693;6667.999800029937;6708.893032649656;6731.49513786468;6770.221424536143;6780.898286525706;5266.526012658879;5267.209918512177;5317.096093664087;5333.893322133536;5341.973290133602;4576.244919588231;4595.058013107305;4625.1443482955765;4661.650376221729;4666.673332866734;5778.27771528559;5781.624194427349;5843.357230704619;5847.619904706181;5848.912266316009;6762.628055456898;6789.592624442549;6824.692888819915;6826.829329266709;6837.042814006043;5824.592278540462;5831.591788574759;5893.911591326134;5901.940980590225;5904.881902361929;5736;5781.103928891029;5781.479666830005;5856.12158176277;5859.53123750099;6574.572652777554;6588.4729221662155;6589.86820263592;6594.538382313192;6594.934050659528;6706.765263215764;6747.966260168668;6755.560888542327;6761.797146085625;6765.695543700447;6559;6627.502937279627;6638.668066596748;6641.103451034049;6641.734330626721;6580.868382632225;6587.63767992765;6592.505562082767;6681.365270299314;6687.966560167168;6613.603183808987;6706.83232919181;6713.530052896445;6719.731210751711;6736.360045795642;6397;6456.935430645822;6482.611043337415;6483.805485835433;6500.772472963424;6503.674816259263;6522.34776522344;6543.934560654333;6549.050387693663;6565.179352580927;6395.232572091379;6401.935980640134;6470.320616335217;6487.0593763903025;6496;6553.377429144223;6578.736850525926;6614.437772789174;6636.037774522763;6643.50173736962;6346.174997250328;6426.903596445964;6438.484921206198;6441.516886233458;6461.127747753993 11:50:00 INFO - PID 3787 | |1;ext.html;840.6889450903163;865.8225063861909;887.1173182683231;889.6930558957162;892.741105079527;39109;39808.40287395684;40161.397579036304;40256.59743402565;40407.19185616286;37099.25801483969;40317.79841100798;40576;40761.796191019006;41015.58984410155;7632.236776322379;7746.535207887545;7753.651085701129;7755.224477552256;7764.068311802564;7673.424493163036;7824.491408058487;7825.8826117608;7827.6477558510005;7827.7651670449695;7813.140554538996;7843.64703588337;7844.4901081429525;7847;7851.5681637509915;7716.151223365426;7793.922060779433;7794.883076753853;7813.609319534029;7814;7641.617919104023;7676.9636099126465;7680.5391676499585;7702.306792388712;7709.267619576131;36958.8152059238;37100.25799484022;37259.25481490382;37287.25425491475;37324.25351492955;3536.098294934801;3550.928981420383;3573.6605022522817;3576.46353047045;3579.785212887235;30694.53958190629;30696.2325941851;30785.38429231425;30800;30813.229669258224;4966.627502937258;5179.378474583036;5200.167973124319;5243.86890327741;5270.657407268515;174322;175013;175977;176070;176301;45884;46034;46109.30836037462;46129.538704613195;46919.76540117278;48374.516254837705;48486.51513484891;48494;48589;48630.270545941836;15049.097054176784;15259.389624414898;15311.846881531264;16045;16218.270177842025;12438;12522.561710340276;12532.122751407314;12542.623721288375;12551.560695375618;14012.299385030912;14083.788743168861;14172.149671019772;14226.430942762174;14343.497977570734;5659.377468478464;5783.450572195718;5812.854678632983;5914.940850591439;5956.463918247378;977.5258999385293;1012.7974405119006;1020.5356562763925;1033.720895358249;1044.3785947361307;22985.540289194123;23008.53982920332;23217.53564928692;23253.302400927998;23311.300660979858;1117.3854380090918;1117.6870476266658;1120.6469961961957;1123.1576317761678;1133.7052366384635;12166.756664866652;12170.782921707758;12280.692982675504;12358.320292384005;12406.875931240573;235846;236337;236862;236865;237319;50986.74506627443;53461.73269133629;53931.999999999214;54122.72938635282;54141.45858541443;1432.9211893345966;1436.5403071017383;1453.6801903581195;1454.1275234859;1457.234951650392;26291;26518.204453866416;26624.06815761439;26736.331591710365;26914.192574222805;36181.27637447289;36582.63417365792;36587.81706091452;36592.63407365892;36673.44989825208;201493;202777;203339;204118;204206;34023;34191.14522136966;34238.14404639904;34331.82834085914;34544.30911381708;40859.38710919398;40992.1801563973;41817.1636567273;41856.74429767112;42314.15371692611;30543;30614.84692576523;31270.218244544067;31556;31839.204019899687;30122.849385752932;30734;30863;31180.22049448691;31184.532232016085;34649.653503464644;34847.25763711855;34929.47605785966;34987.65012349946;35053.123671908405;30170.84914575413;30393;30482.695173048873;30491.2377190572;30710.078697639106;22740.545189095796;22846;22888;22949.54100917939;23036 11:50:00 INFO - PID 3787 | |2;jquery.html;530.4695304695305;537.2559005777002;542.514449567637;563.887222555489;587.553459370878;21224;22032.33902982909;22115.225967091155;22125.778742212595;22135;23051.654225186634;23901.641475377884;24083.277501674933;24168.637470437956;24259.39351516213;6154.661493617849;6565.4419374353;6602.207735071798;6603.306652801459;6606.768763093292;6506.349365063503;6618.768343107992;6621.238557565869;6623.701933412984;6629.602223866584;6093.146959425684;6324.083007963843;6354.3010268870385;6357.904631430532;6591.670416479181;6415.615063096183;6424.100625912352;6447.129637498924;6464.095026696243;6467.029945508164;5822.359540450547;5981;6046.820869930365;6056.303525094582;6059.363766804466;27683;28262.576061359097;28266.57600135979;28272.717272827213;28280.717192828015;2012.154894944127;2044.2231951858348;2044.5910817836343;2050.589882023601;2051.9076641551164;18702.812971870244;19038.143283552134;19308;19315.130819113172;19413.902930485398;2416.5891798394314;2440.6095024795945;2450.889709963056;2478.7397323281157;2480.3055144559553;117618;122288;125874.37062814628;133100;133533.99999999904;14276.57170284893;14422.927885360506;14573.248154908315;14746.705065898623;14836.10983341003;22626.886865565895;22630.547389052128;22660.773392265866;22669.886650566972;22710.205142820254;9311.208547273558;9364.859527107099;9415.246780257563;9467;9616.08647178517;8344.707935222237;8387.203215694499;8441.324694024586;8559.74320770378;8570.142985701505;8927.866082008775;8929.821403571892;8972.327075469366;9020.323475739346;9069.274458043341;2688.4085501189707;2689.838609683425;2693.7979651526216;2708.91873243803;2763.9170824875287;949.6201519392298;968.6100445860213;979.1285755677453;981.7398389426808;985.1527686189871;18745.250189992246;18750.53123671919;18956.620867582846;19232.519187020156;19287.228510859688;1032.4373216596973;1043.8486419469134;1044.0968562193648;1044.09685621938;1044.2272718188485;10513.474326283655;10546.894531054744;10625.893741062646;10698.03717665414;10743.462826858626;470828.93756593677;475970;488474;489054;492798;105596.47201763942;106710;107502.46248768707;108997.45501272443;112185;1144.4106285263097;1159.907207423404;1181.7782568770656;1186.5194596188558;1186.7389174381622;16614;16828.242729077465;17173;17325.913370433067;17447;53615.46384536261;53715;54034.45965540294;54796.178057328376;55146.72426638001;68049.3195068043;68796;68806;68890.31109688838;69243.30756692369;13701.520446784314;14000.299985000505;14117.223552704289;14129.858701413266;14154.150750954976;21775.455613609785;21808.67286990728;21871.67192492082;21981.560368792856;22010.88994555017;17511.21199545998;17657.64684706273;17763.289468421637;17829.554261143574;17834.5541361467;14182.078164919247;15616;15857.841421585637;16121;16399.26203320877;17854.19656115452;17963.550911227325;17988.2804687811;18327;18330.358437454626;13671.931640341734;13701.588952331047;13828.792568111285;13907.235102069484;13936.860631393556;16983.57541061434;17080.145992700564;17187.742183867504;17221.913890430467;17402.564935876704 11:50:00 INFO - PID 3787 | |3;mootools.html;1334.0794851552428;1377.1668140774834;1395.4557722488237;1403.158105136918;1407.366684991754;15179.2410379481;15687.686246275081;15783.447579334712;15792.605184870385;15823.129727864964;15403.84596154038;15579.610509737262;15607.921960390182;15620.609484762886;15656.921715391407;2697.5144473994674;2809.4100238949845;2813.22636275024;2815.366542527925;2818.7181281871854;2544.5165418570414;2619.4499155177436;2622.2133359991926;2642.2205449392477;2643.3259518822674;2245.0682966568857;2318.2349824557855;2736.192823117175;2828.9575656365173;2833.489971805074;2668.746469085434;2750.931226719328;2754.380264440505;2754.903578374757;2768.5155097857896;2496.700395952479;2519.6220566914926;2520.193538067819;2522.066835270943;2523.621456781479;14866.776998345034;14970.700585988328;15005.174715390649;15011.174385408798;15011.849881501264;7787;7836.294733473957;8082.43422960393;8155.062167850714;8279.461834980768;5237.554807841338;5489.313835770528;5603.551715862721;5656.632318899258;5679.375268720438;1856.2946080489462;1878.9530261743566;1901.1159810688096;1951.3267922566693;1972.891490967996;26134.085307014353;26383.472330553283;26785.866070669716;27608.861955690292;27661;6788.389044985975;6809.31906809325;6896.241413444617;6983.546069505466;7067.752628657972;17276.740848887275;17331.133443327784;17343.913280433517;17415.73876391855;17452.65094698099;7818;7971.963644726148;7988.121306656263;8011.639476223468;8014.398920080901;7368.226336234618;7404.518706284074;7422.6288685565505;7499.362554182955;7517;5016.54851063406;5117.769700363493;5146.4853514648985;5162.948370516322;5173.3533308336455;1481.8147731533559;1499.7825315329217;1505.1646336283468;1512.3345727879919;1526.6717655704076;871.1854416120947;904.556767184075;905.6377449020445;907.0340087806464;915.7390143808982;7537.54774713519;7555.357794587521;7627.847443051219;7665.233476652402;7717;685.3112621815044;707.5259576084036;708.2810946888912;710.9502334836616;716.0655344775014;4871.732054737024;4986.077575648516;5032.672876263031;5064.5441910228255;5150.562202212854;20724.58550828975;22040.33878983633;22059.22792702248;22067.66898496524;22075.889620551796;20791.168353266003;21466;21485.743996880414;21524;21575.35273941784;9354.906450935676;9592.424454532751;9888.752781180385;10836.512356943957;11054.281471704313;8706.390552661253;9109.18017378439;9275.72172834816;9284.767880803034;9292.72121836319;18640.440786776417;19016.71474927905;19237.230510779413;19314.32399865998;19318.03409829531;18959.241630335186;19187.61624767469;19225.615487690447;19232.61534769269;19318.710219347002;11042.779144416905;11049.889501104886;11134.109271258441;11255.549778008788;11267.323960562393;14001.159930404208;14156.43374265059;14160.575182744535;14178.14931104137;14194.574162775134;11643.650690479299;11687.707807304885;11724.237924534878;11815.40922953866;11935.940320298343;11047.889521104686;11401.973822356027;11527.308361498337;11633.127515436207;11913.166078374777;10015.248856335658;10239.078482936273;10403.427811470441;10404.219683523917;10409.791804164026;7074.398676112588;7094.219635840157;7107.289271072851;7150.7497237596435;7210.71157153708;7050.25972272904;7106.111736032996;7112.928870711226;7174.820629484305;7252 11:50:00 INFO - PID 3787 | |4;prototype.html;496.39935677829845;510.5864249957536;521.9582433405328;534.9652272602281;535.4244187498438;6236.282827474842;6263.906041409371;6289.716962736677;6303.212098487689;6347.619142851432;6180.721867515961;6203.813885583429;6208.844778880519;6208.906866397007;6283.874322513547;5107.182850743881;5111.948880511184;5112.130937740574;5130;5140.408852981899;4727.149113159629;4849.321095046696;5035.798568057273;5078.974605126988;5091.974540127294;4816.590589799854;4831.275308703705;4835.709857408549;4881.560659540641;4884.82625231772;4807.4952130026195;4809.639277054217;4823.734694591796;4841.7579121044155;4884.853454396374;4196.034911970233;4329.891752706176;4340.52254252032;4343.6959412841115;4381.671374646882;5954.97022514889;5967.761289548413;5991.55063370249;6034.668093254869;6039.667818269993;5483.519449748585;5508.504234618904;5514.228008078872;5545.639533430314;5576.323364784886;6413.262474815409;6430.234998950449;6468.870622587522;6511.479081673455;6536.54244202906;4614.215583350839;4735.810567577293;4776.880577985544;4794.256890181992;4816.686915350526;6648.637029408959;6687.683291783044;6722.731090756412;6849.452043836481;6886.8622627547165;4877.829275975324;4892.877678058006;4910.926336104962;4911.238757992445;4918.622785620032;4875.512448755097;4892.68197567157;4901.166801643729;4923.532264434873;4969.155243608523;5484.424135465799;5503.257060296809;5577.52591029767;5589.801484619262;5600.383957764642;6443.935560644427;6503.544751867324;6539.738410463623;6548.738050478023;6573.769918052845;1673.4143049932427;1696.7963844338512;1707.9146042697816;1724.4998950304523;1726.5165753589015;1125.6341688951125;1174.900133488663;1176.5235079792697;1181.722295260613;1182.6570294614637;5639.464250896158;5675.26904294186;5675.716214189274;5687.971560142256;5740.827775166752;6449.226092868886;6455.870882582322;6520.576162549419;6580.76967306142;6631.469482441393;5510.173473978935;5546.417626149197;5573.386927437979;5619.353774316006;5635.168570214697;3399.558057452515;3497.9300413992087;3506.0358401439807;3527.188746588299;3542.415501442233;6265.592736472206;6385.48916086712;6405.743770249138;6412.326705695835;6419.646919419383;6570.474362051024;6605.174353205849;6659.4006539411685;6692.263850976388;6710.496712746563;6235.846368421857;6270.9372906270355;6323.197888601727;6375.362463753588;6388.361163883575;6390.936090639034;6460.773872914426;6475.158229430144;6604.273529911802;6613.470922326106;6493.350664933469;6501.804945851632;6515.902261465987;6526.24948130971;6528.640924749185;5733.483986441241;6317.7157027932935;6474.643894585843;6486.481081513562;6502.544821862424;4780.713157210578;4803.303520989507;4805.735684537384;4839.491853355347;4844.224924012141;6319.409042292638;6450.774352873127;6572.868542629025;6583.44040756541;6674.566153200027;6299.503775404694;6352.42726695689;6355.173827402408;6502.154719886574;6518.120053792867;6307.7107566854975;6362;6400.327965563735;6404.231492220777;6496.935030649633;6270.404311590391;6299.338569450142;6315.242170939517;6334.968325158345;6418.684169745285;6358.968205158944;6405.647689377129;6433.420992110732;6486.448651864455;6508.479321654161;6229.3770622939155;6251.68741562911;6275;6281.183446151971;6333.493320534439 11:50:00 INFO - PID 3787 | |5;yui.html;911.1753862754208;923.7829110159107;931.8089791592724;932.1843387036344;938.2259635800466;19071.237150513996;19174.712379314322;19545;19579;19598.118084686186;18470.722939155923;18624.906875465604;18654.906725466386;18674.813251867476;18685.906570467163;971.3637567393368;981.3866333541537;985.438300168904;985.8669079674224;986.556049777603;949.539473355422;968.7771812483134;975.3903810118676;977.359829311802;989.6338354808731;1034.7361422837166;1043.0560342889696;1043.9791204175913;1044.1594516414284;1044.770150566874;1030.6083688198437;1035.5650626736751;1039.532210505272;1040.5681642118511;1040.6773900090996;721.520189074265;742.3059439424102;750.7297372945735;751.3087959077661;751.3163021650327;19214.327498537485;19299.90350048255;19339.709904351446;19347;19354.225830966745;21788.673169902464;21841.344759657237;22335.44161395978;22610.773892261197;22712.091516339326;16664.83335166645;16727.414540491023;16755;16953.91523042377;17035.914820425944;3687;3708.870189543353;3710.6474884885893;3711.2391959648207;3715.034091136324;141408;142516;142739;144767;147812;17009;17298.135093245288;17396.913015435093;17416.65166696684;17421;31369.843150784556;31875.203119921724;32615.67384326174;32659.510107348407;32660.836695816368;8668.739937801876;8711.172438618321;8726.912730872737;8748.387612867038;8751.431156974777;4143.81352839123;4242.193983143193;4263.76549289792;4289.914201715948;4327.870163895088;5422.15956526739;5505.752241149158;5517.889642207133;5522.646951496909;5543.196236545678;980;996.8255555277942;1004.9397036177853;1016.2885979814012;1021.1677482851452;699.4684040129538;713.3793599568409;718.741253148866;723.5984028863926;724.6304384763808;11477.426128693533;11580.536778528765;11597;12705.745885082246;12745.10784245094;686.4782765098461;690.4602735898974;702.9015937768717;703.8979347994615;710.9146902371645;5158.819441319536;5174.508421699932;5199.350081239845;5202.791888324425;5255.710935898563;120773.58452830894;122863;122908.38545807214;123961;130009;107477;109232;111425;111435;111436;94798.52600736952;95288.52355738176;95635.52182239183;95687.52156239313;97309.51345243228;9389.765255868659;9432.905670943477;9532.380395274562;9729.416235025921;9752.853707194256;41618;42768;42870;42948.78525607352;45191;53998.46001540092;54926.72536637291;55938.72030639821;56445;57227;14897.627559311104;15258.694826103638;15270.847291527387;15403.152826594196;15444.2277886103;16258.837411625733;16269.837301626832;16451.83548164551;16467.67064658676;16587.17064146812;15062.924685376503;15159.621009474851;15161.24193790284;15225;15347.769783453034;14680.04579702316;14724.411023559365;14764.926175369055;14866.256687165382;14883.851161488246;14231.573052808433;14289.571312860631;14369.928150359181;14480.131192128507;14512.1292722437;10503.94748026255;10858.891411085788;10875.510602023087;10904.61833835812;11094.389808560607;10485.528151233366;10558.419286939292;10613.150947923994;10653.307535010199;10667.306625069346 11:50:00 INFO - PID 3787 | __end_tp_report 11:50:00 INFO - PID 3787 | __start_cc_report 11:50:00 INFO - PID 3787 | _x_x_mozilla_cycle_collect,284 11:50:00 INFO - PID 3787 | __end_cc_report 11:50:00 INFO - PID 3787 | __startTimestamp1505674200073__endTimestamp 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | ------- Summary: start ------- 11:50:00 INFO - PID 3787 | Number of tests: 6 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#0] dojo.html Cycles:165 Average:6151.25 Median:6456.94 stddev:878.04 (13.6%) stddev-sans-first:848.53 11:50:00 INFO - PID 3787 | Values: 3147.8 3148.2 3167.0 3170.0 3170.4 6185.4 6230.3 6236.4 6303.5 6350.9 6166.9 6214.6 6215.4 6218.5 6243.9 5762.7 5829.5 5850.8 5853.4 5863.3 48.9 5793.4 5850.9 5873.7 5882.6 5352.8 5689.3 5691.7 5848.9 5855.0 5743.5 5785.5 5839.3 5856.8 5858.2 5724.0 5731.6 5803.1 5816.0 5818.9 6191.5 6194.3 6229.2 6283.1 6350.3 6714.2 6715.7 6771.1 6784.8 6815.7 6622.6 6731.4 6733.3 6739.6 6739.6 6115.8 6146.4 6192.3 6196.2 6201.7 6897.2 6956.4 6986.6 6987.0 6989.8 6582.1 6585.1 6636.2 6658.3 6667.2 6519.8 6661.7 6662.6 6698.7 6784.4 6619.4 6679.0 6697.5 6697.7 6699.5 6668.0 6708.9 6731.5 6770.2 6780.9 5266.5 5267.2 5317.1 5333.9 5342.0 4576.2 4595.1 4625.1 4661.7 4666.7 5778.3 5781.6 5843.4 5847.6 5848.9 6762.6 6789.6 6824.7 6826.8 6837.0 5824.6 5831.6 5893.9 5901.9 5904.9 5736.0 5781.1 5781.5 5856.1 5859.5 6574.6 6588.5 6589.9 6594.5 6594.9 6706.8 6748.0 6755.6 6761.8 6765.7 6559.0 6627.5 6638.7 6641.1 6641.7 6580.9 6587.6 6592.5 6681.4 6688.0 6613.6 6706.8 6713.5 6719.7 6736.4 6397.0 6456.9 6482.6 6483.8 6500.8 6503.7 6522.3 6543.9 6549.1 6565.2 6395.2 6401.9 6470.3 6487.1 6496.0 6553.4 6578.7 6614.4 6636.0 6643.5 6346.2 6426.9 6438.5 6441.5 6461.1 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#1] ext.html Cycles:180 Average:37111.58 Median:34888.37 stddev:53529.12 (153.4%) stddev-sans-first:53610.00 11:50:00 INFO - PID 3787 | Values: 840.7 865.8 887.1 889.7 892.7 39109.0 39808.4 40161.4 40256.6 40407.2 37099.3 40317.8 40576.0 40761.8 41015.6 7632.2 7746.5 7753.7 7755.2 7764.1 7673.4 7824.5 7825.9 7827.6 7827.8 7813.1 7843.6 7844.5 7847.0 7851.6 7716.2 7793.9 7794.9 7813.6 7814.0 7641.6 7677.0 7680.5 7702.3 7709.3 36958.8 37100.3 37259.3 37287.3 37324.3 3536.1 3550.9 3573.7 3576.5 3579.8 30694.5 30696.2 30785.4 30800.0 30813.2 4966.6 5179.4 5200.2 5243.9 5270.7 174322.0 175013.0 175977.0 176070.0 176301.0 45884.0 46034.0 46109.3 46129.5 46919.8 48374.5 48486.5 48494.0 48589.0 48630.3 15049.1 15259.4 15311.8 16045.0 16218.3 12438.0 12522.6 12532.1 12542.6 12551.6 14012.3 14083.8 14172.1 14226.4 14343.5 5659.4 5783.5 5812.9 5914.9 5956.5 977.5 1012.8 1020.5 1033.7 1044.4 22985.5 23008.5 23217.5 23253.3 23311.3 1117.4 1117.7 1120.6 1123.2 1133.7 12166.8 12170.8 12280.7 12358.3 12406.9 235846.0 236337.0 236862.0 236865.0 237319.0 50986.7 53461.7 53932.0 54122.7 54141.5 1432.9 1436.5 1453.7 1454.1 1457.2 26291.0 26518.2 26624.1 26736.3 26914.2 36181.3 36582.6 36587.8 36592.6 36673.4 201493.0 202777.0 203339.0 204118.0 204206.0 34023.0 34191.1 34238.1 34331.8 34544.3 40859.4 40992.2 41817.2 41856.7 42314.2 30543.0 30614.8 31270.2 31556.0 31839.2 30122.8 30734.0 30863.0 31180.2 31184.5 34649.7 34847.3 34929.5 34987.7 35053.1 30170.8 30393.0 30482.7 30491.2 30710.1 22740.5 22846.0 22888.0 22949.5 23036.0 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#2] jquery.html Cycles:180 Average:33506.44 Median:22628.72 stddev:81018.73 (358.0%) stddev-sans-first:81208.18 11:50:00 INFO - PID 3787 | Values: 530.5 537.3 542.5 563.9 587.6 21224.0 22032.3 22115.2 22125.8 22135.0 23051.7 23901.6 24083.3 24168.6 24259.4 6154.7 6565.4 6602.2 6603.3 6606.8 6506.3 6618.8 6621.2 6623.7 6629.6 6093.1 6324.1 6354.3 6357.9 6591.7 6415.6 6424.1 6447.1 6464.1 6467.0 5822.4 5981.0 6046.8 6056.3 6059.4 27683.0 28262.6 28266.6 28272.7 28280.7 2012.2 2044.2 2044.6 2050.6 2051.9 18702.8 19038.1 19308.0 19315.1 19413.9 2416.6 2440.6 2450.9 2478.7 2480.3 117618.0 122288.0 125874.4 133100.0 133534.0 14276.6 14422.9 14573.2 14746.7 14836.1 22626.9 22630.5 22660.8 22669.9 22710.2 9311.2 9364.9 9415.2 9467.0 9616.1 8344.7 8387.2 8441.3 8559.7 8570.1 8927.9 8929.8 8972.3 9020.3 9069.3 2688.4 2689.8 2693.8 2708.9 2763.9 949.6 968.6 979.1 981.7 985.2 18745.3 18750.5 18956.6 19232.5 19287.2 1032.4 1043.8 1044.1 1044.1 1044.2 10513.5 10546.9 10625.9 10698.0 10743.5 470828.9 475970.0 488474.0 489054.0 492798.0 105596.5 106710.0 107502.5 108997.5 112185.0 1144.4 1159.9 1181.8 1186.5 1186.7 16614.0 16828.2 17173.0 17325.9 17447.0 53615.5 53715.0 54034.5 54796.2 55146.7 68049.3 68796.0 68806.0 68890.3 69243.3 13701.5 14000.3 14117.2 14129.9 14154.2 21775.5 21808.7 21871.7 21981.6 22010.9 17511.2 17657.6 17763.3 17829.6 17834.6 14182.1 15616.0 15857.8 16121.0 16399.3 17854.2 17963.6 17988.3 18327.0 18330.4 13671.9 13701.6 13828.8 13907.2 13936.9 16983.6 17080.1 17187.7 17221.9 17402.6 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#3] mootools.html Cycles:180 Average:9378.46 Median:14376.77 stddev:6772.56 (47.1%) stddev-sans-first:6764.59 11:50:00 INFO - PID 3787 | Values: 1334.1 1377.2 1395.5 1403.2 1407.4 15179.2 15687.7 15783.4 15792.6 15823.1 15403.8 15579.6 15607.9 15620.6 15656.9 2697.5 2809.4 2813.2 2815.4 2818.7 2544.5 2619.4 2622.2 2642.2 2643.3 2245.1 2318.2 2736.2 2829.0 2833.5 2668.7 2750.9 2754.4 2754.9 2768.5 2496.7 2519.6 2520.2 2522.1 2523.6 14866.8 14970.7 15005.2 15011.2 15011.8 7787.0 7836.3 8082.4 8155.1 8279.5 5237.6 5489.3 5603.6 5656.6 5679.4 1856.3 1879.0 1901.1 1951.3 1972.9 26134.1 26383.5 26785.9 27608.9 27661.0 6788.4 6809.3 6896.2 6983.5 7067.8 17276.7 17331.1 17343.9 17415.7 17452.7 7818.0 7972.0 7988.1 8011.6 8014.4 7368.2 7404.5 7422.6 7499.4 7517.0 5016.5 5117.8 5146.5 5162.9 5173.4 1481.8 1499.8 1505.2 1512.3 1526.7 871.2 904.6 905.6 907.0 915.7 7537.5 7555.4 7627.8 7665.2 7717.0 685.3 707.5 708.3 711.0 716.1 4871.7 4986.1 5032.7 5064.5 5150.6 20724.6 22040.3 22059.2 22067.7 22075.9 20791.2 21466.0 21485.7 21524.0 21575.4 9354.9 9592.4 9888.8 10836.5 11054.3 8706.4 9109.2 9275.7 9284.8 9292.7 18640.4 19016.7 19237.2 19314.3 19318.0 18959.2 19187.6 19225.6 19232.6 19318.7 11042.8 11049.9 11134.1 11255.5 11267.3 14001.2 14156.4 14160.6 14178.1 14194.6 11643.7 11687.7 11724.2 11815.4 11935.9 11047.9 11402.0 11527.3 11633.1 11913.2 10015.2 10239.1 10403.4 10404.2 10409.8 7074.4 7094.2 7107.3 7150.7 7210.7 7050.3 7106.1 7112.9 7174.8 7252.0 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#4] prototype.html Cycles:180 Average:5402.64 Median:6110.19 stddev:1519.09 (24.9%) stddev-sans-first:1478.04 11:50:00 INFO - PID 3787 | Values: 496.4 510.6 522.0 535.0 535.4 6236.3 6263.9 6289.7 6303.2 6347.6 6180.7 6203.8 6208.8 6208.9 6283.9 5107.2 5111.9 5112.1 5130.0 5140.4 4727.1 4849.3 5035.8 5079.0 5092.0 4816.6 4831.3 4835.7 4881.6 4884.8 4807.5 4809.6 4823.7 4841.8 4884.9 4196.0 4329.9 4340.5 4343.7 4381.7 5955.0 5967.8 5991.6 6034.7 6039.7 5483.5 5508.5 5514.2 5545.6 5576.3 6413.3 6430.2 6468.9 6511.5 6536.5 4614.2 4735.8 4776.9 4794.3 4816.7 6648.6 6687.7 6722.7 6849.5 6886.9 4877.8 4892.9 4910.9 4911.2 4918.6 4875.5 4892.7 4901.2 4923.5 4969.2 5484.4 5503.3 5577.5 5589.8 5600.4 6443.9 6503.5 6539.7 6548.7 6573.8 1673.4 1696.8 1707.9 1724.5 1726.5 1125.6 1174.9 1176.5 1181.7 1182.7 5639.5 5675.3 5675.7 5688.0 5740.8 6449.2 6455.9 6520.6 6580.8 6631.5 5510.2 5546.4 5573.4 5619.4 5635.2 3399.6 3497.9 3506.0 3527.2 3542.4 6265.6 6385.5 6405.7 6412.3 6419.6 6570.5 6605.2 6659.4 6692.3 6710.5 6235.8 6270.9 6323.2 6375.4 6388.4 6390.9 6460.8 6475.2 6604.3 6613.5 6493.4 6501.8 6515.9 6526.2 6528.6 5733.5 6317.7 6474.6 6486.5 6502.5 4780.7 4803.3 4805.7 4839.5 4844.2 6319.4 6450.8 6572.9 6583.4 6674.6 6299.5 6352.4 6355.2 6502.2 6518.1 6307.7 6362.0 6400.3 6404.2 6496.9 6270.4 6299.3 6315.2 6335.0 6418.7 6359.0 6405.6 6433.4 6486.4 6508.5 6229.4 6251.7 6275.0 6281.2 6333.5 11:50:00 INFO - PID 3787 | 11:50:00 INFO - PID 3787 | [#5] yui.html Cycles:180 Average:24255.28 Median:19562.00 stddev:35929.90 (183.7%) stddev-sans-first:35987.93 11:50:00 INFO - PID 3787 | Values: 911.2 923.8 931.8 932.2 938.2 19071.2 19174.7 19545.0 19579.0 19598.1 18470.7 18624.9 18654.9 18674.8 18685.9 971.4 981.4 985.4 985.9 986.6 949.5 968.8 975.4 977.4 989.6 1034.7 1043.1 1044.0 1044.2 1044.8 1030.6 1035.6 1039.5 1040.6 1040.7 721.5 742.3 750.7 751.3 751.3 19214.3 19299.9 19339.7 19347.0 19354.2 21788.7 21841.3 22335.4 22610.8 22712.1 16664.8 16727.4 16755.0 16953.9 17035.9 3687.0 3708.9 3710.6 3711.2 3715.0 141408.0 142516.0 142739.0 144767.0 147812.0 17009.0 17298.1 17396.9 17416.7 17421.0 31369.8 31875.2 32615.7 32659.5 32660.8 8668.7 8711.2 8726.9 8748.4 8751.4 4143.8 4242.2 4263.8 4289.9 4327.9 5422.2 5505.8 5517.9 5522.6 5543.2 980.0 996.8 1004.9 1016.3 1021.2 699.5 713.4 718.7 723.6 724.6 11477.4 11580.5 11597.0 12705.7 12745.1 686.5 690.5 702.9 703.9 710.9 5158.8 5174.5 5199.4 5202.8 5255.7 120773.6 122863.0 122908.4 123961.0 130009.0 107477.0 109232.0 111425.0 111435.0 111436.0 94798.5 95288.5 95635.5 95687.5 97309.5 9389.8 9432.9 9532.4 9729.4 9752.9 41618.0 42768.0 42870.0 42948.8 45191.0 53998.5 54926.7 55938.7 56445.0 57227.0 14897.6 15258.7 15270.8 15403.2 15444.2 16258.8 16269.8 16451.8 16467.7 16587.2 15062.9 15159.6 15161.2 15225.0 15347.8 14680.0 14724.4 14764.9 14866.3 14883.9 14231.6 14289.6 14369.9 14480.1 14512.1 10503.9 10858.9 10875.5 10904.6 11094.4 10485.5 10558.4 10613.2 10653.3 10667.3 11:50:00 INFO - PID 3787 | -------- Summary: end -------- 11:50:00 INFO - PID 3787 | 11:50:00 INFO - TEST-INFO | 3787: exit 0 11:50:00 INFO - TEST-OK | dromaeo_css | took 1111916ms 11:50:00 INFO - TEST-START | kraken 11:50:00 INFO - Initialising browser for kraken test... 11:50:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47430/getInfo.html -profile /tmp/tmp6DOuxL/profile 11:50:00 INFO - TEST-INFO | started process 4155 (/builds/slave/test/build/application/firefox/firefox http://localhost:47430/getInfo.html) 11:50:05 INFO - TEST-INFO | 4155: exit 0 11:50:05 INFO - Browser initialized. 11:50:05 INFO - Running cycle 1/1 for kraken test... 11:50:05 INFO - Using env: {'DISPLAY': ':0', 11:50:05 INFO - 'HOME': '/home/cltbld', 11:50:05 INFO - 'JSGC_DISABLE_POISONING': '1', 11:50:05 INFO - 'LANG': 'en_US.UTF-8', 11:50:05 INFO - 'LANGUAGE': 'en_US:en', 11:50:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:50:05 INFO - 'LOGNAME': 'cltbld', 11:50:05 INFO - 'MAIL': '/var/mail/cltbld', 11:50:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:05 INFO - 'MOZ_CRASHREPORTER': '1', 11:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:50:05 INFO - 'MOZ_NO_REMOTE': '1', 11:50:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:05 INFO - 'NO_EM_RESTART': '1', 11:50:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:05 INFO - 'PWD': '/builds/slave/test', 11:50:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:05 INFO - 'RUST_BACKTRACE': 'full', 11:50:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:50:05 INFO - 'SHELL': '/bin/bash', 11:50:05 INFO - 'SHLVL': '1', 11:50:05 INFO - 'TERM': 'linux', 11:50:05 INFO - 'TMOUT': '86400', 11:50:05 INFO - 'USER': 'cltbld', 11:50:05 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747', 11:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:05 INFO - '_': '/tools/buildbot/bin/python'} 11:50:05 INFO - TEST-INFO | started process 4381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6DOuxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:06 INFO - PID 4381 | 11:50:06 INFO - PID 4381 | (/builds/slave/test/build/application/firefox/firefox:4430): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:50:06 INFO - PID 4381 | 11:50:17 INFO - PID 4381 | RSS: Main: 157118464 11:50:17 INFO - PID 4381 | 11:50:19 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47430/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:20 INFO - PID 4381 | RSS: Main: 162058240 11:50:20 INFO - PID 4381 | 11:50:23 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47430/tests/kraken/driver.html?testName=audio-dft) 11:50:23 INFO - PID 4381 | RSS: Main: 162291712 11:50:23 INFO - PID 4381 | 11:50:26 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47430/tests/kraken/driver.html?testName=audio-fft) 11:50:27 INFO - PID 4381 | RSS: Main: 158785536 11:50:27 INFO - PID 4381 | 11:50:29 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47430/tests/kraken/driver.html?testName=audio-oscillator) 11:50:30 INFO - PID 4381 | RSS: Main: 158683136 11:50:30 INFO - PID 4381 | 11:50:32 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:32 INFO - PID 4381 | RSS: Main: 159240192 11:50:32 INFO - PID 4381 | 11:50:36 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47430/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:36 INFO - PID 4381 | RSS: Main: 161771520 11:50:36 INFO - PID 4381 | 11:50:40 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47430/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:41 INFO - PID 4381 | RSS: Main: 161693696 11:50:41 INFO - PID 4381 | 11:50:44 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47430/tests/kraken/driver.html?testName=json-parse-financial) 11:50:44 INFO - PID 4381 | RSS: Main: 162013184 11:50:44 INFO - PID 4381 | 11:50:46 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:46 INFO - PID 4381 | RSS: Main: 161845248 11:50:46 INFO - PID 4381 | 11:50:48 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:49 INFO - PID 4381 | RSS: Main: 162283520 11:50:49 INFO - PID 4381 | 11:50:51 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:51 INFO - PID 4381 | RSS: Main: 159084544 11:50:51 INFO - PID 4381 | 11:50:54 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:55 INFO - PID 4381 | RSS: Main: 159387648 11:50:55 INFO - PID 4381 | 11:50:57 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:58 INFO - PID 4381 | RSS: Main: 159449088 11:50:58 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | Cycle 1(1): loaded http://localhost:47430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47430/tests/kraken/driver.html?testName=ai-astar) 11:51:00 INFO - PID 4381 | RSS: Main: 160862208 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | __start_tp_report 11:51:00 INFO - PID 4381 | _x_x_mozilla_page_load 11:51:00 INFO - PID 4381 | _x_x_mozilla_page_load_details 11:51:00 INFO - PID 4381 | |i|pagename|runs| 11:51:00 INFO - PID 4381 | |0;ai-astar;106;106;106;108;106;108;106;105;106;105 11:51:00 INFO - PID 4381 | |1;audio-beat-detection;118;119;116;116;115;114;115;120;118;127 11:51:00 INFO - PID 4381 | |2;audio-dft;162;166;164;161;163;164;163;165;166;163 11:51:00 INFO - PID 4381 | |3;audio-fft;75;74;78;74;89;76;73;73;75;74 11:51:00 INFO - PID 4381 | |4;audio-oscillator;79;79;79;78;81;81;81;78;78;78 11:51:00 INFO - PID 4381 | |5;imaging-gaussian-blur;113;114;113;114;113;113;113;113;114;114 11:51:00 INFO - PID 4381 | |6;imaging-darkroom;160;147;156;147;148;148;149;149;148;150 11:51:00 INFO - PID 4381 | |7;imaging-desaturate;93;93;94;93;95;95;95;94;95;95 11:51:00 INFO - PID 4381 | |8;json-parse-financial;55;56;55;55;56;54;56;56;52;52 11:51:00 INFO - PID 4381 | |9;json-stringify-tinderbox;38;38;39;38;39;38;38;38;38;38 11:51:00 INFO - PID 4381 | |10;stanford-crypto-aes;74;73;73;73;73;73;75;74;75;74 11:51:00 INFO - PID 4381 | |11;stanford-crypto-ccm;110;114;109;109;111;111;111;109;117;108 11:51:00 INFO - PID 4381 | |12;stanford-crypto-pbkdf2;173;170;163;169;173;172;164;168;168;166 11:51:00 INFO - PID 4381 | |13;stanford-crypto-sha256-iterative;64;69;63;63;63;71;73;70;65;65 11:51:00 INFO - PID 4381 | __end_tp_report 11:51:00 INFO - PID 4381 | __start_cc_report 11:51:00 INFO - PID 4381 | _x_x_mozilla_cycle_collect,789 11:51:00 INFO - PID 4381 | __end_cc_report 11:51:00 INFO - PID 4381 | __startTimestamp1505674260605__endTimestamp 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | ------- Summary: start ------- 11:51:00 INFO - PID 4381 | Number of tests: 14 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.00 stddev:1.03 (1.0%) stddev-sans-first:1.09 11:51:00 INFO - PID 4381 | Values: 106.0 106.0 106.0 108.0 106.0 108.0 106.0 105.0 106.0 105.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:118.00 stddev:3.77 (3.2%) stddev-sans-first:3.99 11:51:00 INFO - PID 4381 | Values: 118.0 119.0 116.0 116.0 115.0 114.0 115.0 120.0 118.0 127.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.64 (1.0%) stddev-sans-first:1.62 11:51:00 INFO - PID 4381 | Values: 162.0 166.0 164.0 161.0 163.0 164.0 163.0 165.0 166.0 163.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#3] audio-fft Cycles:10 Average:76.10 Median:75.00 stddev:4.77 (6.4%) stddev-sans-first:5.04 11:51:00 INFO - PID 4381 | Values: 75.0 74.0 78.0 74.0 89.0 76.0 73.0 73.0 75.0 74.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.00 stddev:1.32 (1.7%) stddev-sans-first:1.39 11:51:00 INFO - PID 4381 | Values: 79.0 79.0 79.0 78.0 81.0 81.0 81.0 78.0 78.0 78.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:51:00 INFO - PID 4381 | Values: 113.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 114.0 114.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:149.00 stddev:4.32 (2.9%) stddev-sans-first:2.76 11:51:00 INFO - PID 4381 | Values: 160.0 147.0 156.0 147.0 148.0 148.0 149.0 149.0 148.0 150.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 11:51:00 INFO - PID 4381 | Values: 93.0 93.0 94.0 93.0 95.0 95.0 95.0 94.0 95.0 95.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:1.57 (2.8%) stddev-sans-first:1.66 11:51:00 INFO - PID 4381 | Values: 55.0 56.0 55.0 55.0 56.0 54.0 56.0 56.0 52.0 52.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 11:51:00 INFO - PID 4381 | Values: 38.0 38.0 39.0 38.0 39.0 38.0 38.0 38.0 38.0 38.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 11:51:00 INFO - PID 4381 | Values: 74.0 73.0 73.0 73.0 73.0 73.0 75.0 74.0 75.0 74.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#11] stanford-crypto-ccm Cycles:10 Average:110.90 Median:111.00 stddev:2.73 (2.5%) stddev-sans-first:2.87 11:51:00 INFO - PID 4381 | Values: 110.0 114.0 109.0 109.0 111.0 111.0 111.0 109.0 117.0 108.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.50 stddev:3.53 (2.1%) stddev-sans-first:3.37 11:51:00 INFO - PID 4381 | Values: 173.0 170.0 163.0 169.0 173.0 172.0 164.0 168.0 168.0 166.0 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:3.78 (5.6%) stddev-sans-first:3.89 11:51:00 INFO - PID 4381 | Values: 64.0 69.0 63.0 63.0 63.0 71.0 73.0 70.0 65.0 65.0 11:51:00 INFO - PID 4381 | -------- Summary: end -------- 11:51:00 INFO - PID 4381 | 11:51:00 INFO - PID 4381 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:51:01 INFO - TEST-INFO | 4381: exit 0 11:51:01 INFO - TEST-OK | kraken | took 60465ms 11:51:01 INFO - SUITE-END | took 1172s 11:51:01 INFO - Completed test suite (00:19:32) 11:51:01 INFO - javascript benchmark 11:51:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8380.687991064988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.763917706172, 3148.165736079939, 3167.049885034489, 3170.0172946386615, 3170.3817755537666, 6185.350538193492, 6230.252369715629, 6236.438720515159, 6303.495720342373, 6350.904736428945, 6166.938330616693, 6214.5649804513705, 6215.3784621537825, 6218.502519798417, 6243.937560624392, 5762.711864406784, 5829.475347218749, 5850.824475265749, 5853.443922827325, 5863.325717542473, 48.89234261240796, 5793.420657934215, 5850.853728656796, 5873.7356818943035, 5882.617629854046, 5352.759125839327, 5689.345725241609, 5691.658500489963, 5848.91226631603, 5854.97072514639, 5743.540516758691, 5785.537157027427, 5839.328477225088, 5856.76572937082, 5858.209141765849, 5724.0, 5731.627444216113, 5803.129530570406, 5816.0, 5818.912716309259, 6191.504679625619, 6194.287656919467, 6229.190205273331, 6283.088952101965, 6350.26971898233, 6714.160729908762, 6715.6977935993, 6771.085903403076, 6784.8303792405095, 6815.693293801791, 6622.569532980389, 6731.427828634572, 6733.259341472434, 6739.6293203873765, 6739.6293203873765, 6115.847103822395, 6146.446819786196, 6192.318844927055, 6196.1944947157035, 6201.658908760016, 6897.172339319314, 6956.373926346653, 6986.615736134561, 6986.965065174743, 6989.825254368579, 6582.144321238304, 6585.078089067534, 6636.170478690164, 6658.334166583303, 6667.233268174125, 6519.771807986698, 6661.733530658719, 6662.600243985376, 6698.732050718014, 6784.3554862288, 6619.404253617197, 6679.0315404267085, 6697.464202863759, 6697.6986035628515, 6699.497537684693, 6667.999800029937, 6708.893032649656, 6731.49513786468, 6770.221424536143, 6780.898286525706, 5266.526012658879, 5267.209918512177, 5317.096093664087, 5333.893322133536, 5341.973290133602, 4576.244919588231, 4595.058013107305, 4625.1443482955765, 4661.650376221729, 4666.673332866734, 5778.27771528559, 5781.624194427349, 5843.357230704619, 5847.619904706181, 5848.912266316009, 6762.628055456898, 6789.592624442549, 6824.692888819915, 6826.829329266709, 6837.042814006043, 5824.592278540462, 5831.591788574759, 5893.911591326134, 5901.940980590225, 5904.881902361929, 5736.0, 5781.103928891029, 5781.479666830005, 5856.12158176277, 5859.53123750099, 6574.572652777554, 6588.4729221662155, 6589.86820263592, 6594.538382313192, 6594.934050659528, 6706.765263215764, 6747.966260168668, 6755.560888542327, 6761.797146085625, 6765.695543700447, 6559.0, 6627.502937279627, 6638.668066596748, 6641.103451034049, 6641.734330626721, 6580.868382632225, 6587.63767992765, 6592.505562082767, 6681.365270299314, 6687.966560167168, 6613.603183808987, 6706.83232919181, 6713.530052896445, 6719.731210751711, 6736.360045795642, 6397.0, 6456.935430645822, 6482.611043337415, 6483.805485835433, 6500.772472963424, 6503.674816259263, 6522.34776522344, 6543.934560654333, 6549.050387693663, 6565.179352580927, 6395.232572091379, 6401.935980640134, 6470.320616335217, 6487.0593763903025, 6496.0, 6553.377429144223, 6578.736850525926, 6614.437772789174, 6636.037774522763, 6643.50173736962, 6346.174997250328, 6426.903596445964, 6438.484921206198, 6441.516886233458, 6461.127747753993], "value": 6089.5070808779765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.6889450903163, 865.8225063861909, 887.1173182683231, 889.6930558957162, 892.741105079527, 39109.0, 39808.40287395684, 40161.397579036304, 40256.59743402565, 40407.19185616286, 37099.25801483969, 40317.79841100798, 40576.0, 40761.796191019006, 41015.58984410155, 7632.236776322379, 7746.535207887545, 7753.651085701129, 7755.224477552256, 7764.068311802564, 7673.424493163036, 7824.491408058487, 7825.8826117608, 7827.6477558510005, 7827.7651670449695, 7813.140554538996, 7843.64703588337, 7844.4901081429525, 7847.0, 7851.5681637509915, 7716.151223365426, 7793.922060779433, 7794.883076753853, 7813.609319534029, 7814.0, 7641.617919104023, 7676.9636099126465, 7680.5391676499585, 7702.306792388712, 7709.267619576131, 36958.8152059238, 37100.25799484022, 37259.25481490382, 37287.25425491475, 37324.25351492955, 3536.098294934801, 3550.928981420383, 3573.6605022522817, 3576.46353047045, 3579.785212887235, 30694.53958190629, 30696.2325941851, 30785.38429231425, 30800.0, 30813.229669258224, 4966.627502937258, 5179.378474583036, 5200.167973124319, 5243.86890327741, 5270.657407268515, 174322.0, 175013.0, 175977.0, 176070.0, 176301.0, 45884.0, 46034.0, 46109.30836037462, 46129.538704613195, 46919.76540117278, 48374.516254837705, 48486.51513484891, 48494.0, 48589.0, 48630.270545941836, 15049.097054176784, 15259.389624414898, 15311.846881531264, 16045.0, 16218.270177842025, 12438.0, 12522.561710340276, 12532.122751407314, 12542.623721288375, 12551.560695375618, 14012.299385030912, 14083.788743168861, 14172.149671019772, 14226.430942762174, 14343.497977570734, 5659.377468478464, 5783.450572195718, 5812.854678632983, 5914.940850591439, 5956.463918247378, 977.5258999385293, 1012.7974405119006, 1020.5356562763925, 1033.720895358249, 1044.3785947361307, 22985.540289194123, 23008.53982920332, 23217.53564928692, 23253.302400927998, 23311.300660979858, 1117.3854380090918, 1117.6870476266658, 1120.6469961961957, 1123.1576317761678, 1133.7052366384635, 12166.756664866652, 12170.782921707758, 12280.692982675504, 12358.320292384005, 12406.875931240573, 235846.0, 236337.0, 236862.0, 236865.0, 237319.0, 50986.74506627443, 53461.73269133629, 53931.999999999214, 54122.72938635282, 54141.45858541443, 1432.9211893345966, 1436.5403071017383, 1453.6801903581195, 1454.1275234859, 1457.234951650392, 26291.0, 26518.204453866416, 26624.06815761439, 26736.331591710365, 26914.192574222805, 36181.27637447289, 36582.63417365792, 36587.81706091452, 36592.63407365892, 36673.44989825208, 201493.0, 202777.0, 203339.0, 204118.0, 204206.0, 34023.0, 34191.14522136966, 34238.14404639904, 34331.82834085914, 34544.30911381708, 40859.38710919398, 40992.1801563973, 41817.1636567273, 41856.74429767112, 42314.15371692611, 30543.0, 30614.84692576523, 31270.218244544067, 31556.0, 31839.204019899687, 30122.849385752932, 30734.0, 30863.0, 31180.22049448691, 31184.532232016085, 34649.653503464644, 34847.25763711855, 34929.47605785966, 34987.65012349946, 35053.123671908405, 30170.84914575413, 30393.0, 30482.695173048873, 30491.2377190572, 30710.078697639106, 22740.545189095796, 22846.0, 22888.0, 22949.54100917939, 23036.0], "value": 17019.707458184406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.4695304695305, 537.2559005777002, 542.514449567637, 563.887222555489, 587.553459370878, 21224.0, 22032.33902982909, 22115.225967091155, 22125.778742212595, 22135.0, 23051.654225186634, 23901.641475377884, 24083.277501674933, 24168.637470437956, 24259.39351516213, 6154.661493617849, 6565.4419374353, 6602.207735071798, 6603.306652801459, 6606.768763093292, 6506.349365063503, 6618.768343107992, 6621.238557565869, 6623.701933412984, 6629.602223866584, 6093.146959425684, 6324.083007963843, 6354.3010268870385, 6357.904631430532, 6591.670416479181, 6415.615063096183, 6424.100625912352, 6447.129637498924, 6464.095026696243, 6467.029945508164, 5822.359540450547, 5981.0, 6046.820869930365, 6056.303525094582, 6059.363766804466, 27683.0, 28262.576061359097, 28266.57600135979, 28272.717272827213, 28280.717192828015, 2012.154894944127, 2044.2231951858348, 2044.5910817836343, 2050.589882023601, 2051.9076641551164, 18702.812971870244, 19038.143283552134, 19308.0, 19315.130819113172, 19413.902930485398, 2416.5891798394314, 2440.6095024795945, 2450.889709963056, 2478.7397323281157, 2480.3055144559553, 117618.0, 122288.0, 125874.37062814628, 133100.0, 133533.99999999904, 14276.57170284893, 14422.927885360506, 14573.248154908315, 14746.705065898623, 14836.10983341003, 22626.886865565895, 22630.547389052128, 22660.773392265866, 22669.886650566972, 22710.205142820254, 9311.208547273558, 9364.859527107099, 9415.246780257563, 9467.0, 9616.08647178517, 8344.707935222237, 8387.203215694499, 8441.324694024586, 8559.74320770378, 8570.142985701505, 8927.866082008775, 8929.821403571892, 8972.327075469366, 9020.323475739346, 9069.274458043341, 2688.4085501189707, 2689.838609683425, 2693.7979651526216, 2708.91873243803, 2763.9170824875287, 949.6201519392298, 968.6100445860213, 979.1285755677453, 981.7398389426808, 985.1527686189871, 18745.250189992246, 18750.53123671919, 18956.620867582846, 19232.519187020156, 19287.228510859688, 1032.4373216596973, 1043.8486419469134, 1044.0968562193648, 1044.09685621938, 1044.2272718188485, 10513.474326283655, 10546.894531054744, 10625.893741062646, 10698.03717665414, 10743.462826858626, 470828.93756593677, 475970.0, 488474.0, 489054.0, 492798.0, 105596.47201763942, 106710.0, 107502.46248768707, 108997.45501272443, 112185.0, 1144.4106285263097, 1159.907207423404, 1181.7782568770656, 1186.5194596188558, 1186.7389174381622, 16614.0, 16828.242729077465, 17173.0, 17325.913370433067, 17447.0, 53615.46384536261, 53715.0, 54034.45965540294, 54796.178057328376, 55146.72426638001, 68049.3195068043, 68796.0, 68806.0, 68890.31109688838, 69243.30756692369, 13701.520446784314, 14000.299985000505, 14117.223552704289, 14129.858701413266, 14154.150750954976, 21775.455613609785, 21808.67286990728, 21871.67192492082, 21981.560368792856, 22010.88994555017, 17511.21199545998, 17657.64684706273, 17763.289468421637, 17829.554261143574, 17834.5541361467, 14182.078164919247, 15616.0, 15857.841421585637, 16121.0, 16399.26203320877, 17854.19656115452, 17963.550911227325, 17988.2804687811, 18327.0, 18330.358437454626, 13671.931640341734, 13701.588952331047, 13828.792568111285, 13907.235102069484, 13936.860631393556, 16983.57541061434, 17080.145992700564, 17187.742183867504, 17221.913890430467, 17402.564935876704], "value": 11577.96270485709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.0794851552428, 1377.1668140774834, 1395.4557722488237, 1403.158105136918, 1407.366684991754, 15179.2410379481, 15687.686246275081, 15783.447579334712, 15792.605184870385, 15823.129727864964, 15403.84596154038, 15579.610509737262, 15607.921960390182, 15620.609484762886, 15656.921715391407, 2697.5144473994674, 2809.4100238949845, 2813.22636275024, 2815.366542527925, 2818.7181281871854, 2544.5165418570414, 2619.4499155177436, 2622.2133359991926, 2642.2205449392477, 2643.3259518822674, 2245.0682966568857, 2318.2349824557855, 2736.192823117175, 2828.9575656365173, 2833.489971805074, 2668.746469085434, 2750.931226719328, 2754.380264440505, 2754.903578374757, 2768.5155097857896, 2496.700395952479, 2519.6220566914926, 2520.193538067819, 2522.066835270943, 2523.621456781479, 14866.776998345034, 14970.700585988328, 15005.174715390649, 15011.174385408798, 15011.849881501264, 7787.0, 7836.294733473957, 8082.43422960393, 8155.062167850714, 8279.461834980768, 5237.554807841338, 5489.313835770528, 5603.551715862721, 5656.632318899258, 5679.375268720438, 1856.2946080489462, 1878.9530261743566, 1901.1159810688096, 1951.3267922566693, 1972.891490967996, 26134.085307014353, 26383.472330553283, 26785.866070669716, 27608.861955690292, 27661.0, 6788.389044985975, 6809.31906809325, 6896.241413444617, 6983.546069505466, 7067.752628657972, 17276.740848887275, 17331.133443327784, 17343.913280433517, 17415.73876391855, 17452.65094698099, 7818.0, 7971.963644726148, 7988.121306656263, 8011.639476223468, 8014.398920080901, 7368.226336234618, 7404.518706284074, 7422.6288685565505, 7499.362554182955, 7517.0, 5016.54851063406, 5117.769700363493, 5146.4853514648985, 5162.948370516322, 5173.3533308336455, 1481.8147731533559, 1499.7825315329217, 1505.1646336283468, 1512.3345727879919, 1526.6717655704076, 871.1854416120947, 904.556767184075, 905.6377449020445, 907.0340087806464, 915.7390143808982, 7537.54774713519, 7555.357794587521, 7627.847443051219, 7665.233476652402, 7717.0, 685.3112621815044, 707.5259576084036, 708.2810946888912, 710.9502334836616, 716.0655344775014, 4871.732054737024, 4986.077575648516, 5032.672876263031, 5064.5441910228255, 5150.562202212854, 20724.58550828975, 22040.33878983633, 22059.22792702248, 22067.66898496524, 22075.889620551796, 20791.168353266003, 21466.0, 21485.743996880414, 21524.0, 21575.35273941784, 9354.906450935676, 9592.424454532751, 9888.752781180385, 10836.512356943957, 11054.281471704313, 8706.390552661253, 9109.18017378439, 9275.72172834816, 9284.767880803034, 9292.72121836319, 18640.440786776417, 19016.71474927905, 19237.230510779413, 19314.32399865998, 19318.03409829531, 18959.241630335186, 19187.61624767469, 19225.615487690447, 19232.61534769269, 19318.710219347002, 11042.779144416905, 11049.889501104886, 11134.109271258441, 11255.549778008788, 11267.323960562393, 14001.159930404208, 14156.43374265059, 14160.575182744535, 14178.14931104137, 14194.574162775134, 11643.650690479299, 11687.707807304885, 11724.237924534878, 11815.40922953866, 11935.940320298343, 11047.889521104686, 11401.973822356027, 11527.308361498337, 11633.127515436207, 11913.166078374777, 10015.248856335658, 10239.078482936273, 10403.427811470441, 10404.219683523917, 10409.791804164026, 7074.398676112588, 7094.219635840157, 7107.289271072851, 7150.7497237596435, 7210.71157153708, 7050.25972272904, 7106.111736032996, 7112.928870711226, 7174.820629484305, 7252.0], "value": 6620.1988143857225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.39935677829845, 510.5864249957536, 521.9582433405328, 534.9652272602281, 535.4244187498438, 6236.282827474842, 6263.906041409371, 6289.716962736677, 6303.212098487689, 6347.619142851432, 6180.721867515961, 6203.813885583429, 6208.844778880519, 6208.906866397007, 6283.874322513547, 5107.182850743881, 5111.948880511184, 5112.130937740574, 5130.0, 5140.408852981899, 4727.149113159629, 4849.321095046696, 5035.798568057273, 5078.974605126988, 5091.974540127294, 4816.590589799854, 4831.275308703705, 4835.709857408549, 4881.560659540641, 4884.82625231772, 4807.4952130026195, 4809.639277054217, 4823.734694591796, 4841.7579121044155, 4884.853454396374, 4196.034911970233, 4329.891752706176, 4340.52254252032, 4343.6959412841115, 4381.671374646882, 5954.97022514889, 5967.761289548413, 5991.55063370249, 6034.668093254869, 6039.667818269993, 5483.519449748585, 5508.504234618904, 5514.228008078872, 5545.639533430314, 5576.323364784886, 6413.262474815409, 6430.234998950449, 6468.870622587522, 6511.479081673455, 6536.54244202906, 4614.215583350839, 4735.810567577293, 4776.880577985544, 4794.256890181992, 4816.686915350526, 6648.637029408959, 6687.683291783044, 6722.731090756412, 6849.452043836481, 6886.8622627547165, 4877.829275975324, 4892.877678058006, 4910.926336104962, 4911.238757992445, 4918.622785620032, 4875.512448755097, 4892.68197567157, 4901.166801643729, 4923.532264434873, 4969.155243608523, 5484.424135465799, 5503.257060296809, 5577.52591029767, 5589.801484619262, 5600.383957764642, 6443.935560644427, 6503.544751867324, 6539.738410463623, 6548.738050478023, 6573.769918052845, 1673.4143049932427, 1696.7963844338512, 1707.9146042697816, 1724.4998950304523, 1726.5165753589015, 1125.6341688951125, 1174.900133488663, 1176.5235079792697, 1181.722295260613, 1182.6570294614637, 5639.464250896158, 5675.26904294186, 5675.716214189274, 5687.971560142256, 5740.827775166752, 6449.226092868886, 6455.870882582322, 6520.576162549419, 6580.76967306142, 6631.469482441393, 5510.173473978935, 5546.417626149197, 5573.386927437979, 5619.353774316006, 5635.168570214697, 3399.558057452515, 3497.9300413992087, 3506.0358401439807, 3527.188746588299, 3542.415501442233, 6265.592736472206, 6385.48916086712, 6405.743770249138, 6412.326705695835, 6419.646919419383, 6570.474362051024, 6605.174353205849, 6659.4006539411685, 6692.263850976388, 6710.496712746563, 6235.846368421857, 6270.9372906270355, 6323.197888601727, 6375.362463753588, 6388.361163883575, 6390.936090639034, 6460.773872914426, 6475.158229430144, 6604.273529911802, 6613.470922326106, 6493.350664933469, 6501.804945851632, 6515.902261465987, 6526.24948130971, 6528.640924749185, 5733.483986441241, 6317.7157027932935, 6474.643894585843, 6486.481081513562, 6502.544821862424, 4780.713157210578, 4803.303520989507, 4805.735684537384, 4839.491853355347, 4844.224924012141, 6319.409042292638, 6450.774352873127, 6572.868542629025, 6583.44040756541, 6674.566153200027, 6299.503775404694, 6352.42726695689, 6355.173827402408, 6502.154719886574, 6518.120053792867, 6307.7107566854975, 6362.0, 6400.327965563735, 6404.231492220777, 6496.935030649633, 6270.404311590391, 6299.338569450142, 6315.242170939517, 6334.968325158345, 6418.684169745285, 6358.968205158944, 6405.647689377129, 6433.420992110732, 6486.448651864455, 6508.479321654161, 6229.3770622939155, 6251.68741562911, 6275.0, 6281.183446151971, 6333.493320534439], "value": 4956.761275379133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.1753862754208, 923.7829110159107, 931.8089791592724, 932.1843387036344, 938.2259635800466, 19071.237150513996, 19174.712379314322, 19545.0, 19579.0, 19598.118084686186, 18470.722939155923, 18624.906875465604, 18654.906725466386, 18674.813251867476, 18685.906570467163, 971.3637567393368, 981.3866333541537, 985.438300168904, 985.8669079674224, 986.556049777603, 949.539473355422, 968.7771812483134, 975.3903810118676, 977.359829311802, 989.6338354808731, 1034.7361422837166, 1043.0560342889696, 1043.9791204175913, 1044.1594516414284, 1044.770150566874, 1030.6083688198437, 1035.5650626736751, 1039.532210505272, 1040.5681642118511, 1040.6773900090996, 721.520189074265, 742.3059439424102, 750.7297372945735, 751.3087959077661, 751.3163021650327, 19214.327498537485, 19299.90350048255, 19339.709904351446, 19347.0, 19354.225830966745, 21788.673169902464, 21841.344759657237, 22335.44161395978, 22610.773892261197, 22712.091516339326, 16664.83335166645, 16727.414540491023, 16755.0, 16953.91523042377, 17035.914820425944, 3687.0, 3708.870189543353, 3710.6474884885893, 3711.2391959648207, 3715.034091136324, 141408.0, 142516.0, 142739.0, 144767.0, 147812.0, 17009.0, 17298.135093245288, 17396.913015435093, 17416.65166696684, 17421.0, 31369.843150784556, 31875.203119921724, 32615.67384326174, 32659.510107348407, 32660.836695816368, 8668.739937801876, 8711.172438618321, 8726.912730872737, 8748.387612867038, 8751.431156974777, 4143.81352839123, 4242.193983143193, 4263.76549289792, 4289.914201715948, 4327.870163895088, 5422.15956526739, 5505.752241149158, 5517.889642207133, 5522.646951496909, 5543.196236545678, 980.0, 996.8255555277942, 1004.9397036177853, 1016.2885979814012, 1021.1677482851452, 699.4684040129538, 713.3793599568409, 718.741253148866, 723.5984028863926, 724.6304384763808, 11477.426128693533, 11580.536778528765, 11597.0, 12705.745885082246, 12745.10784245094, 686.4782765098461, 690.4602735898974, 702.9015937768717, 703.8979347994615, 710.9146902371645, 5158.819441319536, 5174.508421699932, 5199.350081239845, 5202.791888324425, 5255.710935898563, 120773.58452830894, 122863.0, 122908.38545807214, 123961.0, 130009.0, 107477.0, 109232.0, 111425.0, 111435.0, 111436.0, 94798.52600736952, 95288.52355738176, 95635.52182239183, 95687.52156239313, 97309.51345243228, 9389.765255868659, 9432.905670943477, 9532.380395274562, 9729.416235025921, 9752.853707194256, 41618.0, 42768.0, 42870.0, 42948.78525607352, 45191.0, 53998.46001540092, 54926.72536637291, 55938.72030639821, 56445.0, 57227.0, 14897.627559311104, 15258.694826103638, 15270.847291527387, 15403.152826594196, 15444.2277886103, 16258.837411625733, 16269.837301626832, 16451.83548164551, 16467.67064658676, 16587.17064146812, 15062.924685376503, 15159.621009474851, 15161.24193790284, 15225.0, 15347.769783453034, 14680.04579702316, 14724.411023559365, 14764.926175369055, 14866.256687165382, 14883.851161488246, 14231.573052808433, 14289.571312860631, 14369.928150359181, 14480.131192128507, 14512.1292722437, 10503.94748026255, 10858.891411085788, 10875.510602023087, 10904.61833835812, 11094.389808560607, 10485.528151233366, 10558.419286939292, 10613.150947923994, 10653.307535010199, 10667.306625069346], "value": 8798.66190887133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1413.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 106.0, 108.0, 106.0, 108.0, 106.0, 105.0, 106.0, 105.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 116.0, 116.0, 115.0, 114.0, 115.0, 120.0, 118.0, 127.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 161.0, 163.0, 164.0, 163.0, 165.0, 166.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 74.0, 89.0, 76.0, 73.0, 73.0, 75.0, 74.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 81.0, 81.0, 81.0, 78.0, 78.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 147.0, 156.0, 147.0, 148.0, 148.0, 149.0, 149.0, 148.0, 150.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 56.0, 54.0, 56.0, 56.0, 52.0, 52.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 73.0, 75.0, 74.0, 75.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 109.0, 109.0, 111.0, 111.0, 111.0, 109.0, 117.0, 108.0], "value": 110.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 163.0, 169.0, 173.0, 172.0, 164.0, 168.0, 168.0, 166.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 63.0, 63.0, 63.0, 71.0, 73.0, 70.0, 65.0, 65.0], "value": 66.6, "unit": "score"}]}]} 11:51:01 INFO - Return code: 0 11:51:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:01 INFO - # TBPL SUCCESS # 11:51:01 INFO - Running post-action listener: _package_coverage_data 11:51:01 INFO - Running post-action listener: _resource_record_post_action 11:51:01 INFO - [mozharness: 2017-09-17 18:51:01.413482Z] Finished run-tests step (success) 11:51:01 INFO - Running post-run listener: _resource_record_post_run 11:51:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 9445376; Write bytes: 464764928; Read time: 3036; Write time: 499440 11:51:01 INFO - TinderboxPrint: CPU usage
13.1% 11:51:01 INFO - TinderboxPrint: I/O read bytes / time
9,445,376 / 3,036 11:51:01 INFO - TinderboxPrint: I/O write bytes / time
464,764,928 / 499,440 11:51:01 INFO - TinderboxPrint: CPU idle
8,249.6 (86.9%) 11:51:01 INFO - TinderboxPrint: CPU user
1,189.4 (12.5%) 11:51:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12447744; Read time: 0; Write time: 2068 11:51:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:51:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6950912; Write bytes: 449937408; Read time: 2344; Write time: 496380 11:51:02 INFO - Running post-run listener: _upload_blobber_files 11:51:02 INFO - Blob upload gear active. 11:51:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:02 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 11:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:03 INFO - (blobuploader) - INFO - Done attempting. 11:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:04 INFO - (blobuploader) - INFO - Done attempting. 11:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:11 INFO - (blobuploader) - INFO - Done attempting. 11:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:12 INFO - (blobuploader) - INFO - Done attempting. 11:51:12 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:12 INFO - Return code: 0 11:51:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42b26533074998c3dfe0f287e2a8857d28c93ddc322435ca54672e9dc70c0e247aeac1c137fe8100799238963fc0b7a09798cc1ad165c919283adcdfde874509", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad6bb3dbd217cacbd52b52c22ee3ce3e31733737f769dcb5ce60a3aae1cf3a32e7168cc9a85985c81b02f597346a70ad43394d4019e94231f84d8105ea590745", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aef775f1413f3be6fbc37a34de28f05ef3334abe362cc93888ebbc3dc6ef1511c2456fd2abfb22075001b2879e6652cdc398df988b9f1c4cbab5dd8e022e3d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a23b687fe4977167c084e328484d489b4c222b7d24ba607ab42bba70f378b8feaa75aa8126902ff79d0085a8c98eb084bf6d5e07228183910da6a1b1b49cd7e"} 11:51:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:12 INFO - Contents: 11:51:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42b26533074998c3dfe0f287e2a8857d28c93ddc322435ca54672e9dc70c0e247aeac1c137fe8100799238963fc0b7a09798cc1ad165c919283adcdfde874509", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad6bb3dbd217cacbd52b52c22ee3ce3e31733737f769dcb5ce60a3aae1cf3a32e7168cc9a85985c81b02f597346a70ad43394d4019e94231f84d8105ea590745", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aef775f1413f3be6fbc37a34de28f05ef3334abe362cc93888ebbc3dc6ef1511c2456fd2abfb22075001b2879e6652cdc398df988b9f1c4cbab5dd8e022e3d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a23b687fe4977167c084e328484d489b4c222b7d24ba607ab42bba70f378b8feaa75aa8126902ff79d0085a8c98eb084bf6d5e07228183910da6a1b1b49cd7e"} 11:51:12 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:12 INFO - Copying logs to upload dir... 11:51:12 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.923303 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-17 11:51:12.564777) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 11:51:12.569782) ========= 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=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42b26533074998c3dfe0f287e2a8857d28c93ddc322435ca54672e9dc70c0e247aeac1c137fe8100799238963fc0b7a09798cc1ad165c919283adcdfde874509", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad6bb3dbd217cacbd52b52c22ee3ce3e31733737f769dcb5ce60a3aae1cf3a32e7168cc9a85985c81b02f597346a70ad43394d4019e94231f84d8105ea590745", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aef775f1413f3be6fbc37a34de28f05ef3334abe362cc93888ebbc3dc6ef1511c2456fd2abfb22075001b2879e6652cdc398df988b9f1c4cbab5dd8e022e3d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a23b687fe4977167c084e328484d489b4c222b7d24ba607ab42bba70f378b8feaa75aa8126902ff79d0085a8c98eb084bf6d5e07228183910da6a1b1b49cd7e"} build_url:https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/BAsmZyBYTdem8SXBoYX9ag/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/42b26533074998c3dfe0f287e2a8857d28c93ddc322435ca54672e9dc70c0e247aeac1c137fe8100799238963fc0b7a09798cc1ad165c919283adcdfde874509", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad6bb3dbd217cacbd52b52c22ee3ce3e31733737f769dcb5ce60a3aae1cf3a32e7168cc9a85985c81b02f597346a70ad43394d4019e94231f84d8105ea590745", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aef775f1413f3be6fbc37a34de28f05ef3334abe362cc93888ebbc3dc6ef1511c2456fd2abfb22075001b2879e6652cdc398df988b9f1c4cbab5dd8e022e3d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a23b687fe4977167c084e328484d489b4c222b7d24ba607ab42bba70f378b8feaa75aa8126902ff79d0085a8c98eb084bf6d5e07228183910da6a1b1b49cd7e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 11:51:12.600234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:51:12.600561) ========= 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=62c568580acbfdaac3eec7be000001dc-1505670066.1889-2022280747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 11:51:12.680286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 11:51:12.683791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 11:51:12.684236) ========= ========= Total master_lag: 0.30 =========