builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-077 starttime: 1506423937.8 results: success (0) revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:37.799752) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:37.800260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:37.800544) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:37.858365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:37.858664) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 04:05:38-- 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% 221M=0s 2017-09-26 04:05:38 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173603 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.059201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.059496) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017756 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.115646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.116038) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6fb1f5fae37168c824b988733aac0d46499b6c11 --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 6fb1f5fae37168c824b988733aac0d46499b6c11 --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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 04:05:38,984 truncating revision to first 12 chars 2017-09-26 04:05:38,984 Setting DEBUG logging. 2017-09-26 04:05:38,984 attempt 1/10 2017-09-26 04:05:38,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6fb1f5fae371?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 04:05:39,574 unpacking tar archive at: mozilla-central-6fb1f5fae371/testing/mozharness/ program finished with exit code 0 elapsedTime=0.863799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.999219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.999546) ========= script_repo_revision: 6fb1f5fae37168c824b988733aac0d46499b6c11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:38.999926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:39.000225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:05:39.014157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-26 04:05:39.014556) ========= /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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:40 INFO - MultiFileLogger online at 20170926 04:05:40 in /builds/slave/test 04:05:40 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 04:05:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:40 INFO - {'append_to_log': False, 04:05:40 INFO - 'base_work_dir': '/builds/slave/test', 04:05:40 INFO - 'blob_upload_branch': 'Firefox', 04:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:40 INFO - 'branch': 'Firefox', 04:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:40 INFO - 'code_coverage': False, 04:05:40 INFO - 'config_files': ('talos/linux_config.py',), 04:05:40 INFO - 'default_actions': ('clobber', 04:05:40 INFO - 'read-buildbot-config', 04:05:40 INFO - 'download-and-extract', 04:05:40 INFO - 'populate-webroot', 04:05:40 INFO - 'create-virtualenv', 04:05:40 INFO - 'install', 04:05:40 INFO - 'setup-mitmproxy', 04:05:40 INFO - 'run-tests'), 04:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:40 INFO - 'disable_ccov_upload': False, 04:05:40 INFO - 'disable_stylo': False, 04:05:40 INFO - 'download_minidump_stackwalk': True, 04:05:40 INFO - 'download_symbols': 'ondemand', 04:05:40 INFO - 'enable_stylo': False, 04:05:40 INFO - 'enable_webrender': False, 04:05:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:40 INFO - 'gecko_profile': False, 04:05:40 INFO - 'gecko_profile_interval': 0, 04:05:40 INFO - 'installer_path': 'installer.exe', 04:05:40 INFO - 'log_level': 'info', 04:05:40 INFO - 'log_name': 'talos', 04:05:40 INFO - 'log_to_console': True, 04:05:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:40 INFO - 'opt_config_files': (), 04:05:40 INFO - 'pip_index': False, 04:05:40 INFO - 'suite': 'dromaeojs-e10s', 04:05:40 INFO - 'system_bits': '32', 04:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:40 INFO - 'title': 'talos-linux64-ix-077', 04:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:40 INFO - 'use_talos_json': True, 04:05:40 INFO - 'verify': 'False', 04:05:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:40 INFO - 'work_dir': 'build'} 04:05:40 INFO - [mozharness: 2017-09-26 11:05:40.023184Z] Running clobber step. 04:05:40 INFO - Running pre-action listener: _resource_record_pre_action 04:05:40 INFO - Running main action method: clobber 04:05:40 INFO - rmtree: /builds/slave/test/build 04:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:41 INFO - Running post-action listener: _resource_record_post_action 04:05:41 INFO - [mozharness: 2017-09-26 11:05:41.063064Z] Finished clobber step (success) 04:05:41 INFO - [mozharness: 2017-09-26 11:05:41.063161Z] Running read-buildbot-config step. 04:05:41 INFO - Running pre-action listener: _resource_record_pre_action 04:05:41 INFO - Running main action method: read_buildbot_config 04:05:41 INFO - Using buildbot properties: 04:05:41 INFO - { 04:05:41 INFO - "project": "", 04:05:41 INFO - "product": "firefox", 04:05:41 INFO - "who": "archaeopteryx@coole-files.de", 04:05:41 INFO - "installer_path": "public/build/target.tar.bz2", 04:05:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 04:05:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:05:41 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 04:05:41 INFO - "stage_platform": "linux64-qr", 04:05:41 INFO - "basedir": "/builds/slave/test", 04:05:41 INFO - "buildnumber": 98, 04:05:41 INFO - "platform": "ubuntu64_hw_qr", 04:05:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:41 INFO - "slavebuilddir": "test", 04:05:41 INFO - "taskId": "I9dBNSDrQAi8aDxYQP3Y-w", 04:05:41 INFO - "branch": "mozilla-central", 04:05:41 INFO - "script_repo_revision": "production", 04:05:41 INFO - "revision": "6fb1f5fae37168c824b988733aac0d46499b6c11", 04:05:41 INFO - "slavename": "talos-linux64-ix-077", 04:05:41 INFO - "repo_path": "mozilla-central" 04:05:41 INFO - } 04:05:41 INFO - Finding installer, test and symbols from parent task. 04:05:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I9dBNSDrQAi8aDxYQP3Y-w'}, attempt #1 04:05:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I9dBNSDrQAi8aDxYQP3Y-w'}, attempt #1 04:05:41 INFO - Task dependencies: NZTur4OUTTCzffNcI7ihNw 04:05:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw'}, attempt #1 04:05:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json 04:05:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip 04:05:42 INFO - Running post-action listener: _resource_record_post_action 04:05:42 INFO - [mozharness: 2017-09-26 11:05:42.391853Z] Finished read-buildbot-config step (success) 04:05:42 INFO - [mozharness: 2017-09-26 11:05:42.392070Z] Running download-and-extract step. 04:05:42 INFO - Running pre-action listener: _resource_record_pre_action 04:05:42 INFO - Running main action method: download_and_extract 04:05:42 INFO - mkdir: /builds/slave/test/build/tests 04:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:42 INFO - trying https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json 04:05:42 INFO - Downloading https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:05:42 INFO - Downloaded 989 bytes. 04:05:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:05:42 INFO - Using the following test package requirements: 04:05:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:05:42 INFO - u'common': [u'target.common.tests.zip'], 04:05:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:05:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:05:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:05:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:05:42 INFO - u'mozbase': [u'target.common.tests.zip'], 04:05:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:05:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:05:42 INFO - u'web-platform': [u'target.common.tests.zip', 04:05:42 INFO - u'target.web-platform.tests.tar.gz'], 04:05:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:05:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:05:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip 04:05:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:42 INFO - Fetch https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.common.tests.zip into memory 04:05:45 INFO - Content-Length response header: 54943909 04:05:45 INFO - Bytes received: 54943909 04:05:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip 04:05:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:05:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.talos.tests.zip into memory 04:05:56 INFO - Content-Length response header: 14513823 04:05:56 INFO - Bytes received: 14513823 04:05: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')]} 04:05:56 INFO - trying https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:56 INFO - Downloading https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:05:58 INFO - Downloaded 61657450 bytes. 04:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:58 INFO - mkdir: /builds/slave/test/properties 04:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:58 INFO - Contents: 04:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - Running post-action listener: find_tests_for_verification 04:05:58 INFO - Running post-action listener: set_extra_try_arguments 04:05:58 INFO - [mozharness: 2017-09-26 11:05:58.163647Z] Finished download-and-extract step (success) 04:05:58 INFO - [mozharness: 2017-09-26 11:05:58.163801Z] Running populate-webroot step. 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: populate_webroot 04:05:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['tresize', 04:05:58 INFO - 'tcanvasmark']}, 04:05:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['dromaeo_css', 04:05:58 INFO - 'kraken']}, 04:05:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'tests': ['damp', 'tps']}, 04:05:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['damp', 'tps']}, 04:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['dromaeo_dom']}, 04:05:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:05:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['basic_compositor_video', 04:05:58 INFO - 'glvideo']}, 04:05:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:05:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['ts_paint_webext', 04:05:58 INFO - 'tp5o_webext']}, 04:05:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_many_windows', 04:05:58 INFO - 'sessionrestore_no_auto_restore', 04:05:58 INFO - 'tabpaint']}, 04:05:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['a11yr', 04:05:58 INFO - 'ts_paint', 04:05:58 INFO - 'tpaint', 04:05:58 INFO - 'sessionrestore', 04:05:58 INFO - 'sessionrestore_many_windows', 04:05:58 INFO - 'sessionrestore_no_auto_restore', 04:05:58 INFO - 'tabpaint']}, 04:05:58 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:05:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:05:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['perf_reftest_singletons']}, 04:05:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['perf_reftest']}, 04:05:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:58 INFO - 'tsvgr_opacity', 04:05:58 INFO - 'tart', 04:05:58 INFO - 'tscrollx', 04:05:58 INFO - 'tsvg_static']}, 04:05:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['tsvgx', 04:05:58 INFO - 'tsvgr_opacity', 04:05:58 INFO - 'tart', 04:05:58 INFO - 'tscrollx', 04:05:58 INFO - 'tsvg_static']}, 04:05:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:05:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--disable-stylo'], 04:05:58 INFO - 'tests': ['tp5o']}, 04:05:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:58 INFO - 'talos_options': ['--mitmproxy', 04:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:58 INFO - '--firstNonBlankPaint'], 04:05:58 INFO - 'tests': ['tp6_google', 04:05:58 INFO - 'tp6_youtube', 04:05:58 INFO - 'tp6_amazon', 04:05:58 INFO - 'tp6_facebook']}, 04:05:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:58 INFO - 'talos_options': ['--disable-stylo', 04:05:58 INFO - '--mitmproxy', 04:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:58 INFO - '--firstNonBlankPaint'], 04:05:58 INFO - 'tests': ['tp6_google', 04:05:58 INFO - 'tp6_youtube', 04:05:58 INFO - 'tp6_amazon', 04:05:58 INFO - 'tp6_facebook']}, 04:05:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:05:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:05:58 INFO - 'talos_options': ['--stylo-threads=1', 04:05:58 INFO - '--mitmproxy', 04:05:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:05:58 INFO - '--firstNonBlankPaint'], 04:05:58 INFO - 'tests': ['tp6_google', 04:05:58 INFO - 'tp6_youtube', 04:05:58 INFO - 'tp6_amazon', 04:05:58 INFO - 'tp6_facebook']}, 04:05:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--xperf_path', 04:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:58 INFO - 'tests': ['tp5n']}, 04:05:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:05:58 INFO - 'talos_options': ['--disable-stylo', 04:05:58 INFO - '--xperf_path', 04:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:58 INFO - 'tests': ['tp5n']}}} 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - [mozharness: 2017-09-26 11:05:58.183467Z] Finished populate-webroot step (success) 04:05:58 INFO - [mozharness: 2017-09-26 11:05:58.183557Z] Running create-virtualenv step. 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: create_virtualenv 04:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:05:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:05:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:59 INFO - Installing pip...............done. 04:05:59 INFO - Return code: 0 04:05:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:05:59 INFO - Reading from file tmpfile_stdout 04:05:59 INFO - Output received: 04:05:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:05:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:59 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')]} 04:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:59 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')]} 04:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:59 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:05:59 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 04:05:59 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 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:06:01 INFO - Downloading/unpacking pip>=1.5 04:06:01 INFO - Running setup.py egg_info for package pip 04:06:01 INFO - warning: no files found matching 'pip/cacert.pem' 04:06:01 INFO - warning: no files found matching '*.html' under directory 'docs' 04:06:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:06:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:06:01 INFO - Installing collected packages: pip 04:06:01 INFO - Found existing installation: pip 1.1 04:06:01 INFO - Uninstalling pip: 04:06:01 INFO - Successfully uninstalled pip 04:06:01 INFO - Running setup.py install for pip 04:06:01 INFO - warning: no files found matching 'pip/cacert.pem' 04:06:01 INFO - warning: no files found matching '*.html' under directory 'docs' 04:06:01 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:06:01 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:06:01 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:06:01 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:06:01 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:06:01 INFO - Successfully installed pip 04:06:01 INFO - Cleaning up... 04:06:01 INFO - Return code: 0 04:06:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:01 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:01 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 04:06:01 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 04:06:01 INFO - Using env: {'DISPLAY': ':0', 04:06:01 INFO - 'HOME': '/home/cltbld', 04:06:01 INFO - 'LANG': 'en_US.UTF-8', 04:06:01 INFO - 'LANGUAGE': 'en_US:en', 04:06:01 INFO - 'LOGNAME': 'cltbld', 04:06:01 INFO - 'MAIL': '/var/mail/cltbld', 04:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:01 INFO - 'MOZ_NO_REMOTE': '1', 04:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:01 INFO - 'NO_EM_RESTART': '1', 04:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:01 INFO - 'PWD': '/builds/slave/test', 04:06:01 INFO - 'SHELL': '/bin/bash', 04:06:01 INFO - 'SHLVL': '1', 04:06:01 INFO - 'TERM': 'linux', 04:06:01 INFO - 'TMOUT': '86400', 04:06:01 INFO - 'USER': 'cltbld', 04:06:01 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:01 INFO - '_': '/tools/buildbot/bin/python'} 04:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:01 INFO - Downloading/unpacking psutil>=3.1.1 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:02 INFO - Installing collected packages: psutil 04:06:02 INFO - Running setup.py install for psutil 04:06:02 INFO - building 'psutil._psutil_linux' extension 04:06:02 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 04:06:02 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 04:06:02 INFO - building 'psutil._psutil_posix' extension 04:06:02 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 04:06:03 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 04:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:03 INFO - Successfully installed psutil 04:06:03 INFO - Cleaning up... 04:06:03 INFO - Return code: 0 04:06:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06:03 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')]} 04:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:03 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')]} 04:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:03 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:03 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 04:06:03 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 04:06:03 INFO - Using env: {'DISPLAY': ':0', 04:06:03 INFO - 'HOME': '/home/cltbld', 04:06:03 INFO - 'LANG': 'en_US.UTF-8', 04:06:03 INFO - 'LANGUAGE': 'en_US:en', 04:06:03 INFO - 'LOGNAME': 'cltbld', 04:06:03 INFO - 'MAIL': '/var/mail/cltbld', 04:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:03 INFO - 'MOZ_NO_REMOTE': '1', 04:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:03 INFO - 'NO_EM_RESTART': '1', 04:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:03 INFO - 'PWD': '/builds/slave/test', 04:06:03 INFO - 'SHELL': '/bin/bash', 04:06:03 INFO - 'SHLVL': '1', 04:06:03 INFO - 'TERM': 'linux', 04:06:03 INFO - 'TMOUT': '86400', 04:06:03 INFO - 'USER': 'cltbld', 04:06:03 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:03 INFO - '_': '/tools/buildbot/bin/python'} 04:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06: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 04:06: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 04:06: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 04:06: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 04:06:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:05 INFO - Installing collected packages: mozsystemmonitor 04:06:05 INFO - Running setup.py install for mozsystemmonitor 04:06:05 INFO - Successfully installed mozsystemmonitor 04:06:05 INFO - Cleaning up... 04:06:06 INFO - Return code: 0 04:06:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:06 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:06 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 04:06:06 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 04:06:06 INFO - Using env: {'DISPLAY': ':0', 04:06:06 INFO - 'HOME': '/home/cltbld', 04:06:06 INFO - 'LANG': 'en_US.UTF-8', 04:06:06 INFO - 'LANGUAGE': 'en_US:en', 04:06:06 INFO - 'LOGNAME': 'cltbld', 04:06:06 INFO - 'MAIL': '/var/mail/cltbld', 04:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:06 INFO - 'MOZ_NO_REMOTE': '1', 04:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:06 INFO - 'NO_EM_RESTART': '1', 04:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:06 INFO - 'PWD': '/builds/slave/test', 04:06:06 INFO - 'SHELL': '/bin/bash', 04:06:06 INFO - 'SHLVL': '1', 04:06:06 INFO - 'TERM': 'linux', 04:06:06 INFO - 'TMOUT': '86400', 04:06:06 INFO - 'USER': 'cltbld', 04:06:06 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:06 INFO - '_': '/tools/buildbot/bin/python'} 04:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:07 INFO - warning: no files found matching '*.txt' 04:06:07 INFO - no previously-included directories found matching 'build' 04:06:07 INFO - no previously-included directories found matching 'dist' 04:06:07 INFO - no previously-included directories found matching '.git*' 04:06:07 INFO - Installing collected packages: jsonschema, functools32 04:06:07 INFO - Running setup.py install for functools32 04:06:08 INFO - warning: no files found matching '*.txt' 04:06:08 INFO - no previously-included directories found matching 'build' 04:06:08 INFO - no previously-included directories found matching 'dist' 04:06:08 INFO - no previously-included directories found matching '.git*' 04:06:08 INFO - Successfully installed jsonschema functools32 04:06:08 INFO - Cleaning up... 04:06:08 INFO - Return code: 0 04:06:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:06:08 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')]} 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:08 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')]} 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:08 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:08 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 04:06:08 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 04:06:08 INFO - Using env: {'DISPLAY': ':0', 04:06:08 INFO - 'HOME': '/home/cltbld', 04:06:08 INFO - 'LANG': 'en_US.UTF-8', 04:06:08 INFO - 'LANGUAGE': 'en_US:en', 04:06:08 INFO - 'LOGNAME': 'cltbld', 04:06:08 INFO - 'MAIL': '/var/mail/cltbld', 04:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:08 INFO - 'MOZ_NO_REMOTE': '1', 04:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:08 INFO - 'NO_EM_RESTART': '1', 04:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:08 INFO - 'PWD': '/builds/slave/test', 04:06:08 INFO - 'SHELL': '/bin/bash', 04:06:08 INFO - 'SHLVL': '1', 04:06:08 INFO - 'TERM': 'linux', 04:06:08 INFO - 'TMOUT': '86400', 04:06:08 INFO - 'USER': 'cltbld', 04:06:08 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:08 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:06:08 INFO - Cleaning up... 04:06:08 INFO - Return code: 0 04:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:08 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')]} 04:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:08 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')]} 04:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:08 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:08 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 04:06:08 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 04:06:08 INFO - Using env: {'DISPLAY': ':0', 04:06:08 INFO - 'HOME': '/home/cltbld', 04:06:08 INFO - 'LANG': 'en_US.UTF-8', 04:06:08 INFO - 'LANGUAGE': 'en_US:en', 04:06:08 INFO - 'LOGNAME': 'cltbld', 04:06:08 INFO - 'MAIL': '/var/mail/cltbld', 04:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:08 INFO - 'MOZ_NO_REMOTE': '1', 04:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:08 INFO - 'NO_EM_RESTART': '1', 04:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:08 INFO - 'PWD': '/builds/slave/test', 04:06:08 INFO - 'SHELL': '/bin/bash', 04:06:08 INFO - 'SHLVL': '1', 04:06:08 INFO - 'TERM': 'linux', 04:06:08 INFO - 'TMOUT': '86400', 04:06:08 INFO - 'USER': 'cltbld', 04:06:08 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:08 INFO - '_': '/tools/buildbot/bin/python'} 04:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:08 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 04:06:08 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 04:06:08 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 04:06:08 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 04:06:09 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:09 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 04:06:09 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 04:06:09 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 04:06:09 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 04:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:09 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 04:06:09 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 04:06:09 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 04:06:09 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 04:06:10 INFO - Downloading docopt-0.6.1.tar.gz 04:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:10 INFO - Running setup.py install for blobuploader 04:06:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:10 INFO - Running setup.py install for requests 04:06:10 INFO - Running setup.py install for docopt 04:06:10 INFO - Successfully installed blobuploader requests docopt 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:10 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 04:06:10 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 04:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:11 INFO - Running setup.py (path:/tmp/pip-dVRiJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:11 INFO - Running setup.py (path:/tmp/pip-nzD25A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:11 INFO - Running setup.py (path:/tmp/pip-ZpkXKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:11 INFO - Running setup.py (path:/tmp/pip-4t9iza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:11 INFO - Running setup.py (path:/tmp/pip-0KEqm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:11 INFO - Running setup.py (path:/tmp/pip-lFyLA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:11 INFO - Running setup.py (path:/tmp/pip-y6cFNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:11 INFO - Running setup.py (path:/tmp/pip-TOFW1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:11 INFO - Running setup.py (path:/tmp/pip-IHSLxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:11 INFO - Running setup.py (path:/tmp/pip-HPwZNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:11 INFO - Running setup.py (path:/tmp/pip-HZXmLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:11 INFO - Running setup.py (path:/tmp/pip-dGL10Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:11 INFO - Running setup.py (path:/tmp/pip-KrJKQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:11 INFO - Running setup.py (path:/tmp/pip-xVzASM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:12 INFO - Running setup.py (path:/tmp/pip-Dzj4Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:12 INFO - Running setup.py (path:/tmp/pip-jadAZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:12 INFO - Running setup.py (path:/tmp/pip-ROvCEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:12 INFO - Running setup.py install for manifestparser 04:06:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozcrash 04:06:12 INFO - Running setup.py install for mozdebug 04:06:12 INFO - Running setup.py install for mozdevice 04:06:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozfile 04:06:12 INFO - Running setup.py install for mozhttpd 04:06:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozinfo 04:06:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozInstall 04:06:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:12 INFO - Running setup.py install for mozleak 04:06:13 INFO - Running setup.py install for mozlog 04:06:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Running setup.py install for moznetwork 04:06:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Running setup.py install for mozprocess 04:06:13 INFO - Running setup.py install for mozprofile 04:06:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Running setup.py install for mozrunner 04:06:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Running setup.py install for mozscreenshot 04:06:13 INFO - Running setup.py install for moztest 04:06:13 INFO - Running setup.py install for mozversion 04:06:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:13 INFO - Cleaning up... 04:06:13 INFO - Return code: 0 04:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:13 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')]} 04:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:13 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')]} 04:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:13 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:13 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 04:06:13 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 04:06:13 INFO - Using env: {'DISPLAY': ':0', 04:06:13 INFO - 'HOME': '/home/cltbld', 04:06:13 INFO - 'LANG': 'en_US.UTF-8', 04:06:13 INFO - 'LANGUAGE': 'en_US:en', 04:06:13 INFO - 'LOGNAME': 'cltbld', 04:06:13 INFO - 'MAIL': '/var/mail/cltbld', 04:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:13 INFO - 'MOZ_NO_REMOTE': '1', 04:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:13 INFO - 'NO_EM_RESTART': '1', 04:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:13 INFO - 'PWD': '/builds/slave/test', 04:06:13 INFO - 'SHELL': '/bin/bash', 04:06:13 INFO - 'SHLVL': '1', 04:06:13 INFO - 'TERM': 'linux', 04:06:13 INFO - 'TMOUT': '86400', 04:06:13 INFO - 'USER': 'cltbld', 04:06:13 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:13 INFO - '_': '/tools/buildbot/bin/python'} 04:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:14 INFO - Running setup.py (path:/tmp/pip-vvRSQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:14 INFO - Running setup.py (path:/tmp/pip-yV9oUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:14 INFO - Running setup.py (path:/tmp/pip-U0FSM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:14 INFO - Running setup.py (path:/tmp/pip-w15UY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:14 INFO - Running setup.py (path:/tmp/pip-coE3ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:14 INFO - Running setup.py (path:/tmp/pip-K3XcFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:14 INFO - Running setup.py (path:/tmp/pip-5cygvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:14 INFO - Running setup.py (path:/tmp/pip-P93ksf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:14 INFO - Running setup.py (path:/tmp/pip-qjGgV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:14 INFO - Running setup.py (path:/tmp/pip-3J1kXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:14 INFO - Running setup.py (path:/tmp/pip-ikLkqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:14 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)) 04:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:14 INFO - Running setup.py (path:/tmp/pip-GU84Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:15 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)) 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:15 INFO - Running setup.py (path:/tmp/pip-ovAoqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:15 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)) 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:15 INFO - Running setup.py (path:/tmp/pip-NST328-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:15 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)) 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:15 INFO - Running setup.py (path:/tmp/pip-TV1szl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:15 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)) 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:15 INFO - Running setup.py (path:/tmp/pip-u7Vpos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:15 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)) 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:15 INFO - Running setup.py (path:/tmp/pip-ShNgUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:15 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)) 04:06:15 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)) 04:06:15 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)) 04:06:15 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)) 04:06:15 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)) 04:06:15 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)) 04:06:15 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)) 04:06:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:15 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 04:06:15 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 04:06:15 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 04:06:15 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 04:06:16 INFO - Downloading blessings-1.6.tar.gz 04:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:16 INFO - Installing collected packages: blessings 04:06:16 INFO - Running setup.py install for blessings 04:06:16 INFO - Successfully installed blessings 04:06:16 INFO - Cleaning up... 04:06:16 INFO - Return code: 0 04:06:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:16 INFO - Reading from file tmpfile_stdout 04:06:16 INFO - Current package versions: 04:06:16 INFO - argparse == 1.2.1 04:06:16 INFO - blessings == 1.6 04:06:16 INFO - blobuploader == 1.2.4 04:06:16 INFO - docopt == 0.6.1 04:06:16 INFO - functools32 == 3.2.3-2 04:06:16 INFO - jsonschema == 2.5.1 04:06:16 INFO - manifestparser == 1.1 04:06:16 INFO - mozInstall == 1.13 04:06:16 INFO - mozcrash == 1.0 04:06:16 INFO - mozdebug == 0.1 04:06:16 INFO - mozdevice == 0.51 04:06:16 INFO - mozfile == 1.2 04:06:16 INFO - mozhttpd == 0.7 04:06:16 INFO - mozinfo == 0.10 04:06:16 INFO - mozleak == 0.1 04:06:16 INFO - mozlog == 3.5 04:06:16 INFO - moznetwork == 0.27 04:06:16 INFO - mozprocess == 0.25 04:06:16 INFO - mozprofile == 0.28 04:06:16 INFO - mozrunner == 6.13 04:06:16 INFO - mozscreenshot == 0.1 04:06:16 INFO - mozsystemmonitor == 0.3 04:06:16 INFO - moztest == 0.8 04:06:16 INFO - mozversion == 1.4 04:06:16 INFO - psutil == 3.1.1 04:06:16 INFO - requests == 1.2.3 04:06:16 INFO - wsgiref == 0.1.2 04:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:16 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')]} 04:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:16 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')]} 04:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:16 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:16 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 04:06:16 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 04:06:16 INFO - Using env: {'DISPLAY': ':0', 04:06:16 INFO - 'HOME': '/home/cltbld', 04:06:16 INFO - 'LANG': 'en_US.UTF-8', 04:06:16 INFO - 'LANGUAGE': 'en_US:en', 04:06:16 INFO - 'LOGNAME': 'cltbld', 04:06:16 INFO - 'MAIL': '/var/mail/cltbld', 04:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:16 INFO - 'MOZ_NO_REMOTE': '1', 04:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:16 INFO - 'NO_EM_RESTART': '1', 04:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:16 INFO - 'PWD': '/builds/slave/test', 04:06:16 INFO - 'SHELL': '/bin/bash', 04:06:16 INFO - 'SHLVL': '1', 04:06:16 INFO - 'TERM': 'linux', 04:06:16 INFO - 'TMOUT': '86400', 04:06:16 INFO - 'USER': 'cltbld', 04:06:16 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:16 INFO - '_': '/tools/buildbot/bin/python'} 04:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 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)) 04:06:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:06:17 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 04:06:17 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 04:06:17 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 04:06:17 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 04:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:06:18 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)) 04:06:18 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)) 04:06:18 INFO - Installing collected packages: simplejson 04:06:18 INFO - Running setup.py install for simplejson 04:06:18 INFO - building 'simplejson._speedups' extension 04:06:18 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 04:06:19 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 04:06:19 INFO - Successfully installed simplejson 04:06:19 INFO - Cleaning up... 04:06:19 INFO - Return code: 0 04:06:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:19 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')]} 04:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:19 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')]} 04:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:19 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 0x12f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b9b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, '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': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', '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 04:06:19 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 04:06:19 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 04:06:19 INFO - Using env: {'DISPLAY': ':0', 04:06:19 INFO - 'HOME': '/home/cltbld', 04:06:19 INFO - 'LANG': 'en_US.UTF-8', 04:06:19 INFO - 'LANGUAGE': 'en_US:en', 04:06:19 INFO - 'LOGNAME': 'cltbld', 04:06:19 INFO - 'MAIL': '/var/mail/cltbld', 04:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:19 INFO - 'MOZ_NO_REMOTE': '1', 04:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:19 INFO - 'NO_EM_RESTART': '1', 04:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:19 INFO - 'PWD': '/builds/slave/test', 04:06:19 INFO - 'SHELL': '/bin/bash', 04:06:19 INFO - 'SHLVL': '1', 04:06:19 INFO - 'TERM': 'linux', 04:06:19 INFO - 'TMOUT': '86400', 04:06:19 INFO - 'USER': 'cltbld', 04:06:19 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:19 INFO - '_': '/tools/buildbot/bin/python'} 04:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:19 INFO - Cleaning up... 04:06:19 INFO - Return code: 0 04:06:19 INFO - Running post-action listener: _resource_record_post_action 04:06:19 INFO - Running post-action listener: _start_resource_monitoring 04:06:19 INFO - Starting resource monitoring. 04:06:19 INFO - [mozharness: 2017-09-26 11:06:19.691769Z] Finished create-virtualenv step (success) 04:06:19 INFO - [mozharness: 2017-09-26 11:06:19.692292Z] Running install step. 04:06:19 INFO - Running pre-action listener: _resource_record_pre_action 04:06:19 INFO - Running main action method: install 04:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:19 INFO - Reading from file tmpfile_stdout 04:06:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:20 INFO - Reading from file tmpfile_stdout 04:06:20 INFO - Output received: 04:06:20 INFO - Usage: mozinstall [options] installer 04:06:20 INFO - Options: 04:06:20 INFO - -h, --help show this help message and exit 04:06:20 INFO - -d DEST, --destination=DEST 04:06:20 INFO - Directory to install application into. [default: 04:06:20 INFO - "/builds/slave/test"] 04:06:20 INFO - --app=APP Application being installed. [default: firefox] 04:06:20 INFO - mkdir: /builds/slave/test/build/application 04:06:20 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'] 04:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:06:37 INFO - Reading from file tmpfile_stdout 04:06:37 INFO - Output received: 04:06:37 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:37 INFO - Running post-action listener: _resource_record_post_action 04:06:37 INFO - [mozharness: 2017-09-26 11:06:37.809650Z] Finished install step (success) 04:06:37 INFO - [mozharness: 2017-09-26 11:06:37.809796Z] Running setup-mitmproxy step. 04:06:37 INFO - Running pre-action listener: _resource_record_pre_action 04:06:37 INFO - Running main action method: setup_mitmproxy 04:06:37 INFO - Skipping: mitmproxy is not required 04:06:37 INFO - Running post-action listener: _resource_record_post_action 04:06:37 INFO - [mozharness: 2017-09-26 11:06:37.810706Z] Finished setup-mitmproxy step (success) 04:06:37 INFO - [mozharness: 2017-09-26 11:06:37.810927Z] Running run-tests step. 04:06:37 INFO - Running pre-action listener: _resource_record_pre_action 04:06:37 INFO - Running pre-action listener: _set_gcov_prefix 04:06:37 INFO - Running main action method: run_tests 04:06:37 WARNING - Try message not found. 04:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:37 INFO - Python 2.7.3 04:06:37 INFO - Return code: 0 04:06:37 INFO - grabbing minidump binary from tooltool 04:06:37 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')]} 04:06:37 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 0x165bd60>, '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 0x165ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:37 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 04:06:37 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 04:06:37 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 04:06:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:37 INFO - Return code: 0 04:06:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:37 INFO - ENV: RUST_BACKTRACE is now full 04:06:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:37 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 04:06:37 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-077 --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 04:06:37 INFO - Using env: {'DISPLAY': ':0', 04:06:37 INFO - 'HOME': '/home/cltbld', 04:06:37 INFO - 'LANG': 'en_US.UTF-8', 04:06:37 INFO - 'LANGUAGE': 'en_US:en', 04:06:37 INFO - 'LOGNAME': 'cltbld', 04:06:37 INFO - 'MAIL': '/var/mail/cltbld', 04:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:37 INFO - 'MOZ_ACCELERATED': '1', 04:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:37 INFO - 'MOZ_NO_REMOTE': '1', 04:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:37 INFO - 'MOZ_WEBRENDER': '1', 04:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:37 INFO - 'NO_EM_RESTART': '1', 04:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:37 INFO - 'PWD': '/builds/slave/test', 04:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:37 INFO - 'RUST_BACKTRACE': 'full', 04:06:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:37 INFO - 'SHELL': '/bin/bash', 04:06:37 INFO - 'SHLVL': '1', 04:06:37 INFO - 'TERM': 'linux', 04:06:37 INFO - 'TMOUT': '86400', 04:06:37 INFO - 'USER': 'cltbld', 04:06:37 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:37 INFO - '_': '/tools/buildbot/bin/python'} 04:06:37 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/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-077', '--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 04:06:38 INFO - mozversion application_buildid: 20170926095221 04:06:38 INFO - mozversion application_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:06:38 INFO - mozversion application_display_name: Nightly 04:06:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:38 INFO - mozversion application_name: Firefox 04:06:38 INFO - mozversion application_remotingname: firefox 04:06:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:38 INFO - mozversion application_vendor: Mozilla 04:06:38 INFO - mozversion application_version: 58.0a1 04:06:38 INFO - mozversion platform_buildid: 20170926095221 04:06:38 INFO - mozversion platform_changeset: 6fb1f5fae37168c824b988733aac0d46499b6c11 04:06:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:38 INFO - mozversion platform_version: 58.0a1 04:06:38 INFO - using testdate: 1506423998 04:06:38 INFO - actual date: 1506423998 04:06:38 INFO - starting webserver on 'localhost:58213' 04:06:38 INFO - SUITE-START | Running 2 tests 04:06:38 INFO - TEST-START | dromaeo_css 04:06:38 INFO - Initialising browser for dromaeo_css test... 04:06:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58213/getInfo.html -profile /tmp/tmp8JEkEs/profile 04:06:38 INFO - TEST-INFO | started process 5874 (/builds/slave/test/build/application/firefox/firefox http://localhost:58213/getInfo.html) 04:06:44 INFO - TEST-INFO | 5874: exit 0 04:06:44 INFO - Browser initialized. 04:06:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:44 INFO - Using env: {'DISPLAY': ':0', 04:06:44 INFO - 'HOME': '/home/cltbld', 04:06:44 INFO - 'JSGC_DISABLE_POISONING': '1', 04:06:44 INFO - 'LANG': 'en_US.UTF-8', 04:06:44 INFO - 'LANGUAGE': 'en_US:en', 04:06:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:06:44 INFO - 'LOGNAME': 'cltbld', 04:06:44 INFO - 'MAIL': '/var/mail/cltbld', 04:06:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:44 INFO - 'MOZ_ACCELERATED': '1', 04:06:44 INFO - 'MOZ_CRASHREPORTER': '1', 04:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:06:44 INFO - 'MOZ_NO_REMOTE': '1', 04:06:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:44 INFO - 'MOZ_WEBRENDER': '1', 04:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:44 INFO - 'NO_EM_RESTART': '1', 04:06:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:44 INFO - 'PWD': '/builds/slave/test', 04:06:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:44 INFO - 'RUST_BACKTRACE': 'full', 04:06:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:44 INFO - 'SHELL': '/bin/bash', 04:06:44 INFO - 'SHLVL': '1', 04:06:44 INFO - 'TERM': 'linux', 04:06:44 INFO - 'TMOUT': '86400', 04:06:44 INFO - 'USER': 'cltbld', 04:06:44 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:44 INFO - '_': '/tools/buildbot/bin/python'} 04:06:44 INFO - TEST-INFO | started process 6119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8JEkEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:45 INFO - PID 6119 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:06:45 INFO - PID 6119 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:06:45 INFO - PID 6119 | 04:06:45 INFO - PID 6119 | (/builds/slave/test/build/application/firefox/firefox:6179): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:45 INFO - PID 6119 | 04:06:56 INFO - PID 6119 | RSS: Main: 189394944 04:06:56 INFO - PID 6119 | 04:09:53 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58213/tests/dromaeo/cssquery-ext.html) 04:09:55 INFO - PID 6119 | RSS: Main: 197361664 04:09:55 INFO - PID 6119 | 04:12:57 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-ext.html (next: http://localhost:58213/tests/dromaeo/cssquery-jquery.html) 04:12:58 INFO - PID 6119 | RSS: Main: 195268608 04:12:58 INFO - PID 6119 | 04:16:00 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58213/tests/dromaeo/cssquery-mootools.html) 04:16:00 INFO - PID 6119 | RSS: Main: 197267456 04:16:00 INFO - PID 6119 | 04:19:02 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58213/tests/dromaeo/cssquery-prototype.html) 04:19:03 INFO - PID 6119 | RSS: Main: 195964928 04:19:03 INFO - PID 6119 | 04:22:07 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58213/tests/dromaeo/cssquery-yui.html) 04:22:07 INFO - PID 6119 | RSS: Main: 197599232 04:22:07 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | Cycle 1(1): loaded http://localhost:58213/tests/dromaeo/cssquery-yui.html (next: http://localhost:58213/tests/dromaeo/cssquery-dojo.html) 04:25:10 INFO - PID 6119 | RSS: Main: 196980736 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | __start_tp_report 04:25:10 INFO - PID 6119 | _x_x_mozilla_page_load 04:25:10 INFO - PID 6119 | _x_x_mozilla_page_load_details 04:25:10 INFO - PID 6119 | |i|pagename|runs| 04:25:10 INFO - PID 6119 | |0;dojo.html;3150.7794454388186;3167.034054613342;3178.6503484616687;3179.205198700325;3192.7445804335657;6198.504119670427;6356.618602883825;6373.681315934208;6386.137871387361;6422.133012043367;6208.379162083789;6293.9685301573545;6320;6324;6331.303556608769;5774.133879918025;5788.305403351604;5813.854653633651;5816.534677225833;5867.4719275265215;5838.795642152526;5899.793507227248;5955.315138759033;5961.105834124873;5966.313873904492;5818.330891947417;5851.268591426072;5888.793892213774;5926.496247818941;5975.282966044081;1125.2802266260994;5744.827655170351;5747.540196784247;5889.796731765652;5944.464998150187;5793.420657934215;5800.941990580082;5832.504237139849;5884.176215329857;5891;6308.621482711006;6322.367763223687;6344.841378965517;6375.394337537973;6417.93582064178;6777.898331525031;6843.520953533254;6860.554063985875;6893.103896493474;6898.551594146415;6850.691718872663;6854.074699915547;6949.548279361876;6957.582545047313;6965.407940325078;6153.876922461525;6305.527085468608;6327;6395.456386207178;6427.132337134473;6911.067005954233;6928.341807528277;6949.7567585134275;6973.895391569029;6978.511504194657;6520.315366886409;6543.345665433419;6581.473482121419;6622.1722284714415;6700.698468568926;6811.080504131879;6831.863362732717;6840.110785597841;6852.5203235774015;6864.24493305736;6748.898766518506;6758.459323254128;6775.898361524581;6834.589924604539;6876.896846547305;6770.1537307836525;6839.1451068616425;6850.143732033496;6931.272216417305;6931.376176144171;5232.005918875401;5290.947090529045;5307.2569840222395;5361.919571206435;5366.195070739343;4677.976610116995;4685.695429797121;4736.739479328601;4747.643926705511;4758.714477131383;5814.098814683731;5820.097884827858;5892.823215303548;5896.7641294348605;5902.940970590239;6797.1843378794865;6799.728010879509;6880.071190389333;6891;6923.861522769516;5652.85867853307;5737.168110624019;5738.741756620962;5758.481736643722;5834.212381328552;5807.477327040587;5837.708114594253;5864.9413505864395;5874.765009399662;5893.410658934073;6579.407853293226;6643.5017373697165;6644.534882558271;6653.567518111307;6694.832629184212;6815.591064536144;6845.965770171118;6856.828579285558;6903;6960.477964152708;6305.464035557029;6493.642849643315;6597.637129957899;6674.83312917181;6695.12963314766;6593.769218077345;6655.866882662416;6657.567258128206;6668.866622667617;6705.530612857053;6854.862902742017;6924.619145947021;6959.443244540324;6986.266442023718;6991.44068474531;6590.7693230736695;6614.338566143347;6615.239247486408;6730;6736.898946515708;6628.105205797156;6631.237407698177;6688.83277918056;6712.899306510504;6721.395074443128;6330.3669633036325;6395.6482393468805;6406.167198264196;6435.967820160869;6477.708503117276;6552.475801935739;6636.369544893228;6655.933440665725;6702.564333318319;6710.027046078389;6409.359064093554;6462.773802916875;6517.804465866032;6523.706433210612;6555.836104097245 04:25:10 INFO - PID 6119 | |1;ext.html;808.1272225995923;833.6332013913881;835.31086853346;836.8284501677155;838.1827717974975;38672;42050.36924446128;42093.36859947103;42149;42469.150616987645;39483;39540.20919581607;39780.204395912064;39839.20321593566;39873.40189897154;6949.652517374137;6978.232394436608;6978.302169783006;7027.683754231072;7076;7875.803104922394;8055.51666899985;8064.233897779702;8092.433529652927;8099.55452450118;8044.879326810103;8077.071136819282;8085.636146373398;8085.757427277191;8124.471909325875;7867.370610351187;7965.6017199139815;8002.559859207741;8025.799355016113;8090.110087890327;7888.171741967069;7949.1653376395225;8009.319207867338;8013.67945282188;8021.558814265213;38195.42706859399;38465.80767096147;38606.613933860586;38613;38693.419598706045;3585.94621080684;3592.6766591006935;3610.9638903611153;3617.7467577269604;3619.9095022624383;31601;31626;31705.841470792497;31711.365772684418;31857;5252.448492908266;5274.5780337572905;5309.601779866525;5420.34955805302;5425;188226.05886970615;189287;189340.99999999863;191322;193001;43534.78232608816;49188.50811491911;49428.752856236206;49446.752766235935;49477;46670.53329466662;51181.232281515804;51832.963340732975;52233.216501752504;52478.737606311726;14430.927845360917;14913.403463861325;14917.104973701613;14919.40322387114;14944;11995.220310679779;12043.819342709867;12064.457099430547;12141.878581214252;12145.514179432901;13589.116707413987;13710;13823.377947992365;13856.376463059187;13928.37322320498;5397.824757187408;5437.972810136003;5468.945310546844;5524.944750552443;5655.886882262332;989.5794287427815;1000.2748007694363;1000.5897581991348;1008.6772232885553;1011.4891979550428;20877.26929557458;21448.142074316853;21610.243641472473;21825.23611673584;21931.561368772534;1091.6070214722693;1099.7910397024539;1109.9223054386277;1117.1565468071553;1125.2629527659396;11599.362035088152;11755.706107347385;11788.587399440978;11829.290242585472;11897.286162830258;229747;229836;231225;231803;234087;53735.73132134314;54029;54043.45956540463;54366.72816635971;54729.726351367986;1409.4080486195821;1442.113100443241;1462.5539210540674;1467.0537503310304;1470.1987416857837;22013.779862201172;22440.438989025406;22474.32577022692;22571.322860314216;22801.771982279966;37618.24763504769;37711.62288377081;37789.4331585032;37927;38035.42946855855;195484;196765;198085;198216;198251;31254.53118203183;31526.58627792065;32038.19904502406;34018.31963360769;35414.46878296879;43222.567774321855;43374.34938475989;43450.56549434465;43644;44137;31178.844105779324;31755.523667145473;31802;31836.84081579577;32384.676153238164;31270.908019692124;31349.52975705412;31357.611761475313;31696.841515792272;32148.357032858745;36004.09989750277;36055.45916811198;36271.818640906626;36279.63720362762;36323.45514817227;31038.534421983237;31483.52774708427;31579.684203157674;31656.36687266288;31777.68222317747;22491.212807551656;22697.092116315824;22711.318660440214;22741.88629056844;22959.6556051656 04:25:10 INFO - PID 6119 | |2;jquery.html;562.5415286541469;586.3081563754768;587.4947545111206;603.0953569645532;621.19244981524;22020.11919523217;22837.314880553567;22909.541809163806;22923.541529169426;23083.538329233405;22941.4264643384;24151.154709585167;24220.636690449614;24429.877850610723;24673;6282.905756413657;6410.1987251593555;6456.515761317896;6481.189851268591;6484.870302593945;6353.428191462767;6385.393387628191;6395.840103997414;6400.295967443578;6402.199725034371;6115.785947491839;6356.141920840673;6360.459360954324;6396.200474940632;6432.839179020515;6315.147455093573;6404.199475065617;6424.196975378078;6437.2918978912285;6442.291347951722;5872.442117998783;5989.580729348947;6000.099985002241;6109.053096770008;6127.142200091991;28351;28839.279018024507;28885.42229155426;28930.132096037152;28969.85515072432;2014.0835919656522;2023.7571491421124;2036.3890832750117;2038.7961203879493;2043.2950632031925;18682.81317186824;19199.61600767991;19440.319588814466;19487.31794387204;19528.70706939397;2433.9269821905373;2441.292025312657;2446.608542633188;2466.7163276223105;2469.3085935937966;118297.40851295774;122804;131096;134123;141459.29270353582;14529.78205326921;14644.891531319565;14673.731204650065;14680.273943862523;14765.741095080266;23106;23210.187643432735;23270.905618494417;23353;23504.294871153892;10028.648997285205;10156.49217539135;10223.795524089477;10300.124489418484;10360.238759410919;9284.303677224236;9385.483798391155;9396.38923469986;9427.387219830825;9435.52822358893;8867.556622168866;9043.457392556467;9055.23030542398;9125.133112354315;9208.631654733736;2657.242685834528;2708.8916443342046;2740.986295068512;2742.986285068602;2766.239284196862;940.3746508571724;957.7749228931195;959.4579062829479;960.6013504395737;970.9417434953925;18126.184321705554;18136.818631813512;18284.725729114074;18313.542161446072;18350.632987340447;1006.225206590921;1015.608990538648;1030.5623655001232;1030.9639162629271;1033.9224558158169;9957.352772069793;10264.127549158406;10371.740706482247;10387.169026478015;10424.374537527772;467454;480119;482276;483768;485114;113596;114301;115794.42102789432;116588;119971;1145.7937571237258;1164.4527072276016;1243.5841908488583;1250.612310183846;1266.7593157300084;19909.203631855144;19970.201191952157;20037.699434508784;20592.58814823725;20838.68741968902;57415.71292143512;57908.84182316246;58289.70855145697;58405.70797145987;58434;73396.63301683457;74297;75094;75289.62355188189;75765.24234757802;14235.786463202852;14260.572182834532;14322.28388580546;14453.783193251898;14471.27643617836;21450.24924127648;21678;21922.89038554797;22230.555388892455;22441.775582244623;16167.625751811227;16502.75245871337;16574.337026518806;16600;16606.83393166101;14060.718785624435;14365.92817035908;14463.379564893035;14960.700785984436;15643;17739.556511087325;17805.10974451298;17807.198676059867;17876.821231787515;17932.64134717272;14333.78499322532;14356.641083972985;14401.567952961008;14402.639934001734;14405.42378304856;15874.126923019345;16860;17521.123943803013;17743.822561774217;17780.55548611295 04:25:10 INFO - PID 6119 | |3;mootools.html;1346.912450690705;1399.4122468563203;1400.4118270326455;1408.1551069358386;1409.2108419285198;15130;15682;15754.842451575481;15861.920690396546;15874;15504.379824807022;15550.533483995498;15603.141827199499;15623.609409764762;15673.764893526606;2760.806743527954;2796.986015069927;2833.5041367760664;2838.120182743346;2845.9715402845914;2676.571748520237;2767.1283545683045;2801.4257077299103;2809.929751756202;2813.8452385118812;2473.2951108933958;2744.3550765570076;2771.722827717232;2780.5134101532253;2780.5829125631117;2802.075315145997;2842.7015163407855;2847.5016872047518;2847.686754457008;2850.5439129739143;2692.7980401469968;2714.050082471139;2753.6420265365573;2754.2012816283254;2760.1167626359575;15080.245987700571;15571.922140389226;15586.844131558653;15586.922065389714;15604.219789010618;8152.307053900426;8379.162083791633;8416.915830841735;8469.237768600855;8481.491110533389;5165.483451654842;5351.384590772072;5428.67427954324;5442.537384322337;5443.537299329561;1966.4788830959808;1982.8810271383618;1990.3829812757947;2011.7887621799646;2051;27404.314892127655;27672.584911226146;27731.306717332027;27791.58312625312;27802.3049423764;6833.794986150423;7079.610621415769;7098.893516597255;7151.42788576923;7283.854322913512;17554;17611.207495662726;17654.911725441547;17728.734068988975;17864.642707145784;7875.7243496478495;8235.423520353637;8252.876206856901;8267.29727973117;8267.958660206781;7402.222766609536;7423.294786995227;7450.96274518624;7476.439267054992;7563;5162.6902385856965;5373.462653734673;5383.730813459311;5409.648372855751;5426.267453893753;1518.491305412677;1532.9080255184501;1543.3286520363679;1544.1738669811598;1551.5267843307674;860.2558786649503;862.7713655881197;867.5575456517222;891.2468963725642;896.1083721696954;7433.145188303306;7433.702651893972;7985.281324680806;8228.753137405887;8243.752687419386;709.6735501669186;709.9148102227663;720.5424555407354;721.1202333153544;729.4273994913967;4974.204127339608;5239.528442440199;5250.291210686585;5328.813491527778;5352.330958630171;20668.689969650466;21400.464988375414;21887;22280.108795648317;22364.329070127922;21328.253511127346;21442.24952126668;22046;22128.33614991553;22340.776592234193;10863.07663848566;10867.347959122479;10873.130149588014;10917.945410272898;11497.310161390344;7886.329661978796;7908.920910790818;7934.388328616332;7969.481983671043;8017.799555010938;18342.81657183411;18987;19245.518862028563;19400.805991940466;19471.318503852865;19740.90129549343;19939;19993.400197994084;20013.699794503384;20363.981800909598;11297.322160670386;11307.038901693448;11513.366764828015;11567.363794991355;11641.47613357384;14111.506097286545;14325.57023289303;14392.85607143957;14407.495737649131;14473.638159046108;11603.941980290045;11681.766364672489;11736.589219377282;11812.114091443003;11934.22427542207;11109.166812488935;11283.830742539032;11314.434278286217;11368.374739389414;11499.965003149422;9215.76960575991;9323.673671421468;9356.15794578464;9376.81246375055;9383.953080234554;7031.191412987572;7040.401565866959;7093.432525398059;7114.14630244374;7133.429325653831;7135.250798666066;7177.4616903731385;7189.209186989531;7199.280071992759;7212.89180662301 04:25:10 INFO - PID 6119 | |4;prototype.html;511.49873124338126;511.726226468839;536.3778017499699;542.568657916956;552.8866582350619;6069.453749162574;6118.4799292060225;6204.689765511724;6266.342034086418;6280.842978925529;6197.566170368076;6254.624722516653;6258.499320054396;6286.245650521943;6287.172470274503;5249.763760630781;5263.3683957925105;5263.7367031912445;5279.815206467774;5293.126634105387;4904.239842824368;5070.619703522232;5183.2743415921805;5301.840944771663;5303.337082864642;5034.974825125869;5035.521625445577;5055.949440505585;5063.822766203184;5068.72122033288;5016.172331565287;5057.547089661512;5060.546718887374;5080.110980578384;5082.339295891529;4472.798724057425;4496.392986946753;4531.977340113278;4541.3215295610335;4572.954270457286;6069.332373438918;6133.172021777048;6182.289036760785;6195.783147589857;6220.751169953196;5758.913616295717;5768.336641286264;5795.2176456178295;5850.82983403321;5865.618734782225;6681.498887583402;6682.699278532477;6688.531802773808;6689.33106689332;6707.128073350434;4906.828261010847;4917.311576379309;4932.112219800434;4954.677945933503;4956.578690811285;6838.281980392087;6881.827954301132;6929.965350173267;6937.410320122745;6984.720611175547;5094.872628184325;5116.283720279164;5134.512221338967;5134.974325128425;5149.253358263031;5174.016007674145;5192.45479224676;5223.869403264949;5248;5250.947490525123;5751.511121554715;5752.9424705753245;5790.507806836466;5796.623219490804;5809.128630705343;6614.536982411281;6663.533552651268;6685.097511835937;6741.561798483083;6756.763513277012;1662.3599914033184;1729.0403825876758;1730.5414065272712;1733.2720257491883;1779.8576113911115;1220.980481298126;1231.9938400307942;1244.7074937389707;1256.2023115321654;1261.678272040642;5711.6001879868845;5724.942750572441;5745.965726169246;5821.76712931478;5833.941660583425;6472.546921715435;6499.902501462482;6607.240167380716;6618.53670243088;6658.234303055114;5615.971920140455;5661.886762264731;5682.54539636828;5712.457316554921;5868.794592189253;3537.2748586539697;3575.567455242944;3592.604813470516;3626.7279954003557;3630.2557975614936;6451.580652256496;6500.252470965805;6618.4705223582;6628.701708423133;6654.600723956578;7000.194977577644;7021.754238601625;7047.400970917427;7066.858662826818;7101.295689034595;6443.194600674916;6520.641364724986;6561.932991107786;6578.190997475636;6625.801225963229;6748.493862960199;6755.6622168892345;6766.93233067663;6816.318368163144;6822.997880932374;6693.26374098839;6693.598384096969;6699.76550820719;6718.395344419026;6744.291849355944;6466.579672321284;6481.703659268071;6492.383223593751;6528;6586.934130658824;4927.581155601814;5006.774695138801;5015.448300686994;5047.974760126176;5081.949180508295;6655.434288085567;6682.866342673022;6700.262971073081;6739.02284168783;6873.875674595203;6417.326180750954;6466.902996454963;6500.219973603198;6515.218173819172;6607.504437167136;6369.49044076482;6551.574147680576;6594.604323740591;6646.567973081927;6688.899666504909;6399.55203135776;6458.451031662174;6517.804465866032;6518.120053792677;6608.933910660832;6399.55203135776;6456.806295811133;6559.540832141704;6565.409113179837;6649.368310010541;6404.775832845828;6407;6442.484601231797;6447.709853056717;6473.902891456538 04:25:10 INFO - PID 6119 | |5;yui.html;904.5884122724161;918.986215206772;934.8550974598935;937.6436953957499;949.1030975727938;19702.90148549257;20595.176192952284;20604.690929636068;20611.07250173744;20651.173953041896;18444.44666659999;18631.347902823403;18854.151563179654;19318.61362772747;19510.21959121637;980.7352014955958;995.6863587969766;998.7203582996773;998.9200863930868;1002.8245057114975;980.1423754215061;987.521052289639;996.8953259907714;998.0618218874235;998.9900100999006;1012.4964427824674;1036.533559898045;1048.397171626314;1048.643461223184;1055.2296823318982;1025.779457416659;1029.8352263637782;1030.0472063341379;1033.0702367868903;1033.9896601034006;719.481972979454;741.3920585120204;750.2122771090388;754.0197742934218;755.4938191411767;19950.102245398994;20197.091130899145;20365;20377.8981105095;20474.283400080927;21819.127234910586;21862.781372186393;22451.550968980693;22469.550608987727;22476.10095596174;16213.675726485522;16299.185040747916;16379.59051023722;16718.91640541802;16844.326226950907;3815.7138214634015;3820.8280627371555;3824.8661296854757;3843.1545060086737;3856.4793752843566;138628.30685846607;142168;143698;144287.27856360757;145939;17152.48542543726;17298.567535811704;17369.65260694779;17410.39063632767;17579.12104394775;31267.530987035214;32108;32207.677923220937;32327.35345293081;32353.35293294121;8376.706815261437;8480.067192608809;8507.95746021266;8523.95738021306;8541.615627296787;4152.148809494047;4173.457450531472;4187.371894215892;4218.7468751874985;4254.936175957363;5520.503154716095;5572.693501857356;5609.943900560942;5620.494155526022;5642.153676948491;1031.6904928521415;1067.1729409707384;1083.1334932054483;1089.4988305379613;1090.9563617455372;702.0802748399612;704.2816327346078;712.7612249896239;715.8138883890226;726.1757904778009;12151.331676757864;12153;12193.817092743617;12328.260304381765;12486.188397754117;565.5645153231989;594.925634295713;598.8203538938388;606.5026678123896;607.0984587886984;5693.373728889819;5693.402192769782;5727.971360143172;5840.737166827418;5920.5559583031445;121682;121966;126521.36739316245;128703;131133;110189.44905275582;113256;113653.86346136598;113868;115986.42006789912;94663.52668236615;96670.51664741631;97767;98465;98766;10592.417417042137;10677.57289708403;10775.245732798943;10828.079613232649;10971.341719496855;42991.355129673706;43643.56356436395;44045.55954440543;44449.55550444454;44926.55073449355;57954;58247.54381140336;58784.11823822732;58987.705061474415;60254.096188558084;16042;16169.434069807501;16222.10778407199;16364.427245046367;16444.588885277484;17347.56631084233;17437.30250789954;17673.20470578801;17897.821021789616;17949.910250448665;16296.918515407348;16423.58941026436;16470.341186352412;16546.751798722787;16640.667186656443;13508.189508629514;13629.931850340685;13657.726845463234;13811.861881381057;13818.170909745448;15259.694806104038;15522.37910483568;15540.611484712972;15685.451009214623;15688.372465101726;10743.785124297314;10789.190810689073;11001.944990274997;11021;11220.046296064926;11210.439478025903;11227.438628068401;11281.435928203393;11422.885771142182;11695.532178712756 04:25:10 INFO - PID 6119 | __end_tp_report 04:25:10 INFO - PID 6119 | __start_cc_report 04:25:10 INFO - PID 6119 | _x_x_mozilla_cycle_collect,266 04:25:10 INFO - PID 6119 | __end_cc_report 04:25:10 INFO - PID 6119 | __startTimestamp1506425110243__endTimestamp 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | ------- Summary: start ------- 04:25:10 INFO - PID 6119 | Number of tests: 6 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#0] dojo.html Cycles:165 Average:6229.83 Median:6477.71 stddev:855.99 (13.2%) stddev-sans-first:823.83 04:25:10 INFO - PID 6119 | Values: 3150.8 3167.0 3178.7 3179.2 3192.7 6198.5 6356.6 6373.7 6386.1 6422.1 6208.4 6294.0 6320.0 6324.0 6331.3 5774.1 5788.3 5813.9 5816.5 5867.5 5838.8 5899.8 5955.3 5961.1 5966.3 5818.3 5851.3 5888.8 5926.5 5975.3 1125.3 5744.8 5747.5 5889.8 5944.5 5793.4 5800.9 5832.5 5884.2 5891.0 6308.6 6322.4 6344.8 6375.4 6417.9 6777.9 6843.5 6860.6 6893.1 6898.6 6850.7 6854.1 6949.5 6957.6 6965.4 6153.9 6305.5 6327.0 6395.5 6427.1 6911.1 6928.3 6949.8 6973.9 6978.5 6520.3 6543.3 6581.5 6622.2 6700.7 6811.1 6831.9 6840.1 6852.5 6864.2 6748.9 6758.5 6775.9 6834.6 6876.9 6770.2 6839.1 6850.1 6931.3 6931.4 5232.0 5290.9 5307.3 5361.9 5366.2 4678.0 4685.7 4736.7 4747.6 4758.7 5814.1 5820.1 5892.8 5896.8 5902.9 6797.2 6799.7 6880.1 6891.0 6923.9 5652.9 5737.2 5738.7 5758.5 5834.2 5807.5 5837.7 5864.9 5874.8 5893.4 6579.4 6643.5 6644.5 6653.6 6694.8 6815.6 6846.0 6856.8 6903.0 6960.5 6305.5 6493.6 6597.6 6674.8 6695.1 6593.8 6655.9 6657.6 6668.9 6705.5 6854.9 6924.6 6959.4 6986.3 6991.4 6590.8 6614.3 6615.2 6730.0 6736.9 6628.1 6631.2 6688.8 6712.9 6721.4 6330.4 6395.6 6406.2 6436.0 6477.7 6552.5 6636.4 6655.9 6702.6 6710.0 6409.4 6462.8 6517.8 6523.7 6555.8 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#1] ext.html Cycles:180 Average:37388.79 Median:19798.39 stddev:53708.51 (271.3%) stddev-sans-first:53788.94 04:25:10 INFO - PID 6119 | Values: 808.1 833.6 835.3 836.8 838.2 38672.0 42050.4 42093.4 42149.0 42469.2 39483.0 39540.2 39780.2 39839.2 39873.4 6949.7 6978.2 6978.3 7027.7 7076.0 7875.8 8055.5 8064.2 8092.4 8099.6 8044.9 8077.1 8085.6 8085.8 8124.5 7867.4 7965.6 8002.6 8025.8 8090.1 7888.2 7949.2 8009.3 8013.7 8021.6 38195.4 38465.8 38606.6 38613.0 38693.4 3585.9 3592.7 3611.0 3617.7 3619.9 31601.0 31626.0 31705.8 31711.4 31857.0 5252.4 5274.6 5309.6 5420.3 5425.0 188226.1 189287.0 189341.0 191322.0 193001.0 43534.8 49188.5 49428.8 49446.8 49477.0 46670.5 51181.2 51833.0 52233.2 52478.7 14430.9 14913.4 14917.1 14919.4 14944.0 11995.2 12043.8 12064.5 12141.9 12145.5 13589.1 13710.0 13823.4 13856.4 13928.4 5397.8 5438.0 5468.9 5524.9 5655.9 989.6 1000.3 1000.6 1008.7 1011.5 20877.3 21448.1 21610.2 21825.2 21931.6 1091.6 1099.8 1109.9 1117.2 1125.3 11599.4 11755.7 11788.6 11829.3 11897.3 229747.0 229836.0 231225.0 231803.0 234087.0 53735.7 54029.0 54043.5 54366.7 54729.7 1409.4 1442.1 1462.6 1467.1 1470.2 22013.8 22440.4 22474.3 22571.3 22801.8 37618.2 37711.6 37789.4 37927.0 38035.4 195484.0 196765.0 198085.0 198216.0 198251.0 31254.5 31526.6 32038.2 34018.3 35414.5 43222.6 43374.3 43450.6 43644.0 44137.0 31178.8 31755.5 31802.0 31836.8 32384.7 31270.9 31349.5 31357.6 31696.8 32148.4 36004.1 36055.5 36271.8 36279.6 36323.5 31038.5 31483.5 31579.7 31656.4 31777.7 22491.2 22697.1 22711.3 22741.9 22959.7 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#2] jquery.html Cycles:180 Average:34109.01 Median:22873.43 stddev:80847.58 (353.5%) stddev-sans-first:81035.14 04:25:10 INFO - PID 6119 | Values: 562.5 586.3 587.5 603.1 621.2 22020.1 22837.3 22909.5 22923.5 23083.5 22941.4 24151.2 24220.6 24429.9 24673.0 6282.9 6410.2 6456.5 6481.2 6484.9 6353.4 6385.4 6395.8 6400.3 6402.2 6115.8 6356.1 6360.5 6396.2 6432.8 6315.1 6404.2 6424.2 6437.3 6442.3 5872.4 5989.6 6000.1 6109.1 6127.1 28351.0 28839.3 28885.4 28930.1 28969.9 2014.1 2023.8 2036.4 2038.8 2043.3 18682.8 19199.6 19440.3 19487.3 19528.7 2433.9 2441.3 2446.6 2466.7 2469.3 118297.4 122804.0 131096.0 134123.0 141459.3 14529.8 14644.9 14673.7 14680.3 14765.7 23106.0 23210.2 23270.9 23353.0 23504.3 10028.6 10156.5 10223.8 10300.1 10360.2 9284.3 9385.5 9396.4 9427.4 9435.5 8867.6 9043.5 9055.2 9125.1 9208.6 2657.2 2708.9 2741.0 2743.0 2766.2 940.4 957.8 959.5 960.6 970.9 18126.2 18136.8 18284.7 18313.5 18350.6 1006.2 1015.6 1030.6 1031.0 1033.9 9957.4 10264.1 10371.7 10387.2 10424.4 467454.0 480119.0 482276.0 483768.0 485114.0 113596.0 114301.0 115794.4 116588.0 119971.0 1145.8 1164.5 1243.6 1250.6 1266.8 19909.2 19970.2 20037.7 20592.6 20838.7 57415.7 57908.8 58289.7 58405.7 58434.0 73396.6 74297.0 75094.0 75289.6 75765.2 14235.8 14260.6 14322.3 14453.8 14471.3 21450.2 21678.0 21922.9 22230.6 22441.8 16167.6 16502.8 16574.3 16600.0 16606.8 14060.7 14365.9 14463.4 14960.7 15643.0 17739.6 17805.1 17807.2 17876.8 17932.6 14333.8 14356.6 14401.6 14402.6 14405.4 15874.1 16860.0 17521.1 17743.8 17780.6 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#3] mootools.html Cycles:180 Average:9486.63 Median:15219.86 stddev:6884.81 (45.2%) stddev-sans-first:6876.96 04:25:10 INFO - PID 6119 | Values: 1346.9 1399.4 1400.4 1408.2 1409.2 15130.0 15682.0 15754.8 15861.9 15874.0 15504.4 15550.5 15603.1 15623.6 15673.8 2760.8 2797.0 2833.5 2838.1 2846.0 2676.6 2767.1 2801.4 2809.9 2813.8 2473.3 2744.4 2771.7 2780.5 2780.6 2802.1 2842.7 2847.5 2847.7 2850.5 2692.8 2714.1 2753.6 2754.2 2760.1 15080.2 15571.9 15586.8 15586.9 15604.2 8152.3 8379.2 8416.9 8469.2 8481.5 5165.5 5351.4 5428.7 5442.5 5443.5 1966.5 1982.9 1990.4 2011.8 2051.0 27404.3 27672.6 27731.3 27791.6 27802.3 6833.8 7079.6 7098.9 7151.4 7283.9 17554.0 17611.2 17654.9 17728.7 17864.6 7875.7 8235.4 8252.9 8267.3 8268.0 7402.2 7423.3 7451.0 7476.4 7563.0 5162.7 5373.5 5383.7 5409.6 5426.3 1518.5 1532.9 1543.3 1544.2 1551.5 860.3 862.8 867.6 891.2 896.1 7433.1 7433.7 7985.3 8228.8 8243.8 709.7 709.9 720.5 721.1 729.4 4974.2 5239.5 5250.3 5328.8 5352.3 20668.7 21400.5 21887.0 22280.1 22364.3 21328.3 21442.2 22046.0 22128.3 22340.8 10863.1 10867.3 10873.1 10917.9 11497.3 7886.3 7908.9 7934.4 7969.5 8017.8 18342.8 18987.0 19245.5 19400.8 19471.3 19740.9 19939.0 19993.4 20013.7 20364.0 11297.3 11307.0 11513.4 11567.4 11641.5 14111.5 14325.6 14392.9 14407.5 14473.6 11603.9 11681.8 11736.6 11812.1 11934.2 11109.2 11283.8 11314.4 11368.4 11500.0 9215.8 9323.7 9356.2 9376.8 9384.0 7031.2 7040.4 7093.4 7114.1 7133.4 7135.3 7177.5 7189.2 7199.3 7212.9 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#4] prototype.html Cycles:180 Average:5566.99 Median:6196.67 stddev:1550.36 (25.0%) stddev-sans-first:1507.56 04:25:10 INFO - PID 6119 | Values: 511.5 511.7 536.4 542.6 552.9 6069.5 6118.5 6204.7 6266.3 6280.8 6197.6 6254.6 6258.5 6286.2 6287.2 5249.8 5263.4 5263.7 5279.8 5293.1 4904.2 5070.6 5183.3 5301.8 5303.3 5035.0 5035.5 5055.9 5063.8 5068.7 5016.2 5057.5 5060.5 5080.1 5082.3 4472.8 4496.4 4532.0 4541.3 4573.0 6069.3 6133.2 6182.3 6195.8 6220.8 5758.9 5768.3 5795.2 5850.8 5865.6 6681.5 6682.7 6688.5 6689.3 6707.1 4906.8 4917.3 4932.1 4954.7 4956.6 6838.3 6881.8 6930.0 6937.4 6984.7 5094.9 5116.3 5134.5 5135.0 5149.3 5174.0 5192.5 5223.9 5248.0 5250.9 5751.5 5752.9 5790.5 5796.6 5809.1 6614.5 6663.5 6685.1 6741.6 6756.8 1662.4 1729.0 1730.5 1733.3 1779.9 1221.0 1232.0 1244.7 1256.2 1261.7 5711.6 5724.9 5746.0 5821.8 5833.9 6472.5 6499.9 6607.2 6618.5 6658.2 5616.0 5661.9 5682.5 5712.5 5868.8 3537.3 3575.6 3592.6 3626.7 3630.3 6451.6 6500.3 6618.5 6628.7 6654.6 7000.2 7021.8 7047.4 7066.9 7101.3 6443.2 6520.6 6561.9 6578.2 6625.8 6748.5 6755.7 6766.9 6816.3 6823.0 6693.3 6693.6 6699.8 6718.4 6744.3 6466.6 6481.7 6492.4 6528.0 6586.9 4927.6 5006.8 5015.4 5048.0 5081.9 6655.4 6682.9 6700.3 6739.0 6873.9 6417.3 6466.9 6500.2 6515.2 6607.5 6369.5 6551.6 6594.6 6646.6 6688.9 6399.6 6458.5 6517.8 6518.1 6608.9 6399.6 6456.8 6559.5 6565.4 6649.4 6404.8 6407.0 6442.5 6447.7 6473.9 04:25:10 INFO - PID 6119 | 04:25:10 INFO - PID 6119 | [#5] yui.html Cycles:180 Average:24755.49 Median:19606.56 stddev:36326.81 (185.3%) stddev-sans-first:36384.57 04:25:10 INFO - PID 6119 | Values: 904.6 919.0 934.9 937.6 949.1 19702.9 20595.2 20604.7 20611.1 20651.2 18444.4 18631.3 18854.2 19318.6 19510.2 980.7 995.7 998.7 998.9 1002.8 980.1 987.5 996.9 998.1 999.0 1012.5 1036.5 1048.4 1048.6 1055.2 1025.8 1029.8 1030.0 1033.1 1034.0 719.5 741.4 750.2 754.0 755.5 19950.1 20197.1 20365.0 20377.9 20474.3 21819.1 21862.8 22451.6 22469.6 22476.1 16213.7 16299.2 16379.6 16718.9 16844.3 3815.7 3820.8 3824.9 3843.2 3856.5 138628.3 142168.0 143698.0 144287.3 145939.0 17152.5 17298.6 17369.7 17410.4 17579.1 31267.5 32108.0 32207.7 32327.4 32353.4 8376.7 8480.1 8508.0 8524.0 8541.6 4152.1 4173.5 4187.4 4218.7 4254.9 5520.5 5572.7 5609.9 5620.5 5642.2 1031.7 1067.2 1083.1 1089.5 1091.0 702.1 704.3 712.8 715.8 726.2 12151.3 12153.0 12193.8 12328.3 12486.2 565.6 594.9 598.8 606.5 607.1 5693.4 5693.4 5728.0 5840.7 5920.6 121682.0 121966.0 126521.4 128703.0 131133.0 110189.4 113256.0 113653.9 113868.0 115986.4 94663.5 96670.5 97767.0 98465.0 98766.0 10592.4 10677.6 10775.2 10828.1 10971.3 42991.4 43643.6 44045.6 44449.6 44926.6 57954.0 58247.5 58784.1 58987.7 60254.1 16042.0 16169.4 16222.1 16364.4 16444.6 17347.6 17437.3 17673.2 17897.8 17949.9 16296.9 16423.6 16470.3 16546.8 16640.7 13508.2 13629.9 13657.7 13811.9 13818.2 15259.7 15522.4 15540.6 15685.5 15688.4 10743.8 10789.2 11001.9 11021.0 11220.0 11210.4 11227.4 11281.4 11422.9 11695.5 04:25:10 INFO - PID 6119 | -------- Summary: end -------- 04:25:10 INFO - PID 6119 | 04:25:11 INFO - TEST-INFO | 6119: exit 0 04:25:11 INFO - TEST-OK | dromaeo_css | took 1112899ms 04:25:11 INFO - TEST-START | kraken 04:25:11 INFO - Initialising browser for kraken test... 04:25:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58213/getInfo.html -profile /tmp/tmpuuE37G/profile 04:25:11 INFO - TEST-INFO | started process 6502 (/builds/slave/test/build/application/firefox/firefox http://localhost:58213/getInfo.html) 04:25:17 INFO - TEST-INFO | 6502: exit 0 04:25:17 INFO - Browser initialized. 04:25:17 INFO - Running cycle 1/1 for kraken test... 04:25:17 INFO - Using env: {'DISPLAY': ':0', 04:25:17 INFO - 'HOME': '/home/cltbld', 04:25:17 INFO - 'JSGC_DISABLE_POISONING': '1', 04:25:17 INFO - 'LANG': 'en_US.UTF-8', 04:25:17 INFO - 'LANGUAGE': 'en_US:en', 04:25:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:25:17 INFO - 'LOGNAME': 'cltbld', 04:25:17 INFO - 'MAIL': '/var/mail/cltbld', 04:25:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:17 INFO - 'MOZ_ACCELERATED': '1', 04:25:17 INFO - 'MOZ_CRASHREPORTER': '1', 04:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:25:17 INFO - 'MOZ_NO_REMOTE': '1', 04:25:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:17 INFO - 'MOZ_WEBRENDER': '1', 04:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:17 INFO - 'NO_EM_RESTART': '1', 04:25:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:17 INFO - 'PWD': '/builds/slave/test', 04:25:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:17 INFO - 'RUST_BACKTRACE': 'full', 04:25:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:25:17 INFO - 'SHELL': '/bin/bash', 04:25:17 INFO - 'SHLVL': '1', 04:25:17 INFO - 'TERM': 'linux', 04:25:17 INFO - 'TMOUT': '86400', 04:25:17 INFO - 'USER': 'cltbld', 04:25:17 INFO - 'XDG_SESSION_COOKIE': '20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137', 04:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:17 INFO - '_': '/tools/buildbot/bin/python'} 04:25:17 INFO - TEST-INFO | started process 6748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuuE37G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:17 INFO - PID 6748 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:25:18 INFO - PID 6748 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 04:25:18 INFO - PID 6748 | 04:25:18 INFO - PID 6748 | (/builds/slave/test/build/application/firefox/firefox:6808): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:25:18 INFO - PID 6748 | 04:25:28 INFO - PID 6748 | RSS: Main: 196390912 04:25:28 INFO - PID 6748 | 04:25:31 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58213/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:32 INFO - PID 6748 | RSS: Main: 196321280 04:25:32 INFO - PID 6748 | 04:25:34 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58213/tests/kraken/driver.html?testName=audio-dft) 04:25:35 INFO - PID 6748 | RSS: Main: 195973120 04:25:35 INFO - PID 6748 | 04:25:38 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58213/tests/kraken/driver.html?testName=audio-fft) 04:25:39 INFO - PID 6748 | RSS: Main: 191971328 04:25:39 INFO - PID 6748 | 04:25:41 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58213/tests/kraken/driver.html?testName=audio-oscillator) 04:25:42 INFO - PID 6748 | RSS: Main: 192208896 04:25:42 INFO - PID 6748 | 04:25:44 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58213/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:44 INFO - PID 6748 | RSS: Main: 193077248 04:25:44 INFO - PID 6748 | 04:25:48 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58213/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:48 INFO - PID 6748 | RSS: Main: 195190784 04:25:48 INFO - PID 6748 | 04:25:52 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58213/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:52 INFO - PID 6748 | RSS: Main: 195837952 04:25:52 INFO - PID 6748 | 04:25:55 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58213/tests/kraken/driver.html?testName=json-parse-financial) 04:25:56 INFO - PID 6748 | RSS: Main: 195940352 04:25:56 INFO - PID 6748 | 04:25:58 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58213/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:58 INFO - PID 6748 | RSS: Main: 196317184 04:25:58 INFO - PID 6748 | 04:26:00 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:01 INFO - PID 6748 | RSS: Main: 193105920 04:26:01 INFO - PID 6748 | 04:26:03 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:04 INFO - PID 6748 | RSS: Main: 193007616 04:26:04 INFO - PID 6748 | 04:26:06 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:07 INFO - PID 6748 | RSS: Main: 192241664 04:26:07 INFO - PID 6748 | 04:26:10 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:10 INFO - PID 6748 | RSS: Main: 192712704 04:26:10 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | Cycle 1(1): loaded http://localhost:58213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58213/tests/kraken/driver.html?testName=ai-astar) 04:26:12 INFO - PID 6748 | RSS: Main: 193785856 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | __start_tp_report 04:26:12 INFO - PID 6748 | _x_x_mozilla_page_load 04:26:12 INFO - PID 6748 | _x_x_mozilla_page_load_details 04:26:12 INFO - PID 6748 | |i|pagename|runs| 04:26:12 INFO - PID 6748 | |0;ai-astar;107;116;108;110;107;107;115;112;116;116 04:26:12 INFO - PID 6748 | |1;audio-beat-detection;129;120;121;124;120;116;115;121;121;147 04:26:12 INFO - PID 6748 | |2;audio-dft;167;162;163;162;163;174;166;174;170;167 04:26:12 INFO - PID 6748 | |3;audio-fft;80;77;74;80;74;74;75;75;75;83 04:26:12 INFO - PID 6748 | |4;audio-oscillator;89;80;78;79;79;87;78;78;79;81 04:26:12 INFO - PID 6748 | |5;imaging-gaussian-blur;118;118;113;114;115;117;110;117;112;115 04:26:12 INFO - PID 6748 | |6;imaging-darkroom;148;150;148;151;149;149;149;149;150;149 04:26:12 INFO - PID 6748 | |7;imaging-desaturate;94;95;101;94;95;94;102;95;96;108 04:26:12 INFO - PID 6748 | |8;json-parse-financial;53;53;52;54;55;54;54;52;53;54 04:26:12 INFO - PID 6748 | |9;json-stringify-tinderbox;43;38;38;41;47;47;38;47;38;38 04:26:12 INFO - PID 6748 | |10;stanford-crypto-aes;76;78;77;76;74;79;81;76;72;74 04:26:12 INFO - PID 6748 | |11;stanford-crypto-ccm;116;112;122;115;125;114;110;116;118;117 04:26:12 INFO - PID 6748 | |12;stanford-crypto-pbkdf2;170;168;182;166;167;162;166;171;166;165 04:26:12 INFO - PID 6748 | |13;stanford-crypto-sha256-iterative;70;77;65;67;68;69;76;64;66;67 04:26:12 INFO - PID 6748 | __end_tp_report 04:26:12 INFO - PID 6748 | __start_cc_report 04:26:12 INFO - PID 6748 | _x_x_mozilla_cycle_collect,764 04:26:12 INFO - PID 6748 | __end_cc_report 04:26:12 INFO - PID 6748 | __startTimestamp1506425172834__endTimestamp 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | ------- Summary: start ------- 04:26:12 INFO - PID 6748 | Number of tests: 14 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:4.06 (3.6%) stddev-sans-first:3.98 04:26:12 INFO - PID 6748 | Values: 107.0 116.0 108.0 110.0 107.0 107.0 115.0 112.0 116.0 116.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:121.00 stddev:9.16 (7.6%) stddev-sans-first:9.48 04:26:12 INFO - PID 6748 | Values: 129.0 120.0 121.0 124.0 120.0 116.0 115.0 121.0 121.0 147.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#2] audio-dft Cycles:10 Average:166.80 Median:167.00 stddev:4.59 (2.7%) stddev-sans-first:4.87 04:26:12 INFO - PID 6748 | Values: 167.0 162.0 163.0 162.0 163.0 174.0 166.0 174.0 170.0 167.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#3] audio-fft Cycles:10 Average:76.70 Median:76.00 stddev:3.20 (4.2%) stddev-sans-first:3.16 04:26:12 INFO - PID 6748 | Values: 80.0 77.0 74.0 80.0 74.0 74.0 75.0 75.0 75.0 83.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#4] audio-oscillator Cycles:10 Average:80.80 Median:79.50 stddev:3.94 (5.0%) stddev-sans-first:2.85 04:26:12 INFO - PID 6748 | Values: 89.0 80.0 78.0 79.0 79.0 87.0 78.0 78.0 79.0 81.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:116.00 stddev:2.69 (2.3%) stddev-sans-first:2.60 04:26:12 INFO - PID 6748 | Values: 118.0 118.0 113.0 114.0 115.0 117.0 110.0 117.0 112.0 115.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:26:12 INFO - PID 6748 | Values: 148.0 150.0 148.0 151.0 149.0 149.0 149.0 149.0 150.0 149.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:94.50 stddev:4.72 (5.0%) stddev-sans-first:4.84 04:26:12 INFO - PID 6748 | Values: 94.0 95.0 101.0 94.0 95.0 94.0 102.0 95.0 96.0 108.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 04:26:12 INFO - PID 6748 | Values: 53.0 53.0 52.0 54.0 55.0 54.0 54.0 52.0 53.0 54.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#9] json-stringify-tinderbox Cycles:10 Average:41.50 Median:42.00 stddev:4.14 (9.9%) stddev-sans-first:4.36 04:26:12 INFO - PID 6748 | Values: 43.0 38.0 38.0 41.0 47.0 47.0 38.0 47.0 38.0 38.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.50 stddev:2.63 (3.4%) stddev-sans-first:2.78 04:26:12 INFO - PID 6748 | Values: 76.0 78.0 77.0 76.0 74.0 79.0 81.0 76.0 72.0 74.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:116.50 stddev:4.43 (3.8%) stddev-sans-first:4.69 04:26:12 INFO - PID 6748 | Values: 116.0 112.0 122.0 115.0 125.0 114.0 110.0 116.0 118.0 117.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:167.50 stddev:5.44 (3.2%) stddev-sans-first:5.73 04:26:12 INFO - PID 6748 | Values: 170.0 168.0 182.0 166.0 167.0 162.0 166.0 171.0 166.0 165.0 04:26:12 INFO - PID 6748 | 04:26:12 INFO - PID 6748 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:4.38 (6.4%) stddev-sans-first:4.63 04:26:12 INFO - PID 6748 | Values: 70.0 77.0 65.0 67.0 68.0 69.0 76.0 64.0 66.0 67.0 04:26:12 INFO - PID 6748 | -------- Summary: end -------- 04:26:12 INFO - PID 6748 | 04:26:13 INFO - PID 6748 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:26:13 INFO - TEST-INFO | 6748: exit 0 04:26:13 INFO - TEST-OK | kraken | took 62678ms 04:26:13 INFO - SUITE-END | took 1175s 04:26:13 INFO - Completed test suite (00:19:35) 04:26:13 INFO - javascript benchmark 04:26:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8507.353790170033, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.7794454388186, 3167.034054613342, 3178.6503484616687, 3179.205198700325, 3192.7445804335657, 6198.504119670427, 6356.618602883825, 6373.681315934208, 6386.137871387361, 6422.133012043367, 6208.379162083789, 6293.9685301573545, 6320.0, 6324.0, 6331.303556608769, 5774.133879918025, 5788.305403351604, 5813.854653633651, 5816.534677225833, 5867.4719275265215, 5838.795642152526, 5899.793507227248, 5955.315138759033, 5961.105834124873, 5966.313873904492, 5818.330891947417, 5851.268591426072, 5888.793892213774, 5926.496247818941, 5975.282966044081, 1125.2802266260994, 5744.827655170351, 5747.540196784247, 5889.796731765652, 5944.464998150187, 5793.420657934215, 5800.941990580082, 5832.504237139849, 5884.176215329857, 5891.0, 6308.621482711006, 6322.367763223687, 6344.841378965517, 6375.394337537973, 6417.93582064178, 6777.898331525031, 6843.520953533254, 6860.554063985875, 6893.103896493474, 6898.551594146415, 6850.691718872663, 6854.074699915547, 6949.548279361876, 6957.582545047313, 6965.407940325078, 6153.876922461525, 6305.527085468608, 6327.0, 6395.456386207178, 6427.132337134473, 6911.067005954233, 6928.341807528277, 6949.7567585134275, 6973.895391569029, 6978.511504194657, 6520.315366886409, 6543.345665433419, 6581.473482121419, 6622.1722284714415, 6700.698468568926, 6811.080504131879, 6831.863362732717, 6840.110785597841, 6852.5203235774015, 6864.24493305736, 6748.898766518506, 6758.459323254128, 6775.898361524581, 6834.589924604539, 6876.896846547305, 6770.1537307836525, 6839.1451068616425, 6850.143732033496, 6931.272216417305, 6931.376176144171, 5232.005918875401, 5290.947090529045, 5307.2569840222395, 5361.919571206435, 5366.195070739343, 4677.976610116995, 4685.695429797121, 4736.739479328601, 4747.643926705511, 4758.714477131383, 5814.098814683731, 5820.097884827858, 5892.823215303548, 5896.7641294348605, 5902.940970590239, 6797.1843378794865, 6799.728010879509, 6880.071190389333, 6891.0, 6923.861522769516, 5652.85867853307, 5737.168110624019, 5738.741756620962, 5758.481736643722, 5834.212381328552, 5807.477327040587, 5837.708114594253, 5864.9413505864395, 5874.765009399662, 5893.410658934073, 6579.407853293226, 6643.5017373697165, 6644.534882558271, 6653.567518111307, 6694.832629184212, 6815.591064536144, 6845.965770171118, 6856.828579285558, 6903.0, 6960.477964152708, 6305.464035557029, 6493.642849643315, 6597.637129957899, 6674.83312917181, 6695.12963314766, 6593.769218077345, 6655.866882662416, 6657.567258128206, 6668.866622667617, 6705.530612857053, 6854.862902742017, 6924.619145947021, 6959.443244540324, 6986.266442023718, 6991.44068474531, 6590.7693230736695, 6614.338566143347, 6615.239247486408, 6730.0, 6736.898946515708, 6628.105205797156, 6631.237407698177, 6688.83277918056, 6712.899306510504, 6721.395074443128, 6330.3669633036325, 6395.6482393468805, 6406.167198264196, 6435.967820160869, 6477.708503117276, 6552.475801935739, 6636.369544893228, 6655.933440665725, 6702.564333318319, 6710.027046078389, 6409.359064093554, 6462.773802916875, 6517.804465866032, 6523.706433210612, 6555.836104097245], "value": 6167.126215670863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.1272225995923, 833.6332013913881, 835.31086853346, 836.8284501677155, 838.1827717974975, 38672.0, 42050.36924446128, 42093.36859947103, 42149.0, 42469.150616987645, 39483.0, 39540.20919581607, 39780.204395912064, 39839.20321593566, 39873.40189897154, 6949.652517374137, 6978.232394436608, 6978.302169783006, 7027.683754231072, 7076.0, 7875.803104922394, 8055.51666899985, 8064.233897779702, 8092.433529652927, 8099.55452450118, 8044.879326810103, 8077.071136819282, 8085.636146373398, 8085.757427277191, 8124.471909325875, 7867.370610351187, 7965.6017199139815, 8002.559859207741, 8025.799355016113, 8090.110087890327, 7888.171741967069, 7949.1653376395225, 8009.319207867338, 8013.67945282188, 8021.558814265213, 38195.42706859399, 38465.80767096147, 38606.613933860586, 38613.0, 38693.419598706045, 3585.94621080684, 3592.6766591006935, 3610.9638903611153, 3617.7467577269604, 3619.9095022624383, 31601.0, 31626.0, 31705.841470792497, 31711.365772684418, 31857.0, 5252.448492908266, 5274.5780337572905, 5309.601779866525, 5420.34955805302, 5425.0, 188226.05886970615, 189287.0, 189340.99999999863, 191322.0, 193001.0, 43534.78232608816, 49188.50811491911, 49428.752856236206, 49446.752766235935, 49477.0, 46670.53329466662, 51181.232281515804, 51832.963340732975, 52233.216501752504, 52478.737606311726, 14430.927845360917, 14913.403463861325, 14917.104973701613, 14919.40322387114, 14944.0, 11995.220310679779, 12043.819342709867, 12064.457099430547, 12141.878581214252, 12145.514179432901, 13589.116707413987, 13710.0, 13823.377947992365, 13856.376463059187, 13928.37322320498, 5397.824757187408, 5437.972810136003, 5468.945310546844, 5524.944750552443, 5655.886882262332, 989.5794287427815, 1000.2748007694363, 1000.5897581991348, 1008.6772232885553, 1011.4891979550428, 20877.26929557458, 21448.142074316853, 21610.243641472473, 21825.23611673584, 21931.561368772534, 1091.6070214722693, 1099.7910397024539, 1109.9223054386277, 1117.1565468071553, 1125.2629527659396, 11599.362035088152, 11755.706107347385, 11788.587399440978, 11829.290242585472, 11897.286162830258, 229747.0, 229836.0, 231225.0, 231803.0, 234087.0, 53735.73132134314, 54029.0, 54043.45956540463, 54366.72816635971, 54729.726351367986, 1409.4080486195821, 1442.113100443241, 1462.5539210540674, 1467.0537503310304, 1470.1987416857837, 22013.779862201172, 22440.438989025406, 22474.32577022692, 22571.322860314216, 22801.771982279966, 37618.24763504769, 37711.62288377081, 37789.4331585032, 37927.0, 38035.42946855855, 195484.0, 196765.0, 198085.0, 198216.0, 198251.0, 31254.53118203183, 31526.58627792065, 32038.19904502406, 34018.31963360769, 35414.46878296879, 43222.567774321855, 43374.34938475989, 43450.56549434465, 43644.0, 44137.0, 31178.844105779324, 31755.523667145473, 31802.0, 31836.84081579577, 32384.676153238164, 31270.908019692124, 31349.52975705412, 31357.611761475313, 31696.841515792272, 32148.357032858745, 36004.09989750277, 36055.45916811198, 36271.818640906626, 36279.63720362762, 36323.45514817227, 31038.534421983237, 31483.52774708427, 31579.684203157674, 31656.36687266288, 31777.68222317747, 22491.212807551656, 22697.092116315824, 22711.318660440214, 22741.88629056844, 22959.6556051656], "value": 16978.844843799296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5415286541469, 586.3081563754768, 587.4947545111206, 603.0953569645532, 621.19244981524, 22020.11919523217, 22837.314880553567, 22909.541809163806, 22923.541529169426, 23083.538329233405, 22941.4264643384, 24151.154709585167, 24220.636690449614, 24429.877850610723, 24673.0, 6282.905756413657, 6410.1987251593555, 6456.515761317896, 6481.189851268591, 6484.870302593945, 6353.428191462767, 6385.393387628191, 6395.840103997414, 6400.295967443578, 6402.199725034371, 6115.785947491839, 6356.141920840673, 6360.459360954324, 6396.200474940632, 6432.839179020515, 6315.147455093573, 6404.199475065617, 6424.196975378078, 6437.2918978912285, 6442.291347951722, 5872.442117998783, 5989.580729348947, 6000.099985002241, 6109.053096770008, 6127.142200091991, 28351.0, 28839.279018024507, 28885.42229155426, 28930.132096037152, 28969.85515072432, 2014.0835919656522, 2023.7571491421124, 2036.3890832750117, 2038.7961203879493, 2043.2950632031925, 18682.81317186824, 19199.61600767991, 19440.319588814466, 19487.31794387204, 19528.70706939397, 2433.9269821905373, 2441.292025312657, 2446.608542633188, 2466.7163276223105, 2469.3085935937966, 118297.40851295774, 122804.0, 131096.0, 134123.0, 141459.29270353582, 14529.78205326921, 14644.891531319565, 14673.731204650065, 14680.273943862523, 14765.741095080266, 23106.0, 23210.187643432735, 23270.905618494417, 23353.0, 23504.294871153892, 10028.648997285205, 10156.49217539135, 10223.795524089477, 10300.124489418484, 10360.238759410919, 9284.303677224236, 9385.483798391155, 9396.38923469986, 9427.387219830825, 9435.52822358893, 8867.556622168866, 9043.457392556467, 9055.23030542398, 9125.133112354315, 9208.631654733736, 2657.242685834528, 2708.8916443342046, 2740.986295068512, 2742.986285068602, 2766.239284196862, 940.3746508571724, 957.7749228931195, 959.4579062829479, 960.6013504395737, 970.9417434953925, 18126.184321705554, 18136.818631813512, 18284.725729114074, 18313.542161446072, 18350.632987340447, 1006.225206590921, 1015.608990538648, 1030.5623655001232, 1030.9639162629271, 1033.9224558158169, 9957.352772069793, 10264.127549158406, 10371.740706482247, 10387.169026478015, 10424.374537527772, 467454.0, 480119.0, 482276.0, 483768.0, 485114.0, 113596.0, 114301.0, 115794.42102789432, 116588.0, 119971.0, 1145.7937571237258, 1164.4527072276016, 1243.5841908488583, 1250.612310183846, 1266.7593157300084, 19909.203631855144, 19970.201191952157, 20037.699434508784, 20592.58814823725, 20838.68741968902, 57415.71292143512, 57908.84182316246, 58289.70855145697, 58405.70797145987, 58434.0, 73396.63301683457, 74297.0, 75094.0, 75289.62355188189, 75765.24234757802, 14235.786463202852, 14260.572182834532, 14322.28388580546, 14453.783193251898, 14471.27643617836, 21450.24924127648, 21678.0, 21922.89038554797, 22230.555388892455, 22441.775582244623, 16167.625751811227, 16502.75245871337, 16574.337026518806, 16600.0, 16606.83393166101, 14060.718785624435, 14365.92817035908, 14463.379564893035, 14960.700785984436, 15643.0, 17739.556511087325, 17805.10974451298, 17807.198676059867, 17876.821231787515, 17932.64134717272, 14333.78499322532, 14356.641083972985, 14401.567952961008, 14402.639934001734, 14405.42378304856, 15874.126923019345, 16860.0, 17521.123943803013, 17743.822561774217, 17780.55548611295], "value": 11764.073204727383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.912450690705, 1399.4122468563203, 1400.4118270326455, 1408.1551069358386, 1409.2108419285198, 15130.0, 15682.0, 15754.842451575481, 15861.920690396546, 15874.0, 15504.379824807022, 15550.533483995498, 15603.141827199499, 15623.609409764762, 15673.764893526606, 2760.806743527954, 2796.986015069927, 2833.5041367760664, 2838.120182743346, 2845.9715402845914, 2676.571748520237, 2767.1283545683045, 2801.4257077299103, 2809.929751756202, 2813.8452385118812, 2473.2951108933958, 2744.3550765570076, 2771.722827717232, 2780.5134101532253, 2780.5829125631117, 2802.075315145997, 2842.7015163407855, 2847.5016872047518, 2847.686754457008, 2850.5439129739143, 2692.7980401469968, 2714.050082471139, 2753.6420265365573, 2754.2012816283254, 2760.1167626359575, 15080.245987700571, 15571.922140389226, 15586.844131558653, 15586.922065389714, 15604.219789010618, 8152.307053900426, 8379.162083791633, 8416.915830841735, 8469.237768600855, 8481.491110533389, 5165.483451654842, 5351.384590772072, 5428.67427954324, 5442.537384322337, 5443.537299329561, 1966.4788830959808, 1982.8810271383618, 1990.3829812757947, 2011.7887621799646, 2051.0, 27404.314892127655, 27672.584911226146, 27731.306717332027, 27791.58312625312, 27802.3049423764, 6833.794986150423, 7079.610621415769, 7098.893516597255, 7151.42788576923, 7283.854322913512, 17554.0, 17611.207495662726, 17654.911725441547, 17728.734068988975, 17864.642707145784, 7875.7243496478495, 8235.423520353637, 8252.876206856901, 8267.29727973117, 8267.958660206781, 7402.222766609536, 7423.294786995227, 7450.96274518624, 7476.439267054992, 7563.0, 5162.6902385856965, 5373.462653734673, 5383.730813459311, 5409.648372855751, 5426.267453893753, 1518.491305412677, 1532.9080255184501, 1543.3286520363679, 1544.1738669811598, 1551.5267843307674, 860.2558786649503, 862.7713655881197, 867.5575456517222, 891.2468963725642, 896.1083721696954, 7433.145188303306, 7433.702651893972, 7985.281324680806, 8228.753137405887, 8243.752687419386, 709.6735501669186, 709.9148102227663, 720.5424555407354, 721.1202333153544, 729.4273994913967, 4974.204127339608, 5239.528442440199, 5250.291210686585, 5328.813491527778, 5352.330958630171, 20668.689969650466, 21400.464988375414, 21887.0, 22280.108795648317, 22364.329070127922, 21328.253511127346, 21442.24952126668, 22046.0, 22128.33614991553, 22340.776592234193, 10863.07663848566, 10867.347959122479, 10873.130149588014, 10917.945410272898, 11497.310161390344, 7886.329661978796, 7908.920910790818, 7934.388328616332, 7969.481983671043, 8017.799555010938, 18342.81657183411, 18987.0, 19245.518862028563, 19400.805991940466, 19471.318503852865, 19740.90129549343, 19939.0, 19993.400197994084, 20013.699794503384, 20363.981800909598, 11297.322160670386, 11307.038901693448, 11513.366764828015, 11567.363794991355, 11641.47613357384, 14111.506097286545, 14325.57023289303, 14392.85607143957, 14407.495737649131, 14473.638159046108, 11603.941980290045, 11681.766364672489, 11736.589219377282, 11812.114091443003, 11934.22427542207, 11109.166812488935, 11283.830742539032, 11314.434278286217, 11368.374739389414, 11499.965003149422, 9215.76960575991, 9323.673671421468, 9356.15794578464, 9376.81246375055, 9383.953080234554, 7031.191412987572, 7040.401565866959, 7093.432525398059, 7114.14630244374, 7133.429325653831, 7135.250798666066, 7177.4616903731385, 7189.209186989531, 7199.280071992759, 7212.89180662301], "value": 6710.410538744512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.49873124338126, 511.726226468839, 536.3778017499699, 542.568657916956, 552.8866582350619, 6069.453749162574, 6118.4799292060225, 6204.689765511724, 6266.342034086418, 6280.842978925529, 6197.566170368076, 6254.624722516653, 6258.499320054396, 6286.245650521943, 6287.172470274503, 5249.763760630781, 5263.3683957925105, 5263.7367031912445, 5279.815206467774, 5293.126634105387, 4904.239842824368, 5070.619703522232, 5183.2743415921805, 5301.840944771663, 5303.337082864642, 5034.974825125869, 5035.521625445577, 5055.949440505585, 5063.822766203184, 5068.72122033288, 5016.172331565287, 5057.547089661512, 5060.546718887374, 5080.110980578384, 5082.339295891529, 4472.798724057425, 4496.392986946753, 4531.977340113278, 4541.3215295610335, 4572.954270457286, 6069.332373438918, 6133.172021777048, 6182.289036760785, 6195.783147589857, 6220.751169953196, 5758.913616295717, 5768.336641286264, 5795.2176456178295, 5850.82983403321, 5865.618734782225, 6681.498887583402, 6682.699278532477, 6688.531802773808, 6689.33106689332, 6707.128073350434, 4906.828261010847, 4917.311576379309, 4932.112219800434, 4954.677945933503, 4956.578690811285, 6838.281980392087, 6881.827954301132, 6929.965350173267, 6937.410320122745, 6984.720611175547, 5094.872628184325, 5116.283720279164, 5134.512221338967, 5134.974325128425, 5149.253358263031, 5174.016007674145, 5192.45479224676, 5223.869403264949, 5248.0, 5250.947490525123, 5751.511121554715, 5752.9424705753245, 5790.507806836466, 5796.623219490804, 5809.128630705343, 6614.536982411281, 6663.533552651268, 6685.097511835937, 6741.561798483083, 6756.763513277012, 1662.3599914033184, 1729.0403825876758, 1730.5414065272712, 1733.2720257491883, 1779.8576113911115, 1220.980481298126, 1231.9938400307942, 1244.7074937389707, 1256.2023115321654, 1261.678272040642, 5711.6001879868845, 5724.942750572441, 5745.965726169246, 5821.76712931478, 5833.941660583425, 6472.546921715435, 6499.902501462482, 6607.240167380716, 6618.53670243088, 6658.234303055114, 5615.971920140455, 5661.886762264731, 5682.54539636828, 5712.457316554921, 5868.794592189253, 3537.2748586539697, 3575.567455242944, 3592.604813470516, 3626.7279954003557, 3630.2557975614936, 6451.580652256496, 6500.252470965805, 6618.4705223582, 6628.701708423133, 6654.600723956578, 7000.194977577644, 7021.754238601625, 7047.400970917427, 7066.858662826818, 7101.295689034595, 6443.194600674916, 6520.641364724986, 6561.932991107786, 6578.190997475636, 6625.801225963229, 6748.493862960199, 6755.6622168892345, 6766.93233067663, 6816.318368163144, 6822.997880932374, 6693.26374098839, 6693.598384096969, 6699.76550820719, 6718.395344419026, 6744.291849355944, 6466.579672321284, 6481.703659268071, 6492.383223593751, 6528.0, 6586.934130658824, 4927.581155601814, 5006.774695138801, 5015.448300686994, 5047.974760126176, 5081.949180508295, 6655.434288085567, 6682.866342673022, 6700.262971073081, 6739.02284168783, 6873.875674595203, 6417.326180750954, 6466.902996454963, 6500.219973603198, 6515.218173819172, 6607.504437167136, 6369.49044076482, 6551.574147680576, 6594.604323740591, 6646.567973081927, 6688.899666504909, 6399.55203135776, 6458.451031662174, 6517.804465866032, 6518.120053792677, 6608.933910660832, 6399.55203135776, 6456.806295811133, 6559.540832141704, 6565.409113179837, 6649.368310010541, 6404.775832845828, 6407.0, 6442.484601231797, 6447.709853056717, 6473.902891456538], "value": 5111.654307734894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.5884122724161, 918.986215206772, 934.8550974598935, 937.6436953957499, 949.1030975727938, 19702.90148549257, 20595.176192952284, 20604.690929636068, 20611.07250173744, 20651.173953041896, 18444.44666659999, 18631.347902823403, 18854.151563179654, 19318.61362772747, 19510.21959121637, 980.7352014955958, 995.6863587969766, 998.7203582996773, 998.9200863930868, 1002.8245057114975, 980.1423754215061, 987.521052289639, 996.8953259907714, 998.0618218874235, 998.9900100999006, 1012.4964427824674, 1036.533559898045, 1048.397171626314, 1048.643461223184, 1055.2296823318982, 1025.779457416659, 1029.8352263637782, 1030.0472063341379, 1033.0702367868903, 1033.9896601034006, 719.481972979454, 741.3920585120204, 750.2122771090388, 754.0197742934218, 755.4938191411767, 19950.102245398994, 20197.091130899145, 20365.0, 20377.8981105095, 20474.283400080927, 21819.127234910586, 21862.781372186393, 22451.550968980693, 22469.550608987727, 22476.10095596174, 16213.675726485522, 16299.185040747916, 16379.59051023722, 16718.91640541802, 16844.326226950907, 3815.7138214634015, 3820.8280627371555, 3824.8661296854757, 3843.1545060086737, 3856.4793752843566, 138628.30685846607, 142168.0, 143698.0, 144287.27856360757, 145939.0, 17152.48542543726, 17298.567535811704, 17369.65260694779, 17410.39063632767, 17579.12104394775, 31267.530987035214, 32108.0, 32207.677923220937, 32327.35345293081, 32353.35293294121, 8376.706815261437, 8480.067192608809, 8507.95746021266, 8523.95738021306, 8541.615627296787, 4152.148809494047, 4173.457450531472, 4187.371894215892, 4218.7468751874985, 4254.936175957363, 5520.503154716095, 5572.693501857356, 5609.943900560942, 5620.494155526022, 5642.153676948491, 1031.6904928521415, 1067.1729409707384, 1083.1334932054483, 1089.4988305379613, 1090.9563617455372, 702.0802748399612, 704.2816327346078, 712.7612249896239, 715.8138883890226, 726.1757904778009, 12151.331676757864, 12153.0, 12193.817092743617, 12328.260304381765, 12486.188397754117, 565.5645153231989, 594.925634295713, 598.8203538938388, 606.5026678123896, 607.0984587886984, 5693.373728889819, 5693.402192769782, 5727.971360143172, 5840.737166827418, 5920.5559583031445, 121682.0, 121966.0, 126521.36739316245, 128703.0, 131133.0, 110189.44905275582, 113256.0, 113653.86346136598, 113868.0, 115986.42006789912, 94663.52668236615, 96670.51664741631, 97767.0, 98465.0, 98766.0, 10592.417417042137, 10677.57289708403, 10775.245732798943, 10828.079613232649, 10971.341719496855, 42991.355129673706, 43643.56356436395, 44045.55954440543, 44449.55550444454, 44926.55073449355, 57954.0, 58247.54381140336, 58784.11823822732, 58987.705061474415, 60254.096188558084, 16042.0, 16169.434069807501, 16222.10778407199, 16364.427245046367, 16444.588885277484, 17347.56631084233, 17437.30250789954, 17673.20470578801, 17897.821021789616, 17949.910250448665, 16296.918515407348, 16423.58941026436, 16470.341186352412, 16546.751798722787, 16640.667186656443, 13508.189508629514, 13629.931850340685, 13657.726845463234, 13811.861881381057, 13818.170909745448, 15259.694806104038, 15522.37910483568, 15540.611484712972, 15685.451009214623, 15688.372465101726, 10743.785124297314, 10789.190810689073, 11001.944990274997, 11021.0, 11220.046296064926, 11210.439478025903, 11227.438628068401, 11281.435928203393, 11422.885771142182, 11695.532178712756], "value": 8971.870579574104, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 108.0, 110.0, 107.0, 107.0, 115.0, 112.0, 116.0, 116.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 120.0, 121.0, 124.0, 120.0, 116.0, 115.0, 121.0, 121.0, 147.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 163.0, 162.0, 163.0, 174.0, 166.0, 174.0, 170.0, 167.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 74.0, 80.0, 74.0, 74.0, 75.0, 75.0, 75.0, 83.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 78.0, 79.0, 79.0, 87.0, 78.0, 78.0, 79.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 113.0, 114.0, 115.0, 117.0, 110.0, 117.0, 112.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 151.0, 149.0, 149.0, 149.0, 149.0, 150.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 101.0, 94.0, 95.0, 94.0, 102.0, 95.0, 96.0, 108.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 55.0, 54.0, 54.0, 52.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 38.0, 38.0, 41.0, 47.0, 47.0, 38.0, 47.0, 38.0, 38.0], "value": 41.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 76.0, 74.0, 79.0, 81.0, 76.0, 72.0, 74.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 122.0, 115.0, 125.0, 114.0, 110.0, 116.0, 118.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 182.0, 166.0, 167.0, 162.0, 166.0, 171.0, 166.0, 165.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 65.0, 67.0, 68.0, 69.0, 76.0, 64.0, 66.0, 67.0], "value": 68.9, "unit": "score"}]}]} 04:26:14 INFO - Return code: 0 04:26:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:14 INFO - # TBPL SUCCESS # 04:26:14 INFO - Running post-action listener: _package_coverage_data 04:26:14 INFO - Running post-action listener: _resource_record_post_action 04:26:14 INFO - [mozharness: 2017-09-26 11:26:14.137956Z] Finished run-tests step (success) 04:26:14 INFO - Running post-run listener: _resource_record_post_run 04:26:14 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 512000; Write bytes: 335929344; Read time: 172; Write time: 165216 04:26:14 INFO - TinderboxPrint: CPU usage
13.3% 04:26:14 INFO - TinderboxPrint: I/O read bytes / time
512,000 / 172 04:26:14 INFO - TinderboxPrint: I/O write bytes / time
335,929,344 / 165,216 04:26:14 INFO - TinderboxPrint: CPU idle
8,252.2 (86.7%) 04:26:14 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 04:26:14 INFO - TinderboxPrint: Swap in / out
0 / 0 04:26:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10227712; Read time: 0; Write time: 944 04:26:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:26:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 507904; Write bytes: 325701632; Read time: 160; Write time: 164272 04:26:14 INFO - Running post-run listener: _upload_blobber_files 04:26:14 INFO - Blob upload gear active. 04:26:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:15 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:16 INFO - (blobuploader) - INFO - Done attempting. 04:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:23 INFO - (blobuploader) - INFO - Done attempting. 04:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:24 INFO - (blobuploader) - INFO - Done attempting. 04:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:25 INFO - (blobuploader) - INFO - Done attempting. 04:26:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:25 INFO - Return code: 0 04:26:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd0d5915c048b06104f3c02e9a11b412b3abd5698b2c46363df60a500504ef160fd5e1efefb0cdf6eeb3f02d5d8d24a79ac0c744eff13964121b17b317bc72c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5589e07675980ce17c3de7445d58600999e6f1915f871445efeda09b3cab11f5c02828490e5d27044497b0c7351491974845bc90cb0650347d3412b1de2e0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b149bab09c741325998365e82ed38d72fb4164077bf555388977bbd2b887917f6a95262b6b1223562e4a643b141587515ca11cb12818e7d724f3311b0d9dd441", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0ae762702d48995daa11a1aa57836953117f7317027a430eda72cea72f0464f75ed8a06952c2cb188445d28f0166f11f3adc50b9c49de34cb99a1bc4050e740"} 04:26:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:25 INFO - Contents: 04:26:25 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd0d5915c048b06104f3c02e9a11b412b3abd5698b2c46363df60a500504ef160fd5e1efefb0cdf6eeb3f02d5d8d24a79ac0c744eff13964121b17b317bc72c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5589e07675980ce17c3de7445d58600999e6f1915f871445efeda09b3cab11f5c02828490e5d27044497b0c7351491974845bc90cb0650347d3412b1de2e0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b149bab09c741325998365e82ed38d72fb4164077bf555388977bbd2b887917f6a95262b6b1223562e4a643b141587515ca11cb12818e7d724f3311b0d9dd441", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0ae762702d48995daa11a1aa57836953117f7317027a430eda72cea72f0464f75ed8a06952c2cb188445d28f0166f11f3adc50b9c49de34cb99a1bc4050e740"} 04:26:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:25 INFO - Copying logs to upload dir... 04:26:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.010410 ========= master_lag: 0.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-26 04:26:25.889284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:25.897171) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd0d5915c048b06104f3c02e9a11b412b3abd5698b2c46363df60a500504ef160fd5e1efefb0cdf6eeb3f02d5d8d24a79ac0c744eff13964121b17b317bc72c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5589e07675980ce17c3de7445d58600999e6f1915f871445efeda09b3cab11f5c02828490e5d27044497b0c7351491974845bc90cb0650347d3412b1de2e0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b149bab09c741325998365e82ed38d72fb4164077bf555388977bbd2b887917f6a95262b6b1223562e4a643b141587515ca11cb12818e7d724f3311b0d9dd441", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0ae762702d48995daa11a1aa57836953117f7317027a430eda72cea72f0464f75ed8a06952c2cb188445d28f0166f11f3adc50b9c49de34cb99a1bc4050e740"} build_url:https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/NZTur4OUTTCzffNcI7ihNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd0d5915c048b06104f3c02e9a11b412b3abd5698b2c46363df60a500504ef160fd5e1efefb0cdf6eeb3f02d5d8d24a79ac0c744eff13964121b17b317bc72c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5589e07675980ce17c3de7445d58600999e6f1915f871445efeda09b3cab11f5c02828490e5d27044497b0c7351491974845bc90cb0650347d3412b1de2e0c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b149bab09c741325998365e82ed38d72fb4164077bf555388977bbd2b887917f6a95262b6b1223562e4a643b141587515ca11cb12818e7d724f3311b0d9dd441", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0ae762702d48995daa11a1aa57836953117f7317027a430eda72cea72f0464f75ed8a06952c2cb188445d28f0166f11f3adc50b9c49de34cb99a1bc4050e740"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:25.928069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:25.928392) ========= 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=20e20d796406ba5117c4a6f1000001ba-1506423937.471840-1428118137 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:26:26.007702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:26:26.008025) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:26:26.008348) ========= ========= Total master_lag: 1.04 =========