builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1504864021.38 results: success (0) revision: fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.384352) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.384851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.385160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.407167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.407571) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 02:47:01-- 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% 50.2M=0s 2017-09-08 02:47:01 (50.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180991 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.628190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.628674) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013586 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:01.682140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-08 02:47:01.682546) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa --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 fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa --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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 02:47:01,688 truncating revision to first 12 chars 2017-09-08 02:47:01,688 Setting DEBUG logging. 2017-09-08 02:47:01,688 attempt 1/10 2017-09-08 02:47:01,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd1ab37308c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 02:47:02,292 unpacking tar archive at: mozilla-central-fd1ab37308c5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929835 ========= master_lag: 1.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-08 02:47:03.697821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:03.702325) ========= script_repo_revision: fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:03.702817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:03.703116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 02:47:03.722050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-08 02:47:03.722459) ========= /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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:47:03 INFO - MultiFileLogger online at 20170908 02:47:03 in /builds/slave/test 02:47:03 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 02:47:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:47:03 INFO - {'append_to_log': False, 02:47:03 INFO - 'base_work_dir': '/builds/slave/test', 02:47:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:47:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:47:03 INFO - 'branch': 'Firefox-Non-PGO', 02:47:03 INFO - 'buildbot_json_path': 'buildprops.json', 02:47:03 INFO - 'code_coverage': False, 02:47:03 INFO - 'config_files': ('talos/linux_config.py',), 02:47:03 INFO - 'default_actions': ('clobber', 02:47:03 INFO - 'read-buildbot-config', 02:47:03 INFO - 'download-and-extract', 02:47:03 INFO - 'populate-webroot', 02:47:03 INFO - 'create-virtualenv', 02:47:03 INFO - 'install', 02:47:03 INFO - 'setup-mitmproxy', 02:47:03 INFO - 'run-tests'), 02:47:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:47:03 INFO - 'disable_ccov_upload': False, 02:47:03 INFO - 'disable_stylo': False, 02:47:03 INFO - 'download_minidump_stackwalk': True, 02:47:03 INFO - 'download_symbols': 'ondemand', 02:47:03 INFO - 'enable_stylo': False, 02:47:03 INFO - 'enable_webrender': False, 02:47:03 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:47:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:47:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:47:03 INFO - 'gecko_profile': False, 02:47:03 INFO - 'gecko_profile_interval': 0, 02:47:03 INFO - 'installer_path': 'installer.exe', 02:47:03 INFO - 'log_level': 'info', 02:47:03 INFO - 'log_name': 'talos', 02:47:03 INFO - 'log_to_console': True, 02:47:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:47:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:47:03 INFO - 'opt_config_files': (), 02:47:03 INFO - 'pip_index': False, 02:47:03 INFO - 'suite': 'dromaeojs-e10s', 02:47:03 INFO - 'system_bits': '32', 02:47:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:47:03 INFO - 'title': 'talos-linux64-ix-023', 02:47:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:47:03 INFO - 'use_talos_json': True, 02:47:03 INFO - 'verify': 'False', 02:47:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:47:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:47:03 INFO - 'work_dir': 'build'} 02:47:03 INFO - [mozharness: 2017-09-08 09:47:03.970159Z] Running clobber step. 02:47:03 INFO - Running pre-action listener: _resource_record_pre_action 02:47:03 INFO - Running main action method: clobber 02:47:03 INFO - rmtree: /builds/slave/test/build 02:47:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:47:04 INFO - Running post-action listener: _resource_record_post_action 02:47:04 INFO - [mozharness: 2017-09-08 09:47:04.944623Z] Finished clobber step (success) 02:47:04 INFO - [mozharness: 2017-09-08 09:47:04.944720Z] Running read-buildbot-config step. 02:47:04 INFO - Running pre-action listener: _resource_record_pre_action 02:47:04 INFO - Running main action method: read_buildbot_config 02:47:04 INFO - Using buildbot properties: 02:47:04 INFO - { 02:47:04 INFO - "project": "", 02:47:04 INFO - "product": "firefox", 02:47:04 INFO - "who": "archaeopteryx@coole-files.de", 02:47:04 INFO - "installer_path": "public/build/target.tar.bz2", 02:47:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:47:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:47:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:47:04 INFO - "stage_platform": "linux64", 02:47:04 INFO - "basedir": "/builds/slave/test", 02:47:04 INFO - "buildnumber": 812, 02:47:04 INFO - "platform": "ubuntu64_hw", 02:47:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:47:04 INFO - "slavebuilddir": "test", 02:47:04 INFO - "taskId": "a1CkLrNBSgKNKyJzVYjw5g", 02:47:04 INFO - "branch": "mozilla-central", 02:47:04 INFO - "script_repo_revision": "production", 02:47:04 INFO - "revision": "fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa", 02:47:04 INFO - "slavename": "talos-linux64-ix-023", 02:47:04 INFO - "repo_path": "mozilla-central" 02:47:04 INFO - } 02:47:04 INFO - Finding installer, test and symbols from parent task. 02:47:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1CkLrNBSgKNKyJzVYjw5g'}, attempt #1 02:47:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a1CkLrNBSgKNKyJzVYjw5g'}, attempt #1 02:47:05 INFO - Task dependencies: F69fQAZfRECOnrdgihUWdw 02:47:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw'}, attempt #1 02:47:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 02:47:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.test_packages.json 02:47:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.crashreporter-symbols.zip 02:47:06 INFO - Running post-action listener: _resource_record_post_action 02:47:06 INFO - [mozharness: 2017-09-08 09:47:06.294491Z] Finished read-buildbot-config step (success) 02:47:06 INFO - [mozharness: 2017-09-08 09:47:06.294707Z] Running download-and-extract step. 02:47:06 INFO - Running pre-action listener: _resource_record_pre_action 02:47:06 INFO - Running main action method: download_and_extract 02:47:06 INFO - mkdir: /builds/slave/test/build/tests 02:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:06 INFO - trying https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.test_packages.json 02:47:06 INFO - Downloading https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:47:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:47:06 INFO - Downloaded 989 bytes. 02:47:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:47:06 INFO - Using the following test package requirements: 02:47:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:47:06 INFO - u'common': [u'target.common.tests.zip'], 02:47:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:47:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:47:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:47:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:47:06 INFO - u'mozbase': [u'target.common.tests.zip'], 02:47:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:47:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:47:06 INFO - u'web-platform': [u'target.common.tests.zip', 02:47:06 INFO - u'target.web-platform.tests.tar.gz'], 02:47:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:47:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:47:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.common.tests.zip 02:47:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:47:06 INFO - Fetch https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.common.tests.zip into memory 02:47:08 INFO - Content-Length response header: 55023663 02:47:08 INFO - Bytes received: 55023663 02:47:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.talos.tests.zip 02:47:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:47:19 INFO - Fetch https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.talos.tests.zip into memory 02:47:20 INFO - Content-Length response header: 14496665 02:47:20 INFO - Bytes received: 14496665 02:47:20 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')]} 02:47:20 INFO - trying https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 02:47:20 INFO - Downloading https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:47:21 INFO - Downloaded 62765897 bytes. 02:47:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 02:47:21 INFO - mkdir: /builds/slave/test/properties 02:47:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:47:21 INFO - Writing to file /builds/slave/test/properties/build_url 02:47:21 INFO - Contents: 02:47:21 INFO - build_url:https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 02:47:21 INFO - Running post-action listener: _resource_record_post_action 02:47:21 INFO - Running post-action listener: find_tests_for_verification 02:47:21 INFO - Running post-action listener: set_extra_try_arguments 02:47:21 INFO - [mozharness: 2017-09-08 09:47:21.464824Z] Finished download-and-extract step (success) 02:47:21 INFO - [mozharness: 2017-09-08 09:47:21.464923Z] Running populate-webroot step. 02:47:21 INFO - Running pre-action listener: _resource_record_pre_action 02:47:21 INFO - Running main action method: populate_webroot 02:47:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:47:21 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['tresize', 02:47:21 INFO - 'tcanvasmark']}, 02:47:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:47:21 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['dromaeo_css', 02:47:21 INFO - 'kraken']}, 02:47:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:21 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:47:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'tests': ['damp', 'tps']}, 02:47:21 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['damp', 'tps']}, 02:47:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:47:21 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['dromaeo_dom']}, 02:47:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:47:21 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['basic_compositor_video', 02:47:21 INFO - 'glvideo']}, 02:47:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:47:21 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['ts_paint_webext', 02:47:21 INFO - 'tp5o_webext']}, 02:47:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_many_windows', 02:47:21 INFO - 'sessionrestore_no_auto_restore', 02:47:21 INFO - 'tabpaint']}, 02:47:21 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['a11yr', 02:47:21 INFO - 'ts_paint', 02:47:21 INFO - 'tpaint', 02:47:21 INFO - 'sessionrestore', 02:47:21 INFO - 'sessionrestore_many_windows', 02:47:21 INFO - 'sessionrestore_no_auto_restore', 02:47:21 INFO - 'tabpaint']}, 02:47:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:47:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:47:21 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['bloom_basic_singleton']}, 02:47:21 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['bloom_basic']}, 02:47:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:47:21 INFO - 'tsvgr_opacity', 02:47:21 INFO - 'tart', 02:47:21 INFO - 'tscrollx', 02:47:21 INFO - 'tsvg_static']}, 02:47:21 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['tsvgx', 02:47:21 INFO - 'tsvgr_opacity', 02:47:21 INFO - 'tart', 02:47:21 INFO - 'tscrollx', 02:47:21 INFO - 'tsvg_static']}, 02:47:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:47:21 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo'], 02:47:21 INFO - 'tests': ['tp5o']}, 02:47:21 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:47:21 INFO - 'talos_options': ['--mitmproxy', 02:47:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:47:21 INFO - '--firstNonBlankPaint'], 02:47:21 INFO - 'tests': ['tp6_google', 02:47:21 INFO - 'tp6_youtube', 02:47:21 INFO - 'tp6_amazon', 02:47:21 INFO - 'tp6_facebook']}, 02:47:21 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo', 02:47:21 INFO - '--mitmproxy', 02:47:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:47:21 INFO - '--firstNonBlankPaint'], 02:47:21 INFO - 'tests': ['tp6_google', 02:47:21 INFO - 'tp6_youtube', 02:47:21 INFO - 'tp6_amazon', 02:47:21 INFO - 'tp6_facebook']}, 02:47:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:47:21 INFO - 'talos_options': ['--stylo-threads=1', 02:47:21 INFO - '--mitmproxy', 02:47:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:47:21 INFO - '--firstNonBlankPaint'], 02:47:21 INFO - 'tests': ['tp6_google', 02:47:21 INFO - 'tp6_youtube', 02:47:21 INFO - 'tp6_amazon', 02:47:21 INFO - 'tp6_facebook']}, 02:47:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--xperf_path', 02:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:21 INFO - 'tests': ['tp5n']}, 02:47:21 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:47:21 INFO - 'talos_options': ['--disable-stylo', 02:47:21 INFO - '--xperf_path', 02:47:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:47:21 INFO - 'tests': ['tp5n']}}} 02:47:21 INFO - Running post-action listener: _resource_record_post_action 02:47:21 INFO - [mozharness: 2017-09-08 09:47:21.479871Z] Finished populate-webroot step (success) 02:47:21 INFO - [mozharness: 2017-09-08 09:47:21.479960Z] Running create-virtualenv step. 02:47:21 INFO - Running pre-action listener: _resource_record_pre_action 02:47:21 INFO - Running main action method: create_virtualenv 02:47:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:47:21 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:47:21 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:47:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:47:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:47:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:47:23 INFO - Installing pip...............done. 02:47:23 INFO - Return code: 0 02:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:47:23 INFO - Reading from file tmpfile_stdout 02:47:23 INFO - Output received: 02:47:23 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:47:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:47:23 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')]} 02:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:23 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')]} 02:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:23 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:23 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 02:47:23 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 02:47:23 INFO - Using env: {'DISPLAY': ':0', 02:47:23 INFO - 'HOME': '/home/cltbld', 02:47:23 INFO - 'LANG': 'en_US.UTF-8', 02:47:23 INFO - 'LANGUAGE': 'en_US:en', 02:47:23 INFO - 'LOGNAME': 'cltbld', 02:47:23 INFO - 'MAIL': '/var/mail/cltbld', 02:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:23 INFO - 'MOZ_NO_REMOTE': '1', 02:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:23 INFO - 'NO_EM_RESTART': '1', 02:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:23 INFO - 'PWD': '/builds/slave/test', 02:47:23 INFO - 'SHELL': '/bin/bash', 02:47:23 INFO - 'SHLVL': '1', 02:47:23 INFO - 'TERM': 'linux', 02:47:23 INFO - 'TMOUT': '86400', 02:47:23 INFO - 'USER': 'cltbld', 02:47:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:23 INFO - '_': '/tools/buildbot/bin/python'} 02:47:24 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:47:24 INFO - Downloading/unpacking pip>=1.5 02:47:24 INFO - Running setup.py egg_info for package pip 02:47:24 INFO - warning: no files found matching 'pip/cacert.pem' 02:47:24 INFO - warning: no files found matching '*.html' under directory 'docs' 02:47:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:47:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:47:24 INFO - Installing collected packages: pip 02:47:24 INFO - Found existing installation: pip 1.1 02:47:24 INFO - Uninstalling pip: 02:47:24 INFO - Successfully uninstalled pip 02:47:24 INFO - Running setup.py install for pip 02:47:24 INFO - warning: no files found matching 'pip/cacert.pem' 02:47:24 INFO - warning: no files found matching '*.html' under directory 'docs' 02:47:24 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:47:24 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:47:24 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:47:24 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:47:24 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:47:24 INFO - Successfully installed pip 02:47:24 INFO - Cleaning up... 02:47:24 INFO - Return code: 0 02:47:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:24 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:24 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 02:47:24 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 02:47:24 INFO - Using env: {'DISPLAY': ':0', 02:47:24 INFO - 'HOME': '/home/cltbld', 02:47:24 INFO - 'LANG': 'en_US.UTF-8', 02:47:24 INFO - 'LANGUAGE': 'en_US:en', 02:47:24 INFO - 'LOGNAME': 'cltbld', 02:47:24 INFO - 'MAIL': '/var/mail/cltbld', 02:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:24 INFO - 'MOZ_NO_REMOTE': '1', 02:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:24 INFO - 'NO_EM_RESTART': '1', 02:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:24 INFO - 'PWD': '/builds/slave/test', 02:47:24 INFO - 'SHELL': '/bin/bash', 02:47:24 INFO - 'SHLVL': '1', 02:47:24 INFO - 'TERM': 'linux', 02:47:24 INFO - 'TMOUT': '86400', 02:47:24 INFO - 'USER': 'cltbld', 02:47:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:24 INFO - '_': '/tools/buildbot/bin/python'} 02:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:24 INFO - Downloading/unpacking psutil>=3.1.1 02:47:24 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 02:47:24 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 02:47:24 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 02:47:24 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 02:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:47:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:26 INFO - Installing collected packages: psutil 02:47:26 INFO - Running setup.py install for psutil 02:47:26 INFO - building 'psutil._psutil_linux' extension 02:47:26 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 02:47:28 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 02:47:28 INFO - building 'psutil._psutil_posix' extension 02:47:28 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 02:47:28 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 02:47:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:47:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:47:28 INFO - Successfully installed psutil 02:47:28 INFO - Cleaning up... 02:47:28 INFO - Return code: 0 02:47:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47: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')]} 02:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:47:28 INFO - Using env: {'DISPLAY': ':0', 02:47:28 INFO - 'HOME': '/home/cltbld', 02:47:28 INFO - 'LANG': 'en_US.UTF-8', 02:47:28 INFO - 'LANGUAGE': 'en_US:en', 02:47:28 INFO - 'LOGNAME': 'cltbld', 02:47:28 INFO - 'MAIL': '/var/mail/cltbld', 02:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:28 INFO - 'MOZ_NO_REMOTE': '1', 02:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:28 INFO - 'NO_EM_RESTART': '1', 02:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:28 INFO - 'PWD': '/builds/slave/test', 02:47:28 INFO - 'SHELL': '/bin/bash', 02:47:28 INFO - 'SHLVL': '1', 02:47:28 INFO - 'TERM': 'linux', 02:47:28 INFO - 'TMOUT': '86400', 02:47:28 INFO - 'USER': 'cltbld', 02:47:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:28 INFO - '_': '/tools/buildbot/bin/python'} 02:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:47:31 INFO - Installing collected packages: mozsystemmonitor 02:47:31 INFO - Running setup.py install for mozsystemmonitor 02:47:31 INFO - Successfully installed mozsystemmonitor 02:47:31 INFO - Cleaning up... 02:47:31 INFO - Return code: 0 02:47:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:47:31 INFO - Using env: {'DISPLAY': ':0', 02:47:31 INFO - 'HOME': '/home/cltbld', 02:47:31 INFO - 'LANG': 'en_US.UTF-8', 02:47:31 INFO - 'LANGUAGE': 'en_US:en', 02:47:31 INFO - 'LOGNAME': 'cltbld', 02:47:31 INFO - 'MAIL': '/var/mail/cltbld', 02:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:31 INFO - 'MOZ_NO_REMOTE': '1', 02:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:31 INFO - 'NO_EM_RESTART': '1', 02:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:31 INFO - 'PWD': '/builds/slave/test', 02:47:31 INFO - 'SHELL': '/bin/bash', 02:47:31 INFO - 'SHLVL': '1', 02:47:31 INFO - 'TERM': 'linux', 02:47:31 INFO - 'TMOUT': '86400', 02:47:31 INFO - 'USER': 'cltbld', 02:47:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:31 INFO - '_': '/tools/buildbot/bin/python'} 02:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:31 INFO - Downloading/unpacking jsonschema==2.5.1 02:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:47:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:47:32 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 02:47:32 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 02:47:32 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 02:47:32 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 02:47:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:47:32 INFO - warning: no files found matching '*.txt' 02:47:32 INFO - no previously-included directories found matching 'build' 02:47:32 INFO - no previously-included directories found matching 'dist' 02:47:32 INFO - no previously-included directories found matching '.git*' 02:47:32 INFO - Installing collected packages: jsonschema, functools32 02:47:33 INFO - Running setup.py install for functools32 02:47:33 INFO - warning: no files found matching '*.txt' 02:47:33 INFO - no previously-included directories found matching 'build' 02:47:33 INFO - no previously-included directories found matching 'dist' 02:47:33 INFO - no previously-included directories found matching '.git*' 02:47:33 INFO - Successfully installed jsonschema functools32 02:47:33 INFO - Cleaning up... 02:47:33 INFO - Return code: 0 02:47:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:47:33 INFO - Using env: {'DISPLAY': ':0', 02:47:33 INFO - 'HOME': '/home/cltbld', 02:47:33 INFO - 'LANG': 'en_US.UTF-8', 02:47:33 INFO - 'LANGUAGE': 'en_US:en', 02:47:33 INFO - 'LOGNAME': 'cltbld', 02:47:33 INFO - 'MAIL': '/var/mail/cltbld', 02:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:33 INFO - 'MOZ_NO_REMOTE': '1', 02:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:33 INFO - 'NO_EM_RESTART': '1', 02:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:33 INFO - 'PWD': '/builds/slave/test', 02:47:33 INFO - 'SHELL': '/bin/bash', 02:47:33 INFO - 'SHLVL': '1', 02:47:33 INFO - 'TERM': 'linux', 02:47:33 INFO - 'TMOUT': '86400', 02:47:33 INFO - 'USER': 'cltbld', 02:47:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:33 INFO - '_': '/tools/buildbot/bin/python'} 02:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:47:33 INFO - Cleaning up... 02:47:33 INFO - Return code: 0 02:47:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:47:33 INFO - Using env: {'DISPLAY': ':0', 02:47:33 INFO - 'HOME': '/home/cltbld', 02:47:33 INFO - 'LANG': 'en_US.UTF-8', 02:47:33 INFO - 'LANGUAGE': 'en_US:en', 02:47:33 INFO - 'LOGNAME': 'cltbld', 02:47:33 INFO - 'MAIL': '/var/mail/cltbld', 02:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:33 INFO - 'MOZ_NO_REMOTE': '1', 02:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:33 INFO - 'NO_EM_RESTART': '1', 02:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:33 INFO - 'PWD': '/builds/slave/test', 02:47:33 INFO - 'SHELL': '/bin/bash', 02:47:33 INFO - 'SHLVL': '1', 02:47:33 INFO - 'TERM': 'linux', 02:47:33 INFO - 'TMOUT': '86400', 02:47:33 INFO - 'USER': 'cltbld', 02:47:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:33 INFO - '_': '/tools/buildbot/bin/python'} 02:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:47:33 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 02:47:33 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 02:47:33 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 02:47:33 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 02:47:34 INFO - Downloading blobuploader-1.2.4.tar.gz 02:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:47:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:47:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:47:35 INFO - Downloading docopt-0.6.1.tar.gz 02:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:47:35 INFO - Installing collected packages: blobuploader, requests, docopt 02:47:35 INFO - Running setup.py install for blobuploader 02:47:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:47:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:47:35 INFO - Running setup.py install for requests 02:47:36 INFO - Running setup.py install for docopt 02:47:36 INFO - Successfully installed blobuploader requests docopt 02:47:36 INFO - Cleaning up... 02:47:36 INFO - Return code: 0 02:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:36 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:36 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 02:47:36 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 02:47:36 INFO - Using env: {'DISPLAY': ':0', 02:47:36 INFO - 'HOME': '/home/cltbld', 02:47:36 INFO - 'LANG': 'en_US.UTF-8', 02:47:36 INFO - 'LANGUAGE': 'en_US:en', 02:47:36 INFO - 'LOGNAME': 'cltbld', 02:47:36 INFO - 'MAIL': '/var/mail/cltbld', 02:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:36 INFO - 'MOZ_NO_REMOTE': '1', 02:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:36 INFO - 'NO_EM_RESTART': '1', 02:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:36 INFO - 'PWD': '/builds/slave/test', 02:47:36 INFO - 'SHELL': '/bin/bash', 02:47:36 INFO - 'SHLVL': '1', 02:47:36 INFO - 'TERM': 'linux', 02:47:36 INFO - 'TMOUT': '86400', 02:47:36 INFO - 'USER': 'cltbld', 02:47:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:36 INFO - '_': '/tools/buildbot/bin/python'} 02:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:36 INFO - Running setup.py (path:/tmp/pip-1ZB7Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:36 INFO - Running setup.py (path:/tmp/pip-tJscUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:36 INFO - Running setup.py (path:/tmp/pip-VA9xsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:36 INFO - Running setup.py (path:/tmp/pip-xM8Y3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:36 INFO - Running setup.py (path:/tmp/pip-Wj0gFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:36 INFO - Running setup.py (path:/tmp/pip-ZHTI6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:36 INFO - Running setup.py (path:/tmp/pip-gzJMVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:36 INFO - Running setup.py (path:/tmp/pip-xQ34Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:36 INFO - Running setup.py (path:/tmp/pip-0onltg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:36 INFO - Running setup.py (path:/tmp/pip-LbsTpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:36 INFO - Running setup.py (path:/tmp/pip-5CDgwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:37 INFO - Running setup.py (path:/tmp/pip-eNfbQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:37 INFO - Running setup.py (path:/tmp/pip-Yj3Oal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:37 INFO - Running setup.py (path:/tmp/pip-LEKzxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:37 INFO - Running setup.py (path:/tmp/pip-uv7yfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:37 INFO - Running setup.py (path:/tmp/pip-5iFWSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:37 INFO - Running setup.py (path:/tmp/pip-cIRdPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:47:37 INFO - Running setup.py install for manifestparser 02:47:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:47:37 INFO - Running setup.py install for mozcrash 02:47:37 INFO - Running setup.py install for mozdebug 02:47:37 INFO - Running setup.py install for mozdevice 02:47:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:47:37 INFO - Running setup.py install for mozfile 02:47:37 INFO - Running setup.py install for mozhttpd 02:47:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozinfo 02:47:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozInstall 02:47:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozleak 02:47:38 INFO - Running setup.py install for mozlog 02:47:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for moznetwork 02:47:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozprocess 02:47:38 INFO - Running setup.py install for mozprofile 02:47:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozrunner 02:47:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:47:38 INFO - Running setup.py install for mozscreenshot 02:47:39 INFO - Running setup.py install for moztest 02:47:39 INFO - Running setup.py install for mozversion 02:47:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:47:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:47:39 INFO - Cleaning up... 02:47:39 INFO - Return code: 0 02:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:39 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:39 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 02:47:39 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 02:47:39 INFO - Using env: {'DISPLAY': ':0', 02:47:39 INFO - 'HOME': '/home/cltbld', 02:47:39 INFO - 'LANG': 'en_US.UTF-8', 02:47:39 INFO - 'LANGUAGE': 'en_US:en', 02:47:39 INFO - 'LOGNAME': 'cltbld', 02:47:39 INFO - 'MAIL': '/var/mail/cltbld', 02:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:39 INFO - 'MOZ_NO_REMOTE': '1', 02:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:39 INFO - 'NO_EM_RESTART': '1', 02:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:39 INFO - 'PWD': '/builds/slave/test', 02:47:39 INFO - 'SHELL': '/bin/bash', 02:47:39 INFO - 'SHLVL': '1', 02:47:39 INFO - 'TERM': 'linux', 02:47:39 INFO - 'TMOUT': '86400', 02:47:39 INFO - 'USER': 'cltbld', 02:47:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:39 INFO - '_': '/tools/buildbot/bin/python'} 02:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:47:39 INFO - Running setup.py (path:/tmp/pip-VpOsDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:47:39 INFO - Running setup.py (path:/tmp/pip-y_WqPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:47:39 INFO - Running setup.py (path:/tmp/pip-l83CgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:47:39 INFO - Running setup.py (path:/tmp/pip-zN81YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:47:39 INFO - Running setup.py (path:/tmp/pip-WQEEal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:47:39 INFO - Running setup.py (path:/tmp/pip-Hmqjzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:47:39 INFO - Running setup.py (path:/tmp/pip-ABcR4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:47:39 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)) 02:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:47:39 INFO - Running setup.py (path:/tmp/pip-MqUlVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:47:40 INFO - Running setup.py (path:/tmp/pip-LNjrmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:47:40 INFO - Running setup.py (path:/tmp/pip-xzriQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:47:40 INFO - Running setup.py (path:/tmp/pip-lf1TzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:47:40 INFO - Running setup.py (path:/tmp/pip-E_OEh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:47:40 INFO - Running setup.py (path:/tmp/pip-1HOKUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:47:40 INFO - Running setup.py (path:/tmp/pip-_3pXwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:40 INFO - Running setup.py (path:/tmp/pip-_1b_MD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:47:40 INFO - Running setup.py (path:/tmp/pip-3sIlww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:47:40 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)) 02:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:47:40 INFO - Running setup.py (path:/tmp/pip-LKjC13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:47:40 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)) 02:47:40 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)) 02:47:40 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)) 02:47:40 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)) 02:47:40 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)) 02:47:40 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)) 02:47:40 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)) 02:47:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:47:40 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 02:47:40 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 02:47:40 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 02:47:40 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 02:47:41 INFO - Downloading blessings-1.6.tar.gz 02:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:47:41 INFO - Installing collected packages: blessings 02:47:41 INFO - Running setup.py install for blessings 02:47:42 INFO - Successfully installed blessings 02:47:42 INFO - Cleaning up... 02:47:42 INFO - Return code: 0 02:47:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:47:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:42 INFO - Reading from file tmpfile_stdout 02:47:42 INFO - Current package versions: 02:47:42 INFO - argparse == 1.2.1 02:47:42 INFO - blessings == 1.6 02:47:42 INFO - blobuploader == 1.2.4 02:47:42 INFO - docopt == 0.6.1 02:47:42 INFO - functools32 == 3.2.3-2 02:47:42 INFO - jsonschema == 2.5.1 02:47:42 INFO - manifestparser == 1.1 02:47:42 INFO - mozInstall == 1.13 02:47:42 INFO - mozcrash == 1.0 02:47:42 INFO - mozdebug == 0.1 02:47:42 INFO - mozdevice == 0.51 02:47:42 INFO - mozfile == 1.2 02:47:42 INFO - mozhttpd == 0.7 02:47:42 INFO - mozinfo == 0.10 02:47:42 INFO - mozleak == 0.1 02:47:42 INFO - mozlog == 3.5 02:47:42 INFO - moznetwork == 0.27 02:47:42 INFO - mozprocess == 0.25 02:47:42 INFO - mozprofile == 0.28 02:47:42 INFO - mozrunner == 6.13 02:47:42 INFO - mozscreenshot == 0.1 02:47:42 INFO - mozsystemmonitor == 0.3 02:47:42 INFO - moztest == 0.8 02:47:42 INFO - mozversion == 1.4 02:47:42 INFO - psutil == 3.1.1 02:47:42 INFO - requests == 1.2.3 02:47:42 INFO - wsgiref == 0.1.2 02:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:42 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:42 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 02:47:42 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 02:47:42 INFO - Using env: {'DISPLAY': ':0', 02:47:42 INFO - 'HOME': '/home/cltbld', 02:47:42 INFO - 'LANG': 'en_US.UTF-8', 02:47:42 INFO - 'LANGUAGE': 'en_US:en', 02:47:42 INFO - 'LOGNAME': 'cltbld', 02:47:42 INFO - 'MAIL': '/var/mail/cltbld', 02:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:42 INFO - 'MOZ_NO_REMOTE': '1', 02:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:42 INFO - 'NO_EM_RESTART': '1', 02:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:42 INFO - 'PWD': '/builds/slave/test', 02:47:42 INFO - 'SHELL': '/bin/bash', 02:47:42 INFO - 'SHLVL': '1', 02:47:42 INFO - 'TERM': 'linux', 02:47:42 INFO - 'TMOUT': '86400', 02:47:42 INFO - 'USER': 'cltbld', 02:47:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:42 INFO - '_': '/tools/buildbot/bin/python'} 02:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 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)) 02:47:42 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:47:42 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 02:47:42 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 02:47:42 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 02:47:42 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 02:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:47:43 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)) 02:47:43 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)) 02:47:43 INFO - Installing collected packages: simplejson 02:47:43 INFO - Running setup.py install for simplejson 02:47:43 INFO - building 'simplejson._speedups' extension 02:47:43 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 02:47:44 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 02:47:44 INFO - Successfully installed simplejson 02:47:44 INFO - Cleaning up... 02:47:44 INFO - Return code: 0 02:47:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:47: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')]} 02:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:47: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')]} 02:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:47:44 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 0x12f51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1661a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, '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': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', '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 02:47:44 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 02:47:44 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 02:47:44 INFO - Using env: {'DISPLAY': ':0', 02:47:44 INFO - 'HOME': '/home/cltbld', 02:47:44 INFO - 'LANG': 'en_US.UTF-8', 02:47:44 INFO - 'LANGUAGE': 'en_US:en', 02:47:44 INFO - 'LOGNAME': 'cltbld', 02:47:44 INFO - 'MAIL': '/var/mail/cltbld', 02:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:44 INFO - 'MOZ_NO_REMOTE': '1', 02:47:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:47:44 INFO - 'NO_EM_RESTART': '1', 02:47:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:44 INFO - 'PWD': '/builds/slave/test', 02:47:44 INFO - 'SHELL': '/bin/bash', 02:47:44 INFO - 'SHLVL': '1', 02:47:44 INFO - 'TERM': 'linux', 02:47:44 INFO - 'TMOUT': '86400', 02:47:44 INFO - 'USER': 'cltbld', 02:47:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:44 INFO - '_': '/tools/buildbot/bin/python'} 02:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:47:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:47:44 INFO - Cleaning up... 02:47:45 INFO - Return code: 0 02:47:45 INFO - Running post-action listener: _resource_record_post_action 02:47:45 INFO - Running post-action listener: _start_resource_monitoring 02:47:45 INFO - Starting resource monitoring. 02:47:45 INFO - [mozharness: 2017-09-08 09:47:45.027263Z] Finished create-virtualenv step (success) 02:47:45 INFO - [mozharness: 2017-09-08 09:47:45.028285Z] Running install step. 02:47:45 INFO - Running pre-action listener: _resource_record_pre_action 02:47:45 INFO - Running main action method: install 02:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:47:45 INFO - Reading from file tmpfile_stdout 02:47:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:47:45 INFO - Reading from file tmpfile_stdout 02:47:45 INFO - Output received: 02:47:45 INFO - Usage: mozinstall [options] installer 02:47:45 INFO - Options: 02:47:45 INFO - -h, --help show this help message and exit 02:47:45 INFO - -d DEST, --destination=DEST 02:47:45 INFO - Directory to install application into. [default: 02:47:45 INFO - "/builds/slave/test"] 02:47:45 INFO - --app=APP Application being installed. [default: firefox] 02:47:45 INFO - mkdir: /builds/slave/test/build/application 02:47:45 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'] 02:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:48:01 INFO - Reading from file tmpfile_stdout 02:48:01 INFO - Output received: 02:48:01 INFO - /builds/slave/test/build/application/firefox/firefox 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - [mozharness: 2017-09-08 09:48:01.931185Z] Finished install step (success) 02:48:01 INFO - [mozharness: 2017-09-08 09:48:01.931331Z] Running setup-mitmproxy step. 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: setup_mitmproxy 02:48:01 INFO - Skipping: mitmproxy is not required 02:48:01 INFO - Running post-action listener: _resource_record_post_action 02:48:01 INFO - [mozharness: 2017-09-08 09:48:01.931863Z] Finished setup-mitmproxy step (success) 02:48:01 INFO - [mozharness: 2017-09-08 09:48:01.931969Z] Running run-tests step. 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running pre-action listener: _set_gcov_prefix 02:48:01 INFO - Running main action method: run_tests 02:48:01 WARNING - Try message not found. 02:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:48:01 INFO - Python 2.7.3 02:48:01 INFO - Return code: 0 02:48:01 INFO - grabbing minidump binary from tooltool 02:48: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')]} 02:48:01 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 0x1665090>, '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 0x1665d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:48:01 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 02:48:01 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 02:48:01 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 02:48:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:48:02 INFO - Return code: 0 02:48:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:48:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:48:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:48:02 INFO - ENV: RUST_BACKTRACE is now full 02:48:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:48:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:48:02 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/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 02:48:02 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/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 02:48:02 INFO - Using env: {'DISPLAY': ':0', 02:48:02 INFO - 'HOME': '/home/cltbld', 02:48:02 INFO - 'LANG': 'en_US.UTF-8', 02:48:02 INFO - 'LANGUAGE': 'en_US:en', 02:48:02 INFO - 'LOGNAME': 'cltbld', 02:48:02 INFO - 'MAIL': '/var/mail/cltbld', 02:48:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:48:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:02 INFO - 'MOZ_NO_REMOTE': '1', 02:48:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:02 INFO - 'NO_EM_RESTART': '1', 02:48:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:02 INFO - 'PWD': '/builds/slave/test', 02:48:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:48:02 INFO - 'RUST_BACKTRACE': 'full', 02:48:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:48:02 INFO - 'SHELL': '/bin/bash', 02:48:02 INFO - 'SHLVL': '1', 02:48:02 INFO - 'TERM': 'linux', 02:48:02 INFO - 'TMOUT': '86400', 02:48:02 INFO - 'USER': 'cltbld', 02:48:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:02 INFO - '_': '/tools/buildbot/bin/python'} 02:48:02 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/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 02:48:02 INFO - mozversion application_buildid: 20170908085353 02:48:02 INFO - mozversion application_changeset: fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa 02:48:02 INFO - mozversion application_display_name: Nightly 02:48:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:48:02 INFO - mozversion application_name: Firefox 02:48:02 INFO - mozversion application_remotingname: firefox 02:48:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:48:02 INFO - mozversion application_vendor: Mozilla 02:48:02 INFO - mozversion application_version: 57.0a1 02:48:02 INFO - mozversion platform_buildid: 20170908085353 02:48:02 INFO - mozversion platform_changeset: fd1ab37308c5cf0e1fd2471708f53d8e6ddc69aa 02:48:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:48:02 INFO - mozversion platform_version: 57.0a1 02:48:02 INFO - using testdate: 1504864082 02:48:02 INFO - actual date: 1504864082 02:48:02 INFO - starting webserver on 'localhost:34166' 02:48:02 INFO - SUITE-START | Running 2 tests 02:48:02 INFO - TEST-START | dromaeo_css 02:48:02 INFO - Initialising browser for dromaeo_css test... 02:48:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34166/getInfo.html -profile /tmp/tmpglKLIv/profile 02:48:02 INFO - TEST-INFO | started process 3571 (/builds/slave/test/build/application/firefox/firefox http://localhost:34166/getInfo.html) 02:48:09 INFO - TEST-INFO | 3571: exit 0 02:48:09 INFO - Browser initialized. 02:48:09 INFO - Running cycle 1/1 for dromaeo_css test... 02:48:09 INFO - Using env: {'DISPLAY': ':0', 02:48:09 INFO - 'HOME': '/home/cltbld', 02:48:09 INFO - 'JSGC_DISABLE_POISONING': '1', 02:48:09 INFO - 'LANG': 'en_US.UTF-8', 02:48:09 INFO - 'LANGUAGE': 'en_US:en', 02:48:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:48:09 INFO - 'LOGNAME': 'cltbld', 02:48:09 INFO - 'MAIL': '/var/mail/cltbld', 02:48:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:48:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:48:09 INFO - 'MOZ_CRASHREPORTER': '1', 02:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:48:09 INFO - 'MOZ_NO_REMOTE': '1', 02:48:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:48:09 INFO - 'NO_EM_RESTART': '1', 02:48:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:09 INFO - 'PWD': '/builds/slave/test', 02:48:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:48:09 INFO - 'RUST_BACKTRACE': 'full', 02:48:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:48:09 INFO - 'SHELL': '/bin/bash', 02:48:09 INFO - 'SHLVL': '1', 02:48:09 INFO - 'TERM': 'linux', 02:48:09 INFO - 'TMOUT': '86400', 02:48:09 INFO - 'USER': 'cltbld', 02:48:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 02:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:09 INFO - '_': '/tools/buildbot/bin/python'} 02:48:09 INFO - TEST-INFO | started process 3771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpglKLIv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:10 INFO - PID 3771 | 02:48:10 INFO - PID 3771 | (/builds/slave/test/build/application/firefox/firefox:3822): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:48:10 INFO - PID 3771 | 02:48:20 INFO - PID 3771 | RSS: Main: 172617728 02:48:20 INFO - PID 3771 | 02:51:18 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34166/tests/dromaeo/cssquery-ext.html) 02:51:19 INFO - PID 3771 | RSS: Main: 174661632 02:51:19 INFO - PID 3771 | 02:54:21 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-ext.html (next: http://localhost:34166/tests/dromaeo/cssquery-jquery.html) 02:54:22 INFO - PID 3771 | RSS: Main: 171036672 02:54:22 INFO - PID 3771 | 02:57:23 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34166/tests/dromaeo/cssquery-mootools.html) 02:57:24 INFO - PID 3771 | RSS: Main: 171515904 02:57:24 INFO - PID 3771 | 03:00:26 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34166/tests/dromaeo/cssquery-prototype.html) 03:00:26 INFO - PID 3771 | RSS: Main: 172158976 03:00:26 INFO - PID 3771 | 03:03:30 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34166/tests/dromaeo/cssquery-yui.html) 03:03:30 INFO - PID 3771 | RSS: Main: 173285376 03:03:30 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | Cycle 1(1): loaded http://localhost:34166/tests/dromaeo/cssquery-yui.html (next: http://localhost:34166/tests/dromaeo/cssquery-dojo.html) 03:06:32 INFO - PID 3771 | RSS: Main: 175751168 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | __start_tp_report 03:06:32 INFO - PID 3771 | _x_x_mozilla_page_load 03:06:32 INFO - PID 3771 | _x_x_mozilla_page_load_details 03:06:32 INFO - PID 3771 | |i|pagename|runs| 03:06:32 INFO - PID 3771 | |0;dojo.html;3120.0951724000042;3133.858976346064;3152.3380090181054;3162.067190178897;3162.5098109792975;6215.875682486348;6383.329750376208;6386.26557945837;6408;6415.422611964928;6285.277193122793;6293.779717709881;6426.325235850239;6436.034594810781;6477.54657173998;5811.564132690044;5869.383714709958;5883.23517942668;5964.821055368324;5970.8805823883495;5819.941800582003;5850.385709500505;5946.345901950782;5964.850878728045;5973.910391344133;5688.374278829326;5798.1592669063175;5813.622114562561;5853;5863.296404431474;5768.509676677488;5837.066069428914;5843.620164689281;5868.061110222387;5879.147523609053;5812.273465816773;5815.069588865761;5854.6194497357965;5863.882722345529;5902.409759024106;6209.192804935329;6342.714577844008;6372.426481616631;6415.550911436201;6455.7740479083;6662.267150613428;6752.1222241108835;6782.321767823228;6794.388505034571;6800.047993280945;6822.249552549216;6825.658717064177;6903.309669033107;6903.689333979983;6907.689153988083;6211.3167551569295;6292.087647291117;6292.779752708633;6292.779752708633;6294.968525157391;6897.206821215625;6910.965445172742;6918.5502942308585;6924.065251191126;6927.792166235021;6517.641529715911;6582.3746744059235;6591.439727623206;6591.835204119935;6616.569922954993;6630.602163870087;6646.435053020451;6687.762763888696;6804.149481314836;6941.583504989717;6751.291114433012;6825.215100263533;6867.896981545281;6871;6872.965635171892;6738.427233685094;6786.083878676414;6823.454123670193;6871.106756121672;6875;5214.817481388133;5287.339082614673;5320.920186197211;5349.5720342372515;5386.5152136307925;4655.138799322136;4710.599599034052;4717.858464246078;4727.149113159664;4736.407949006374;5797.101449275369;5803.448672376117;5869.207656966255;5891.41085891416;5895.29256489224;6859.622720750406;6862.176538815374;6909.689063992132;6936.514443988873;6942.652867356612;5698.857528561736;5787.768489260382;5805.564582656318;5868.442497962772;5871.442212989845;5893.793717219876;5908.350081491032;5908.763649454059;5934.970325148433;5936.673482958392;6442.35576442352;6527.934720652733;6613.900791488131;6614.702338394687;6649.966750166218;6687.866242675216;6850.588964662136;6857.622830744357;6945.756898508528;6948.930510694829;6416.454601358937;6476.31998640136;6523.7716679915975;6568.343165683394;6591.011348297794;6550.443212327005;6729.932700672931;6782.762603308861;6792.218894827158;6794.898076528955;6863.347981941708;6876.621785801829;6901.447884169354;6959.26927672587;6962.617056061965;6436.613803171825;6553.442957348679;6583.703733331916;6612.801615951529;6712.127423434922;6688.431483323972;6712.328767123444;6714.496412768965;6740.9325906740305;6745;6359.936400635935;6401.583897046677;6489.707963141575;6490.643014634241;6602.240742314695;6569.770058048137;6579.078928950046;6604.108445360007;6803;6804.149481314836;6302;6366.427021568081;6395.968020159869;6404.039394090923;6483.448906842783 03:06:32 INFO - PID 3771 | |1;ext.html;853.6841368693584;880.5333173418082;881.2509367038018;884.1821315283365;887.1527691055041;39147.60852391479;42477.362839557434;42756;42761.786191069004;42776.572234277686;38790.224195516144;38793.80603096988;39032;39074.21851562974;39089.60910390895;7065.788026359218;7150.499465037449;7174.497785155041;7175.4977151599405;7180.425565954711;7042.4718146138985;7153.713851445936;7154.248803875596;7154.534955227893;7154.8569028619395;7124.608146551937;7154.427645788324;7155;7158.069450971392;7789.260020298091;7844.215578442138;7904.723334683287;7908.644111015018;7914.406419518559;7916.525008499509;7762.340201082915;7872.370210383156;7876.409269304768;7880.330171935392;7883.763487095396;37913.241735165415;38555;38678;38732;38802.22395552101;3362.142653623335;3399.031276086328;3404.591449026108;3409.8465569049454;3415.282790613974;32327.191820204447;32499.187520311945;32510.837445812856;32521.837390812896;32554.18614534632;5194.065068287745;5209.062368773619;5231.764570594294;5234.842954711365;5282.128448805943;185646;185713;185723;185843;185857;42060.36909446361;43006;48639;48685.26972095422;48783.756081220075;53051.73474132682;53855.461445385044;53881.46118538843;53909.46090539123;53926;16022.19889005545;16107.355705771872;16114;16132.838671613368;16141.19294035317;13218;13326.200427974352;13328.866711332956;13338.266395348155;13349.265790381622;13510.392032358372;13600.795988060187;13609.455621775018;13710.451581936612;13750.312484375741;5704.11586204139;5752.338481074647;5752.511036561856;5756.625819321731;5777.006932608243;995.9800803983879;1019.7399663085865;1024.0987930621006;1027.4605831938143;1038.5482315192914;22512.955568770958;22784.31647050558;22906.31281061571;23043.88478057599;23139.3058208254;1089.9618513351995;1104.2932523185168;1104.640991677708;1107.346665467362;1108.1854836695022;11946.34295113777;12117.27296362221;12122.75754484923;12242.44908979098;12251.877481225252;226767;228986;229258;229726;230021;46968.530314696414;47057.529424706;47167.29249061267;56425.7178714112;57913.420865791646;1414.2575148047358;1440.9783853242209;1450.158907833475;1457.271364317841;1460.2698650674663;26552.336191595365;26847.194584162506;27201.455970880867;27255.318617034733;27542.5868611975;38010.809945950095;38463;38470.23059538737;38561.22877542378;38561.80719096387;209007;209045;209979;210227;210334;34529.82735086309;36891.26217475689;37897.43153852639;38088.23823523459;38100.237995240495;46396;46701.29948050714;47113.2933006012;47235.527644723115;47438.76280618575;33027.504587430725;33148.834255828566;33429.83285083559;33632;33978.150546235556;30416.543751844183;30476;30735.846320768254;31148.22129446782;31360.686393135777;37469.81265093657;37630;37688;37710.24579508449;37759.81120094382;32058.038258852273;32285.35429291448;32363.51454728228;32394.83802580972;32684.836575816968;23936.52126957416;24182;24283.757162428858;24456.581430411497;24543.754562454862 03:06:32 INFO - PID 3771 | |2;jquery.html;563.2143160291394;566.5074813773089;571.0948147186709;571.6598623818829;575.4993155954319;22059.22792702256;22686.43283917903;22693.886530567346;22741.886290568524;22750.43123921903;22742.20402285916;23857.642135367983;24004;24187.27438176853;24256;6305.653189074611;6396.648184349859;6447.935520644804;6455.580387274836;6469.385408386196;6262.467690246334;6310.905336419957;6415.06981487684;6418;6419.582727122745;6451.548391612589;6473.967630161843;6478.643674597919;6483.708233129497;6486.2540807807;6460.93539064608;6464.224293084836;6468.902966455507;6482.773102941374;6493.6103833769885;5904.61619994699;5915.852103697399;6135.171751813493;6146.016637338004;6148.016317389196;27556.724432755615;28371.148865534065;28387.432251354858;28388.148355549365;28406.431871362456;2001.8698784578955;2053.650879350499;2053.661145910923;2053.722747429093;2055.1882006607457;18647.906760466245;19097.713534296996;19378;19387.612247755107;19656.70514942277;2378.7273808512364;2395.5448464791634;2415.118481754147;2428.672129262545;2470.5800013997664;119714.40142799317;125106.374468128;129885;135579.32210338884;136290.3185484076;13963.511277105252;14005.719885602435;14298;14466.493672721404;14634.926825365805;22624.886875565517;22774.772252277595;22785.772142278696;22792;22881.084756609882;9337.486438245825;9509.809803803884;9605.47169905662;9622.37454565451;9670.371425857296;8636.784080397914;8751.168638979287;8775.473471591726;8899;8909.109089091038;8572.570971611281;8823.382363234641;8831.823363532694;8998.730038098867;9066.863997040049;2784.1439606145636;2788.135677939845;2802.4114935863695;2805.5370863807243;2878.1221727373354;939.9060093990546;958.3483231402713;963.0802583532709;968.9854652180223;969.6266937229077;18707.34524291643;18720.25118995225;18756.437306880816;18762.155702993397;19274.22903083889;1007.2596641468515;1010.4594042187395;1015.7409860485529;1016.7966406718685;1017.1506791828906;10289.639862604772;10401.84397234042;10479.318844275098;10486.685399438029;10497.422641754776;436116;454106;454880;462825;463728;108770;110470;110693.44653276843;111558;113354;1126.8704099028716;1167.3171194851107;1167.5329868052677;1171.437709899236;1181.8640856301463;16266.349346026027;16623.750643740113;16812.327506899586;16880.57798555046;17120.657586848443;56149.15776263278;56545.43454565566;56587;57033;58977;71395.64302178456;71520.64239678768;72149;72258;72758.45345412884;13971.30143492801;14298.642533936734;14318.856811431753;14325.856741432452;14348.497802577278;21558.461038474165;21662.566748664623;21811.890940545196;21866.344009679735;21918.23286184976;17020;17151.142442877557;17157.227924743165;17457;17517.64964700724;14511.709765804835;14705.779413308595;14849.331780070139;14945.925270373578;15030.323635436212;17760.3783867564;17776.288948441917;17914.10429478547;17977.73033404474;18043.368482103062;13811.585652430444;13844.861551384358;13950.581482555539;13992.790108148183;13996.020278580401;17262.223199956283;17320.65358692844;17347.739783903504;17471.475855724348;17499.212535435683 03:06:32 INFO - PID 3771 | |3;mootools.html;1319.201882860869;1366.2553908120074;1370.5614203454893;1376.781548329728;1383.854695256998;14989;15610.375584976588;15613.297401616926;15686.607834804136;15764.763528547051;15194.392224311014;15377.384904603803;15378.38486460543;15407.614809629766;15420.61448463789;2734.179746076179;2837.163036904108;2840.772738180951;2841.3038805492683;2841.8579071046365;2703.7431444012886;2775.708550602188;2816.0143949617573;2816.4367126574666;2817.3238422778486;2671.9732802672015;2767.1975127213086;2860.5280128778727;2870.5694145878183;2878.2948177696494;2684.932876678079;2693.932651683704;2699.6895357033995;2706.052881491482;2720.2927238917923;2746.285965648926;2751.2296556964084;2751.5184842652457;2763.3367991681853;2767.4741799058115;14881.10713357202;15028.624284392869;15089.094654320666;15101.924490377478;15117.622059448491;7928.365730741527;8149.755507334789;8216.301614362786;8222.342212622976;8228.794280142984;5370.731463426852;5582.246396736429;5742.28221472316;5753.741081651294;5769.394213607553;1929.9903500482408;1976.1700085963787;1979.3468155508792;2021.6664250398815;2025.2506572568097;24884.626730599055;24983.750162498505;25004.499910001698;25039.499210015696;25064.87467562687;6697.665116744143;6707.832304192337;6764.120664313607;6886;6895.55178913369;16949;16958.152092395332;16958.915205423895;16968.066756328273;16995;7837.9216207838335;8070.556119413372;8079.151689072681;8081.232282933112;8086.110527841933;7378;7434.145073316529;7510;7510.6620202091035;7530.359919406912;5155.819546315861;5327.866803329948;5344.679319240858;5345.4654534546235;5374.758135883894;1469.4342678068806;1482.2440555316866;1482.5996980815119;1489.3819065088085;1504.1125735815701;859.2352806002663;903.8824952756099;906.9319801014818;907.6521365771823;913.9131782480654;7621.618919054025;7651.5409075455655;7760.534367937942;7767.1067827200595;7855.13593504714;697.4629535257925;702.6873041496588;722.1622917415773;725.7967769024682;727.9927200728031;4704.482506924235;4764.190087685102;4767.427908650915;5052.595792336604;5391.406945236021;20497.692534611695;22052.779472205395;22062.669059964115;22073.44816379571;22093;19897.403077907686;20512.282070127472;21186.15255389767;21586.244481443075;21618.91905404755;11324.263922845154;11635.243709158878;11682.415879206006;11713.18007739467;11740.530378784753;8538.957305213435;8650.56747162652;8990;9155.084491550791;9167.679131230376;18790.53023674419;18910.716339255196;18912.14895329686;18990.145443455353;19069;19363.225470981004;19644.90177549103;19735.60528789445;19811.405657830288;19938.70091948651;12037.939810300892;12389.93805030969;12516.624501264976;12537.373131343578;12561.811572826233;14068.788968165281;14085.366158523097;14197.858021419654;14202.644933876736;14254;11176.776464470828;11233.32600044;11375.317480950838;11470.311781293149;11484.655460336204;10990.230683852054;11340.603078892529;11386.943065284951;11420.143489238175;11495.310281383145;10086.344387614781;10189;10189.337693049929;10193.490325483845;10199.235057370579;7095.858082838417;7338.633068346455;7364.410847132323;7453.2546745325035;7613.238676132564;7398.334149926317;7439.367653749492;7470.663820128216;7482.438817088631;7570.848583028199 03:06:32 INFO - PID 3771 | |4;prototype.html;499.24921334774325;512.492632294029;516.801031602833;523.1759978034594;527.8416475057481;6385.297617262109;6427.550071494991;6461.192350956137;6477.935220647792;6509;6342.936570634292;6344;6361.7137228824695;6363.809085727424;6371.745130194799;5257.789688412459;5266.3153790007245;5269.578433725293;5276.868078298035;5283.709395983219;4937.80248790048;5118;5251.632385733;5271.919256552397;5297.12597421425;5054.519820617035;5062.645614806965;5065.873353166164;5067.74661266937;5112.335396398463;5020.548150666421;5034.942662040976;5035.84892453227;5089.465606111342;5113.801065541816;4533.161365147458;4548.226801443762;4555.316702494619;4574.268117101248;4588.908221835578;6261.499080073583;6308.810735677937;6327.8801601463565;6327.930953487555;6340.270868850049;5688.886222275572;5728.112142617901;5783;5790.305163380422;5799.971000145015;6529.812512808215;6603.372679595431;6678.298778628271;6705.089049620883;6709.798706038778;4844.927326090112;4874.318360165737;4904.346262034771;4904.566803237748;4910.600478863543;6631.801045968628;6820.590764554143;6838.623875686835;6839.897401538931;6901.309869013058;4911.263310503382;4945.802167913315;4973.905740737032;5004.349434573555;5018.397792264952;5041.117804384218;5046.343975283263;5058.595312375001;5061.139606266944;5080.161773307437;5605.271314729059;5676.517496012885;5684.431556844283;5735.885282294331;5768.163616275617;6631.701573429207;6665.233498147678;6672;6742.932570674328;6767.1202743644;1742.4685470931488;1765.2762367429293;1774.476529423823;1779.17268470162;1779.973300400495;1171;1204.6687161030786;1216.2459275249225;1221.1390969366576;1222.5720997650928;5683.920055189501;5720.856978575569;5741.942580574141;5778.248827652378;5808.332041815161;6636.83407914806;6653.6340501271925;6793.320667933266;6821.3519715626935;6841.452683785285;5665.951798917214;5666.631668941505;5668.319801623831;5676.148577713376;5694.288213973254;3595.1551385424405;3609.819509024538;3620.873269435557;3643.362411577963;3645.799481028569;6560.475161987125;6562.737490500422;6574.520732835073;6576.44100251484;6583.728613628291;6546.400979154281;6936.4797640177185;6987.336203060701;6990.965045174843;6991.252186953262;6413.647249401234;6430.292667806538;6448.1295025171;6449.226092868792;6503.382178693111;6560.639164845979;6588.934110658832;6597.472202223715;6776.492697701882;6792.830179245559;6598.27418983921;6629.171353580802;6663.766768163091;6731.798046058626;6769.120014398097;6434.195725534309;6478.70845811949;6510.414062734377;6512.822306266435;6602.471802255904;4837.854864354075;4973.477784832685;5010.774515146754;5050.77271522775;5069.391672999263;6606.768763093269;6609;6645.700943457459;6848.657567121723;6858.622775747382;6458.870822583616;6520.6413647247955;6526.314736952741;6529.151210342625;6639.966800165968;6467;6498.155239818982;6582.3746744059235;6614.867702645824;6615.900761488485;6428.6785660717715;6483.157189565515;6501;6537.7058032389605;6605.867882642417;6580.5064620152725;6588.769393071219;6695.765648202289;6713.865722685421;6734.393904548614;6380.585261957958;6383.489320854228;6401.711922963571;6434.806955791334;6462 03:06:32 INFO - PID 3771 | |5;yui.html;854.3634991931004;887.5917078144049;889.5907882374107;898.4294972692338;925.7222833150055;19101;19154.616907661857;19940.102695378726;20000.399988000347;20008.69986950197;16432.75350869738;16491.58771030725;16536.090515021668;17502.299908003664;18023.63952720945;950.8478643417054;983.8081574093055;987.274353350287;988.6737376665683;990.400807511456;939.2251392601097;971.4996776660025;974.3569244298765;984.8621193032981;985.6895078050427;1034.100332710543;1036.2487196782347;1036.9533370998286;1037.2687255484866;1037.4397825174397;1022.0648106982139;1022.0954455307033;1023.7184774187084;1023.8566600675837;1024.8975102489728;722.5592388642924;735.6799792090404;748.2069006852754;748.4536288509419;762.7368557847534;20250.49373765653;20307.187712491483;20329.18683252668;20431.182752689874;20447.897760511252;20146.79853201464;20173.798262017484;20530.589388212153;20644.277450289166;20667.379978600668;17482.65034699299;17535.824641753676;17731.113444327733;18217.63564728698;18299;3675.44868269759;3701.9444708329397;3702.1670124222105;3703.037210325308;3704.2221133561984;140416.29791851077;141064;142711.28644356815;144504.277478613;146654;16301.83698163027;16390.098544580163;16683.16584170811;16755.246013929158;16850;29055.85472072626;29692.554611680844;29778.10665680033;29934.700652993626;30004.249893752833;8551.871721924175;8564.443311184754;8596;8606.6987655433;8608.69869554575;4067.4102255172834;4153.190127925026;4159.043420013353;4199.832006719758;4209.726367786084;5439.5648348132845;5537.390887002426;5539.972300138554;5546.112621980545;5571.693556854331;943.429225318686;959.4051687953513;968.7045451137329;970.7233438470003;976.9120779129912;660.8182749743859;673.1585518102372;684.4695361095191;690.6960937187621;698.2110215456502;11413.42932853354;11511.079113670887;11819.409029548488;12409.379531023413;12617.621471355875;655.5509476008949;666.8299583606149;676.9729210831512;677.8034370032635;679.242644451443;5549.778008879681;5554.944450555443;5558.194061861008;5688.829335119953;5723.570732195102;127215.36392318165;129375.35312323378;132841;132945;133186;108831.45584272029;110162;111277;112089;112828;93375;95788.52105739426;97112.51443742878;97933;103639;10200.4389758564;10247.128994035591;10254.53854576531;10288.588456461957;10463.267571269938;43039.56960430481;43682.563174367846;44449.77775111233;44584;44743.55256447394;56622.43377566172;57223;57241.713791430775;57621.42378576328;58834.41165588461;14448.349824257723;14890.181040042902;14891.47879824201;14967.326470308644;15000.699986000001;17069.231884564975;17326.480205593853;17396.130193490528;17467.30130794754;17510.82489175143;15110.39558417651;15188.772168417703;15247.313870875616;15374.9231253843;15427;15820.525384238492;15978;16020.359185632444;16202.432914847925;16255.75616365779;15214.087154770748;15429.845701542841;15446.691066178839;15611.609709756893;15629.296681649126;10757;10777.89222107769;11029;11050.668479945292;11121.221514493907;11286.20996530235;11515.481803318704;11598;11650.76698466043;11712.648620541397 03:06:32 INFO - PID 3771 | __end_tp_report 03:06:32 INFO - PID 3771 | __start_cc_report 03:06:32 INFO - PID 3771 | _x_x_mozilla_cycle_collect,383 03:06:32 INFO - PID 3771 | __end_cc_report 03:06:32 INFO - PID 3771 | __startTimestamp1504865192520__endTimestamp 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | ------- Summary: start ------- 03:06:32 INFO - PID 3771 | Number of tests: 6 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#0] dojo.html Cycles:165 Average:6250.62 Median:6455.77 stddev:753.33 (11.7%) stddev-sans-first:714.49 03:06:32 INFO - PID 3771 | Values: 3120.1 3133.9 3152.3 3162.1 3162.5 6215.9 6383.3 6386.3 6408.0 6415.4 6285.3 6293.8 6426.3 6436.0 6477.5 5811.6 5869.4 5883.2 5964.8 5970.9 5819.9 5850.4 5946.3 5964.9 5973.9 5688.4 5798.2 5813.6 5853.0 5863.3 5768.5 5837.1 5843.6 5868.1 5879.1 5812.3 5815.1 5854.6 5863.9 5902.4 6209.2 6342.7 6372.4 6415.6 6455.8 6662.3 6752.1 6782.3 6794.4 6800.0 6822.2 6825.7 6903.3 6903.7 6907.7 6211.3 6292.1 6292.8 6292.8 6295.0 6897.2 6911.0 6918.6 6924.1 6927.8 6517.6 6582.4 6591.4 6591.8 6616.6 6630.6 6646.4 6687.8 6804.1 6941.6 6751.3 6825.2 6867.9 6871.0 6873.0 6738.4 6786.1 6823.5 6871.1 6875.0 5214.8 5287.3 5320.9 5349.6 5386.5 4655.1 4710.6 4717.9 4727.1 4736.4 5797.1 5803.4 5869.2 5891.4 5895.3 6859.6 6862.2 6909.7 6936.5 6942.7 5698.9 5787.8 5805.6 5868.4 5871.4 5893.8 5908.4 5908.8 5935.0 5936.7 6442.4 6527.9 6613.9 6614.7 6650.0 6687.9 6850.6 6857.6 6945.8 6948.9 6416.5 6476.3 6523.8 6568.3 6591.0 6550.4 6729.9 6782.8 6792.2 6794.9 6863.3 6876.6 6901.4 6959.3 6962.6 6436.6 6553.4 6583.7 6612.8 6712.1 6688.4 6712.3 6714.5 6740.9 6745.0 6359.9 6401.6 6489.7 6490.6 6602.2 6569.8 6579.1 6604.1 6803.0 6804.1 6302.0 6366.4 6396.0 6404.0 6483.4 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#1] ext.html Cycles:180 Average:38049.49 Median:37180.54 stddev:54117.56 (145.6%) stddev-sans-first:54197.30 03:06:32 INFO - PID 3771 | Values: 853.7 880.5 881.3 884.2 887.2 39147.6 42477.4 42756.0 42761.8 42776.6 38790.2 38793.8 39032.0 39074.2 39089.6 7065.8 7150.5 7174.5 7175.5 7180.4 7042.5 7153.7 7154.2 7154.5 7154.9 7124.6 7154.4 7155.0 7158.1 7789.3 7844.2 7904.7 7908.6 7914.4 7916.5 7762.3 7872.4 7876.4 7880.3 7883.8 37913.2 38555.0 38678.0 38732.0 38802.2 3362.1 3399.0 3404.6 3409.8 3415.3 32327.2 32499.2 32510.8 32521.8 32554.2 5194.1 5209.1 5231.8 5234.8 5282.1 185646.0 185713.0 185723.0 185843.0 185857.0 42060.4 43006.0 48639.0 48685.3 48783.8 53051.7 53855.5 53881.5 53909.5 53926.0 16022.2 16107.4 16114.0 16132.8 16141.2 13218.0 13326.2 13328.9 13338.3 13349.3 13510.4 13600.8 13609.5 13710.5 13750.3 5704.1 5752.3 5752.5 5756.6 5777.0 996.0 1019.7 1024.1 1027.5 1038.5 22513.0 22784.3 22906.3 23043.9 23139.3 1090.0 1104.3 1104.6 1107.3 1108.2 11946.3 12117.3 12122.8 12242.4 12251.9 226767.0 228986.0 229258.0 229726.0 230021.0 46968.5 47057.5 47167.3 56425.7 57913.4 1414.3 1441.0 1450.2 1457.3 1460.3 26552.3 26847.2 27201.5 27255.3 27542.6 38010.8 38463.0 38470.2 38561.2 38561.8 209007.0 209045.0 209979.0 210227.0 210334.0 34529.8 36891.3 37897.4 38088.2 38100.2 46396.0 46701.3 47113.3 47235.5 47438.8 33027.5 33148.8 33429.8 33632.0 33978.2 30416.5 30476.0 30735.8 31148.2 31360.7 37469.8 37630.0 37688.0 37710.2 37759.8 32058.0 32285.4 32363.5 32394.8 32684.8 23936.5 24182.0 24283.8 24456.6 24543.8 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#2] jquery.html Cycles:180 Average:32995.61 Median:22746.32 stddev:76777.79 (337.5%) stddev-sans-first:76954.55 03:06:32 INFO - PID 3771 | Values: 563.2 566.5 571.1 571.7 575.5 22059.2 22686.4 22693.9 22741.9 22750.4 22742.2 23857.6 24004.0 24187.3 24256.0 6305.7 6396.6 6447.9 6455.6 6469.4 6262.5 6310.9 6415.1 6418.0 6419.6 6451.5 6474.0 6478.6 6483.7 6486.3 6460.9 6464.2 6468.9 6482.8 6493.6 5904.6 5915.9 6135.2 6146.0 6148.0 27556.7 28371.1 28387.4 28388.1 28406.4 2001.9 2053.7 2053.7 2053.7 2055.2 18647.9 19097.7 19378.0 19387.6 19656.7 2378.7 2395.5 2415.1 2428.7 2470.6 119714.4 125106.4 129885.0 135579.3 136290.3 13963.5 14005.7 14298.0 14466.5 14634.9 22624.9 22774.8 22785.8 22792.0 22881.1 9337.5 9509.8 9605.5 9622.4 9670.4 8636.8 8751.2 8775.5 8899.0 8909.1 8572.6 8823.4 8831.8 8998.7 9066.9 2784.1 2788.1 2802.4 2805.5 2878.1 939.9 958.3 963.1 969.0 969.6 18707.3 18720.3 18756.4 18762.2 19274.2 1007.3 1010.5 1015.7 1016.8 1017.2 10289.6 10401.8 10479.3 10486.7 10497.4 436116.0 454106.0 454880.0 462825.0 463728.0 108770.0 110470.0 110693.4 111558.0 113354.0 1126.9 1167.3 1167.5 1171.4 1181.9 16266.3 16623.8 16812.3 16880.6 17120.7 56149.2 56545.4 56587.0 57033.0 58977.0 71395.6 71520.6 72149.0 72258.0 72758.5 13971.3 14298.6 14318.9 14325.9 14348.5 21558.5 21662.6 21811.9 21866.3 21918.2 17020.0 17151.1 17157.2 17457.0 17517.6 14511.7 14705.8 14849.3 14945.9 15030.3 17760.4 17776.3 17914.1 17977.7 18043.4 13811.6 13844.9 13950.6 13992.8 13996.0 17262.2 17320.7 17347.7 17471.5 17499.2 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#3] mootools.html Cycles:180 Average:9400.24 Median:2678.45 stddev:6600.65 (246.4%) stddev-sans-first:6591.24 03:06:32 INFO - PID 3771 | Values: 1319.2 1366.3 1370.6 1376.8 1383.9 14989.0 15610.4 15613.3 15686.6 15764.8 15194.4 15377.4 15378.4 15407.6 15420.6 2734.2 2837.2 2840.8 2841.3 2841.9 2703.7 2775.7 2816.0 2816.4 2817.3 2672.0 2767.2 2860.5 2870.6 2878.3 2684.9 2693.9 2699.7 2706.1 2720.3 2746.3 2751.2 2751.5 2763.3 2767.5 14881.1 15028.6 15089.1 15101.9 15117.6 7928.4 8149.8 8216.3 8222.3 8228.8 5370.7 5582.2 5742.3 5753.7 5769.4 1930.0 1976.2 1979.3 2021.7 2025.3 24884.6 24983.8 25004.5 25039.5 25064.9 6697.7 6707.8 6764.1 6886.0 6895.6 16949.0 16958.2 16958.9 16968.1 16995.0 7837.9 8070.6 8079.2 8081.2 8086.1 7378.0 7434.1 7510.0 7510.7 7530.4 5155.8 5327.9 5344.7 5345.5 5374.8 1469.4 1482.2 1482.6 1489.4 1504.1 859.2 903.9 906.9 907.7 913.9 7621.6 7651.5 7760.5 7767.1 7855.1 697.5 702.7 722.2 725.8 728.0 4704.5 4764.2 4767.4 5052.6 5391.4 20497.7 22052.8 22062.7 22073.4 22093.0 19897.4 20512.3 21186.2 21586.2 21618.9 11324.3 11635.2 11682.4 11713.2 11740.5 8539.0 8650.6 8990.0 9155.1 9167.7 18790.5 18910.7 18912.1 18990.1 19069.0 19363.2 19644.9 19735.6 19811.4 19938.7 12037.9 12389.9 12516.6 12537.4 12561.8 14068.8 14085.4 14197.9 14202.6 14254.0 11176.8 11233.3 11375.3 11470.3 11484.7 10990.2 11340.6 11386.9 11420.1 11495.3 10086.3 10189.0 10189.3 10193.5 10199.2 7095.9 7338.6 7364.4 7453.3 7613.2 7398.3 7439.4 7470.7 7482.4 7570.8 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#4] prototype.html Cycles:180 Average:5561.11 Median:6343.47 stddev:1553.23 (24.5%) stddev-sans-first:1510.41 03:06:32 INFO - PID 3771 | Values: 499.2 512.5 516.8 523.2 527.8 6385.3 6427.6 6461.2 6477.9 6509.0 6342.9 6344.0 6361.7 6363.8 6371.7 5257.8 5266.3 5269.6 5276.9 5283.7 4937.8 5118.0 5251.6 5271.9 5297.1 5054.5 5062.6 5065.9 5067.7 5112.3 5020.5 5034.9 5035.8 5089.5 5113.8 4533.2 4548.2 4555.3 4574.3 4588.9 6261.5 6308.8 6327.9 6327.9 6340.3 5688.9 5728.1 5783.0 5790.3 5800.0 6529.8 6603.4 6678.3 6705.1 6709.8 4844.9 4874.3 4904.3 4904.6 4910.6 6631.8 6820.6 6838.6 6839.9 6901.3 4911.3 4945.8 4973.9 5004.3 5018.4 5041.1 5046.3 5058.6 5061.1 5080.2 5605.3 5676.5 5684.4 5735.9 5768.2 6631.7 6665.2 6672.0 6742.9 6767.1 1742.5 1765.3 1774.5 1779.2 1780.0 1171.0 1204.7 1216.2 1221.1 1222.6 5683.9 5720.9 5741.9 5778.2 5808.3 6636.8 6653.6 6793.3 6821.4 6841.5 5666.0 5666.6 5668.3 5676.1 5694.3 3595.2 3609.8 3620.9 3643.4 3645.8 6560.5 6562.7 6574.5 6576.4 6583.7 6546.4 6936.5 6987.3 6991.0 6991.3 6413.6 6430.3 6448.1 6449.2 6503.4 6560.6 6588.9 6597.5 6776.5 6792.8 6598.3 6629.2 6663.8 6731.8 6769.1 6434.2 6478.7 6510.4 6512.8 6602.5 4837.9 4973.5 5010.8 5050.8 5069.4 6606.8 6609.0 6645.7 6848.7 6858.6 6458.9 6520.6 6526.3 6529.2 6640.0 6467.0 6498.2 6582.4 6614.9 6615.9 6428.7 6483.2 6501.0 6537.7 6605.9 6580.5 6588.8 6695.8 6713.9 6734.4 6380.6 6383.5 6401.7 6434.8 6462.0 03:06:32 INFO - PID 3771 | 03:06:32 INFO - PID 3771 | [#5] yui.html Cycles:180 Average:24589.98 Median:20077.75 stddev:36589.76 (182.2%) stddev-sans-first:36649.00 03:06:32 INFO - PID 3771 | Values: 854.4 887.6 889.6 898.4 925.7 19101.0 19154.6 19940.1 20000.4 20008.7 16432.8 16491.6 16536.1 17502.3 18023.6 950.8 983.8 987.3 988.7 990.4 939.2 971.5 974.4 984.9 985.7 1034.1 1036.2 1037.0 1037.3 1037.4 1022.1 1022.1 1023.7 1023.9 1024.9 722.6 735.7 748.2 748.5 762.7 20250.5 20307.2 20329.2 20431.2 20447.9 20146.8 20173.8 20530.6 20644.3 20667.4 17482.7 17535.8 17731.1 18217.6 18299.0 3675.4 3701.9 3702.2 3703.0 3704.2 140416.3 141064.0 142711.3 144504.3 146654.0 16301.8 16390.1 16683.2 16755.2 16850.0 29055.9 29692.6 29778.1 29934.7 30004.2 8551.9 8564.4 8596.0 8606.7 8608.7 4067.4 4153.2 4159.0 4199.8 4209.7 5439.6 5537.4 5540.0 5546.1 5571.7 943.4 959.4 968.7 970.7 976.9 660.8 673.2 684.5 690.7 698.2 11413.4 11511.1 11819.4 12409.4 12617.6 655.6 666.8 677.0 677.8 679.2 5549.8 5554.9 5558.2 5688.8 5723.6 127215.4 129375.4 132841.0 132945.0 133186.0 108831.5 110162.0 111277.0 112089.0 112828.0 93375.0 95788.5 97112.5 97933.0 103639.0 10200.4 10247.1 10254.5 10288.6 10463.3 43039.6 43682.6 44449.8 44584.0 44743.6 56622.4 57223.0 57241.7 57621.4 58834.4 14448.3 14890.2 14891.5 14967.3 15000.7 17069.2 17326.5 17396.1 17467.3 17510.8 15110.4 15188.8 15247.3 15374.9 15427.0 15820.5 15978.0 16020.4 16202.4 16255.8 15214.1 15429.8 15446.7 15611.6 15629.3 10757.0 10777.9 11029.0 11050.7 11121.2 11286.2 11515.5 11598.0 11650.8 11712.6 03:06:32 INFO - PID 3771 | -------- Summary: end -------- 03:06:32 INFO - PID 3771 | 03:06:33 INFO - TEST-INFO | 3771: exit 0 03:06:33 INFO - TEST-OK | dromaeo_css | took 1110534ms 03:06:33 INFO - TEST-START | kraken 03:06:33 INFO - Initialising browser for kraken test... 03:06:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34166/getInfo.html -profile /tmp/tmpIqMShT/profile 03:06:33 INFO - TEST-INFO | started process 4155 (/builds/slave/test/build/application/firefox/firefox http://localhost:34166/getInfo.html) 03:06:38 INFO - TEST-INFO | 4155: exit 0 03:06:38 INFO - Browser initialized. 03:06:38 INFO - Running cycle 1/1 for kraken test... 03:06:38 INFO - Using env: {'DISPLAY': ':0', 03:06:38 INFO - 'HOME': '/home/cltbld', 03:06:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:06:38 INFO - 'LANG': 'en_US.UTF-8', 03:06:38 INFO - 'LANGUAGE': 'en_US:en', 03:06:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:06:38 INFO - 'LOGNAME': 'cltbld', 03:06:38 INFO - 'MAIL': '/var/mail/cltbld', 03:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:06:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:06:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:06:38 INFO - 'MOZ_NO_REMOTE': '1', 03:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:06:38 INFO - 'NO_EM_RESTART': '1', 03:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:06:38 INFO - 'PWD': '/builds/slave/test', 03:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:06:38 INFO - 'RUST_BACKTRACE': 'full', 03:06:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:06:38 INFO - 'SHELL': '/bin/bash', 03:06:38 INFO - 'SHLVL': '1', 03:06:38 INFO - 'TERM': 'linux', 03:06:38 INFO - 'TMOUT': '86400', 03:06:38 INFO - 'USER': 'cltbld', 03:06:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003', 03:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:06:38 INFO - '_': '/tools/buildbot/bin/python'} 03:06:38 INFO - TEST-INFO | started process 4348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIqMShT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:39 INFO - PID 4348 | 03:06:39 INFO - PID 4348 | (/builds/slave/test/build/application/firefox/firefox:4399): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:06:39 INFO - PID 4348 | 03:06:50 INFO - PID 4348 | RSS: Main: 172810240 03:06:50 INFO - PID 4348 | 03:06:52 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34166/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:53 INFO - PID 4348 | RSS: Main: 178753536 03:06:53 INFO - PID 4348 | 03:06:56 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34166/tests/kraken/driver.html?testName=audio-dft) 03:06:56 INFO - PID 4348 | RSS: Main: 178946048 03:06:56 INFO - PID 4348 | 03:06:59 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34166/tests/kraken/driver.html?testName=audio-fft) 03:07:00 INFO - PID 4348 | RSS: Main: 173596672 03:07:00 INFO - PID 4348 | 03:07:02 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34166/tests/kraken/driver.html?testName=audio-oscillator) 03:07:03 INFO - PID 4348 | RSS: Main: 174157824 03:07:03 INFO - PID 4348 | 03:07:05 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34166/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:07:05 INFO - PID 4348 | RSS: Main: 174669824 03:07:05 INFO - PID 4348 | 03:07:09 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34166/tests/kraken/driver.html?testName=imaging-darkroom) 03:07:09 INFO - PID 4348 | RSS: Main: 176959488 03:07:09 INFO - PID 4348 | 03:07:13 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34166/tests/kraken/driver.html?testName=imaging-desaturate) 03:07:13 INFO - PID 4348 | RSS: Main: 176664576 03:07:13 INFO - PID 4348 | 03:07:16 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34166/tests/kraken/driver.html?testName=json-parse-financial) 03:07:17 INFO - PID 4348 | RSS: Main: 177221632 03:07:17 INFO - PID 4348 | 03:07:19 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34166/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:07:19 INFO - PID 4348 | RSS: Main: 176926720 03:07:19 INFO - PID 4348 | 03:07:21 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:07:21 INFO - PID 4348 | RSS: Main: 176979968 03:07:21 INFO - PID 4348 | 03:07:24 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:07:24 INFO - PID 4348 | RSS: Main: 173989888 03:07:24 INFO - PID 4348 | 03:07:27 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:07:28 INFO - PID 4348 | RSS: Main: 174305280 03:07:28 INFO - PID 4348 | 03:07:31 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:07:31 INFO - PID 4348 | RSS: Main: 174567424 03:07:31 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | Cycle 1(1): loaded http://localhost:34166/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34166/tests/kraken/driver.html?testName=ai-astar) 03:07:33 INFO - PID 4348 | RSS: Main: 176107520 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | __start_tp_report 03:07:33 INFO - PID 4348 | _x_x_mozilla_page_load 03:07:33 INFO - PID 4348 | _x_x_mozilla_page_load_details 03:07:33 INFO - PID 4348 | |i|pagename|runs| 03:07:33 INFO - PID 4348 | |0;ai-astar;110;107;107;108;107;97;106;106;110;107 03:07:33 INFO - PID 4348 | |1;audio-beat-detection;117;117;117;118;117;126;147;115;118;118 03:07:33 INFO - PID 4348 | |2;audio-dft;164;166;166;165;164;165;167;171;166;166 03:07:33 INFO - PID 4348 | |3;audio-fft;73;74;78;76;80;75;76;76;74;74 03:07:33 INFO - PID 4348 | |4;audio-oscillator;80;80;79;79;79;79;79;80;79;80 03:07:33 INFO - PID 4348 | |5;imaging-gaussian-blur;113;114;113;114;114;113;113;110;114;118 03:07:33 INFO - PID 4348 | |6;imaging-darkroom;147;148;149;148;148;148;150;148;149;147 03:07:33 INFO - PID 4348 | |7;imaging-desaturate;95;95;93;94;98;95;94;95;95;94 03:07:33 INFO - PID 4348 | |8;json-parse-financial;53;51;52;57;53;54;52;52;48;49 03:07:33 INFO - PID 4348 | |9;json-stringify-tinderbox;38;37;38;37;38;37;37;37;37;37 03:07:33 INFO - PID 4348 | |10;stanford-crypto-aes;74;75;74;84;74;78;73;76;74;74 03:07:33 INFO - PID 4348 | |11;stanford-crypto-ccm;120;121;118;118;117;124;130;122;117;119 03:07:33 INFO - PID 4348 | |12;stanford-crypto-pbkdf2;173;165;185;171;169;169;170;168;168;173 03:07:33 INFO - PID 4348 | |13;stanford-crypto-sha256-iterative;72;63;63;66;62;64;69;66;66;67 03:07:33 INFO - PID 4348 | __end_tp_report 03:07:33 INFO - PID 4348 | __start_cc_report 03:07:33 INFO - PID 4348 | _x_x_mozilla_cycle_collect,950 03:07:33 INFO - PID 4348 | __end_cc_report 03:07:33 INFO - PID 4348 | __startTimestamp1504865253696__endTimestamp 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | ------- Summary: start ------- 03:07:33 INFO - PID 4348 | Number of tests: 14 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#0] ai-astar Cycles:10 Average:106.50 Median:107.50 stddev:3.63 (3.4%) stddev-sans-first:3.62 03:07:33 INFO - PID 4348 | Values: 110.0 107.0 107.0 108.0 107.0 97.0 106.0 106.0 110.0 107.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#1] audio-beat-detection Cycles:10 Average:121.00 Median:118.00 stddev:9.59 (8.1%) stddev-sans-first:10.06 03:07:33 INFO - PID 4348 | Values: 117.0 117.0 117.0 118.0 117.0 126.0 147.0 115.0 118.0 118.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:2.00 (1.2%) stddev-sans-first:1.99 03:07:33 INFO - PID 4348 | Values: 164.0 166.0 166.0 165.0 164.0 165.0 167.0 171.0 166.0 166.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#3] audio-fft Cycles:10 Average:75.60 Median:76.00 stddev:2.12 (2.8%) stddev-sans-first:2.03 03:07:33 INFO - PID 4348 | Values: 73.0 74.0 78.0 76.0 80.0 75.0 76.0 76.0 74.0 74.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 03:07:33 INFO - PID 4348 | Values: 80.0 80.0 79.0 79.0 79.0 79.0 79.0 80.0 79.0 80.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 03:07:33 INFO - PID 4348 | Values: 113.0 114.0 113.0 114.0 114.0 113.0 113.0 110.0 114.0 118.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:07:33 INFO - PID 4348 | Values: 147.0 148.0 149.0 148.0 148.0 148.0 150.0 148.0 149.0 147.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.32 (1.4%) stddev-sans-first:1.39 03:07:33 INFO - PID 4348 | Values: 95.0 95.0 93.0 94.0 98.0 95.0 94.0 95.0 95.0 94.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:2.51 (4.8%) stddev-sans-first:2.65 03:07:33 INFO - PID 4348 | Values: 53.0 51.0 52.0 57.0 53.0 54.0 52.0 52.0 48.0 49.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 03:07:33 INFO - PID 4348 | Values: 38.0 37.0 38.0 37.0 38.0 37.0 37.0 37.0 37.0 37.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:74.50 stddev:3.27 (4.4%) stddev-sans-first:3.42 03:07:33 INFO - PID 4348 | Values: 74.0 75.0 74.0 84.0 74.0 78.0 73.0 76.0 74.0 74.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:4.01 (3.3%) stddev-sans-first:4.24 03:07:33 INFO - PID 4348 | Values: 120.0 121.0 118.0 118.0 117.0 124.0 130.0 122.0 117.0 119.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:170.50 stddev:5.45 (3.2%) stddev-sans-first:5.73 03:07:33 INFO - PID 4348 | Values: 173.0 165.0 185.0 171.0 169.0 169.0 170.0 168.0 168.0 173.0 03:07:33 INFO - PID 4348 | 03:07:33 INFO - PID 4348 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:3.05 (4.6%) stddev-sans-first:2.26 03:07:33 INFO - PID 4348 | Values: 72.0 63.0 63.0 66.0 62.0 64.0 69.0 66.0 66.0 67.0 03:07:33 INFO - PID 4348 | -------- Summary: end -------- 03:07:33 INFO - PID 4348 | 03:07:34 INFO - PID 4348 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:07:34 INFO - TEST-INFO | 4348: exit 0 03:07:34 INFO - TEST-OK | kraken | took 61180ms 03:07:34 INFO - SUITE-END | took 1171s 03:07:34 INFO - Completed test suite (00:19:32) 03:07:34 INFO - javascript benchmark 03:07:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8489.031471128632, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.0951724000042, 3133.858976346064, 3152.3380090181054, 3162.067190178897, 3162.5098109792975, 6215.875682486348, 6383.329750376208, 6386.26557945837, 6408.0, 6415.422611964928, 6285.277193122793, 6293.779717709881, 6426.325235850239, 6436.034594810781, 6477.54657173998, 5811.564132690044, 5869.383714709958, 5883.23517942668, 5964.821055368324, 5970.8805823883495, 5819.941800582003, 5850.385709500505, 5946.345901950782, 5964.850878728045, 5973.910391344133, 5688.374278829326, 5798.1592669063175, 5813.622114562561, 5853.0, 5863.296404431474, 5768.509676677488, 5837.066069428914, 5843.620164689281, 5868.061110222387, 5879.147523609053, 5812.273465816773, 5815.069588865761, 5854.6194497357965, 5863.882722345529, 5902.409759024106, 6209.192804935329, 6342.714577844008, 6372.426481616631, 6415.550911436201, 6455.7740479083, 6662.267150613428, 6752.1222241108835, 6782.321767823228, 6794.388505034571, 6800.047993280945, 6822.249552549216, 6825.658717064177, 6903.309669033107, 6903.689333979983, 6907.689153988083, 6211.3167551569295, 6292.087647291117, 6292.779752708633, 6292.779752708633, 6294.968525157391, 6897.206821215625, 6910.965445172742, 6918.5502942308585, 6924.065251191126, 6927.792166235021, 6517.641529715911, 6582.3746744059235, 6591.439727623206, 6591.835204119935, 6616.569922954993, 6630.602163870087, 6646.435053020451, 6687.762763888696, 6804.149481314836, 6941.583504989717, 6751.291114433012, 6825.215100263533, 6867.896981545281, 6871.0, 6872.965635171892, 6738.427233685094, 6786.083878676414, 6823.454123670193, 6871.106756121672, 6875.0, 5214.817481388133, 5287.339082614673, 5320.920186197211, 5349.5720342372515, 5386.5152136307925, 4655.138799322136, 4710.599599034052, 4717.858464246078, 4727.149113159664, 4736.407949006374, 5797.101449275369, 5803.448672376117, 5869.207656966255, 5891.41085891416, 5895.29256489224, 6859.622720750406, 6862.176538815374, 6909.689063992132, 6936.514443988873, 6942.652867356612, 5698.857528561736, 5787.768489260382, 5805.564582656318, 5868.442497962772, 5871.442212989845, 5893.793717219876, 5908.350081491032, 5908.763649454059, 5934.970325148433, 5936.673482958392, 6442.35576442352, 6527.934720652733, 6613.900791488131, 6614.702338394687, 6649.966750166218, 6687.866242675216, 6850.588964662136, 6857.622830744357, 6945.756898508528, 6948.930510694829, 6416.454601358937, 6476.31998640136, 6523.7716679915975, 6568.343165683394, 6591.011348297794, 6550.443212327005, 6729.932700672931, 6782.762603308861, 6792.218894827158, 6794.898076528955, 6863.347981941708, 6876.621785801829, 6901.447884169354, 6959.26927672587, 6962.617056061965, 6436.613803171825, 6553.442957348679, 6583.703733331916, 6612.801615951529, 6712.127423434922, 6688.431483323972, 6712.328767123444, 6714.496412768965, 6740.9325906740305, 6745.0, 6359.936400635935, 6401.583897046677, 6489.707963141575, 6490.643014634241, 6602.240742314695, 6569.770058048137, 6579.078928950046, 6604.108445360007, 6803.0, 6804.149481314836, 6302.0, 6366.427021568081, 6395.968020159869, 6404.039394090923, 6483.448906842783], "value": 6192.543994666033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.6841368693584, 880.5333173418082, 881.2509367038018, 884.1821315283365, 887.1527691055041, 39147.60852391479, 42477.362839557434, 42756.0, 42761.786191069004, 42776.572234277686, 38790.224195516144, 38793.80603096988, 39032.0, 39074.21851562974, 39089.60910390895, 7065.788026359218, 7150.499465037449, 7174.497785155041, 7175.4977151599405, 7180.425565954711, 7042.4718146138985, 7153.713851445936, 7154.248803875596, 7154.534955227893, 7154.8569028619395, 7124.608146551937, 7154.427645788324, 7155.0, 7158.069450971392, 7789.260020298091, 7844.215578442138, 7904.723334683287, 7908.644111015018, 7914.406419518559, 7916.525008499509, 7762.340201082915, 7872.370210383156, 7876.409269304768, 7880.330171935392, 7883.763487095396, 37913.241735165415, 38555.0, 38678.0, 38732.0, 38802.22395552101, 3362.142653623335, 3399.031276086328, 3404.591449026108, 3409.8465569049454, 3415.282790613974, 32327.191820204447, 32499.187520311945, 32510.837445812856, 32521.837390812896, 32554.18614534632, 5194.065068287745, 5209.062368773619, 5231.764570594294, 5234.842954711365, 5282.128448805943, 185646.0, 185713.0, 185723.0, 185843.0, 185857.0, 42060.36909446361, 43006.0, 48639.0, 48685.26972095422, 48783.756081220075, 53051.73474132682, 53855.461445385044, 53881.46118538843, 53909.46090539123, 53926.0, 16022.19889005545, 16107.355705771872, 16114.0, 16132.838671613368, 16141.19294035317, 13218.0, 13326.200427974352, 13328.866711332956, 13338.266395348155, 13349.265790381622, 13510.392032358372, 13600.795988060187, 13609.455621775018, 13710.451581936612, 13750.312484375741, 5704.11586204139, 5752.338481074647, 5752.511036561856, 5756.625819321731, 5777.006932608243, 995.9800803983879, 1019.7399663085865, 1024.0987930621006, 1027.4605831938143, 1038.5482315192914, 22512.955568770958, 22784.31647050558, 22906.31281061571, 23043.88478057599, 23139.3058208254, 1089.9618513351995, 1104.2932523185168, 1104.640991677708, 1107.346665467362, 1108.1854836695022, 11946.34295113777, 12117.27296362221, 12122.75754484923, 12242.44908979098, 12251.877481225252, 226767.0, 228986.0, 229258.0, 229726.0, 230021.0, 46968.530314696414, 47057.529424706, 47167.29249061267, 56425.7178714112, 57913.420865791646, 1414.2575148047358, 1440.9783853242209, 1450.158907833475, 1457.271364317841, 1460.2698650674663, 26552.336191595365, 26847.194584162506, 27201.455970880867, 27255.318617034733, 27542.5868611975, 38010.809945950095, 38463.0, 38470.23059538737, 38561.22877542378, 38561.80719096387, 209007.0, 209045.0, 209979.0, 210227.0, 210334.0, 34529.82735086309, 36891.26217475689, 37897.43153852639, 38088.23823523459, 38100.237995240495, 46396.0, 46701.29948050714, 47113.2933006012, 47235.527644723115, 47438.76280618575, 33027.504587430725, 33148.834255828566, 33429.83285083559, 33632.0, 33978.150546235556, 30416.543751844183, 30476.0, 30735.846320768254, 31148.22129446782, 31360.686393135777, 37469.81265093657, 37630.0, 37688.0, 37710.24579508449, 37759.81120094382, 32058.038258852273, 32285.35429291448, 32363.51454728228, 32394.83802580972, 32684.836575816968, 23936.52126957416, 24182.0, 24283.757162428858, 24456.581430411497, 24543.754562454862], "value": 17272.38238964497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2143160291394, 566.5074813773089, 571.0948147186709, 571.6598623818829, 575.4993155954319, 22059.22792702256, 22686.43283917903, 22693.886530567346, 22741.886290568524, 22750.43123921903, 22742.20402285916, 23857.642135367983, 24004.0, 24187.27438176853, 24256.0, 6305.653189074611, 6396.648184349859, 6447.935520644804, 6455.580387274836, 6469.385408386196, 6262.467690246334, 6310.905336419957, 6415.06981487684, 6418.0, 6419.582727122745, 6451.548391612589, 6473.967630161843, 6478.643674597919, 6483.708233129497, 6486.2540807807, 6460.93539064608, 6464.224293084836, 6468.902966455507, 6482.773102941374, 6493.6103833769885, 5904.61619994699, 5915.852103697399, 6135.171751813493, 6146.016637338004, 6148.016317389196, 27556.724432755615, 28371.148865534065, 28387.432251354858, 28388.148355549365, 28406.431871362456, 2001.8698784578955, 2053.650879350499, 2053.661145910923, 2053.722747429093, 2055.1882006607457, 18647.906760466245, 19097.713534296996, 19378.0, 19387.612247755107, 19656.70514942277, 2378.7273808512364, 2395.5448464791634, 2415.118481754147, 2428.672129262545, 2470.5800013997664, 119714.40142799317, 125106.374468128, 129885.0, 135579.32210338884, 136290.3185484076, 13963.511277105252, 14005.719885602435, 14298.0, 14466.493672721404, 14634.926825365805, 22624.886875565517, 22774.772252277595, 22785.772142278696, 22792.0, 22881.084756609882, 9337.486438245825, 9509.809803803884, 9605.47169905662, 9622.37454565451, 9670.371425857296, 8636.784080397914, 8751.168638979287, 8775.473471591726, 8899.0, 8909.109089091038, 8572.570971611281, 8823.382363234641, 8831.823363532694, 8998.730038098867, 9066.863997040049, 2784.1439606145636, 2788.135677939845, 2802.4114935863695, 2805.5370863807243, 2878.1221727373354, 939.9060093990546, 958.3483231402713, 963.0802583532709, 968.9854652180223, 969.6266937229077, 18707.34524291643, 18720.25118995225, 18756.437306880816, 18762.155702993397, 19274.22903083889, 1007.2596641468515, 1010.4594042187395, 1015.7409860485529, 1016.7966406718685, 1017.1506791828906, 10289.639862604772, 10401.84397234042, 10479.318844275098, 10486.685399438029, 10497.422641754776, 436116.0, 454106.0, 454880.0, 462825.0, 463728.0, 108770.0, 110470.0, 110693.44653276843, 111558.0, 113354.0, 1126.8704099028716, 1167.3171194851107, 1167.5329868052677, 1171.437709899236, 1181.8640856301463, 16266.349346026027, 16623.750643740113, 16812.327506899586, 16880.57798555046, 17120.657586848443, 56149.15776263278, 56545.43454565566, 56587.0, 57033.0, 58977.0, 71395.64302178456, 71520.64239678768, 72149.0, 72258.0, 72758.45345412884, 13971.30143492801, 14298.642533936734, 14318.856811431753, 14325.856741432452, 14348.497802577278, 21558.461038474165, 21662.566748664623, 21811.890940545196, 21866.344009679735, 21918.23286184976, 17020.0, 17151.142442877557, 17157.227924743165, 17457.0, 17517.64964700724, 14511.709765804835, 14705.779413308595, 14849.331780070139, 14945.925270373578, 15030.323635436212, 17760.3783867564, 17776.288948441917, 17914.10429478547, 17977.73033404474, 18043.368482103062, 13811.585652430444, 13844.861551384358, 13950.581482555539, 13992.790108148183, 13996.020278580401, 17262.223199956283, 17320.65358692844, 17347.739783903504, 17471.475855724348, 17499.212535435683], "value": 11583.94188246532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.201882860869, 1366.2553908120074, 1370.5614203454893, 1376.781548329728, 1383.854695256998, 14989.0, 15610.375584976588, 15613.297401616926, 15686.607834804136, 15764.763528547051, 15194.392224311014, 15377.384904603803, 15378.38486460543, 15407.614809629766, 15420.61448463789, 2734.179746076179, 2837.163036904108, 2840.772738180951, 2841.3038805492683, 2841.8579071046365, 2703.7431444012886, 2775.708550602188, 2816.0143949617573, 2816.4367126574666, 2817.3238422778486, 2671.9732802672015, 2767.1975127213086, 2860.5280128778727, 2870.5694145878183, 2878.2948177696494, 2684.932876678079, 2693.932651683704, 2699.6895357033995, 2706.052881491482, 2720.2927238917923, 2746.285965648926, 2751.2296556964084, 2751.5184842652457, 2763.3367991681853, 2767.4741799058115, 14881.10713357202, 15028.624284392869, 15089.094654320666, 15101.924490377478, 15117.622059448491, 7928.365730741527, 8149.755507334789, 8216.301614362786, 8222.342212622976, 8228.794280142984, 5370.731463426852, 5582.246396736429, 5742.28221472316, 5753.741081651294, 5769.394213607553, 1929.9903500482408, 1976.1700085963787, 1979.3468155508792, 2021.6664250398815, 2025.2506572568097, 24884.626730599055, 24983.750162498505, 25004.499910001698, 25039.499210015696, 25064.87467562687, 6697.665116744143, 6707.832304192337, 6764.120664313607, 6886.0, 6895.55178913369, 16949.0, 16958.152092395332, 16958.915205423895, 16968.066756328273, 16995.0, 7837.9216207838335, 8070.556119413372, 8079.151689072681, 8081.232282933112, 8086.110527841933, 7378.0, 7434.145073316529, 7510.0, 7510.6620202091035, 7530.359919406912, 5155.819546315861, 5327.866803329948, 5344.679319240858, 5345.4654534546235, 5374.758135883894, 1469.4342678068806, 1482.2440555316866, 1482.5996980815119, 1489.3819065088085, 1504.1125735815701, 859.2352806002663, 903.8824952756099, 906.9319801014818, 907.6521365771823, 913.9131782480654, 7621.618919054025, 7651.5409075455655, 7760.534367937942, 7767.1067827200595, 7855.13593504714, 697.4629535257925, 702.6873041496588, 722.1622917415773, 725.7967769024682, 727.9927200728031, 4704.482506924235, 4764.190087685102, 4767.427908650915, 5052.595792336604, 5391.406945236021, 20497.692534611695, 22052.779472205395, 22062.669059964115, 22073.44816379571, 22093.0, 19897.403077907686, 20512.282070127472, 21186.15255389767, 21586.244481443075, 21618.91905404755, 11324.263922845154, 11635.243709158878, 11682.415879206006, 11713.18007739467, 11740.530378784753, 8538.957305213435, 8650.56747162652, 8990.0, 9155.084491550791, 9167.679131230376, 18790.53023674419, 18910.716339255196, 18912.14895329686, 18990.145443455353, 19069.0, 19363.225470981004, 19644.90177549103, 19735.60528789445, 19811.405657830288, 19938.70091948651, 12037.939810300892, 12389.93805030969, 12516.624501264976, 12537.373131343578, 12561.811572826233, 14068.788968165281, 14085.366158523097, 14197.858021419654, 14202.644933876736, 14254.0, 11176.776464470828, 11233.32600044, 11375.317480950838, 11470.311781293149, 11484.655460336204, 10990.230683852054, 11340.603078892529, 11386.943065284951, 11420.143489238175, 11495.310281383145, 10086.344387614781, 10189.0, 10189.337693049929, 10193.490325483845, 10199.235057370579, 7095.858082838417, 7338.633068346455, 7364.410847132323, 7453.2546745325035, 7613.238676132564, 7398.334149926317, 7439.367653749492, 7470.663820128216, 7482.438817088631, 7570.848583028199], "value": 6700.08063851861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.24921334774325, 512.492632294029, 516.801031602833, 523.1759978034594, 527.8416475057481, 6385.297617262109, 6427.550071494991, 6461.192350956137, 6477.935220647792, 6509.0, 6342.936570634292, 6344.0, 6361.7137228824695, 6363.809085727424, 6371.745130194799, 5257.789688412459, 5266.3153790007245, 5269.578433725293, 5276.868078298035, 5283.709395983219, 4937.80248790048, 5118.0, 5251.632385733, 5271.919256552397, 5297.12597421425, 5054.519820617035, 5062.645614806965, 5065.873353166164, 5067.74661266937, 5112.335396398463, 5020.548150666421, 5034.942662040976, 5035.84892453227, 5089.465606111342, 5113.801065541816, 4533.161365147458, 4548.226801443762, 4555.316702494619, 4574.268117101248, 4588.908221835578, 6261.499080073583, 6308.810735677937, 6327.8801601463565, 6327.930953487555, 6340.270868850049, 5688.886222275572, 5728.112142617901, 5783.0, 5790.305163380422, 5799.971000145015, 6529.812512808215, 6603.372679595431, 6678.298778628271, 6705.089049620883, 6709.798706038778, 4844.927326090112, 4874.318360165737, 4904.346262034771, 4904.566803237748, 4910.600478863543, 6631.801045968628, 6820.590764554143, 6838.623875686835, 6839.897401538931, 6901.309869013058, 4911.263310503382, 4945.802167913315, 4973.905740737032, 5004.349434573555, 5018.397792264952, 5041.117804384218, 5046.343975283263, 5058.595312375001, 5061.139606266944, 5080.161773307437, 5605.271314729059, 5676.517496012885, 5684.431556844283, 5735.885282294331, 5768.163616275617, 6631.701573429207, 6665.233498147678, 6672.0, 6742.932570674328, 6767.1202743644, 1742.4685470931488, 1765.2762367429293, 1774.476529423823, 1779.17268470162, 1779.973300400495, 1171.0, 1204.6687161030786, 1216.2459275249225, 1221.1390969366576, 1222.5720997650928, 5683.920055189501, 5720.856978575569, 5741.942580574141, 5778.248827652378, 5808.332041815161, 6636.83407914806, 6653.6340501271925, 6793.320667933266, 6821.3519715626935, 6841.452683785285, 5665.951798917214, 5666.631668941505, 5668.319801623831, 5676.148577713376, 5694.288213973254, 3595.1551385424405, 3609.819509024538, 3620.873269435557, 3643.362411577963, 3645.799481028569, 6560.475161987125, 6562.737490500422, 6574.520732835073, 6576.44100251484, 6583.728613628291, 6546.400979154281, 6936.4797640177185, 6987.336203060701, 6990.965045174843, 6991.252186953262, 6413.647249401234, 6430.292667806538, 6448.1295025171, 6449.226092868792, 6503.382178693111, 6560.639164845979, 6588.934110658832, 6597.472202223715, 6776.492697701882, 6792.830179245559, 6598.27418983921, 6629.171353580802, 6663.766768163091, 6731.798046058626, 6769.120014398097, 6434.195725534309, 6478.70845811949, 6510.414062734377, 6512.822306266435, 6602.471802255904, 4837.854864354075, 4973.477784832685, 5010.774515146754, 5050.77271522775, 5069.391672999263, 6606.768763093269, 6609.0, 6645.700943457459, 6848.657567121723, 6858.622775747382, 6458.870822583616, 6520.6413647247955, 6526.314736952741, 6529.151210342625, 6639.966800165968, 6467.0, 6498.155239818982, 6582.3746744059235, 6614.867702645824, 6615.900761488485, 6428.6785660717715, 6483.157189565515, 6501.0, 6537.7058032389605, 6605.867882642417, 6580.5064620152725, 6588.769393071219, 6695.765648202289, 6713.865722685421, 6734.393904548614, 6380.585261957958, 6383.489320854228, 6401.711922963571, 6434.806955791334, 6462.0], "value": 5101.2557228445485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.3634991931004, 887.5917078144049, 889.5907882374107, 898.4294972692338, 925.7222833150055, 19101.0, 19154.616907661857, 19940.102695378726, 20000.399988000347, 20008.69986950197, 16432.75350869738, 16491.58771030725, 16536.090515021668, 17502.299908003664, 18023.63952720945, 950.8478643417054, 983.8081574093055, 987.274353350287, 988.6737376665683, 990.400807511456, 939.2251392601097, 971.4996776660025, 974.3569244298765, 984.8621193032981, 985.6895078050427, 1034.100332710543, 1036.2487196782347, 1036.9533370998286, 1037.2687255484866, 1037.4397825174397, 1022.0648106982139, 1022.0954455307033, 1023.7184774187084, 1023.8566600675837, 1024.8975102489728, 722.5592388642924, 735.6799792090404, 748.2069006852754, 748.4536288509419, 762.7368557847534, 20250.49373765653, 20307.187712491483, 20329.18683252668, 20431.182752689874, 20447.897760511252, 20146.79853201464, 20173.798262017484, 20530.589388212153, 20644.277450289166, 20667.379978600668, 17482.65034699299, 17535.824641753676, 17731.113444327733, 18217.63564728698, 18299.0, 3675.44868269759, 3701.9444708329397, 3702.1670124222105, 3703.037210325308, 3704.2221133561984, 140416.29791851077, 141064.0, 142711.28644356815, 144504.277478613, 146654.0, 16301.83698163027, 16390.098544580163, 16683.16584170811, 16755.246013929158, 16850.0, 29055.85472072626, 29692.554611680844, 29778.10665680033, 29934.700652993626, 30004.249893752833, 8551.871721924175, 8564.443311184754, 8596.0, 8606.6987655433, 8608.69869554575, 4067.4102255172834, 4153.190127925026, 4159.043420013353, 4199.832006719758, 4209.726367786084, 5439.5648348132845, 5537.390887002426, 5539.972300138554, 5546.112621980545, 5571.693556854331, 943.429225318686, 959.4051687953513, 968.7045451137329, 970.7233438470003, 976.9120779129912, 660.8182749743859, 673.1585518102372, 684.4695361095191, 690.6960937187621, 698.2110215456502, 11413.42932853354, 11511.079113670887, 11819.409029548488, 12409.379531023413, 12617.621471355875, 655.5509476008949, 666.8299583606149, 676.9729210831512, 677.8034370032635, 679.242644451443, 5549.778008879681, 5554.944450555443, 5558.194061861008, 5688.829335119953, 5723.570732195102, 127215.36392318165, 129375.35312323378, 132841.0, 132945.0, 133186.0, 108831.45584272029, 110162.0, 111277.0, 112089.0, 112828.0, 93375.0, 95788.52105739426, 97112.51443742878, 97933.0, 103639.0, 10200.4389758564, 10247.128994035591, 10254.53854576531, 10288.588456461957, 10463.267571269938, 43039.56960430481, 43682.563174367846, 44449.77775111233, 44584.0, 44743.55256447394, 56622.43377566172, 57223.0, 57241.713791430775, 57621.42378576328, 58834.41165588461, 14448.349824257723, 14890.181040042902, 14891.47879824201, 14967.326470308644, 15000.699986000001, 17069.231884564975, 17326.480205593853, 17396.130193490528, 17467.30130794754, 17510.82489175143, 15110.39558417651, 15188.772168417703, 15247.313870875616, 15374.9231253843, 15427.0, 15820.525384238492, 15978.0, 16020.359185632444, 16202.432914847925, 16255.75616365779, 15214.087154770748, 15429.845701542841, 15446.691066178839, 15611.609709756893, 15629.296681649126, 10757.0, 10777.89222107769, 11029.0, 11050.668479945292, 11121.221514493907, 11286.20996530235, 11515.481803318704, 11598.0, 11650.76698466043, 11712.648620541397], "value": 8836.679778025638, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 107.0, 108.0, 107.0, 97.0, 106.0, 106.0, 110.0, 107.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 126.0, 147.0, 115.0, 118.0, 118.0], "value": 121.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 165.0, 164.0, 165.0, 167.0, 171.0, 166.0, 166.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 78.0, 76.0, 80.0, 75.0, 76.0, 76.0, 74.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 79.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 110.0, 114.0, 118.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 93.0, 94.0, 98.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 57.0, 53.0, 54.0, 52.0, 52.0, 48.0, 49.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 84.0, 74.0, 78.0, 73.0, 76.0, 74.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 118.0, 118.0, 117.0, 124.0, 130.0, 122.0, 117.0, 119.0], "value": 120.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 165.0, 185.0, 171.0, 169.0, 169.0, 170.0, 168.0, 168.0, 173.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 63.0, 63.0, 66.0, 62.0, 64.0, 69.0, 66.0, 66.0, 67.0], "value": 65.8, "unit": "score"}]}]} 03:07:34 INFO - Return code: 0 03:07:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:07:34 INFO - # TBPL SUCCESS # 03:07:34 INFO - Running post-action listener: _package_coverage_data 03:07:34 INFO - Running post-action listener: _resource_record_post_action 03:07:34 INFO - [mozharness: 2017-09-08 10:07:34.962038Z] Finished run-tests step (success) 03:07:34 INFO - Running post-run listener: _resource_record_post_run 03:07:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 5763072; Write bytes: 412782592; Read time: 2628; Write time: 371420 03:07:35 INFO - TinderboxPrint: CPU usage
13.1% 03:07:35 INFO - TinderboxPrint: I/O read bytes / time
5,763,072 / 2,628 03:07:35 INFO - TinderboxPrint: I/O write bytes / time
412,782,592 / 371,420 03:07:35 INFO - TinderboxPrint: CPU idle
8,235.8 (86.9%) 03:07:35 INFO - TinderboxPrint: CPU user
1,190.7 (12.6%) 03:07:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:07:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 421888; Read time: 0; Write time: 48 03:07:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:07:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 5763072; Write bytes: 343142400; Read time: 2628; Write time: 312440 03:07:35 INFO - Running post-run listener: _upload_blobber_files 03:07:35 INFO - Blob upload gear active. 03:07:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:07:35 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 03:07:35 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'] 03:07:35 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 03:07:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:36 INFO - (blobuploader) - INFO - Done attempting. 03:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:07:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:37 INFO - (blobuploader) - INFO - Done attempting. 03:07:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:07:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:07:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:38 INFO - (blobuploader) - INFO - Done attempting. 03:07:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:07:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:07:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:07:45 INFO - (blobuploader) - INFO - Done attempting. 03:07:45 INFO - (blobuploader) - INFO - Iteration through files over. 03:07:45 INFO - Return code: 0 03:07:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:07:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:07:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd9948a4a1b8697a152949e4d5993be7cbed1475f815d70c940e1a83f54a201804f004a1fc7e53c07aa3b385efd146e1c2184734e754e0ccebb0dc345229c33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32432b70b56f3422bdf98b66b68427492b94c597689dffd7de8dc31613d512690dc7ea5fda5fafb8e983bde048c25e68a03a9d7788711c62020867e22205b6f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f52926b12cf4ce377a13c267f3f288294410cbf3967c652bc3a6080aff7d25990d4c3cb1e594085fb76a6c5e4b01daff0d48ac5bed8a9d7f4909d4ae9ab628fb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d698c5fb59ef5d41ef8d2478aa4826fff630cb551472879431e1ed7bcbb8017487dac0c785e624f24992fc20461f0b7d701aee0d0a18bbb0e2b1011e5a736bf5"} 03:07:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:07:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:07:45 INFO - Contents: 03:07:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd9948a4a1b8697a152949e4d5993be7cbed1475f815d70c940e1a83f54a201804f004a1fc7e53c07aa3b385efd146e1c2184734e754e0ccebb0dc345229c33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32432b70b56f3422bdf98b66b68427492b94c597689dffd7de8dc31613d512690dc7ea5fda5fafb8e983bde048c25e68a03a9d7788711c62020867e22205b6f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f52926b12cf4ce377a13c267f3f288294410cbf3967c652bc3a6080aff7d25990d4c3cb1e594085fb76a6c5e4b01daff0d48ac5bed8a9d7f4909d4ae9ab628fb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d698c5fb59ef5d41ef8d2478aa4826fff630cb551472879431e1ed7bcbb8017487dac0c785e624f24992fc20461f0b7d701aee0d0a18bbb0e2b1011e5a736bf5"} 03:07:45 INFO - Running post-run listener: copy_logs_to_upload_dir 03:07:45 INFO - Copying logs to upload dir... 03:07:45 INFO - mkdir: /builds/slave/test/build/upload/logs 03:07:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.865480 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-08 03:07:45.329574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:07:45.337444) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 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/9dd9948a4a1b8697a152949e4d5993be7cbed1475f815d70c940e1a83f54a201804f004a1fc7e53c07aa3b385efd146e1c2184734e754e0ccebb0dc345229c33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32432b70b56f3422bdf98b66b68427492b94c597689dffd7de8dc31613d512690dc7ea5fda5fafb8e983bde048c25e68a03a9d7788711c62020867e22205b6f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f52926b12cf4ce377a13c267f3f288294410cbf3967c652bc3a6080aff7d25990d4c3cb1e594085fb76a6c5e4b01daff0d48ac5bed8a9d7f4909d4ae9ab628fb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d698c5fb59ef5d41ef8d2478aa4826fff630cb551472879431e1ed7bcbb8017487dac0c785e624f24992fc20461f0b7d701aee0d0a18bbb0e2b1011e5a736bf5"} build_url:https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/F69fQAZfRECOnrdgihUWdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd9948a4a1b8697a152949e4d5993be7cbed1475f815d70c940e1a83f54a201804f004a1fc7e53c07aa3b385efd146e1c2184734e754e0ccebb0dc345229c33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32432b70b56f3422bdf98b66b68427492b94c597689dffd7de8dc31613d512690dc7ea5fda5fafb8e983bde048c25e68a03a9d7788711c62020867e22205b6f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f52926b12cf4ce377a13c267f3f288294410cbf3967c652bc3a6080aff7d25990d4c3cb1e594085fb76a6c5e4b01daff0d48ac5bed8a9d7f4909d4ae9ab628fb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d698c5fb59ef5d41ef8d2478aa4826fff630cb551472879431e1ed7bcbb8017487dac0c785e624f24992fc20461f0b7d701aee0d0a18bbb0e2b1011e5a736bf5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 03:07:45.368359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:07:45.368761) ========= 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=6d15e502d8e29d5d2676d664000001c3-1504864019.871775-706255003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 03:07:45.448985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:07:45.449331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 03:07:45.449670) ========= ========= Total master_lag: 1.00 =========