builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1506687925.9 results: success (0) revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:25.906126) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:25.907088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:25.907483) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.247569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.252089) ========= 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=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 05:25:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2017-09-29 05:25:26 (46.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130820 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.526425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.526869) ========= 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=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015793 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.680652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.681214) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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 cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 05:25:26,743 truncating revision to first 12 chars 2017-09-29 05:25:26,743 Setting DEBUG logging. 2017-09-29 05:25:26,743 attempt 1/10 2017-09-29 05:25:26,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cd9c8c48e4b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 05:25:27,128 unpacking tar archive at: mozilla-central-cd9c8c48e4b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720690 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.458160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.458565) ========= script_repo_revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.463113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.463426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.480586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-29 05:25:27.481061) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:27 INFO - MultiFileLogger online at 20170929 05:25:27 in /builds/slave/test 05:25:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:25:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:27 INFO - {'append_to_log': False, 05:25:27 INFO - 'base_work_dir': '/builds/slave/test', 05:25:27 INFO - 'blob_upload_branch': 'Firefox', 05:25:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:27 INFO - 'branch': 'Firefox', 05:25:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:27 INFO - 'code_coverage': False, 05:25:27 INFO - 'config_files': ('talos/linux_config.py',), 05:25:27 INFO - 'default_actions': ('clobber', 05:25:27 INFO - 'read-buildbot-config', 05:25:27 INFO - 'download-and-extract', 05:25:27 INFO - 'populate-webroot', 05:25:27 INFO - 'create-virtualenv', 05:25:27 INFO - 'install', 05:25:27 INFO - 'setup-mitmproxy', 05:25:27 INFO - 'run-tests'), 05:25:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:27 INFO - 'disable_ccov_upload': False, 05:25:27 INFO - 'disable_stylo': False, 05:25:27 INFO - 'download_minidump_stackwalk': True, 05:25:27 INFO - 'download_symbols': 'ondemand', 05:25:27 INFO - 'enable_stylo': False, 05:25:27 INFO - 'enable_webrender': False, 05:25:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:25:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:27 INFO - 'gecko_profile': False, 05:25:27 INFO - 'gecko_profile_interval': 0, 05:25:27 INFO - 'installer_path': 'installer.exe', 05:25:27 INFO - 'log_level': 'info', 05:25:27 INFO - 'log_name': 'talos', 05:25:27 INFO - 'log_to_console': True, 05:25:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:27 INFO - 'opt_config_files': (), 05:25:27 INFO - 'pip_index': False, 05:25:27 INFO - 'suite': 'dromaeojs-e10s', 05:25:27 INFO - 'system_bits': '32', 05:25:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:27 INFO - 'title': 'talos-linux64-ix-070', 05:25:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:27 INFO - 'use_talos_json': True, 05:25:27 INFO - 'verify': 'False', 05:25:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:27 INFO - 'work_dir': 'build'} 05:25:27 INFO - [mozharness: 2017-09-29 12:25:27.726252Z] Running clobber step. 05:25:27 INFO - Running pre-action listener: _resource_record_pre_action 05:25:27 INFO - Running main action method: clobber 05:25:27 INFO - rmtree: /builds/slave/test/build 05:25:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:28 INFO - Running post-action listener: _resource_record_post_action 05:25:28 INFO - [mozharness: 2017-09-29 12:25:28.679733Z] Finished clobber step (success) 05:25:28 INFO - [mozharness: 2017-09-29 12:25:28.679829Z] Running read-buildbot-config step. 05:25:28 INFO - Running pre-action listener: _resource_record_pre_action 05:25:28 INFO - Running main action method: read_buildbot_config 05:25:28 INFO - Using buildbot properties: 05:25:28 INFO - { 05:25:28 INFO - "project": "", 05:25:28 INFO - "product": "firefox", 05:25:28 INFO - "who": "archaeopteryx@coole-files.de", 05:25:28 INFO - "installer_path": "public/build/target.tar.bz2", 05:25:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 05:25:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:25:28 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 05:25:28 INFO - "stage_platform": "linux64-qr", 05:25:28 INFO - "basedir": "/builds/slave/test", 05:25:28 INFO - "buildnumber": 108, 05:25:28 INFO - "platform": "ubuntu64_hw_qr", 05:25:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:25:28 INFO - "slavebuilddir": "test", 05:25:28 INFO - "taskId": "XYLJl7HPStSVKt8Ylm_O6A", 05:25:28 INFO - "branch": "mozilla-central", 05:25:28 INFO - "script_repo_revision": "production", 05:25:28 INFO - "revision": "cd9c8c48e4b3ded47a776f757008f3dcf570c59c", 05:25:28 INFO - "slavename": "talos-linux64-ix-070", 05:25:28 INFO - "repo_path": "mozilla-central" 05:25:28 INFO - } 05:25:28 INFO - Finding installer, test and symbols from parent task. 05:25:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XYLJl7HPStSVKt8Ylm_O6A'}, attempt #1 05:25:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XYLJl7HPStSVKt8Ylm_O6A'}, attempt #1 05:25:29 INFO - Task dependencies: IH85rkEeSoiGVybgA5cHLA 05:25:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA'}, attempt #1 05:25:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json 05:25:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip 05:25:30 INFO - Running post-action listener: _resource_record_post_action 05:25:30 INFO - [mozharness: 2017-09-29 12:25:30.290328Z] Finished read-buildbot-config step (success) 05:25:30 INFO - [mozharness: 2017-09-29 12:25:30.290546Z] Running download-and-extract step. 05:25:30 INFO - Running pre-action listener: _resource_record_pre_action 05:25:30 INFO - Running main action method: download_and_extract 05:25:30 INFO - mkdir: /builds/slave/test/build/tests 05:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:30 INFO - trying https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json 05:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:25:30 INFO - Downloaded 989 bytes. 05:25:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:25:30 INFO - Using the following test package requirements: 05:25:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:25:30 INFO - u'common': [u'target.common.tests.zip'], 05:25:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:25:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:25:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:25:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:25:30 INFO - u'mozbase': [u'target.common.tests.zip'], 05:25:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:25:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:25:30 INFO - u'web-platform': [u'target.common.tests.zip', 05:25:30 INFO - u'target.web-platform.tests.tar.gz'], 05:25:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:25:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:25:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip 05:25:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:25:30 INFO - Fetch https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip into memory 05:25:32 INFO - Content-Length response header: 55366218 05:25:32 INFO - Bytes received: 55366218 05:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip 05:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip into memory 05:25:44 INFO - Content-Length response header: 14521355 05:25:44 INFO - Bytes received: 14521355 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - trying https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:25:46 INFO - Downloaded 61539289 bytes. 05:25:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:46 INFO - mkdir: /builds/slave/test/properties 05:25:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:46 INFO - Contents: 05:25:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - Running post-action listener: find_tests_for_verification 05:25:46 INFO - Running post-action listener: set_extra_try_arguments 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.488824Z] Finished download-and-extract step (success) 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.488923Z] Running populate-webroot step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: populate_webroot 05:25:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tresize', 05:25:46 INFO - 'tcanvasmark']}, 05:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['dromaeo_css', 05:25:46 INFO - 'kraken']}, 05:25:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['damp', 'tps']}, 05:25:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['damp', 'tps']}, 05:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['dromaeo_dom']}, 05:25:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:25:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['basic_compositor_video', 05:25:46 INFO - 'glvideo']}, 05:25:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:25:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['ts_paint_webext', 05:25:46 INFO - 'tp5o_webext']}, 05:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:46 INFO - 'ts_paint', 05:25:46 INFO - 'tpaint', 05:25:46 INFO - 'sessionrestore', 05:25:46 INFO - 'sessionrestore_many_windows', 05:25:46 INFO - 'sessionrestore_no_auto_restore', 05:25:46 INFO - 'tabpaint', 05:25:46 INFO - 'cpstartup']}, 05:25:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['a11yr', 05:25:46 INFO - 'ts_paint', 05:25:46 INFO - 'tpaint', 05:25:46 INFO - 'sessionrestore', 05:25:46 INFO - 'sessionrestore_many_windows', 05:25:46 INFO - 'sessionrestore_no_auto_restore', 05:25:46 INFO - 'tabpaint', 05:25:46 INFO - 'cpstartup']}, 05:25:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 05:25:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:25:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['perf_reftest_singletons']}, 05:25:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['perf_reftest']}, 05:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:46 INFO - 'tsvgr_opacity', 05:25:46 INFO - 'tart', 05:25:46 INFO - 'tscrollx', 05:25:46 INFO - 'tsvg_static']}, 05:25:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tsvgx', 05:25:46 INFO - 'tsvgr_opacity', 05:25:46 INFO - 'tart', 05:25:46 INFO - 'tscrollx', 05:25:46 INFO - 'tsvg_static']}, 05:25:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:25:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tp5o']}, 05:25:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--disable-stylo', 05:25:46 INFO - '--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--stylo-threads=1', 05:25:46 INFO - '--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--xperf_path', 05:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:46 INFO - 'tests': ['tp5n']}, 05:25:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo', 05:25:46 INFO - '--xperf_path', 05:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:46 INFO - 'tests': ['tp5n']}}} 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.504719Z] Finished populate-webroot step (success) 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.504808Z] Running create-virtualenv step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: create_virtualenv 05:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:25:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:25:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:48 INFO - Installing pip...............done. 05:25:48 INFO - Return code: 0 05:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:25:48 INFO - Reading from file tmpfile_stdout 05:25:48 INFO - Output received: 05:25:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:48 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')]} 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:48 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')]} 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:48 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:48 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 05:25:48 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 05:25:48 INFO - Using env: {'DISPLAY': ':0', 05:25:48 INFO - 'HOME': '/home/cltbld', 05:25:48 INFO - 'LANG': 'en_US.UTF-8', 05:25:48 INFO - 'LANGUAGE': 'en_US:en', 05:25:48 INFO - 'LOGNAME': 'cltbld', 05:25:48 INFO - 'MAIL': '/var/mail/cltbld', 05:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:48 INFO - 'MOZ_NO_REMOTE': '1', 05:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:48 INFO - 'NO_EM_RESTART': '1', 05:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:48 INFO - 'PWD': '/builds/slave/test', 05:25:48 INFO - 'SHELL': '/bin/bash', 05:25:48 INFO - 'SHLVL': '1', 05:25:48 INFO - 'TERM': 'linux', 05:25:48 INFO - 'TMOUT': '86400', 05:25:48 INFO - 'USER': 'cltbld', 05:25:48 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:48 INFO - '_': '/tools/buildbot/bin/python'} 05:25:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:25:49 INFO - Downloading/unpacking pip>=1.5 05:25:49 INFO - Running setup.py egg_info for package pip 05:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:25:49 INFO - Installing collected packages: pip 05:25:49 INFO - Found existing installation: pip 1.1 05:25:49 INFO - Uninstalling pip: 05:25:49 INFO - Successfully uninstalled pip 05:25:49 INFO - Running setup.py install for pip 05:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:25:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Successfully installed pip 05:25:49 INFO - Cleaning up... 05:25:49 INFO - Return code: 0 05:25:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:49 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')]} 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:49 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')]} 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:49 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:49 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 05:25:49 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 05:25:49 INFO - Using env: {'DISPLAY': ':0', 05:25:49 INFO - 'HOME': '/home/cltbld', 05:25:49 INFO - 'LANG': 'en_US.UTF-8', 05:25:49 INFO - 'LANGUAGE': 'en_US:en', 05:25:49 INFO - 'LOGNAME': 'cltbld', 05:25:49 INFO - 'MAIL': '/var/mail/cltbld', 05:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:49 INFO - 'MOZ_NO_REMOTE': '1', 05:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:49 INFO - 'NO_EM_RESTART': '1', 05:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:49 INFO - 'PWD': '/builds/slave/test', 05:25:49 INFO - 'SHELL': '/bin/bash', 05:25:49 INFO - 'SHLVL': '1', 05:25:49 INFO - 'TERM': 'linux', 05:25:49 INFO - 'TMOUT': '86400', 05:25:49 INFO - 'USER': 'cltbld', 05:25:49 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:49 INFO - '_': '/tools/buildbot/bin/python'} 05:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:50 INFO - Downloading/unpacking psutil>=3.1.1 05:25:50 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 05:25:50 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 05:25:50 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 05:25:50 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 05:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:51 INFO - Installing collected packages: psutil 05:25:51 INFO - Running setup.py install for psutil 05:25:51 INFO - building 'psutil._psutil_linux' extension 05:25:51 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 05:25:52 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 05:25:52 INFO - building 'psutil._psutil_posix' extension 05:25:52 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 05:25:52 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 05:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:52 INFO - Successfully installed psutil 05:25:52 INFO - Cleaning up... 05:25:52 INFO - Return code: 0 05:25:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:25:52 INFO - Using env: {'DISPLAY': ':0', 05:25:52 INFO - 'HOME': '/home/cltbld', 05:25:52 INFO - 'LANG': 'en_US.UTF-8', 05:25:52 INFO - 'LANGUAGE': 'en_US:en', 05:25:52 INFO - 'LOGNAME': 'cltbld', 05:25:52 INFO - 'MAIL': '/var/mail/cltbld', 05:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:52 INFO - 'MOZ_NO_REMOTE': '1', 05:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:52 INFO - 'NO_EM_RESTART': '1', 05:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:52 INFO - 'PWD': '/builds/slave/test', 05:25:52 INFO - 'SHELL': '/bin/bash', 05:25:52 INFO - 'SHLVL': '1', 05:25:52 INFO - 'TERM': 'linux', 05:25:52 INFO - 'TMOUT': '86400', 05:25:52 INFO - 'USER': 'cltbld', 05:25:52 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:52 INFO - '_': '/tools/buildbot/bin/python'} 05:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:54 INFO - Installing collected packages: mozsystemmonitor 05:25:54 INFO - Running setup.py install for mozsystemmonitor 05:25:54 INFO - Successfully installed mozsystemmonitor 05:25:54 INFO - Cleaning up... 05:25:54 INFO - Return code: 0 05:25:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:54 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:54 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 05:25:54 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 05:25:54 INFO - Using env: {'DISPLAY': ':0', 05:25:54 INFO - 'HOME': '/home/cltbld', 05:25:54 INFO - 'LANG': 'en_US.UTF-8', 05:25:54 INFO - 'LANGUAGE': 'en_US:en', 05:25:54 INFO - 'LOGNAME': 'cltbld', 05:25:54 INFO - 'MAIL': '/var/mail/cltbld', 05:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:54 INFO - 'MOZ_NO_REMOTE': '1', 05:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:54 INFO - 'NO_EM_RESTART': '1', 05:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:54 INFO - 'PWD': '/builds/slave/test', 05:25:54 INFO - 'SHELL': '/bin/bash', 05:25:54 INFO - 'SHLVL': '1', 05:25:54 INFO - 'TERM': 'linux', 05:25:54 INFO - 'TMOUT': '86400', 05:25:54 INFO - 'USER': 'cltbld', 05:25:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:54 INFO - '_': '/tools/buildbot/bin/python'} 05:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:25:54 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 05:25:54 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 05:25:54 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 05:25:54 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 05:25:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:55 INFO - warning: no files found matching '*.txt' 05:25:55 INFO - no previously-included directories found matching 'build' 05:25:55 INFO - no previously-included directories found matching 'dist' 05:25:55 INFO - no previously-included directories found matching '.git*' 05:25:55 INFO - Installing collected packages: jsonschema, functools32 05:25:56 INFO - Running setup.py install for functools32 05:25:56 INFO - warning: no files found matching '*.txt' 05:25:56 INFO - no previously-included directories found matching 'build' 05:25:56 INFO - no previously-included directories found matching 'dist' 05:25:56 INFO - no previously-included directories found matching '.git*' 05:25:56 INFO - Successfully installed jsonschema functools32 05:25:56 INFO - Cleaning up... 05:25:56 INFO - Return code: 0 05:25:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:25:56 INFO - Using env: {'DISPLAY': ':0', 05:25:56 INFO - 'HOME': '/home/cltbld', 05:25:56 INFO - 'LANG': 'en_US.UTF-8', 05:25:56 INFO - 'LANGUAGE': 'en_US:en', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MAIL': '/var/mail/cltbld', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SHLVL': '1', 05:25:56 INFO - 'TERM': 'linux', 05:25:56 INFO - 'TMOUT': '86400', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - '_': '/tools/buildbot/bin/python'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:25:56 INFO - Cleaning up... 05:25:56 INFO - Return code: 0 05:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:25:56 INFO - Using env: {'DISPLAY': ':0', 05:25:56 INFO - 'HOME': '/home/cltbld', 05:25:56 INFO - 'LANG': 'en_US.UTF-8', 05:25:56 INFO - 'LANGUAGE': 'en_US:en', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MAIL': '/var/mail/cltbld', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SHLVL': '1', 05:25:56 INFO - 'TERM': 'linux', 05:25:56 INFO - 'TMOUT': '86400', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - '_': '/tools/buildbot/bin/python'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:56 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 05:25:56 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 05:25:56 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 05:25:56 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 05:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:58 INFO - Downloading docopt-0.6.1.tar.gz 05:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:58 INFO - Running setup.py install for blobuploader 05:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:58 INFO - Running setup.py install for requests 05:25:58 INFO - Running setup.py install for docopt 05:25:58 INFO - Successfully installed blobuploader requests docopt 05:25:58 INFO - Cleaning up... 05:25:58 INFO - Return code: 0 05:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:25:58 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 05:25:58 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 05:25:58 INFO - Using env: {'DISPLAY': ':0', 05:25:58 INFO - 'HOME': '/home/cltbld', 05:25:58 INFO - 'LANG': 'en_US.UTF-8', 05:25:58 INFO - 'LANGUAGE': 'en_US:en', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MAIL': '/var/mail/cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SHLVL': '1', 05:25:58 INFO - 'TERM': 'linux', 05:25:58 INFO - 'TMOUT': '86400', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - '_': '/tools/buildbot/bin/python'} 05:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:59 INFO - Running setup.py (path:/tmp/pip-p6NcvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:59 INFO - Running setup.py (path:/tmp/pip-PHj8RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Running setup.py (path:/tmp/pip-20fSrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Running setup.py (path:/tmp/pip-KQdTrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Running setup.py (path:/tmp/pip-QIqm1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Running setup.py (path:/tmp/pip-KrxmaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:59 INFO - Running setup.py (path:/tmp/pip-x4tEQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:59 INFO - Running setup.py (path:/tmp/pip-HJphF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:59 INFO - Running setup.py (path:/tmp/pip-Qk_twx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:59 INFO - Running setup.py (path:/tmp/pip-Pe_hSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:59 INFO - Running setup.py (path:/tmp/pip-m18AjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:59 INFO - Running setup.py (path:/tmp/pip-PqZd_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:59 INFO - Running setup.py (path:/tmp/pip-YlnN3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:00 INFO - Running setup.py (path:/tmp/pip-tzklSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:00 INFO - Running setup.py (path:/tmp/pip-ZC88Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:00 INFO - Running setup.py (path:/tmp/pip-SjdHwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:00 INFO - Running setup.py (path:/tmp/pip-Xfw9K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:00 INFO - Running setup.py install for manifestparser 05:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozcrash 05:26:00 INFO - Running setup.py install for mozdebug 05:26:00 INFO - Running setup.py install for mozdevice 05:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozfile 05:26:00 INFO - Running setup.py install for mozhttpd 05:26:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozinfo 05:26:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozInstall 05:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozleak 05:26:01 INFO - Running setup.py install for mozlog 05:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for moznetwork 05:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozprocess 05:26:01 INFO - Running setup.py install for mozprofile 05:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozrunner 05:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozscreenshot 05:26:01 INFO - Running setup.py install for moztest 05:26:01 INFO - Running setup.py install for mozversion 05:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:02 INFO - Cleaning up... 05:26:02 INFO - Return code: 0 05:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:02 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')]} 05:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:02 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')]} 05:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:02 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:26:02 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 05:26:02 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 05:26:02 INFO - Using env: {'DISPLAY': ':0', 05:26:02 INFO - 'HOME': '/home/cltbld', 05:26:02 INFO - 'LANG': 'en_US.UTF-8', 05:26:02 INFO - 'LANGUAGE': 'en_US:en', 05:26:02 INFO - 'LOGNAME': 'cltbld', 05:26:02 INFO - 'MAIL': '/var/mail/cltbld', 05:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:02 INFO - 'MOZ_NO_REMOTE': '1', 05:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:02 INFO - 'NO_EM_RESTART': '1', 05:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:02 INFO - 'PWD': '/builds/slave/test', 05:26:02 INFO - 'SHELL': '/bin/bash', 05:26:02 INFO - 'SHLVL': '1', 05:26:02 INFO - 'TERM': 'linux', 05:26:02 INFO - 'TMOUT': '86400', 05:26:02 INFO - 'USER': 'cltbld', 05:26:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:02 INFO - '_': '/tools/buildbot/bin/python'} 05:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:02 INFO - Running setup.py (path:/tmp/pip-pk92v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:02 INFO - Running setup.py (path:/tmp/pip-nLfHzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:02 INFO - Running setup.py (path:/tmp/pip-FtyKMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 INFO - Running setup.py (path:/tmp/pip-g3rM5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:02 INFO - Running setup.py (path:/tmp/pip-CbYCUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 INFO - Running setup.py (path:/tmp/pip-pIVGRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 INFO - Running setup.py (path:/tmp/pip-ENssEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 INFO - Running setup.py (path:/tmp/pip-wQAW7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:02 INFO - Running setup.py (path:/tmp/pip-UfdWET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:02 INFO - Running setup.py (path:/tmp/pip-qCwV0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:03 INFO - Running setup.py (path:/tmp/pip-pxKXwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:03 INFO - Running setup.py (path:/tmp/pip-SXKEqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:03 INFO - Running setup.py (path:/tmp/pip-R_WQ43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 INFO - Running setup.py (path:/tmp/pip-UfJUJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 INFO - Running setup.py (path:/tmp/pip-Rk9m_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:03 INFO - Running setup.py (path:/tmp/pip-g9rKlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:03 INFO - Running setup.py (path:/tmp/pip-_GMMfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:04 INFO - Downloading blessings-1.6.tar.gz 05:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:04 INFO - Installing collected packages: blessings 05:26:04 INFO - Running setup.py install for blessings 05:26:04 INFO - Successfully installed blessings 05:26:04 INFO - Cleaning up... 05:26:04 INFO - Return code: 0 05:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:05 INFO - Reading from file tmpfile_stdout 05:26:05 INFO - Current package versions: 05:26:05 INFO - argparse == 1.2.1 05:26:05 INFO - blessings == 1.6 05:26:05 INFO - blobuploader == 1.2.4 05:26:05 INFO - docopt == 0.6.1 05:26:05 INFO - functools32 == 3.2.3-2 05:26:05 INFO - jsonschema == 2.5.1 05:26:05 INFO - manifestparser == 1.1 05:26:05 INFO - mozInstall == 1.13 05:26:05 INFO - mozcrash == 1.0 05:26:05 INFO - mozdebug == 0.1 05:26:05 INFO - mozdevice == 0.51 05:26:05 INFO - mozfile == 1.2 05:26:05 INFO - mozhttpd == 0.7 05:26:05 INFO - mozinfo == 0.10 05:26:05 INFO - mozleak == 0.1 05:26:05 INFO - mozlog == 3.5 05:26:05 INFO - moznetwork == 0.27 05:26:05 INFO - mozprocess == 0.25 05:26:05 INFO - mozprofile == 0.28 05:26:05 INFO - mozrunner == 6.13 05:26:05 INFO - mozscreenshot == 0.1 05:26:05 INFO - mozsystemmonitor == 0.3 05:26:05 INFO - moztest == 0.8 05:26:05 INFO - mozversion == 1.4 05:26:05 INFO - psutil == 3.1.1 05:26:05 INFO - requests == 1.2.3 05:26:05 INFO - wsgiref == 0.1.2 05:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:05 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')]} 05:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:05 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')]} 05:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:05 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:26:05 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 05:26:05 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 05:26:05 INFO - Using env: {'DISPLAY': ':0', 05:26:05 INFO - 'HOME': '/home/cltbld', 05:26:05 INFO - 'LANG': 'en_US.UTF-8', 05:26:05 INFO - 'LANGUAGE': 'en_US:en', 05:26:05 INFO - 'LOGNAME': 'cltbld', 05:26:05 INFO - 'MAIL': '/var/mail/cltbld', 05:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:05 INFO - 'MOZ_NO_REMOTE': '1', 05:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:05 INFO - 'NO_EM_RESTART': '1', 05:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:05 INFO - 'PWD': '/builds/slave/test', 05:26:05 INFO - 'SHELL': '/bin/bash', 05:26:05 INFO - 'SHLVL': '1', 05:26:05 INFO - 'TERM': 'linux', 05:26:05 INFO - 'TMOUT': '86400', 05:26:05 INFO - 'USER': 'cltbld', 05:26:05 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:05 INFO - '_': '/tools/buildbot/bin/python'} 05:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:26:06 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)) 05:26:06 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)) 05:26:06 INFO - Installing collected packages: simplejson 05:26:06 INFO - Running setup.py install for simplejson 05:26:06 INFO - building 'simplejson._speedups' extension 05:26:06 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 05:26:07 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 05:26:07 INFO - Successfully installed simplejson 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:07 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 0x16111f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', '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 05:26:07 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 05:26:07 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 05:26:07 INFO - Using env: {'DISPLAY': ':0', 05:26:07 INFO - 'HOME': '/home/cltbld', 05:26:07 INFO - 'LANG': 'en_US.UTF-8', 05:26:07 INFO - 'LANGUAGE': 'en_US:en', 05:26:07 INFO - 'LOGNAME': 'cltbld', 05:26:07 INFO - 'MAIL': '/var/mail/cltbld', 05:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:07 INFO - 'MOZ_NO_REMOTE': '1', 05:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:07 INFO - 'NO_EM_RESTART': '1', 05:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:07 INFO - 'PWD': '/builds/slave/test', 05:26:07 INFO - 'SHELL': '/bin/bash', 05:26:07 INFO - 'SHLVL': '1', 05:26:07 INFO - 'TERM': 'linux', 05:26:07 INFO - 'TMOUT': '86400', 05:26:07 INFO - 'USER': 'cltbld', 05:26:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:07 INFO - '_': '/tools/buildbot/bin/python'} 05:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Running post-action listener: _resource_record_post_action 05:26:07 INFO - Running post-action listener: _start_resource_monitoring 05:26:07 INFO - Starting resource monitoring. 05:26:07 INFO - [mozharness: 2017-09-29 12:26:07.828949Z] Finished create-virtualenv step (success) 05:26:07 INFO - [mozharness: 2017-09-29 12:26:07.830030Z] Running install step. 05:26:07 INFO - Running pre-action listener: _resource_record_pre_action 05:26:07 INFO - Running main action method: install 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:08 INFO - Reading from file tmpfile_stdout 05:26:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:08 INFO - Reading from file tmpfile_stdout 05:26:08 INFO - Output received: 05:26:08 INFO - Usage: mozinstall [options] installer 05:26:08 INFO - Options: 05:26:08 INFO - -h, --help show this help message and exit 05:26:08 INFO - -d DEST, --destination=DEST 05:26:08 INFO - Directory to install application into. [default: 05:26:08 INFO - "/builds/slave/test"] 05:26:08 INFO - --app=APP Application being installed. [default: firefox] 05:26:08 INFO - mkdir: /builds/slave/test/build/application 05:26:08 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'] 05:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:26:25 INFO - Reading from file tmpfile_stdout 05:26:25 INFO - Output received: 05:26:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.963259Z] Finished install step (success) 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.963405Z] Running setup-mitmproxy step. 05:26:25 INFO - Running pre-action listener: _resource_record_pre_action 05:26:25 INFO - Running main action method: setup_mitmproxy 05:26:25 INFO - Skipping: mitmproxy is not required 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.963935Z] Finished setup-mitmproxy step (success) 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.964046Z] Running run-tests step. 05:26:25 INFO - Running pre-action listener: _resource_record_pre_action 05:26:25 INFO - Running pre-action listener: _set_gcov_prefix 05:26:25 INFO - Running main action method: run_tests 05:26:25 WARNING - Try message not found. 05:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:25 INFO - Python 2.7.3 05:26:25 INFO - Return code: 0 05:26:25 INFO - grabbing minidump binary from tooltool 05:26:25 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')]} 05:26:25 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 0x197bd60>, '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 0x197ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:25 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 05:26:25 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 05:26:25 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 05:26:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:26 INFO - Return code: 0 05:26:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:26:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:26 INFO - ENV: RUST_BACKTRACE is now full 05:26:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:26:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 05:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --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 05:26:26 INFO - Using env: {'DISPLAY': ':0', 05:26:26 INFO - 'HOME': '/home/cltbld', 05:26:26 INFO - 'LANG': 'en_US.UTF-8', 05:26:26 INFO - 'LANGUAGE': 'en_US:en', 05:26:26 INFO - 'LOGNAME': 'cltbld', 05:26:26 INFO - 'MAIL': '/var/mail/cltbld', 05:26:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:26 INFO - 'MOZ_ACCELERATED': '1', 05:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:26 INFO - 'MOZ_NO_REMOTE': '1', 05:26:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:26 INFO - 'MOZ_WEBRENDER': '1', 05:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:26 INFO - 'NO_EM_RESTART': '1', 05:26:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:26 INFO - 'PWD': '/builds/slave/test', 05:26:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:26 INFO - 'RUST_BACKTRACE': 'full', 05:26:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:26:26 INFO - 'SHELL': '/bin/bash', 05:26:26 INFO - 'SHLVL': '1', 05:26:26 INFO - 'TERM': 'linux', 05:26:26 INFO - 'TMOUT': '86400', 05:26:26 INFO - 'USER': 'cltbld', 05:26:26 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:26 INFO - '_': '/tools/buildbot/bin/python'} 05:26:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 05:26:26 INFO - mozversion application_buildid: 20170929113110 05:26:26 INFO - mozversion application_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:26:26 INFO - mozversion application_display_name: Nightly 05:26:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:26 INFO - mozversion application_name: Firefox 05:26:26 INFO - mozversion application_remotingname: firefox 05:26:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:26 INFO - mozversion application_vendor: Mozilla 05:26:26 INFO - mozversion application_version: 58.0a1 05:26:26 INFO - mozversion platform_buildid: 20170929113110 05:26:26 INFO - mozversion platform_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:26:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:26 INFO - mozversion platform_version: 58.0a1 05:26:26 INFO - using testdate: 1506687986 05:26:26 INFO - actual date: 1506687986 05:26:26 INFO - starting webserver on 'localhost:59675' 05:26:26 INFO - SUITE-START | Running 2 tests 05:26:26 INFO - TEST-START | dromaeo_css 05:26:26 INFO - Initialising browser for dromaeo_css test... 05:26:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59675/getInfo.html -profile /tmp/tmpnALizo/profile 05:26:26 INFO - TEST-INFO | started process 3626 (/builds/slave/test/build/application/firefox/firefox http://localhost:59675/getInfo.html) 05:26:35 INFO - TEST-INFO | 3626: exit 0 05:26:35 INFO - Browser initialized. 05:26:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:35 INFO - Using env: {'DISPLAY': ':0', 05:26:35 INFO - 'HOME': '/home/cltbld', 05:26:35 INFO - 'JSGC_DISABLE_POISONING': '1', 05:26:35 INFO - 'LANG': 'en_US.UTF-8', 05:26:35 INFO - 'LANGUAGE': 'en_US:en', 05:26:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:26:35 INFO - 'LOGNAME': 'cltbld', 05:26:35 INFO - 'MAIL': '/var/mail/cltbld', 05:26:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:35 INFO - 'MOZ_ACCELERATED': '1', 05:26:35 INFO - 'MOZ_CRASHREPORTER': '1', 05:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:26:35 INFO - 'MOZ_NO_REMOTE': '1', 05:26:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:35 INFO - 'MOZ_WEBRENDER': '1', 05:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:35 INFO - 'NO_EM_RESTART': '1', 05:26:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:35 INFO - 'PWD': '/builds/slave/test', 05:26:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:35 INFO - 'RUST_BACKTRACE': 'full', 05:26:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:26:35 INFO - 'SHELL': '/bin/bash', 05:26:35 INFO - 'SHLVL': '1', 05:26:35 INFO - 'TERM': 'linux', 05:26:35 INFO - 'TMOUT': '86400', 05:26:35 INFO - 'USER': 'cltbld', 05:26:35 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:35 INFO - '_': '/tools/buildbot/bin/python'} 05:26:35 INFO - TEST-INFO | started process 3871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnALizo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:36 INFO - PID 3871 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:26:36 INFO - PID 3871 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:26:36 INFO - PID 3871 | 05:26:36 INFO - PID 3871 | (/builds/slave/test/build/application/firefox/firefox:3931): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:26:36 INFO - PID 3871 | 05:26:47 INFO - PID 3871 | RSS: Main: 198242304 05:26:47 INFO - PID 3871 | 05:29:44 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59675/tests/dromaeo/cssquery-ext.html) 05:29:46 INFO - PID 3871 | RSS: Main: 192999424 05:29:46 INFO - PID 3871 | 05:32:48 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-ext.html (next: http://localhost:59675/tests/dromaeo/cssquery-jquery.html) 05:32:49 INFO - PID 3871 | RSS: Main: 192364544 05:32:49 INFO - PID 3871 | 05:35:51 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59675/tests/dromaeo/cssquery-mootools.html) 05:35:51 INFO - PID 3871 | RSS: Main: 193708032 05:35:51 INFO - PID 3871 | 05:38:53 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59675/tests/dromaeo/cssquery-prototype.html) 05:38:54 INFO - PID 3871 | RSS: Main: 193228800 05:38:54 INFO - PID 3871 | 05:41:57 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59675/tests/dromaeo/cssquery-yui.html) 05:41:58 INFO - PID 3871 | RSS: Main: 195698688 05:41:58 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | Cycle 1(1): loaded http://localhost:59675/tests/dromaeo/cssquery-yui.html (next: http://localhost:59675/tests/dromaeo/cssquery-dojo.html) 05:45:00 INFO - PID 3871 | RSS: Main: 197259264 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | __start_tp_report 05:45:00 INFO - PID 3871 | _x_x_mozilla_page_load 05:45:00 INFO - PID 3871 | _x_x_mozilla_page_load_details 05:45:00 INFO - PID 3871 | |i|pagename|runs| 05:45:00 INFO - PID 3871 | |0;dojo.html;3176.8729250829965;3203.4714272145097;3216.3728073025763;3226.548283240347;3238.9797213877614;6241.812745617627;6284.717187726552;6322.336154703758;6336.42972132508;6356.586821856587;6326.905096423558;6362.236531616201;6373.426391624753;6378.3621637836195;6404.039394090877;5712.971435142818;5821.3887541808135;5913.9112913306335;5946.851328716773;5980.401959804029;5818.709064546777;5848.093545500455;5886.705664716747;5904.911426328587;5967.5524335675;5639.520640745542;5684.971575142139;5720.2849643794525;5736.799212027559;5897.4692277695;5641.548676105902;5653.349864765563;5685.431456854323;5727.713614319267;5745.253117094751;5671.829845104653;5680.943190568083;5683.374828768832;5688;5744.770209191627;6145.600535965148;6241.750329986795;6256;6288.056791481269;6290.308066112724;6667.399934005963;6681.432078273353;6724.899126513106;6753.189617245913;6763.154605674291;6682.866342673119;6685.19777626683;6718.66406679664;6741.0899528563505;6764.222114456851;6161.6303021818385;6287.339829317947;6289.088082228097;6292.307846136876;6305.87388252237;6940.271271516519;6974.163100427981;7058.082449281561;7060.7881763547175;7067.823304417328;6638.900416493757;6696.961970894519;6779.254282028973;6788.59268443895;6798;6781.287964763727;6819.147606549182;6861.416779573692;6870.175578930561;6885.139357580302;6572.539922205399;6612.86774264512;6640.335966403321;6679.499037572202;6731.629760363129;6850.897236541456;6859.862802743917;6860.897086543706;6861.794146175623;6876.793696189123;5269.947300526946;5314.1497360422145;5354.036273470812;5369.758360873692;5389.622726409114;4668.329177057357;4698.7415692137265;4700.059988002345;4714.717116972993;4736.313234580966;5805.274340707411;5814.447627475383;5894.587378883522;5901.940980590225;5902.144189092557;6614.338566143347;6646.767363142267;6724.865502689919;6732.461403087741;6778;5669.546436285087;5759.1649210865025;5795.7971470999155;5799.623024503394;5832.708364581754;5716.28546431696;5823.79616713413;5843.5909486336395;5849.298084229835;5855.297364316224;6521.184851893513;6539;6641.937290033571;6644.468442524587;6650.501212409089;6563.671816409256;6576.8355791105605;6667.166604174478;6700.698468569024;6783.830404239835;6445.4199122079235;6445.452136568257;6475.870482590228;6481.837954051187;6497.707603157774;6590.934090659032;6667.733290668319;6671.66641667905;6671.833204169935;6678.899816502659;6459.870802584016;6854.451643868579;6884.001819736211;6956.5478243913985;6964.164300283998;6609.438197753245;6613.735450581923;6638.800835974928;6647.069410282661;6687.531872768859;6540.967295163494;6606.4384527315715;6606.735730570724;6681.09805176295;6725.663716814238;6237.5009999200865;6416.967915160394;6494.512911531749;6554.442872355903;6562.5406221564035;6451.0645956337;6482.157319548617;6590.538662293593;6612.371824676648;6636.070950066898;6447.742090316335;6463.7737679181;6489.513286503437;6522.706478208397;6529.281779004211 05:45:00 INFO - PID 3871 | |1;ext.html;803.2770506544114;829.8921140251767;843.7004863273538;845.2688424512794;855.1619412975281;39381;40281;40548.79725601371;40736.796316018415;40797.59202407975;37754.811225943835;38060.61939380605;41326.17347653045;41355.17289654205;42057.579424205745;7791.376689864811;7927.643256053462;7929.1277959424415;7987.241212084843;7996.120426753053;7841.647125879321;7908.406869484783;7956.283934445928;7960.681572737083;7974.641141148633;7969.203079692043;7993.880091798627;8020.518768873857;8024.317932975675;8033.4778239414545;7883.566403847786;7899.4865333753405;7929.920700793034;7932.127465978738;7948.523088614673;7793.961030194812;7853.685852565891;7856.725014624518;7867.763967080997;7875.566843823587;37467.25065498702;37792.433113503044;37883;38065;38130.61869381298;3427.160345715291;3449.1032331593715;3461.6365281645567;3486.1458942558984;3491.7555771096036;31110.222244443845;31306.37387252265;31324.53013204781;31343.686563134306;31520.054398368087;5039.848804535834;5198.870028249286;5251.947480525184;5275.261463395128;5332.546733527654;190039.0498047501;190407;191112;191128;191868;46471;46879.531204688195;47083.29375059308;47185.29222061672;47346.76326618345;49724.50275497271;49777.751111244936;54217.1867421989;54780;54786.72606636941;16259.59351016234;16364.590885227964;16376.426825061304;16394.83605163957;16406.671866562603;13255.73488530224;13256.73486530264;13386.929045676323;13407.530736424178;13438.46246150143;14653.780193297109;14659.92670036643;14737.336819843133;14883.627909302137;14892.404303827725;5706.771729130871;5767.769289228384;5791.855203619859;5898.734556944948;5990.041593345131;1008.9495525223709;1015.8679371681634;1016.8932262112372;1033.5865653738565;1047.261680515235;23382.532349352918;23745.643815342784;23802.64296035561;23934.7606523936;23971.04115835382;1121.1647322744607;1141.4292853573213;1143.9485223164977;1154.6766905266538;1157.6584907452323;12527.373631318398;12531.624051278477;12555.497780088877;12588.81116783249;12613.684657883627;237985;238153;240350;240612;240899;44794;45466.54533454689;45878.54121458809;52624.736876316136;52825.735871321165;1441.54591303739;1462.6928345047659;1464.5752731707898;1464.5825939607162;1467.523055007127;27645.58531621987;27905;28553.14340569786;28568.714312856606;28778.280542985754;37425.81287093547;37544.249115018094;37627.623723762415;37720.24559508849;37762.811185943894;207246;208933;210156;210878;211712;34885;36448.27103457969;36647.45028824516;36688.63311366959;37076.81461592675;44705.55294447014;44728.10543789171;45150;45610.54389456195;45846.31230531478;32736.181595460304;32899.50650740193;33165.33669326552;33352.33295334031;33576.16059598432;33122.66877331196;33195.83402082974;33324.66675333313;33411.33177336488;33696;35787.28425431529;37042.8147859259;37215;37865.81067094647;37929.43105853359;32226.194345141557;32378.190545236557;32496.187595310308;32740.181495462803;32766;23894.641580376658;23926.042958281472;24136.87931560331;24301.14945976882;24318.148864789648 05:45:00 INFO - PID 3871 | |2;jquery.html;583.2301362201895;588.5997521685252;588.7880363069297;600.636614848017;608.5800797449759;22070.88964555177;22452.775472245292;22491.66262506064;22625.547489050252;22736.88631556842;23641.881790591066;24185.153519626816;24665.26004219872;24816.503669926635;25031.374215644617;6339.77810776624;6530;6538.967305163467;6552.868942621145;6554.639494827783;6305.936940630604;6474.417302442779;6575.112359831433;6582.308857569958;6590.8681826363445;6479.384458476437;6493;6513.153290072308;6552.443042341407;6589.0775291458995;6472.773452929125;6474.676266186719;6493.318201588812;6539.346065393446;6563.835904102411;6060.060690592965;6060.545459090542;6688.799336019927;6970.5710329382355;7010.43916486685;29627;30365;30626.92805751788;30643.69356306453;30683.386332273454;2039.1129858511595;2066.3181150220544;2068.917243310266;2077.875327480356;2080.355089922114;19968.70046949297;20468.181272749072;20574.485637859172;20647.793522064738;20748.688769668468;2503.8998440062373;2516.773490385874;2541.4789968056502;2555.0546297869723;2577.8453292802305;122614.38692806568;129128;144420.2778986109;154748;156056;19891;20389.592208155755;21241.575168496853;21252.362429126842;22026.779732202795;43197.78401107974;43252.78373608112;43516.782416088354;43545;43581;11592.942035289769;11623;11881.346525940984;12003.51985920571;12025.87974120265;9850.852237216448;9918.603255869828;9979.650712225037;9987.700368988943;10053.64812231583;10857.511411986321;11051.778964420666;11260.268082574607;11507;11539.711507212387;3655.3968595182027;3745.763897913682;3754.5494540655295;4015.438617514763;4190.811413486339;940.47333493244;975.3611384543135;975.4589294886717;976.72651657536;977.5161295158941;19211.812810541356;19409.61180776405;19580.412587622395;19719.309824156087;20017.399478015683;997.551102004101;1040.7866387390566;1040.885502594714;1046.0794500839365;1054.9630762923261;10580.41807700584;10691.30506517074;10746.78506429867;10868.565257389615;11067.446627668583;479523;496112;509259;510033;511859;113677.4316128414;115394;117658;118872;122599;1169.830374595696;1184.579474286633;1245.3586403002462;1256.6230130960857;1257.591282833083;19852.70220946658;20084.19663213455;20118.69821952701;20325.186992520725;20825.89587052055;57461.42538574728;58665.4133458677;58993.705031474565;59535;60631.69684151551;73893.630531847;73996;74348.2565174363;74629.6268518654;75857.62071189609;14577.562673119823;14632.975691701478;14724.116553006854;14761.483348082766;14773.335199916244;22435.32694019182;22763;22840.771592283865;22854.200102996314;22940.655890161328;18055.187516562048;18285.99427031526;18348.449546513624;18422.723659144856;18546.258149674402;16164.515064548083;16345.754813677566;16560.585985350463;16825;17228.138593070045;18357.632847342713;18860.811391885905;18863.43409697711;18963.620727585647;19035.143418546475;14245.715085698435;14288.28558572088;14302.427902883768;14421.278936052946;14438.639034023814;16650;18038.549036273675;18197;18197.999110049073;18314.358997435025 05:45:00 INFO - PID 3871 | |3;mootools.html;1325.6487030936803;1380.5789234283538;1393.8118354022208;1407.4651632379694;1410.386481880382;14698.26508674566;15326;15372.308246128923;15378.92310538447;15437.536873893787;14945.40218391263;15084.924575377136;15092.16993065381;15196.164210968393;15210.619734506643;2697.4739925714443;2801.3976994946083;2803.7756979441597;2810.058630358822;2818.0136952066714;2593.922182334533;2709.552923767586;2719.1434698070043;2726.7273272672774;2728.290644432452;2625.0681008242086;2707.6615423072117;2779.138467075213;2796.734310240524;2808.2979255186206;2721.5101281769275;2778.458200650874;2791.7347851954237;2798.272449163222;2817.591449239859;2742.3418379588957;2788.247173263228;2796.3987742635227;2800.509910765608;2809.494291027614;14455.49405770793;14893.702125957529;14941.477048303366;14942.925285373503;14993.775093373499;8154.3884208684585;8330.125336839605;8434.367422443342;8457.323414126855;8462.111478294752;5218.191180367049;5271.86820329491;5330.600204984603;5395.325584301962;5399.62202645815;1862.0596598717696;1872.4850666066804;1898.1078892920443;1921.807819218067;1926.5087402712359;25919.74080259192;25930.35174120662;25972.610410843852;26200.34499137518;26261.474770504676;7400.888986665204;7433.962830185815;7599.506032107895;7635.618219089134;7692.346150577152;17269.13654317279;17271.481855544353;17283;17355.30578776835;17444.738328925076;7797.532148071134;8014.839703205903;8016;8096.473729207582;8101.189881011852;7236.661217674747;7332;7369.852602947911;7371.8157046074275;7491.325780679765;5058.721770302595;5262.447443018505;5294.788208471618;5341.732913354317;5381.515663590218;1419.2265215457394;1424.5853278692516;1525.3441020361352;1561.7032763774846;1573.3863793120693;740.3854800515559;877.9429337093069;892.2549671024638;901.3195037746591;917.499962520428;8338.207870252316;8566.271866891384;8581.013183483854;8633.568321583896;8657.696980605648;973.4889183178888;1013.8732658417698;1017.4861694844204;1018.2414101494286;1021.9284650074424;5305.814296499604;5397.973010135002;5423.620346575702;5578.748956296977;5593.105103183471;21314.254001109886;21919.232826850985;22216.444588885082;22222.444438889157;22299.21952731679;20503.28238511645;21382.251621193183;21430.571388572454;21546.845315468327;21637.13451461924;10540.683779486628;10572.471376431302;10631.946840265904;10682.62610808618;10729.409882456539;8022.358211343195;8370.748877533684;8507.95746021266;8509.149085091442;8538.871916921375;17998;18378.172982215565;18659.346922857636;18829.529261768566;18969.14638841283;18679.34622288268;19318.227270909007;19334.70997935004;20040.69938950946;20153.697694534887;10658.73353166177;10750.569977200825;10765.89234107649;10772.784544309226;10776.29954052984;12979.156354836905;13728.352597688341;13835.654108647364;13895.374708137955;13953.302334883012;11084.501197445972;11203.663890083311;11325.490352933974;11659.941700291443;11930.463129159381;11020.118390528898;11122.555097795997;11231.157663175458;11294.491747871201;11457.197996140523;9726.465044422624;9747.9025209747;9822.901770982198;9828.26288028415;9837.213022958003;7063.046488724162;7122.109736282965;7167.8924816126755;7176.677049532679;7233.276672332725;7113.3953613943395;7116.181639111568;7243.855122897618;7301.598412087386;7349.795061481641 05:45:00 INFO - PID 3871 | |4;prototype.html;499.48802477460623;511.13873123786436;536.3081624704131;538.453469728226;546.1043888023639;6319.431251187392;6322.336154703758;6331.77838775643;6357.110004599354;6362.459190968773;5955.315138759033;6141.785037523688;6165.290991535975;6202.8910170542;6269.780557680482;5032.9748351258195;5045.243213517983;5053.545180933706;5065.721385323805;5076.695398276115;4872.731999740013;5019.272205530214;5039.168537191359;5051.5453609175165;5074.746262686851;4989.625778066659;5007.524285192901;5039.244113382985;5072.923906141411;5089.669171503859;4994.450610432849;5007.449180590114;5018.749062546858;5052.823151189691;5087.135187018216;4518.683692141552;4537.659675524349;4554.749488778116;4561.40701708779;4567.954320456786;6135.815925522197;6147.723352449106;6178.752849885999;6218.844528886769;6260.686965651699;5776.537876969875;5782.768689252425;5789.2763404574425;5812.651240925558;5822.534197264209;6589.505787065941;6624.370684784938;6629.204495460575;6634;6649.335066493312;4845.345878306454;4874.220124780054;4887.95112048882;4896.143174944406;4935.099986505185;6738.8315292117595;6829.487788415889;6878.27778083304;6887.5178737488395;6908.6545672716165;5038.294638750578;5049.722265275445;5056.57019153376;5097.286379906816;5099.821506247264;5017.8243761468175;5168.560672342893;5171.50870667286;5182.870428239325;5202.661826981234;5702.6293290935955;5717.171010203498;5729.169270455761;5765.3369862465515;5789.1895134680335;6455;6517.902231466532;6566.507511936624;6570.441512471398;6634.933650663528;1663.4593757029013;1715.271009820821;1720.1571230097163;1745.8079611242754;1756.6135450200936;1167.101331974375;1227.1287385955893;1249.4127759952808;1253.2104773992326;1260.0738457234108;5642.576806739429;5652.9152062719095;5708.4862362387585;5734.16854556087;5736.311642602915;6526.23584783111;6534.7455127980775;6536.379043990813;6537.705803238866;6571.539992200595;5396.64921780083;5560.497776000816;5597.692126933058;5693.373728889819;5710.400407957188;3520.5247291615306;3521.207728261121;3524.136586536315;3533.5936367318086;3556.1643013891717;6291.182146320949;6362.77730279438;6364.204474440695;6367.872642547216;6400.839979000469;6700;6785.946324154151;6792.592444453348;6806.625635589991;6809.250982391933;6466.741330346827;6487.54587178893;6499.675016249169;6545.214574251025;6562.376574225441;6745.561538499982;6764.188297404343;6792.9470932005615;6802.319768023158;6812.489063320171;6511.413972742286;6573.57271777333;6615.437687796399;6649.03588979605;6689.2976237496305;6325.652089134957;6348.333424990495;6353.396427339396;6456;6497.935020649922;5044.268581055653;5055.924161137512;5069.9746501267255;5072.188449848154;5080.339555857862;6683.198016237888;6692.56109936366;6696.665166741546;6736.191657001191;6809.897851532132;6414.262359828493;6499.855047834298;6566.343365663395;6568.1789776277965;6608.4382827458285;6344.904826427515;6365.809025729235;6425.839354016187;6472.126262954629;6538.444232240123;6326.905096423649;6357.442426605511;6394.90407643895;6395.616263024233;6412.583182093149;5902.291724993029;6258.937410625836;6350.396712312323;6493.415592596689;6663.600183988976;6243.313235544178;6243.594166379171;6270;6294;6377.840553986188 05:45:00 INFO - PID 3871 | |5;yui.html;898.7663207566031;916.2807196350864;930.2836815651948;934.2432629570048;949.0319873728795;19448.51378715531;20381.592368152647;20404;20420.591588168227;20435.795642043577;18300.450986470427;18536.721949170773;18723.876567405965;19143.04284785762;19305.034748262566;955.5317894231811;957.8036502516985;968.1528662420383;969.2294625772528;974.3374505336368;976.6874600127962;977.5161295158906;978.9461579613119;980.5930538826378;982.3663736889702;996.5067291690588;1021.2238698589089;1021.7394564386071;1028.1825948371063;1055.709679838043;1021.3208216536032;1024.5952848624752;1026.845973104033;1027.3681685763277;1031.3090229546185;745.3254804402025;746.9663865126082;748.988765168523;750.1036261667309;752.9548227106336;20089.8995505023;20491;20845.374638760863;20925.47686307839;20948.37154885356;22056.88971555132;22101.66847497289;22506.88746556273;22520.549589008293;22522.887385563132;17105.23026463812;17402.912985434992;17724.379646712434;17850.464486065437;17877.106144692712;3799.1072098056934;3843.385058390644;3854.036490877281;3857.035741064734;3859.691224702045;139958.30020849933;143603;144888.27555862258;145079;145304;16940.83059169417;17098.487045388658;17166.141692915553;17167.742483862752;17511.03689297101;31958.520622190685;31967.68032319647;32070.518942215884;32385.676143238736;32517.51223731646;8654;8785.428947118417;8815.426997245158;8816.647334106692;8829.470231786114;4163.417121602978;4259.552746961586;4295.248331541968;4425.911481770411;4428.512863585003;5387.6228663993925;5509.531689806411;5554.527865131509;5559.082751346064;5561.749721262553;947.3179310896144;979.3340528440586;990.5790039233441;992.836182029957;997.81540415022;665.3379887012453;678.9626570538668;688.2085601558148;703.4723957032226;707.5789905006513;12367.134300599051;12486.562970295996;12888.355582221038;12953.935230323788;13051.608451746462;681.6251061916025;686.7527690031585;691.2085661917076;701.6456689371937;702.578452928239;5972.820815375546;5984.850378740566;6006.519478441802;6096.390360963868;6133.907991380132;119434.40282798531;124176;125117;126419;130839.34580327038;109109;109961;111033;111789.44105279584;113138.43430782793;94277;96466;97876.02123978669;97876.99999999857;98146.5092674532;10930.234883558074;10960.12319014461;10999.890001099886;11164.88835111671;11215.327080375204;45025.09949801051;45300;45334.546654533035;45980.54019459763;46497;58706;58706.119408208055;59933.40066599278;60014.39985600263;60283.397166029536;15245.237738113272;15426.228688565303;15488.07071575709;15502.069875807487;15685.843141568896;15670.216489175267;15847.52457426279;15937.760933586238;15971.201439927725;16037.198140093182;15905.920470398038;16001.719862411212;16012.759808603114;16146.596335091717;16164.110973896548;16874;16898.15509224509;16940.915295423936;17021.829781702025;17216.91391543034;14778.778318325449;15976.44082457155;16180.110093944946;16218.351265949701;16364.754528682317;11902;11947.522099115939;12072.637820865388;12306.753864922472;12336.81494777597;11900.940495297467;11980.700482487659;12069.336186509476;12284.250807190847;12348.629541113782 05:45:00 INFO - PID 3871 | __end_tp_report 05:45:00 INFO - PID 3871 | __start_cc_report 05:45:00 INFO - PID 3871 | _x_x_mozilla_cycle_collect,272 05:45:00 INFO - PID 3871 | __end_cc_report 05:45:00 INFO - PID 3871 | __startTimestamp1506689100777__endTimestamp 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | ------- Summary: start ------- 05:45:00 INFO - PID 3871 | Number of tests: 6 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#0] dojo.html Cycles:165 Average:6212.24 Median:6463.77 stddev:739.81 (11.4%) stddev-sans-first:702.72 05:45:00 INFO - PID 3871 | Values: 3176.9 3203.5 3216.4 3226.5 3239.0 6241.8 6284.7 6322.3 6336.4 6356.6 6326.9 6362.2 6373.4 6378.4 6404.0 5713.0 5821.4 5913.9 5946.9 5980.4 5818.7 5848.1 5886.7 5904.9 5967.6 5639.5 5685.0 5720.3 5736.8 5897.5 5641.5 5653.3 5685.4 5727.7 5745.3 5671.8 5680.9 5683.4 5688.0 5744.8 6145.6 6241.8 6256.0 6288.1 6290.3 6667.4 6681.4 6724.9 6753.2 6763.2 6682.9 6685.2 6718.7 6741.1 6764.2 6161.6 6287.3 6289.1 6292.3 6305.9 6940.3 6974.2 7058.1 7060.8 7067.8 6638.9 6697.0 6779.3 6788.6 6798.0 6781.3 6819.1 6861.4 6870.2 6885.1 6572.5 6612.9 6640.3 6679.5 6731.6 6850.9 6859.9 6860.9 6861.8 6876.8 5269.9 5314.1 5354.0 5369.8 5389.6 4668.3 4698.7 4700.1 4714.7 4736.3 5805.3 5814.4 5894.6 5901.9 5902.1 6614.3 6646.8 6724.9 6732.5 6778.0 5669.5 5759.2 5795.8 5799.6 5832.7 5716.3 5823.8 5843.6 5849.3 5855.3 6521.2 6539.0 6641.9 6644.5 6650.5 6563.7 6576.8 6667.2 6700.7 6783.8 6445.4 6445.5 6475.9 6481.8 6497.7 6590.9 6667.7 6671.7 6671.8 6678.9 6459.9 6854.5 6884.0 6956.5 6964.2 6609.4 6613.7 6638.8 6647.1 6687.5 6541.0 6606.4 6606.7 6681.1 6725.7 6237.5 6417.0 6494.5 6554.4 6562.5 6451.1 6482.2 6590.5 6612.4 6636.1 6447.7 6463.8 6489.5 6522.7 6529.3 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#1] ext.html Cycles:180 Average:38474.76 Median:19639.52 stddev:55471.87 (282.5%) stddev-sans-first:55555.37 05:45:00 INFO - PID 3871 | Values: 803.3 829.9 843.7 845.3 855.2 39381.0 40281.0 40548.8 40736.8 40797.6 37754.8 38060.6 41326.2 41355.2 42057.6 7791.4 7927.6 7929.1 7987.2 7996.1 7841.6 7908.4 7956.3 7960.7 7974.6 7969.2 7993.9 8020.5 8024.3 8033.5 7883.6 7899.5 7929.9 7932.1 7948.5 7794.0 7853.7 7856.7 7867.8 7875.6 37467.3 37792.4 37883.0 38065.0 38130.6 3427.2 3449.1 3461.6 3486.1 3491.8 31110.2 31306.4 31324.5 31343.7 31520.1 5039.8 5198.9 5251.9 5275.3 5332.5 190039.0 190407.0 191112.0 191128.0 191868.0 46471.0 46879.5 47083.3 47185.3 47346.8 49724.5 49777.8 54217.2 54780.0 54786.7 16259.6 16364.6 16376.4 16394.8 16406.7 13255.7 13256.7 13386.9 13407.5 13438.5 14653.8 14659.9 14737.3 14883.6 14892.4 5706.8 5767.8 5791.9 5898.7 5990.0 1008.9 1015.9 1016.9 1033.6 1047.3 23382.5 23745.6 23802.6 23934.8 23971.0 1121.2 1141.4 1143.9 1154.7 1157.7 12527.4 12531.6 12555.5 12588.8 12613.7 237985.0 238153.0 240350.0 240612.0 240899.0 44794.0 45466.5 45878.5 52624.7 52825.7 1441.5 1462.7 1464.6 1464.6 1467.5 27645.6 27905.0 28553.1 28568.7 28778.3 37425.8 37544.2 37627.6 37720.2 37762.8 207246.0 208933.0 210156.0 210878.0 211712.0 34885.0 36448.3 36647.5 36688.6 37076.8 44705.6 44728.1 45150.0 45610.5 45846.3 32736.2 32899.5 33165.3 33352.3 33576.2 33122.7 33195.8 33324.7 33411.3 33696.0 35787.3 37042.8 37215.0 37865.8 37929.4 32226.2 32378.2 32496.2 32740.2 32766.0 23894.6 23926.0 24136.9 24301.1 24318.1 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#2] jquery.html Cycles:180 Average:36338.51 Median:22253.11 stddev:84489.45 (379.7%) stddev-sans-first:84683.81 05:45:00 INFO - PID 3871 | Values: 583.2 588.6 588.8 600.6 608.6 22070.9 22452.8 22491.7 22625.5 22736.9 23641.9 24185.2 24665.3 24816.5 25031.4 6339.8 6530.0 6539.0 6552.9 6554.6 6305.9 6474.4 6575.1 6582.3 6590.9 6479.4 6493.0 6513.2 6552.4 6589.1 6472.8 6474.7 6493.3 6539.3 6563.8 6060.1 6060.5 6688.8 6970.6 7010.4 29627.0 30365.0 30626.9 30643.7 30683.4 2039.1 2066.3 2068.9 2077.9 2080.4 19968.7 20468.2 20574.5 20647.8 20748.7 2503.9 2516.8 2541.5 2555.1 2577.8 122614.4 129128.0 144420.3 154748.0 156056.0 19891.0 20389.6 21241.6 21252.4 22026.8 43197.8 43252.8 43516.8 43545.0 43581.0 11592.9 11623.0 11881.3 12003.5 12025.9 9850.9 9918.6 9979.7 9987.7 10053.6 10857.5 11051.8 11260.3 11507.0 11539.7 3655.4 3745.8 3754.5 4015.4 4190.8 940.5 975.4 975.5 976.7 977.5 19211.8 19409.6 19580.4 19719.3 20017.4 997.6 1040.8 1040.9 1046.1 1055.0 10580.4 10691.3 10746.8 10868.6 11067.4 479523.0 496112.0 509259.0 510033.0 511859.0 113677.4 115394.0 117658.0 118872.0 122599.0 1169.8 1184.6 1245.4 1256.6 1257.6 19852.7 20084.2 20118.7 20325.2 20825.9 57461.4 58665.4 58993.7 59535.0 60631.7 73893.6 73996.0 74348.3 74629.6 75857.6 14577.6 14633.0 14724.1 14761.5 14773.3 22435.3 22763.0 22840.8 22854.2 22940.7 18055.2 18286.0 18348.4 18422.7 18546.3 16164.5 16345.8 16560.6 16825.0 17228.1 18357.6 18860.8 18863.4 18963.6 19035.1 14245.7 14288.3 14302.4 14421.3 14438.6 16650.0 18038.5 18197.0 18198.0 18314.4 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#3] mootools.html Cycles:180 Average:9349.00 Median:14479.47 stddev:6625.45 (45.8%) stddev-sans-first:6616.61 05:45:00 INFO - PID 3871 | Values: 1325.6 1380.6 1393.8 1407.5 1410.4 14698.3 15326.0 15372.3 15378.9 15437.5 14945.4 15084.9 15092.2 15196.2 15210.6 2697.5 2801.4 2803.8 2810.1 2818.0 2593.9 2709.6 2719.1 2726.7 2728.3 2625.1 2707.7 2779.1 2796.7 2808.3 2721.5 2778.5 2791.7 2798.3 2817.6 2742.3 2788.2 2796.4 2800.5 2809.5 14455.5 14893.7 14941.5 14942.9 14993.8 8154.4 8330.1 8434.4 8457.3 8462.1 5218.2 5271.9 5330.6 5395.3 5399.6 1862.1 1872.5 1898.1 1921.8 1926.5 25919.7 25930.4 25972.6 26200.3 26261.5 7400.9 7434.0 7599.5 7635.6 7692.3 17269.1 17271.5 17283.0 17355.3 17444.7 7797.5 8014.8 8016.0 8096.5 8101.2 7236.7 7332.0 7369.9 7371.8 7491.3 5058.7 5262.4 5294.8 5341.7 5381.5 1419.2 1424.6 1525.3 1561.7 1573.4 740.4 877.9 892.3 901.3 917.5 8338.2 8566.3 8581.0 8633.6 8657.7 973.5 1013.9 1017.5 1018.2 1021.9 5305.8 5398.0 5423.6 5578.7 5593.1 21314.3 21919.2 22216.4 22222.4 22299.2 20503.3 21382.3 21430.6 21546.8 21637.1 10540.7 10572.5 10631.9 10682.6 10729.4 8022.4 8370.7 8508.0 8509.1 8538.9 17998.0 18378.2 18659.3 18829.5 18969.1 18679.3 19318.2 19334.7 20040.7 20153.7 10658.7 10750.6 10765.9 10772.8 10776.3 12979.2 13728.4 13835.7 13895.4 13953.3 11084.5 11203.7 11325.5 11659.9 11930.5 11020.1 11122.6 11231.2 11294.5 11457.2 9726.5 9747.9 9822.9 9828.3 9837.2 7063.0 7122.1 7167.9 7176.7 7233.3 7113.4 7116.2 7243.9 7301.6 7349.8 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#4] prototype.html Cycles:180 Average:5501.24 Median:6172.02 stddev:1527.73 (24.8%) stddev-sans-first:1485.17 05:45:00 INFO - PID 3871 | Values: 499.5 511.1 536.3 538.5 546.1 6319.4 6322.3 6331.8 6357.1 6362.5 5955.3 6141.8 6165.3 6202.9 6269.8 5033.0 5045.2 5053.5 5065.7 5076.7 4872.7 5019.3 5039.2 5051.5 5074.7 4989.6 5007.5 5039.2 5072.9 5089.7 4994.5 5007.4 5018.7 5052.8 5087.1 4518.7 4537.7 4554.7 4561.4 4568.0 6135.8 6147.7 6178.8 6218.8 6260.7 5776.5 5782.8 5789.3 5812.7 5822.5 6589.5 6624.4 6629.2 6634.0 6649.3 4845.3 4874.2 4888.0 4896.1 4935.1 6738.8 6829.5 6878.3 6887.5 6908.7 5038.3 5049.7 5056.6 5097.3 5099.8 5017.8 5168.6 5171.5 5182.9 5202.7 5702.6 5717.2 5729.2 5765.3 5789.2 6455.0 6517.9 6566.5 6570.4 6634.9 1663.5 1715.3 1720.2 1745.8 1756.6 1167.1 1227.1 1249.4 1253.2 1260.1 5642.6 5652.9 5708.5 5734.2 5736.3 6526.2 6534.7 6536.4 6537.7 6571.5 5396.6 5560.5 5597.7 5693.4 5710.4 3520.5 3521.2 3524.1 3533.6 3556.2 6291.2 6362.8 6364.2 6367.9 6400.8 6700.0 6785.9 6792.6 6806.6 6809.3 6466.7 6487.5 6499.7 6545.2 6562.4 6745.6 6764.2 6792.9 6802.3 6812.5 6511.4 6573.6 6615.4 6649.0 6689.3 6325.7 6348.3 6353.4 6456.0 6497.9 5044.3 5055.9 5070.0 5072.2 5080.3 6683.2 6692.6 6696.7 6736.2 6809.9 6414.3 6499.9 6566.3 6568.2 6608.4 6344.9 6365.8 6425.8 6472.1 6538.4 6326.9 6357.4 6394.9 6395.6 6412.6 5902.3 6258.9 6350.4 6493.4 6663.6 6243.3 6243.6 6270.0 6294.0 6377.8 05:45:00 INFO - PID 3871 | 05:45:00 INFO - PID 3871 | [#5] yui.html Cycles:180 Average:24885.69 Median:20668.19 stddev:36155.02 (174.9%) stddev-sans-first:36211.59 05:45:00 INFO - PID 3871 | Values: 898.8 916.3 930.3 934.2 949.0 19448.5 20381.6 20404.0 20420.6 20435.8 18300.5 18536.7 18723.9 19143.0 19305.0 955.5 957.8 968.2 969.2 974.3 976.7 977.5 978.9 980.6 982.4 996.5 1021.2 1021.7 1028.2 1055.7 1021.3 1024.6 1026.8 1027.4 1031.3 745.3 747.0 749.0 750.1 753.0 20089.9 20491.0 20845.4 20925.5 20948.4 22056.9 22101.7 22506.9 22520.5 22522.9 17105.2 17402.9 17724.4 17850.5 17877.1 3799.1 3843.4 3854.0 3857.0 3859.7 139958.3 143603.0 144888.3 145079.0 145304.0 16940.8 17098.5 17166.1 17167.7 17511.0 31958.5 31967.7 32070.5 32385.7 32517.5 8654.0 8785.4 8815.4 8816.6 8829.5 4163.4 4259.6 4295.2 4425.9 4428.5 5387.6 5509.5 5554.5 5559.1 5561.7 947.3 979.3 990.6 992.8 997.8 665.3 679.0 688.2 703.5 707.6 12367.1 12486.6 12888.4 12953.9 13051.6 681.6 686.8 691.2 701.6 702.6 5972.8 5984.9 6006.5 6096.4 6133.9 119434.4 124176.0 125117.0 126419.0 130839.3 109109.0 109961.0 111033.0 111789.4 113138.4 94277.0 96466.0 97876.0 97877.0 98146.5 10930.2 10960.1 10999.9 11164.9 11215.3 45025.1 45300.0 45334.5 45980.5 46497.0 58706.0 58706.1 59933.4 60014.4 60283.4 15245.2 15426.2 15488.1 15502.1 15685.8 15670.2 15847.5 15937.8 15971.2 16037.2 15905.9 16001.7 16012.8 16146.6 16164.1 16874.0 16898.2 16940.9 17021.8 17216.9 14778.8 15976.4 16180.1 16218.4 16364.8 11902.0 11947.5 12072.6 12306.8 12336.8 11900.9 11980.7 12069.3 12284.3 12348.6 05:45:00 INFO - PID 3871 | -------- Summary: end -------- 05:45:00 INFO - PID 3871 | 05:45:01 INFO - TEST-INFO | 3871: exit 0 05:45:01 INFO - TEST-OK | dromaeo_css | took 1115060ms 05:45:01 INFO - TEST-START | kraken 05:45:01 INFO - Initialising browser for kraken test... 05:45:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59675/getInfo.html -profile /tmp/tmpeRZNAn/profile 05:45:01 INFO - TEST-INFO | started process 4259 (/builds/slave/test/build/application/firefox/firefox http://localhost:59675/getInfo.html) 05:45:06 INFO - TEST-INFO | 4259: exit 0 05:45:07 INFO - Browser initialized. 05:45:07 INFO - Running cycle 1/1 for kraken test... 05:45:07 INFO - Using env: {'DISPLAY': ':0', 05:45:07 INFO - 'HOME': '/home/cltbld', 05:45:07 INFO - 'JSGC_DISABLE_POISONING': '1', 05:45:07 INFO - 'LANG': 'en_US.UTF-8', 05:45:07 INFO - 'LANGUAGE': 'en_US:en', 05:45:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:45:07 INFO - 'LOGNAME': 'cltbld', 05:45:07 INFO - 'MAIL': '/var/mail/cltbld', 05:45:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:07 INFO - 'MOZ_ACCELERATED': '1', 05:45:07 INFO - 'MOZ_CRASHREPORTER': '1', 05:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:45:07 INFO - 'MOZ_NO_REMOTE': '1', 05:45:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:07 INFO - 'MOZ_WEBRENDER': '1', 05:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:07 INFO - 'NO_EM_RESTART': '1', 05:45:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:07 INFO - 'PWD': '/builds/slave/test', 05:45:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:07 INFO - 'RUST_BACKTRACE': 'full', 05:45:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:45:07 INFO - 'SHELL': '/bin/bash', 05:45:07 INFO - 'SHLVL': '1', 05:45:07 INFO - 'TERM': 'linux', 05:45:07 INFO - 'TMOUT': '86400', 05:45:07 INFO - 'USER': 'cltbld', 05:45:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144', 05:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:07 INFO - '_': '/tools/buildbot/bin/python'} 05:45:07 INFO - TEST-INFO | started process 4507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRZNAn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:07 INFO - PID 4507 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:45:08 INFO - PID 4507 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:45:08 INFO - PID 4507 | 05:45:08 INFO - PID 4507 | (/builds/slave/test/build/application/firefox/firefox:4566): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:45:08 INFO - PID 4507 | 05:45:18 INFO - PID 4507 | RSS: Main: 201015296 05:45:18 INFO - PID 4507 | 05:45:21 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59675/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:22 INFO - PID 4507 | RSS: Main: 197885952 05:45:22 INFO - PID 4507 | 05:45:24 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59675/tests/kraken/driver.html?testName=audio-dft) 05:45:25 INFO - PID 4507 | RSS: Main: 198053888 05:45:25 INFO - PID 4507 | 05:45:28 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59675/tests/kraken/driver.html?testName=audio-fft) 05:45:29 INFO - PID 4507 | RSS: Main: 194850816 05:45:29 INFO - PID 4507 | 05:45:31 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59675/tests/kraken/driver.html?testName=audio-oscillator) 05:45:31 INFO - PID 4507 | RSS: Main: 195321856 05:45:31 INFO - PID 4507 | 05:45:34 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:34 INFO - PID 4507 | RSS: Main: 195137536 05:45:34 INFO - PID 4507 | 05:45:37 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59675/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:38 INFO - PID 4507 | RSS: Main: 197124096 05:45:38 INFO - PID 4507 | 05:45:42 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59675/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:42 INFO - PID 4507 | RSS: Main: 198082560 05:45:42 INFO - PID 4507 | 05:45:45 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59675/tests/kraken/driver.html?testName=json-parse-financial) 05:45:46 INFO - PID 4507 | RSS: Main: 198049792 05:45:46 INFO - PID 4507 | 05:45:48 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:48 INFO - PID 4507 | RSS: Main: 198254592 05:45:48 INFO - PID 4507 | 05:45:50 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:51 INFO - PID 4507 | RSS: Main: 195551232 05:45:51 INFO - PID 4507 | 05:45:53 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:53 INFO - PID 4507 | RSS: Main: 195133440 05:45:53 INFO - PID 4507 | 05:45:56 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:57 INFO - PID 4507 | RSS: Main: 195751936 05:45:57 INFO - PID 4507 | 05:46:00 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:00 INFO - PID 4507 | RSS: Main: 195805184 05:46:00 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | Cycle 1(1): loaded http://localhost:59675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59675/tests/kraken/driver.html?testName=ai-astar) 05:46:02 INFO - PID 4507 | RSS: Main: 197038080 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | __start_tp_report 05:46:02 INFO - PID 4507 | _x_x_mozilla_page_load 05:46:02 INFO - PID 4507 | _x_x_mozilla_page_load_details 05:46:02 INFO - PID 4507 | |i|pagename|runs| 05:46:02 INFO - PID 4507 | |0;ai-astar;115;114;106;107;108;113;108;107;117;108 05:46:02 INFO - PID 4507 | |1;audio-beat-detection;124;117;115;120;117;118;120;116;117;116 05:46:02 INFO - PID 4507 | |2;audio-dft;170;163;163;171;174;173;187;167;164;163 05:46:02 INFO - PID 4507 | |3;audio-fft;83;81;77;72;74;75;82;74;75;85 05:46:02 INFO - PID 4507 | |4;audio-oscillator;79;78;87;82;83;78;84;86;84;89 05:46:02 INFO - PID 4507 | |5;imaging-gaussian-blur;120;117;116;113;113;111;116;118;116;113 05:46:02 INFO - PID 4507 | |6;imaging-darkroom;155;147;148;148;149;149;150;149;149;147 05:46:02 INFO - PID 4507 | |7;imaging-desaturate;100;95;94;94;97;93;100;99;96;95 05:46:02 INFO - PID 4507 | |8;json-parse-financial;53;58;52;52;59;50;53;50;52;51 05:46:02 INFO - PID 4507 | |9;json-stringify-tinderbox;48;42;37;46;42;46;38;47;37;37 05:46:02 INFO - PID 4507 | |10;stanford-crypto-aes;76;79;81;77;72;76;74;79;77;78 05:46:02 INFO - PID 4507 | |11;stanford-crypto-ccm;116;110;117;115;121;113;110;113;122;117 05:46:02 INFO - PID 4507 | |12;stanford-crypto-pbkdf2;165;160;168;167;170;163;159;156;158;164 05:46:02 INFO - PID 4507 | |13;stanford-crypto-sha256-iterative;65;62;73;71;62;64;64;63;67;60 05:46:02 INFO - PID 4507 | __end_tp_report 05:46:02 INFO - PID 4507 | __start_cc_report 05:46:02 INFO - PID 4507 | _x_x_mozilla_cycle_collect,740 05:46:02 INFO - PID 4507 | __end_cc_report 05:46:02 INFO - PID 4507 | __startTimestamp1506689162677__endTimestamp 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | ------- Summary: start ------- 05:46:02 INFO - PID 4507 | Number of tests: 14 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:4.00 (3.6%) stddev-sans-first:3.87 05:46:02 INFO - PID 4507 | Values: 115.0 114.0 106.0 107.0 108.0 113.0 108.0 107.0 117.0 108.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:117.50 stddev:2.67 (2.3%) stddev-sans-first:1.73 05:46:02 INFO - PID 4507 | Values: 124.0 117.0 115.0 120.0 117.0 118.0 120.0 116.0 117.0 116.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#2] audio-dft Cycles:10 Average:169.50 Median:170.50 stddev:7.49 (4.4%) stddev-sans-first:7.94 05:46:02 INFO - PID 4507 | Values: 170.0 163.0 163.0 171.0 174.0 173.0 187.0 167.0 164.0 163.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#3] audio-fft Cycles:10 Average:77.80 Median:79.00 stddev:4.54 (5.7%) stddev-sans-first:4.41 05:46:02 INFO - PID 4507 | Values: 83.0 81.0 77.0 72.0 74.0 75.0 82.0 74.0 75.0 85.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:84.00 stddev:3.80 (4.5%) stddev-sans-first:3.75 05:46:02 INFO - PID 4507 | Values: 79.0 78.0 87.0 82.0 83.0 78.0 84.0 86.0 84.0 89.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:116.00 stddev:2.75 (2.4%) stddev-sans-first:2.33 05:46:02 INFO - PID 4507 | Values: 120.0 117.0 116.0 113.0 113.0 111.0 116.0 118.0 116.0 113.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:2.28 (1.5%) stddev-sans-first:1.01 05:46:02 INFO - PID 4507 | Values: 155.0 147.0 148.0 148.0 149.0 149.0 150.0 149.0 149.0 147.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.58 (2.7%) stddev-sans-first:2.37 05:46:02 INFO - PID 4507 | Values: 100.0 95.0 94.0 94.0 97.0 93.0 100.0 99.0 96.0 95.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:52.50 stddev:3.09 (5.9%) stddev-sans-first:3.28 05:46:02 INFO - PID 4507 | Values: 53.0 58.0 52.0 52.0 59.0 50.0 53.0 50.0 52.0 51.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#9] json-stringify-tinderbox Cycles:10 Average:42.00 Median:44.00 stddev:4.52 (10.3%) stddev-sans-first:4.24 05:46:02 INFO - PID 4507 | Values: 48.0 42.0 37.0 46.0 42.0 46.0 38.0 47.0 37.0 37.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.50 stddev:2.60 (3.4%) stddev-sans-first:2.74 05:46:02 INFO - PID 4507 | Values: 76.0 79.0 81.0 77.0 72.0 76.0 74.0 79.0 77.0 78.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.50 stddev:4.09 (3.5%) stddev-sans-first:4.33 05:46:02 INFO - PID 4507 | Values: 116.0 110.0 117.0 115.0 121.0 113.0 110.0 113.0 122.0 117.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:164.50 stddev:4.64 (2.8%) stddev-sans-first:4.87 05:46:02 INFO - PID 4507 | Values: 165.0 160.0 168.0 167.0 170.0 163.0 159.0 156.0 158.0 164.0 05:46:02 INFO - PID 4507 | 05:46:02 INFO - PID 4507 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:64.50 stddev:4.12 (6.4%) stddev-sans-first:4.37 05:46:02 INFO - PID 4507 | Values: 65.0 62.0 73.0 71.0 62.0 64.0 64.0 63.0 67.0 60.0 05:46:02 INFO - PID 4507 | -------- Summary: end -------- 05:46:02 INFO - PID 4507 | 05:46:03 INFO - PID 4507 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:46:03 INFO - TEST-INFO | 4507: exit 0 05:46:03 INFO - TEST-OK | kraken | took 62251ms 05:46:03 INFO - SUITE-END | took 1177s 05:46:03 INFO - Completed test suite (00:19:37) 05:46:03 INFO - javascript benchmark 05:46:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8661.37196393761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.8729250829965, 3203.4714272145097, 3216.3728073025763, 3226.548283240347, 3238.9797213877614, 6241.812745617627, 6284.717187726552, 6322.336154703758, 6336.42972132508, 6356.586821856587, 6326.905096423558, 6362.236531616201, 6373.426391624753, 6378.3621637836195, 6404.039394090877, 5712.971435142818, 5821.3887541808135, 5913.9112913306335, 5946.851328716773, 5980.401959804029, 5818.709064546777, 5848.093545500455, 5886.705664716747, 5904.911426328587, 5967.5524335675, 5639.520640745542, 5684.971575142139, 5720.2849643794525, 5736.799212027559, 5897.4692277695, 5641.548676105902, 5653.349864765563, 5685.431456854323, 5727.713614319267, 5745.253117094751, 5671.829845104653, 5680.943190568083, 5683.374828768832, 5688.0, 5744.770209191627, 6145.600535965148, 6241.750329986795, 6256.0, 6288.056791481269, 6290.308066112724, 6667.399934005963, 6681.432078273353, 6724.899126513106, 6753.189617245913, 6763.154605674291, 6682.866342673119, 6685.19777626683, 6718.66406679664, 6741.0899528563505, 6764.222114456851, 6161.6303021818385, 6287.339829317947, 6289.088082228097, 6292.307846136876, 6305.87388252237, 6940.271271516519, 6974.163100427981, 7058.082449281561, 7060.7881763547175, 7067.823304417328, 6638.900416493757, 6696.961970894519, 6779.254282028973, 6788.59268443895, 6798.0, 6781.287964763727, 6819.147606549182, 6861.416779573692, 6870.175578930561, 6885.139357580302, 6572.539922205399, 6612.86774264512, 6640.335966403321, 6679.499037572202, 6731.629760363129, 6850.897236541456, 6859.862802743917, 6860.897086543706, 6861.794146175623, 6876.793696189123, 5269.947300526946, 5314.1497360422145, 5354.036273470812, 5369.758360873692, 5389.622726409114, 4668.329177057357, 4698.7415692137265, 4700.059988002345, 4714.717116972993, 4736.313234580966, 5805.274340707411, 5814.447627475383, 5894.587378883522, 5901.940980590225, 5902.144189092557, 6614.338566143347, 6646.767363142267, 6724.865502689919, 6732.461403087741, 6778.0, 5669.546436285087, 5759.1649210865025, 5795.7971470999155, 5799.623024503394, 5832.708364581754, 5716.28546431696, 5823.79616713413, 5843.5909486336395, 5849.298084229835, 5855.297364316224, 6521.184851893513, 6539.0, 6641.937290033571, 6644.468442524587, 6650.501212409089, 6563.671816409256, 6576.8355791105605, 6667.166604174478, 6700.698468569024, 6783.830404239835, 6445.4199122079235, 6445.452136568257, 6475.870482590228, 6481.837954051187, 6497.707603157774, 6590.934090659032, 6667.733290668319, 6671.66641667905, 6671.833204169935, 6678.899816502659, 6459.870802584016, 6854.451643868579, 6884.001819736211, 6956.5478243913985, 6964.164300283998, 6609.438197753245, 6613.735450581923, 6638.800835974928, 6647.069410282661, 6687.531872768859, 6540.967295163494, 6606.4384527315715, 6606.735730570724, 6681.09805176295, 6725.663716814238, 6237.5009999200865, 6416.967915160394, 6494.512911531749, 6554.442872355903, 6562.5406221564035, 6451.0645956337, 6482.157319548617, 6590.538662293593, 6612.371824676648, 6636.070950066898, 6447.742090316335, 6463.7737679181, 6489.513286503437, 6522.706478208397, 6529.281779004211], "value": 6156.831736159803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.2770506544114, 829.8921140251767, 843.7004863273538, 845.2688424512794, 855.1619412975281, 39381.0, 40281.0, 40548.79725601371, 40736.796316018415, 40797.59202407975, 37754.811225943835, 38060.61939380605, 41326.17347653045, 41355.17289654205, 42057.579424205745, 7791.376689864811, 7927.643256053462, 7929.1277959424415, 7987.241212084843, 7996.120426753053, 7841.647125879321, 7908.406869484783, 7956.283934445928, 7960.681572737083, 7974.641141148633, 7969.203079692043, 7993.880091798627, 8020.518768873857, 8024.317932975675, 8033.4778239414545, 7883.566403847786, 7899.4865333753405, 7929.920700793034, 7932.127465978738, 7948.523088614673, 7793.961030194812, 7853.685852565891, 7856.725014624518, 7867.763967080997, 7875.566843823587, 37467.25065498702, 37792.433113503044, 37883.0, 38065.0, 38130.61869381298, 3427.160345715291, 3449.1032331593715, 3461.6365281645567, 3486.1458942558984, 3491.7555771096036, 31110.222244443845, 31306.37387252265, 31324.53013204781, 31343.686563134306, 31520.054398368087, 5039.848804535834, 5198.870028249286, 5251.947480525184, 5275.261463395128, 5332.546733527654, 190039.0498047501, 190407.0, 191112.0, 191128.0, 191868.0, 46471.0, 46879.531204688195, 47083.29375059308, 47185.29222061672, 47346.76326618345, 49724.50275497271, 49777.751111244936, 54217.1867421989, 54780.0, 54786.72606636941, 16259.59351016234, 16364.590885227964, 16376.426825061304, 16394.83605163957, 16406.671866562603, 13255.73488530224, 13256.73486530264, 13386.929045676323, 13407.530736424178, 13438.46246150143, 14653.780193297109, 14659.92670036643, 14737.336819843133, 14883.627909302137, 14892.404303827725, 5706.771729130871, 5767.769289228384, 5791.855203619859, 5898.734556944948, 5990.041593345131, 1008.9495525223709, 1015.8679371681634, 1016.8932262112372, 1033.5865653738565, 1047.261680515235, 23382.532349352918, 23745.643815342784, 23802.64296035561, 23934.7606523936, 23971.04115835382, 1121.1647322744607, 1141.4292853573213, 1143.9485223164977, 1154.6766905266538, 1157.6584907452323, 12527.373631318398, 12531.624051278477, 12555.497780088877, 12588.81116783249, 12613.684657883627, 237985.0, 238153.0, 240350.0, 240612.0, 240899.0, 44794.0, 45466.54533454689, 45878.54121458809, 52624.736876316136, 52825.735871321165, 1441.54591303739, 1462.6928345047659, 1464.5752731707898, 1464.5825939607162, 1467.523055007127, 27645.58531621987, 27905.0, 28553.14340569786, 28568.714312856606, 28778.280542985754, 37425.81287093547, 37544.249115018094, 37627.623723762415, 37720.24559508849, 37762.811185943894, 207246.0, 208933.0, 210156.0, 210878.0, 211712.0, 34885.0, 36448.27103457969, 36647.45028824516, 36688.63311366959, 37076.81461592675, 44705.55294447014, 44728.10543789171, 45150.0, 45610.54389456195, 45846.31230531478, 32736.181595460304, 32899.50650740193, 33165.33669326552, 33352.33295334031, 33576.16059598432, 33122.66877331196, 33195.83402082974, 33324.66675333313, 33411.33177336488, 33696.0, 35787.28425431529, 37042.8147859259, 37215.0, 37865.81067094647, 37929.43105853359, 32226.194345141557, 32378.190545236557, 32496.187595310308, 32740.181495462803, 32766.0, 23894.641580376658, 23926.042958281472, 24136.87931560331, 24301.14945976882, 24318.148864789648], "value": 17503.301208475612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2301362201895, 588.5997521685252, 588.7880363069297, 600.636614848017, 608.5800797449759, 22070.88964555177, 22452.775472245292, 22491.66262506064, 22625.547489050252, 22736.88631556842, 23641.881790591066, 24185.153519626816, 24665.26004219872, 24816.503669926635, 25031.374215644617, 6339.77810776624, 6530.0, 6538.967305163467, 6552.868942621145, 6554.639494827783, 6305.936940630604, 6474.417302442779, 6575.112359831433, 6582.308857569958, 6590.8681826363445, 6479.384458476437, 6493.0, 6513.153290072308, 6552.443042341407, 6589.0775291458995, 6472.773452929125, 6474.676266186719, 6493.318201588812, 6539.346065393446, 6563.835904102411, 6060.060690592965, 6060.545459090542, 6688.799336019927, 6970.5710329382355, 7010.43916486685, 29627.0, 30365.0, 30626.92805751788, 30643.69356306453, 30683.386332273454, 2039.1129858511595, 2066.3181150220544, 2068.917243310266, 2077.875327480356, 2080.355089922114, 19968.70046949297, 20468.181272749072, 20574.485637859172, 20647.793522064738, 20748.688769668468, 2503.8998440062373, 2516.773490385874, 2541.4789968056502, 2555.0546297869723, 2577.8453292802305, 122614.38692806568, 129128.0, 144420.2778986109, 154748.0, 156056.0, 19891.0, 20389.592208155755, 21241.575168496853, 21252.362429126842, 22026.779732202795, 43197.78401107974, 43252.78373608112, 43516.782416088354, 43545.0, 43581.0, 11592.942035289769, 11623.0, 11881.346525940984, 12003.51985920571, 12025.87974120265, 9850.852237216448, 9918.603255869828, 9979.650712225037, 9987.700368988943, 10053.64812231583, 10857.511411986321, 11051.778964420666, 11260.268082574607, 11507.0, 11539.711507212387, 3655.3968595182027, 3745.763897913682, 3754.5494540655295, 4015.438617514763, 4190.811413486339, 940.47333493244, 975.3611384543135, 975.4589294886717, 976.72651657536, 977.5161295158941, 19211.812810541356, 19409.61180776405, 19580.412587622395, 19719.309824156087, 20017.399478015683, 997.551102004101, 1040.7866387390566, 1040.885502594714, 1046.0794500839365, 1054.9630762923261, 10580.41807700584, 10691.30506517074, 10746.78506429867, 10868.565257389615, 11067.446627668583, 479523.0, 496112.0, 509259.0, 510033.0, 511859.0, 113677.4316128414, 115394.0, 117658.0, 118872.0, 122599.0, 1169.830374595696, 1184.579474286633, 1245.3586403002462, 1256.6230130960857, 1257.591282833083, 19852.70220946658, 20084.19663213455, 20118.69821952701, 20325.186992520725, 20825.89587052055, 57461.42538574728, 58665.4133458677, 58993.705031474565, 59535.0, 60631.69684151551, 73893.630531847, 73996.0, 74348.2565174363, 74629.6268518654, 75857.62071189609, 14577.562673119823, 14632.975691701478, 14724.116553006854, 14761.483348082766, 14773.335199916244, 22435.32694019182, 22763.0, 22840.771592283865, 22854.200102996314, 22940.655890161328, 18055.187516562048, 18285.99427031526, 18348.449546513624, 18422.723659144856, 18546.258149674402, 16164.515064548083, 16345.754813677566, 16560.585985350463, 16825.0, 17228.138593070045, 18357.632847342713, 18860.811391885905, 18863.43409697711, 18963.620727585647, 19035.143418546475, 14245.715085698435, 14288.28558572088, 14302.427902883768, 14421.278936052946, 14438.639034023814, 16650.0, 18038.549036273675, 18197.0, 18197.999110049073, 18314.358997435025], "value": 12708.489329122387, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.6487030936803, 1380.5789234283538, 1393.8118354022208, 1407.4651632379694, 1410.386481880382, 14698.26508674566, 15326.0, 15372.308246128923, 15378.92310538447, 15437.536873893787, 14945.40218391263, 15084.924575377136, 15092.16993065381, 15196.164210968393, 15210.619734506643, 2697.4739925714443, 2801.3976994946083, 2803.7756979441597, 2810.058630358822, 2818.0136952066714, 2593.922182334533, 2709.552923767586, 2719.1434698070043, 2726.7273272672774, 2728.290644432452, 2625.0681008242086, 2707.6615423072117, 2779.138467075213, 2796.734310240524, 2808.2979255186206, 2721.5101281769275, 2778.458200650874, 2791.7347851954237, 2798.272449163222, 2817.591449239859, 2742.3418379588957, 2788.247173263228, 2796.3987742635227, 2800.509910765608, 2809.494291027614, 14455.49405770793, 14893.702125957529, 14941.477048303366, 14942.925285373503, 14993.775093373499, 8154.3884208684585, 8330.125336839605, 8434.367422443342, 8457.323414126855, 8462.111478294752, 5218.191180367049, 5271.86820329491, 5330.600204984603, 5395.325584301962, 5399.62202645815, 1862.0596598717696, 1872.4850666066804, 1898.1078892920443, 1921.807819218067, 1926.5087402712359, 25919.74080259192, 25930.35174120662, 25972.610410843852, 26200.34499137518, 26261.474770504676, 7400.888986665204, 7433.962830185815, 7599.506032107895, 7635.618219089134, 7692.346150577152, 17269.13654317279, 17271.481855544353, 17283.0, 17355.30578776835, 17444.738328925076, 7797.532148071134, 8014.839703205903, 8016.0, 8096.473729207582, 8101.189881011852, 7236.661217674747, 7332.0, 7369.852602947911, 7371.8157046074275, 7491.325780679765, 5058.721770302595, 5262.447443018505, 5294.788208471618, 5341.732913354317, 5381.515663590218, 1419.2265215457394, 1424.5853278692516, 1525.3441020361352, 1561.7032763774846, 1573.3863793120693, 740.3854800515559, 877.9429337093069, 892.2549671024638, 901.3195037746591, 917.499962520428, 8338.207870252316, 8566.271866891384, 8581.013183483854, 8633.568321583896, 8657.696980605648, 973.4889183178888, 1013.8732658417698, 1017.4861694844204, 1018.2414101494286, 1021.9284650074424, 5305.814296499604, 5397.973010135002, 5423.620346575702, 5578.748956296977, 5593.105103183471, 21314.254001109886, 21919.232826850985, 22216.444588885082, 22222.444438889157, 22299.21952731679, 20503.28238511645, 21382.251621193183, 21430.571388572454, 21546.845315468327, 21637.13451461924, 10540.683779486628, 10572.471376431302, 10631.946840265904, 10682.62610808618, 10729.409882456539, 8022.358211343195, 8370.748877533684, 8507.95746021266, 8509.149085091442, 8538.871916921375, 17998.0, 18378.172982215565, 18659.346922857636, 18829.529261768566, 18969.14638841283, 18679.34622288268, 19318.227270909007, 19334.70997935004, 20040.69938950946, 20153.697694534887, 10658.73353166177, 10750.569977200825, 10765.89234107649, 10772.784544309226, 10776.29954052984, 12979.156354836905, 13728.352597688341, 13835.654108647364, 13895.374708137955, 13953.302334883012, 11084.501197445972, 11203.663890083311, 11325.490352933974, 11659.941700291443, 11930.463129159381, 11020.118390528898, 11122.555097795997, 11231.157663175458, 11294.491747871201, 11457.197996140523, 9726.465044422624, 9747.9025209747, 9822.901770982198, 9828.26288028415, 9837.213022958003, 7063.046488724162, 7122.109736282965, 7167.8924816126755, 7176.677049532679, 7233.276672332725, 7113.3953613943395, 7116.181639111568, 7243.855122897618, 7301.598412087386, 7349.795061481641], "value": 6716.831594959332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.48802477460623, 511.13873123786436, 536.3081624704131, 538.453469728226, 546.1043888023639, 6319.431251187392, 6322.336154703758, 6331.77838775643, 6357.110004599354, 6362.459190968773, 5955.315138759033, 6141.785037523688, 6165.290991535975, 6202.8910170542, 6269.780557680482, 5032.9748351258195, 5045.243213517983, 5053.545180933706, 5065.721385323805, 5076.695398276115, 4872.731999740013, 5019.272205530214, 5039.168537191359, 5051.5453609175165, 5074.746262686851, 4989.625778066659, 5007.524285192901, 5039.244113382985, 5072.923906141411, 5089.669171503859, 4994.450610432849, 5007.449180590114, 5018.749062546858, 5052.823151189691, 5087.135187018216, 4518.683692141552, 4537.659675524349, 4554.749488778116, 4561.40701708779, 4567.954320456786, 6135.815925522197, 6147.723352449106, 6178.752849885999, 6218.844528886769, 6260.686965651699, 5776.537876969875, 5782.768689252425, 5789.2763404574425, 5812.651240925558, 5822.534197264209, 6589.505787065941, 6624.370684784938, 6629.204495460575, 6634.0, 6649.335066493312, 4845.345878306454, 4874.220124780054, 4887.95112048882, 4896.143174944406, 4935.099986505185, 6738.8315292117595, 6829.487788415889, 6878.27778083304, 6887.5178737488395, 6908.6545672716165, 5038.294638750578, 5049.722265275445, 5056.57019153376, 5097.286379906816, 5099.821506247264, 5017.8243761468175, 5168.560672342893, 5171.50870667286, 5182.870428239325, 5202.661826981234, 5702.6293290935955, 5717.171010203498, 5729.169270455761, 5765.3369862465515, 5789.1895134680335, 6455.0, 6517.902231466532, 6566.507511936624, 6570.441512471398, 6634.933650663528, 1663.4593757029013, 1715.271009820821, 1720.1571230097163, 1745.8079611242754, 1756.6135450200936, 1167.101331974375, 1227.1287385955893, 1249.4127759952808, 1253.2104773992326, 1260.0738457234108, 5642.576806739429, 5652.9152062719095, 5708.4862362387585, 5734.16854556087, 5736.311642602915, 6526.23584783111, 6534.7455127980775, 6536.379043990813, 6537.705803238866, 6571.539992200595, 5396.64921780083, 5560.497776000816, 5597.692126933058, 5693.373728889819, 5710.400407957188, 3520.5247291615306, 3521.207728261121, 3524.136586536315, 3533.5936367318086, 3556.1643013891717, 6291.182146320949, 6362.77730279438, 6364.204474440695, 6367.872642547216, 6400.839979000469, 6700.0, 6785.946324154151, 6792.592444453348, 6806.625635589991, 6809.250982391933, 6466.741330346827, 6487.54587178893, 6499.675016249169, 6545.214574251025, 6562.376574225441, 6745.561538499982, 6764.188297404343, 6792.9470932005615, 6802.319768023158, 6812.489063320171, 6511.413972742286, 6573.57271777333, 6615.437687796399, 6649.03588979605, 6689.2976237496305, 6325.652089134957, 6348.333424990495, 6353.396427339396, 6456.0, 6497.935020649922, 5044.268581055653, 5055.924161137512, 5069.9746501267255, 5072.188449848154, 5080.339555857862, 6683.198016237888, 6692.56109936366, 6696.665166741546, 6736.191657001191, 6809.897851532132, 6414.262359828493, 6499.855047834298, 6566.343365663395, 6568.1789776277965, 6608.4382827458285, 6344.904826427515, 6365.809025729235, 6425.839354016187, 6472.126262954629, 6538.444232240123, 6326.905096423649, 6357.442426605511, 6394.90407643895, 6395.616263024233, 6412.583182093149, 5902.291724993029, 6258.937410625836, 6350.396712312323, 6493.415592596689, 6663.600183988976, 6243.313235544178, 6243.594166379171, 6270.0, 6294.0, 6377.840553986188], "value": 5053.3794329043685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.7663207566031, 916.2807196350864, 930.2836815651948, 934.2432629570048, 949.0319873728795, 19448.51378715531, 20381.592368152647, 20404.0, 20420.591588168227, 20435.795642043577, 18300.450986470427, 18536.721949170773, 18723.876567405965, 19143.04284785762, 19305.034748262566, 955.5317894231811, 957.8036502516985, 968.1528662420383, 969.2294625772528, 974.3374505336368, 976.6874600127962, 977.5161295158906, 978.9461579613119, 980.5930538826378, 982.3663736889702, 996.5067291690588, 1021.2238698589089, 1021.7394564386071, 1028.1825948371063, 1055.709679838043, 1021.3208216536032, 1024.5952848624752, 1026.845973104033, 1027.3681685763277, 1031.3090229546185, 745.3254804402025, 746.9663865126082, 748.988765168523, 750.1036261667309, 752.9548227106336, 20089.8995505023, 20491.0, 20845.374638760863, 20925.47686307839, 20948.37154885356, 22056.88971555132, 22101.66847497289, 22506.88746556273, 22520.549589008293, 22522.887385563132, 17105.23026463812, 17402.912985434992, 17724.379646712434, 17850.464486065437, 17877.106144692712, 3799.1072098056934, 3843.385058390644, 3854.036490877281, 3857.035741064734, 3859.691224702045, 139958.30020849933, 143603.0, 144888.27555862258, 145079.0, 145304.0, 16940.83059169417, 17098.487045388658, 17166.141692915553, 17167.742483862752, 17511.03689297101, 31958.520622190685, 31967.68032319647, 32070.518942215884, 32385.676143238736, 32517.51223731646, 8654.0, 8785.428947118417, 8815.426997245158, 8816.647334106692, 8829.470231786114, 4163.417121602978, 4259.552746961586, 4295.248331541968, 4425.911481770411, 4428.512863585003, 5387.6228663993925, 5509.531689806411, 5554.527865131509, 5559.082751346064, 5561.749721262553, 947.3179310896144, 979.3340528440586, 990.5790039233441, 992.836182029957, 997.81540415022, 665.3379887012453, 678.9626570538668, 688.2085601558148, 703.4723957032226, 707.5789905006513, 12367.134300599051, 12486.562970295996, 12888.355582221038, 12953.935230323788, 13051.608451746462, 681.6251061916025, 686.7527690031585, 691.2085661917076, 701.6456689371937, 702.578452928239, 5972.820815375546, 5984.850378740566, 6006.519478441802, 6096.390360963868, 6133.907991380132, 119434.40282798531, 124176.0, 125117.0, 126419.0, 130839.34580327038, 109109.0, 109961.0, 111033.0, 111789.44105279584, 113138.43430782793, 94277.0, 96466.0, 97876.02123978669, 97876.99999999857, 98146.5092674532, 10930.234883558074, 10960.12319014461, 10999.890001099886, 11164.88835111671, 11215.327080375204, 45025.09949801051, 45300.0, 45334.546654533035, 45980.54019459763, 46497.0, 58706.0, 58706.119408208055, 59933.40066599278, 60014.39985600263, 60283.397166029536, 15245.237738113272, 15426.228688565303, 15488.07071575709, 15502.069875807487, 15685.843141568896, 15670.216489175267, 15847.52457426279, 15937.760933586238, 15971.201439927725, 16037.198140093182, 15905.920470398038, 16001.719862411212, 16012.759808603114, 16146.596335091717, 16164.110973896548, 16874.0, 16898.15509224509, 16940.915295423936, 17021.829781702025, 17216.91391543034, 14778.778318325449, 15976.44082457155, 16180.110093944946, 16218.351265949701, 16364.754528682317, 11902.0, 11947.522099115939, 12072.637820865388, 12306.753864922472, 12336.81494777597, 11900.940495297467, 11980.700482487659, 12069.336186509476, 12284.250807190847, 12348.629541113782], "value": 9081.874649888634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1434.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 106.0, 107.0, 108.0, 113.0, 108.0, 107.0, 117.0, 108.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 115.0, 120.0, 117.0, 118.0, 120.0, 116.0, 117.0, 116.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 163.0, 171.0, 174.0, 173.0, 187.0, 167.0, 164.0, 163.0], "value": 169.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 77.0, 72.0, 74.0, 75.0, 82.0, 74.0, 75.0, 85.0], "value": 77.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 87.0, 82.0, 83.0, 78.0, 84.0, 86.0, 84.0, 89.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 116.0, 113.0, 113.0, 111.0, 116.0, 118.0, 116.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 147.0, 148.0, 148.0, 149.0, 149.0, 150.0, 149.0, 149.0, 147.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 94.0, 94.0, 97.0, 93.0, 100.0, 99.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 52.0, 52.0, 59.0, 50.0, 53.0, 50.0, 52.0, 51.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 42.0, 37.0, 46.0, 42.0, 46.0, 38.0, 47.0, 37.0, 37.0], "value": 42.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 81.0, 77.0, 72.0, 76.0, 74.0, 79.0, 77.0, 78.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 117.0, 115.0, 121.0, 113.0, 110.0, 113.0, 122.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 168.0, 167.0, 170.0, 163.0, 159.0, 156.0, 158.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 73.0, 71.0, 62.0, 64.0, 64.0, 63.0, 67.0, 60.0], "value": 65.1, "unit": "score"}]}]} 05:46:03 INFO - Return code: 0 05:46:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:04 INFO - # TBPL SUCCESS # 05:46:04 INFO - Running post-action listener: _package_coverage_data 05:46:04 INFO - Running post-action listener: _resource_record_post_action 05:46:04 INFO - [mozharness: 2017-09-29 12:46:04.002541Z] Finished run-tests step (success) 05:46:04 INFO - Running post-run listener: _resource_record_post_run 05:46:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 18595840; Write bytes: 524029952; Read time: 7984; Write time: 419880 05:46:04 INFO - TinderboxPrint: CPU usage
13.3% 05:46:04 INFO - TinderboxPrint: I/O read bytes / time
18,595,840 / 7,984 05:46:04 INFO - TinderboxPrint: I/O write bytes / time
524,029,952 / 419,880 05:46:04 INFO - TinderboxPrint: CPU idle
8,265.4 (86.7%) 05:46:04 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 05:46:04 INFO - TinderboxPrint: Swap in / out
0 / 0 05:46:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 152928256; Read time: 0; Write time: 95160 05:46:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:46:04 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 16228352; Write bytes: 371101696; Read time: 7412; Write time: 324720 05:46:04 INFO - Running post-run listener: _upload_blobber_files 05:46:04 INFO - Blob upload gear active. 05:46:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:46:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:06 INFO - (blobuploader) - INFO - Done attempting. 05:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:07 INFO - (blobuploader) - INFO - Done attempting. 05:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:08 INFO - (blobuploader) - INFO - Done attempting. 05:46:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:15 INFO - (blobuploader) - INFO - Done attempting. 05:46:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:15 INFO - Return code: 0 05:46:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321786326258585df39fefe840666789e68815b8b12fd02fbc9b530cdf32da03a18d5a355dba6701af2fc81b9ce753a1d8f51465c01d7cc21bf9f545b0983dac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbf15fbede9254958ff6df32f66d67b8737069408531225a91c4ebbc28e6130db7664231bba5d0e74d1263847a8abe4497ef70b4feb9f121ebc49c03905d0268", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0d332e60596bb8588dd2e5b413d351a3e72e33377ad9d3ee0672f1ad12d67681f7479657241186c3d8e6b736b7bfac3a496c0faf76b808be49191830b9e7d4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c763163b318b3e1c2c79f6be5fc0c6526ecf9bc5e5a330e517c8798c7bf78f49cb3f0f2c3b5fd3effe2951e3930908a5780852c2157f3951223ec53047b2e6d"} 05:46:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:15 INFO - Contents: 05:46:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321786326258585df39fefe840666789e68815b8b12fd02fbc9b530cdf32da03a18d5a355dba6701af2fc81b9ce753a1d8f51465c01d7cc21bf9f545b0983dac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbf15fbede9254958ff6df32f66d67b8737069408531225a91c4ebbc28e6130db7664231bba5d0e74d1263847a8abe4497ef70b4feb9f121ebc49c03905d0268", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0d332e60596bb8588dd2e5b413d351a3e72e33377ad9d3ee0672f1ad12d67681f7479657241186c3d8e6b736b7bfac3a496c0faf76b808be49191830b9e7d4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c763163b318b3e1c2c79f6be5fc0c6526ecf9bc5e5a330e517c8798c7bf78f49cb3f0f2c3b5fd3effe2951e3930908a5780852c2157f3951223ec53047b2e6d"} 05:46:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:15 INFO - Copying logs to upload dir... 05:46:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.959699 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-29 05:46:15.344691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:15.353236) ========= 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=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321786326258585df39fefe840666789e68815b8b12fd02fbc9b530cdf32da03a18d5a355dba6701af2fc81b9ce753a1d8f51465c01d7cc21bf9f545b0983dac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbf15fbede9254958ff6df32f66d67b8737069408531225a91c4ebbc28e6130db7664231bba5d0e74d1263847a8abe4497ef70b4feb9f121ebc49c03905d0268", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0d332e60596bb8588dd2e5b413d351a3e72e33377ad9d3ee0672f1ad12d67681f7479657241186c3d8e6b736b7bfac3a496c0faf76b808be49191830b9e7d4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c763163b318b3e1c2c79f6be5fc0c6526ecf9bc5e5a330e517c8798c7bf78f49cb3f0f2c3b5fd3effe2951e3930908a5780852c2157f3951223ec53047b2e6d"} build_url:https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/321786326258585df39fefe840666789e68815b8b12fd02fbc9b530cdf32da03a18d5a355dba6701af2fc81b9ce753a1d8f51465c01d7cc21bf9f545b0983dac", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbf15fbede9254958ff6df32f66d67b8737069408531225a91c4ebbc28e6130db7664231bba5d0e74d1263847a8abe4497ef70b4feb9f121ebc49c03905d0268", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e0d332e60596bb8588dd2e5b413d351a3e72e33377ad9d3ee0672f1ad12d67681f7479657241186c3d8e6b736b7bfac3a496c0faf76b808be49191830b9e7d4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c763163b318b3e1c2c79f6be5fc0c6526ecf9bc5e5a330e517c8798c7bf78f49cb3f0f2c3b5fd3effe2951e3930908a5780852c2157f3951223ec53047b2e6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:15.387286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:15.387729) ========= 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=2432103b8b3de4003b23cad4000001c2-1506686963.733431-945362144 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:15.464691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 05:46:15.468030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 05:46:15.468352) ========= ========= Total master_lag: 0.34 =========