builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1505429610.66 results: success (0) revision: 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.663003) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.663432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.663739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.775258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.775510) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 15:53:30-- 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% 225M=0s 2017-09-14 15:53:31 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134191 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.945334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:30.945639) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017547 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.034897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.035238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 --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 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 --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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 15:53:31,202 truncating revision to first 12 chars 2017-09-14 15:53:31,203 Setting DEBUG logging. 2017-09-14 15:53:31,203 attempt 1/10 2017-09-14 15:53:31,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8e818b5e9b6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 15:53:31,469 unpacking tar archive at: mozilla-central-8e818b5e9b6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.633772) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.634085) ========= script_repo_revision: 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.634445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.634717) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 15:53:31.651384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-14 15:53:31.651704) ========= /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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:31 INFO - MultiFileLogger online at 20170914 15:53:31 in /builds/slave/test 15:53:31 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 15:53:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:31 INFO - {'append_to_log': False, 15:53:31 INFO - 'base_work_dir': '/builds/slave/test', 15:53:31 INFO - 'blob_upload_branch': 'Firefox', 15:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:31 INFO - 'branch': 'Firefox', 15:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:31 INFO - 'code_coverage': False, 15:53:31 INFO - 'config_files': ('talos/linux_config.py',), 15:53:31 INFO - 'default_actions': ('clobber', 15:53:31 INFO - 'read-buildbot-config', 15:53:31 INFO - 'download-and-extract', 15:53:31 INFO - 'populate-webroot', 15:53:31 INFO - 'create-virtualenv', 15:53:31 INFO - 'install', 15:53:31 INFO - 'setup-mitmproxy', 15:53:31 INFO - 'run-tests'), 15:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:31 INFO - 'disable_ccov_upload': False, 15:53:31 INFO - 'disable_stylo': False, 15:53:31 INFO - 'download_minidump_stackwalk': True, 15:53:31 INFO - 'download_symbols': 'ondemand', 15:53:31 INFO - 'enable_stylo': False, 15:53:31 INFO - 'enable_webrender': False, 15:53:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:31 INFO - 'gecko_profile': False, 15:53:31 INFO - 'gecko_profile_interval': 0, 15:53:31 INFO - 'installer_path': 'installer.exe', 15:53:31 INFO - 'log_level': 'info', 15:53:31 INFO - 'log_name': 'talos', 15:53:31 INFO - 'log_to_console': True, 15:53:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:31 INFO - 'opt_config_files': (), 15:53:31 INFO - 'pip_index': False, 15:53:31 INFO - 'suite': 'dromaeojs-e10s', 15:53:31 INFO - 'system_bits': '32', 15:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:31 INFO - 'title': 'talos-linux64-ix-046', 15:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:31 INFO - 'use_talos_json': True, 15:53:31 INFO - 'verify': 'False', 15:53:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:31 INFO - 'work_dir': 'build'} 15:53:31 INFO - [mozharness: 2017-09-14 22:53:31.956736Z] Running clobber step. 15:53:31 INFO - Running pre-action listener: _resource_record_pre_action 15:53:31 INFO - Running main action method: clobber 15:53:31 INFO - rmtree: /builds/slave/test/build 15:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:33 INFO - Running post-action listener: _resource_record_post_action 15:53:33 INFO - [mozharness: 2017-09-14 22:53:33.466517Z] Finished clobber step (success) 15:53:33 INFO - [mozharness: 2017-09-14 22:53:33.466614Z] Running read-buildbot-config step. 15:53:33 INFO - Running pre-action listener: _resource_record_pre_action 15:53:33 INFO - Running main action method: read_buildbot_config 15:53:33 INFO - Using buildbot properties: 15:53:33 INFO - { 15:53:33 INFO - "project": "", 15:53:33 INFO - "product": "firefox", 15:53:33 INFO - "who": "archaeopteryx@coole-files.de", 15:53:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:53:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:53:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:53:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:53:33 INFO - "stage_platform": "linux64-qr", 15:53:33 INFO - "basedir": "/builds/slave/test", 15:53:33 INFO - "buildnumber": 56, 15:53:33 INFO - "platform": "ubuntu64_hw_qr", 15:53:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:53:33 INFO - "slavebuilddir": "test", 15:53:33 INFO - "taskId": "ReqI3hNHTzCCZl0lrd7yLg", 15:53:33 INFO - "branch": "mozilla-central", 15:53:33 INFO - "script_repo_revision": "production", 15:53:33 INFO - "revision": "8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14", 15:53:33 INFO - "slavename": "talos-linux64-ix-046", 15:53:33 INFO - "repo_path": "mozilla-central" 15:53:33 INFO - } 15:53:33 INFO - Finding installer, test and symbols from parent task. 15:53:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ReqI3hNHTzCCZl0lrd7yLg'}, attempt #1 15:53:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ReqI3hNHTzCCZl0lrd7yLg'}, attempt #1 15:53:34 INFO - Task dependencies: SB_Iszi2RUqvi8dFYD-q6Q 15:53:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q'}, attempt #1 15:53:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 15:53:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.test_packages.json 15:53:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.crashreporter-symbols.zip 15:53:34 INFO - Running post-action listener: _resource_record_post_action 15:53:34 INFO - [mozharness: 2017-09-14 22:53:34.827826Z] Finished read-buildbot-config step (success) 15:53:34 INFO - [mozharness: 2017-09-14 22:53:34.828042Z] Running download-and-extract step. 15:53:34 INFO - Running pre-action listener: _resource_record_pre_action 15:53:34 INFO - Running main action method: download_and_extract 15:53:34 INFO - mkdir: /builds/slave/test/build/tests 15:53:34 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')]} 15:53:34 INFO - trying https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.test_packages.json 15:53:34 INFO - Downloading https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:53:35 INFO - Downloaded 989 bytes. 15:53:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:53:35 INFO - Using the following test package requirements: 15:53:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:53:35 INFO - u'common': [u'target.common.tests.zip'], 15:53:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:53:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:53:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:53:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:53:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:53:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:53:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:53:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:53:35 INFO - u'target.web-platform.tests.tar.gz'], 15:53:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:53:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:53:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.common.tests.zip 15:53:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:53:35 INFO - Fetch https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.common.tests.zip into memory 15:53:37 INFO - Content-Length response header: 54736798 15:53:37 INFO - Bytes received: 54736798 15:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.talos.tests.zip 15:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.talos.tests.zip into memory 15:53:48 INFO - Content-Length response header: 14500356 15:53:48 INFO - Bytes received: 14500356 15:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:49 INFO - trying https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 15:53:49 INFO - Downloading https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:53:50 INFO - Downloaded 61382355 bytes. 15:53:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 15:53:50 INFO - mkdir: /builds/slave/test/properties 15:53:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:50 INFO - Contents: 15:53:50 INFO - build_url:https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 15:53:50 INFO - Running post-action listener: _resource_record_post_action 15:53:50 INFO - Running post-action listener: find_tests_for_verification 15:53:50 INFO - Running post-action listener: set_extra_try_arguments 15:53:50 INFO - [mozharness: 2017-09-14 22:53:50.916034Z] Finished download-and-extract step (success) 15:53:50 INFO - [mozharness: 2017-09-14 22:53:50.916133Z] Running populate-webroot step. 15:53:50 INFO - Running pre-action listener: _resource_record_pre_action 15:53:50 INFO - Running main action method: populate_webroot 15:53:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['tresize', 15:53:50 INFO - 'tcanvasmark']}, 15:53:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['dromaeo_css', 15:53:50 INFO - 'kraken']}, 15:53:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'tests': ['damp', 'tps']}, 15:53:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['damp', 'tps']}, 15:53:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['dromaeo_dom']}, 15:53:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:53:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['basic_compositor_video', 15:53:50 INFO - 'glvideo']}, 15:53:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:53:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['ts_paint_webext', 15:53:50 INFO - 'tp5o_webext']}, 15:53:50 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:50 INFO - 'ts_paint', 15:53:50 INFO - 'tpaint', 15:53:50 INFO - 'sessionrestore', 15:53:50 INFO - 'sessionrestore_many_windows', 15:53:50 INFO - 'sessionrestore_no_auto_restore', 15:53:50 INFO - 'tabpaint']}, 15:53:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['a11yr', 15:53:50 INFO - 'ts_paint', 15:53:50 INFO - 'tpaint', 15:53:50 INFO - 'sessionrestore', 15:53:50 INFO - 'sessionrestore_many_windows', 15:53:50 INFO - 'sessionrestore_no_auto_restore', 15:53:50 INFO - 'tabpaint']}, 15:53:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:53:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:53:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['bloom_basic_singleton']}, 15:53:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['bloom_basic']}, 15:53:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:50 INFO - 'tsvgr_opacity', 15:53:50 INFO - 'tart', 15:53:50 INFO - 'tscrollx', 15:53:50 INFO - 'tsvg_static']}, 15:53:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['tsvgx', 15:53:50 INFO - 'tsvgr_opacity', 15:53:50 INFO - 'tart', 15:53:50 INFO - 'tscrollx', 15:53:50 INFO - 'tsvg_static']}, 15:53:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:53:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo'], 15:53:50 INFO - 'tests': ['tp5o']}, 15:53:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:50 INFO - 'talos_options': ['--mitmproxy', 15:53:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:50 INFO - '--firstNonBlankPaint'], 15:53:50 INFO - 'tests': ['tp6_google', 15:53:50 INFO - 'tp6_youtube', 15:53:50 INFO - 'tp6_amazon', 15:53:50 INFO - 'tp6_facebook']}, 15:53:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo', 15:53:50 INFO - '--mitmproxy', 15:53:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:50 INFO - '--firstNonBlankPaint'], 15:53:50 INFO - 'tests': ['tp6_google', 15:53:50 INFO - 'tp6_youtube', 15:53:50 INFO - 'tp6_amazon', 15:53:50 INFO - 'tp6_facebook']}, 15:53:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:53:50 INFO - 'talos_options': ['--stylo-threads=1', 15:53:50 INFO - '--mitmproxy', 15:53:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:53:50 INFO - '--firstNonBlankPaint'], 15:53:50 INFO - 'tests': ['tp6_google', 15:53:50 INFO - 'tp6_youtube', 15:53:50 INFO - 'tp6_amazon', 15:53:50 INFO - 'tp6_facebook']}, 15:53:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--xperf_path', 15:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:50 INFO - 'tests': ['tp5n']}, 15:53:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:53:50 INFO - 'talos_options': ['--disable-stylo', 15:53:50 INFO - '--xperf_path', 15:53:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:50 INFO - 'tests': ['tp5n']}}} 15:53:50 INFO - Running post-action listener: _resource_record_post_action 15:53:50 INFO - [mozharness: 2017-09-14 22:53:50.932010Z] Finished populate-webroot step (success) 15:53:50 INFO - [mozharness: 2017-09-14 22:53:50.932100Z] Running create-virtualenv step. 15:53:50 INFO - Running pre-action listener: _resource_record_pre_action 15:53:50 INFO - Running main action method: create_virtualenv 15:53:50 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:53:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:53:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:51 INFO - Installing pip...............done. 15:53:51 INFO - Return code: 0 15:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:53:51 INFO - Reading from file tmpfile_stdout 15:53:51 INFO - Output received: 15:53:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:53:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53:51 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')]} 15:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:51 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')]} 15:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:51 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 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:51 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 15:53:51 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 15:53:51 INFO - Using env: {'DISPLAY': ':0', 15:53:51 INFO - 'HOME': '/home/cltbld', 15:53:51 INFO - 'LANG': 'en_US.UTF-8', 15:53:51 INFO - 'LANGUAGE': 'en_US:en', 15:53:51 INFO - 'LOGNAME': 'cltbld', 15:53:51 INFO - 'MAIL': '/var/mail/cltbld', 15:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:51 INFO - 'MOZ_NO_REMOTE': '1', 15:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:51 INFO - 'NO_EM_RESTART': '1', 15:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:51 INFO - 'PWD': '/builds/slave/test', 15:53:51 INFO - 'SHELL': '/bin/bash', 15:53:51 INFO - 'SHLVL': '1', 15:53:51 INFO - 'TERM': 'linux', 15:53:51 INFO - 'TMOUT': '86400', 15:53:51 INFO - 'USER': 'cltbld', 15:53:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:51 INFO - '_': '/tools/buildbot/bin/python'} 15:53:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:53:53 INFO - Downloading/unpacking pip>=1.5 15:53:53 INFO - Running setup.py egg_info for package pip 15:53:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:53 INFO - Installing collected packages: pip 15:53:53 INFO - Found existing installation: pip 1.1 15:53:53 INFO - Uninstalling pip: 15:53:53 INFO - Successfully uninstalled pip 15:53:53 INFO - Running setup.py install for pip 15:53:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:53:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:53:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:53:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:53:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:53:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:53:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:53:53 INFO - Successfully installed pip 15:53:53 INFO - Cleaning up... 15:53:53 INFO - Return code: 0 15:53:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53:53 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')]} 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:53 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')]} 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:53 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 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:53 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 15:53:53 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 15:53:53 INFO - Using env: {'DISPLAY': ':0', 15:53:53 INFO - 'HOME': '/home/cltbld', 15:53:53 INFO - 'LANG': 'en_US.UTF-8', 15:53:53 INFO - 'LANGUAGE': 'en_US:en', 15:53:53 INFO - 'LOGNAME': 'cltbld', 15:53:53 INFO - 'MAIL': '/var/mail/cltbld', 15:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:53 INFO - 'MOZ_NO_REMOTE': '1', 15:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:53 INFO - 'NO_EM_RESTART': '1', 15:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:53 INFO - 'PWD': '/builds/slave/test', 15:53:53 INFO - 'SHELL': '/bin/bash', 15:53:53 INFO - 'SHLVL': '1', 15:53:53 INFO - 'TERM': 'linux', 15:53:53 INFO - 'TMOUT': '86400', 15:53:53 INFO - 'USER': 'cltbld', 15:53:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:53 INFO - '_': '/tools/buildbot/bin/python'} 15:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:53 INFO - Downloading/unpacking psutil>=3.1.1 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:54 INFO - Installing collected packages: psutil 15:53:54 INFO - Running setup.py install for psutil 15:53:54 INFO - building 'psutil._psutil_linux' extension 15:53:54 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 15:53:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:53:55 INFO - building 'psutil._psutil_posix' extension 15:53:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:53:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:55 INFO - Successfully installed psutil 15:53:55 INFO - Cleaning up... 15:53:55 INFO - Return code: 0 15:53:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:53:55 INFO - Using env: {'DISPLAY': ':0', 15:53:55 INFO - 'HOME': '/home/cltbld', 15:53:55 INFO - 'LANG': 'en_US.UTF-8', 15:53:55 INFO - 'LANGUAGE': 'en_US:en', 15:53:55 INFO - 'LOGNAME': 'cltbld', 15:53:55 INFO - 'MAIL': '/var/mail/cltbld', 15:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:55 INFO - 'MOZ_NO_REMOTE': '1', 15:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:55 INFO - 'NO_EM_RESTART': '1', 15:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:55 INFO - 'PWD': '/builds/slave/test', 15:53:55 INFO - 'SHELL': '/bin/bash', 15:53:55 INFO - 'SHLVL': '1', 15:53:55 INFO - 'TERM': 'linux', 15:53:55 INFO - 'TMOUT': '86400', 15:53:55 INFO - 'USER': 'cltbld', 15:53:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:55 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:56 INFO - Installing collected packages: mozsystemmonitor 15:53:56 INFO - Running setup.py install for mozsystemmonitor 15:53:56 INFO - Successfully installed mozsystemmonitor 15:53:56 INFO - Cleaning up... 15:53:56 INFO - Return code: 0 15:53:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53: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')]} 15:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:53:56 INFO - Using env: {'DISPLAY': ':0', 15:53:56 INFO - 'HOME': '/home/cltbld', 15:53:56 INFO - 'LANG': 'en_US.UTF-8', 15:53:56 INFO - 'LANGUAGE': 'en_US:en', 15:53:56 INFO - 'LOGNAME': 'cltbld', 15:53:56 INFO - 'MAIL': '/var/mail/cltbld', 15:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:56 INFO - 'MOZ_NO_REMOTE': '1', 15:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:56 INFO - 'NO_EM_RESTART': '1', 15:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:56 INFO - 'PWD': '/builds/slave/test', 15:53:56 INFO - 'SHELL': '/bin/bash', 15:53:56 INFO - 'SHLVL': '1', 15:53:56 INFO - 'TERM': 'linux', 15:53:56 INFO - 'TMOUT': '86400', 15:53:56 INFO - 'USER': 'cltbld', 15:53:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:56 INFO - '_': '/tools/buildbot/bin/python'} 15:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:57 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:58 INFO - warning: no files found matching '*.txt' 15:53:58 INFO - no previously-included directories found matching 'build' 15:53:58 INFO - no previously-included directories found matching 'dist' 15:53:58 INFO - no previously-included directories found matching '.git*' 15:53:58 INFO - Installing collected packages: jsonschema, functools32 15:53:58 INFO - Running setup.py install for functools32 15:53:58 INFO - warning: no files found matching '*.txt' 15:53:58 INFO - no previously-included directories found matching 'build' 15:53:58 INFO - no previously-included directories found matching 'dist' 15:53:58 INFO - no previously-included directories found matching '.git*' 15:53:58 INFO - Successfully installed jsonschema functools32 15:53:58 INFO - Cleaning up... 15:53:58 INFO - Return code: 0 15:53:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:53:58 INFO - Using env: {'DISPLAY': ':0', 15:53:58 INFO - 'HOME': '/home/cltbld', 15:53:58 INFO - 'LANG': 'en_US.UTF-8', 15:53:58 INFO - 'LANGUAGE': 'en_US:en', 15:53:58 INFO - 'LOGNAME': 'cltbld', 15:53:58 INFO - 'MAIL': '/var/mail/cltbld', 15:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:58 INFO - 'MOZ_NO_REMOTE': '1', 15:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:58 INFO - 'NO_EM_RESTART': '1', 15:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:58 INFO - 'PWD': '/builds/slave/test', 15:53:58 INFO - 'SHELL': '/bin/bash', 15:53:58 INFO - 'SHLVL': '1', 15:53:58 INFO - 'TERM': 'linux', 15:53:58 INFO - 'TMOUT': '86400', 15:53:58 INFO - 'USER': 'cltbld', 15:53:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:58 INFO - '_': '/tools/buildbot/bin/python'} 15:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:58 INFO - Cleaning up... 15:53:58 INFO - Return code: 0 15:53:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:53:58 INFO - Using env: {'DISPLAY': ':0', 15:53:58 INFO - 'HOME': '/home/cltbld', 15:53:58 INFO - 'LANG': 'en_US.UTF-8', 15:53:58 INFO - 'LANGUAGE': 'en_US:en', 15:53:58 INFO - 'LOGNAME': 'cltbld', 15:53:58 INFO - 'MAIL': '/var/mail/cltbld', 15:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:58 INFO - 'MOZ_NO_REMOTE': '1', 15:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:58 INFO - 'NO_EM_RESTART': '1', 15:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:58 INFO - 'PWD': '/builds/slave/test', 15:53:58 INFO - 'SHELL': '/bin/bash', 15:53:58 INFO - 'SHLVL': '1', 15:53:58 INFO - 'TERM': 'linux', 15:53:58 INFO - 'TMOUT': '86400', 15:53:58 INFO - 'USER': 'cltbld', 15:53:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:58 INFO - '_': '/tools/buildbot/bin/python'} 15:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:58 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:00 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:00 INFO - Downloading docopt-0.6.1.tar.gz 15:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:00 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:00 INFO - Running setup.py install for blobuploader 15:54:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:00 INFO - Running setup.py install for requests 15:54:01 INFO - Running setup.py install for docopt 15:54:01 INFO - Successfully installed blobuploader requests docopt 15:54:01 INFO - Cleaning up... 15:54:01 INFO - Return code: 0 15:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54: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')]} 15:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:01 INFO - Using env: {'DISPLAY': ':0', 15:54:01 INFO - 'HOME': '/home/cltbld', 15:54:01 INFO - 'LANG': 'en_US.UTF-8', 15:54:01 INFO - 'LANGUAGE': 'en_US:en', 15:54:01 INFO - 'LOGNAME': 'cltbld', 15:54:01 INFO - 'MAIL': '/var/mail/cltbld', 15:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:01 INFO - 'MOZ_NO_REMOTE': '1', 15:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:01 INFO - 'NO_EM_RESTART': '1', 15:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:01 INFO - 'PWD': '/builds/slave/test', 15:54:01 INFO - 'SHELL': '/bin/bash', 15:54:01 INFO - 'SHLVL': '1', 15:54:01 INFO - 'TERM': 'linux', 15:54:01 INFO - 'TMOUT': '86400', 15:54:01 INFO - 'USER': 'cltbld', 15:54:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:01 INFO - '_': '/tools/buildbot/bin/python'} 15:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:02 INFO - Running setup.py (path:/tmp/pip-Fnvlk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:02 INFO - Running setup.py (path:/tmp/pip-FNDB2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:02 INFO - Running setup.py (path:/tmp/pip-nyM2Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:02 INFO - Running setup.py (path:/tmp/pip-DIUxvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:02 INFO - Running setup.py (path:/tmp/pip-ALT8ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:02 INFO - Running setup.py (path:/tmp/pip-dLH35F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:02 INFO - Running setup.py (path:/tmp/pip-NqxMnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:02 INFO - Running setup.py (path:/tmp/pip-zg8Q4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:02 INFO - Running setup.py (path:/tmp/pip-zmM6M6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:02 INFO - Running setup.py (path:/tmp/pip-yrcEV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:02 INFO - Running setup.py (path:/tmp/pip-V0QHD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:02 INFO - Running setup.py (path:/tmp/pip-_ZhJoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:03 INFO - Running setup.py (path:/tmp/pip-g2UZNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:03 INFO - Running setup.py (path:/tmp/pip-PW0Nn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:03 INFO - Running setup.py (path:/tmp/pip-KVygD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:03 INFO - Running setup.py (path:/tmp/pip-BuMFCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:03 INFO - Running setup.py (path:/tmp/pip-5D5XoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:03 INFO - Running setup.py install for manifestparser 15:54:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:03 INFO - Running setup.py install for mozcrash 15:54:03 INFO - Running setup.py install for mozdebug 15:54:03 INFO - Running setup.py install for mozdevice 15:54:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:03 INFO - Running setup.py install for mozfile 15:54:03 INFO - Running setup.py install for mozhttpd 15:54:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:03 INFO - Running setup.py install for mozinfo 15:54:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozInstall 15:54:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozleak 15:54:04 INFO - Running setup.py install for mozlog 15:54:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for moznetwork 15:54:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozprocess 15:54:04 INFO - Running setup.py install for mozprofile 15:54:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozrunner 15:54:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozscreenshot 15:54:04 INFO - Running setup.py install for moztest 15:54:05 INFO - Running setup.py install for mozversion 15:54:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:05 INFO - Cleaning up... 15:54:05 INFO - Return code: 0 15:54:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:05 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 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:54:05 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 15:54:05 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 15:54:05 INFO - Using env: {'DISPLAY': ':0', 15:54:05 INFO - 'HOME': '/home/cltbld', 15:54:05 INFO - 'LANG': 'en_US.UTF-8', 15:54:05 INFO - 'LANGUAGE': 'en_US:en', 15:54:05 INFO - 'LOGNAME': 'cltbld', 15:54:05 INFO - 'MAIL': '/var/mail/cltbld', 15:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:05 INFO - 'MOZ_NO_REMOTE': '1', 15:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:05 INFO - 'NO_EM_RESTART': '1', 15:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:05 INFO - 'PWD': '/builds/slave/test', 15:54:05 INFO - 'SHELL': '/bin/bash', 15:54:05 INFO - 'SHLVL': '1', 15:54:05 INFO - 'TERM': 'linux', 15:54:05 INFO - 'TMOUT': '86400', 15:54:05 INFO - 'USER': 'cltbld', 15:54:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:05 INFO - '_': '/tools/buildbot/bin/python'} 15:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:05 INFO - Running setup.py (path:/tmp/pip-qzcl1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:05 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)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:05 INFO - Running setup.py (path:/tmp/pip-lpBRJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:05 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)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:05 INFO - Running setup.py (path:/tmp/pip-VQKmul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:05 INFO - Running setup.py (path:/tmp/pip-pmkP_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:05 INFO - Running setup.py (path:/tmp/pip-hcmA9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:05 INFO - Running setup.py (path:/tmp/pip-Zim2lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:05 INFO - Running setup.py (path:/tmp/pip-Og4pIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:05 INFO - Running setup.py (path:/tmp/pip-UujOzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:54:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:05 INFO - Running setup.py (path:/tmp/pip-XQnvaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:06 INFO - Running setup.py (path:/tmp/pip-mjzvvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:06 INFO - Running setup.py (path:/tmp/pip-tpzrNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:06 INFO - Running setup.py (path:/tmp/pip-jAGeva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:06 INFO - Running setup.py (path:/tmp/pip-xKy_5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:06 INFO - Running setup.py (path:/tmp/pip-nd87oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:06 INFO - Running setup.py (path:/tmp/pip-pv4oJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:06 INFO - Running setup.py (path:/tmp/pip-jL8bbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:06 INFO - Running setup.py (path:/tmp/pip-rYB2gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:54:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54: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 15:54: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 15:54: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 15:54: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 15:54:07 INFO - Downloading blessings-1.6.tar.gz 15:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:07 INFO - Installing collected packages: blessings 15:54:07 INFO - Running setup.py install for blessings 15:54:07 INFO - Successfully installed blessings 15:54:07 INFO - Cleaning up... 15:54:07 INFO - Return code: 0 15:54:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:08 INFO - Reading from file tmpfile_stdout 15:54:08 INFO - Current package versions: 15:54:08 INFO - argparse == 1.2.1 15:54:08 INFO - blessings == 1.6 15:54:08 INFO - blobuploader == 1.2.4 15:54:08 INFO - docopt == 0.6.1 15:54:08 INFO - functools32 == 3.2.3-2 15:54:08 INFO - jsonschema == 2.5.1 15:54:08 INFO - manifestparser == 1.1 15:54:08 INFO - mozInstall == 1.13 15:54:08 INFO - mozcrash == 1.0 15:54:08 INFO - mozdebug == 0.1 15:54:08 INFO - mozdevice == 0.51 15:54:08 INFO - mozfile == 1.2 15:54:08 INFO - mozhttpd == 0.7 15:54:08 INFO - mozinfo == 0.10 15:54:08 INFO - mozleak == 0.1 15:54:08 INFO - mozlog == 3.5 15:54:08 INFO - moznetwork == 0.27 15:54:08 INFO - mozprocess == 0.25 15:54:08 INFO - mozprofile == 0.28 15:54:08 INFO - mozrunner == 6.13 15:54:08 INFO - mozscreenshot == 0.1 15:54:08 INFO - mozsystemmonitor == 0.3 15:54:08 INFO - moztest == 0.8 15:54:08 INFO - mozversion == 1.4 15:54:08 INFO - psutil == 3.1.1 15:54:08 INFO - requests == 1.2.3 15:54:08 INFO - wsgiref == 0.1.2 15:54:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54: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')]} 15:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:08 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 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:54:08 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 15:54:08 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 15:54:08 INFO - Using env: {'DISPLAY': ':0', 15:54:08 INFO - 'HOME': '/home/cltbld', 15:54:08 INFO - 'LANG': 'en_US.UTF-8', 15:54:08 INFO - 'LANGUAGE': 'en_US:en', 15:54:08 INFO - 'LOGNAME': 'cltbld', 15:54:08 INFO - 'MAIL': '/var/mail/cltbld', 15:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:08 INFO - 'MOZ_NO_REMOTE': '1', 15:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:08 INFO - 'NO_EM_RESTART': '1', 15:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:08 INFO - 'PWD': '/builds/slave/test', 15:54:08 INFO - 'SHELL': '/bin/bash', 15:54:08 INFO - 'SHLVL': '1', 15:54:08 INFO - 'TERM': 'linux', 15:54:08 INFO - 'TMOUT': '86400', 15:54:08 INFO - 'USER': 'cltbld', 15:54:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:08 INFO - '_': '/tools/buildbot/bin/python'} 15:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 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)) 15:54:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:54: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 15:54: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 15:54: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 15:54: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 15:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:54:09 INFO - Installing collected packages: simplejson 15:54:09 INFO - Running setup.py install for simplejson 15:54:09 INFO - building 'simplejson._speedups' extension 15:54:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:54:10 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 15:54:10 INFO - Successfully installed simplejson 15:54:10 INFO - Cleaning up... 15:54:10 INFO - Return code: 0 15:54:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54: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')]} 15:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1174a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1317a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', '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 15:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:54:10 INFO - Using env: {'DISPLAY': ':0', 15:54:10 INFO - 'HOME': '/home/cltbld', 15:54:10 INFO - 'LANG': 'en_US.UTF-8', 15:54:10 INFO - 'LANGUAGE': 'en_US:en', 15:54:10 INFO - 'LOGNAME': 'cltbld', 15:54:10 INFO - 'MAIL': '/var/mail/cltbld', 15:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:10 INFO - 'MOZ_NO_REMOTE': '1', 15:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:10 INFO - 'NO_EM_RESTART': '1', 15:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:10 INFO - 'PWD': '/builds/slave/test', 15:54:10 INFO - 'SHELL': '/bin/bash', 15:54:10 INFO - 'SHLVL': '1', 15:54:10 INFO - 'TERM': 'linux', 15:54:10 INFO - 'TMOUT': '86400', 15:54:10 INFO - 'USER': 'cltbld', 15:54:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:10 INFO - '_': '/tools/buildbot/bin/python'} 15:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:10 INFO - Cleaning up... 15:54:10 INFO - Return code: 0 15:54:10 INFO - Running post-action listener: _resource_record_post_action 15:54:10 INFO - Running post-action listener: _start_resource_monitoring 15:54:10 INFO - Starting resource monitoring. 15:54:10 INFO - [mozharness: 2017-09-14 22:54:10.807068Z] Finished create-virtualenv step (success) 15:54:10 INFO - [mozharness: 2017-09-14 22:54:10.807634Z] Running install step. 15:54:10 INFO - Running pre-action listener: _resource_record_pre_action 15:54:10 INFO - Running main action method: install 15:54:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:11 INFO - Reading from file tmpfile_stdout 15:54:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:11 INFO - Reading from file tmpfile_stdout 15:54:11 INFO - Output received: 15:54:11 INFO - Usage: mozinstall [options] installer 15:54:11 INFO - Options: 15:54:11 INFO - -h, --help show this help message and exit 15:54:11 INFO - -d DEST, --destination=DEST 15:54:11 INFO - Directory to install application into. [default: 15:54:11 INFO - "/builds/slave/test"] 15:54:11 INFO - --app=APP Application being installed. [default: firefox] 15:54:11 INFO - mkdir: /builds/slave/test/build/application 15:54:11 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'] 15:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:54:28 INFO - Reading from file tmpfile_stdout 15:54:28 INFO - Output received: 15:54:28 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:28 INFO - Running post-action listener: _resource_record_post_action 15:54:28 INFO - [mozharness: 2017-09-14 22:54:28.873339Z] Finished install step (success) 15:54:28 INFO - [mozharness: 2017-09-14 22:54:28.873592Z] Running setup-mitmproxy step. 15:54:28 INFO - Running pre-action listener: _resource_record_pre_action 15:54:28 INFO - Running main action method: setup_mitmproxy 15:54:28 INFO - Skipping: mitmproxy is not required 15:54:28 INFO - Running post-action listener: _resource_record_post_action 15:54:28 INFO - [mozharness: 2017-09-14 22:54:28.874711Z] Finished setup-mitmproxy step (success) 15:54:28 INFO - [mozharness: 2017-09-14 22:54:28.874932Z] Running run-tests step. 15:54:28 INFO - Running pre-action listener: _resource_record_pre_action 15:54:28 INFO - Running pre-action listener: _set_gcov_prefix 15:54:28 INFO - Running main action method: run_tests 15:54:28 WARNING - Try message not found. 15:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:28 INFO - Python 2.7.3 15:54:28 INFO - Return code: 0 15:54:28 INFO - grabbing minidump binary from tooltool 15:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131b090>, '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 0x131bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1315f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:54:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:54:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:54:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:29 INFO - Return code: 0 15:54:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:29 INFO - ENV: RUST_BACKTRACE is now full 15:54:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:29 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/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:54:29 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/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 15:54:29 INFO - Using env: {'DISPLAY': ':0', 15:54:29 INFO - 'HOME': '/home/cltbld', 15:54:29 INFO - 'LANG': 'en_US.UTF-8', 15:54:29 INFO - 'LANGUAGE': 'en_US:en', 15:54:29 INFO - 'LOGNAME': 'cltbld', 15:54:29 INFO - 'MAIL': '/var/mail/cltbld', 15:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:29 INFO - 'MOZ_ACCELERATED': '1', 15:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:29 INFO - 'MOZ_NO_REMOTE': '1', 15:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:29 INFO - 'MOZ_WEBRENDER': '1', 15:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:29 INFO - 'NO_EM_RESTART': '1', 15:54:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:29 INFO - 'PWD': '/builds/slave/test', 15:54:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:29 INFO - 'RUST_BACKTRACE': 'full', 15:54:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:29 INFO - 'SHELL': '/bin/bash', 15:54:29 INFO - 'SHLVL': '1', 15:54:29 INFO - 'TERM': 'linux', 15:54:29 INFO - 'TMOUT': '86400', 15:54:29 INFO - 'USER': 'cltbld', 15:54:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:29 INFO - '_': '/tools/buildbot/bin/python'} 15:54:29 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/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 15:54:29 INFO - mozversion application_buildid: 20170914215922 15:54:29 INFO - mozversion application_changeset: 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 15:54:29 INFO - mozversion application_display_name: Nightly 15:54:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:29 INFO - mozversion application_name: Firefox 15:54:29 INFO - mozversion application_remotingname: firefox 15:54:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:54:29 INFO - mozversion application_vendor: Mozilla 15:54:29 INFO - mozversion application_version: 57.0a1 15:54:29 INFO - mozversion platform_buildid: 20170914215922 15:54:29 INFO - mozversion platform_changeset: 8e818b5e9b6bef0fc1a5c527ecf30b0d56a02f14 15:54:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:54:29 INFO - mozversion platform_version: 57.0a1 15:54:29 INFO - using testdate: 1505429669 15:54:29 INFO - actual date: 1505429669 15:54:29 INFO - starting webserver on 'localhost:55502' 15:54:29 INFO - SUITE-START | Running 2 tests 15:54:29 INFO - TEST-START | dromaeo_css 15:54:29 INFO - Initialising browser for dromaeo_css test... 15:54:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html -profile /tmp/tmpXAyeCD/profile 15:54:29 INFO - TEST-INFO | started process 4334 (/builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html) 15:54:36 INFO - TEST-INFO | 4334: exit 0 15:54:36 INFO - Browser initialized. 15:54:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:36 INFO - Using env: {'DISPLAY': ':0', 15:54:36 INFO - 'HOME': '/home/cltbld', 15:54:36 INFO - 'JSGC_DISABLE_POISONING': '1', 15:54:36 INFO - 'LANG': 'en_US.UTF-8', 15:54:36 INFO - 'LANGUAGE': 'en_US:en', 15:54:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:54:36 INFO - 'LOGNAME': 'cltbld', 15:54:36 INFO - 'MAIL': '/var/mail/cltbld', 15:54:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:36 INFO - 'MOZ_ACCELERATED': '1', 15:54:36 INFO - 'MOZ_CRASHREPORTER': '1', 15:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:54:36 INFO - 'MOZ_NO_REMOTE': '1', 15:54:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:36 INFO - 'MOZ_WEBRENDER': '1', 15:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:36 INFO - 'NO_EM_RESTART': '1', 15:54:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:36 INFO - 'PWD': '/builds/slave/test', 15:54:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:36 INFO - 'RUST_BACKTRACE': 'full', 15:54:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:36 INFO - 'SHELL': '/bin/bash', 15:54:36 INFO - 'SHLVL': '1', 15:54:36 INFO - 'TERM': 'linux', 15:54:36 INFO - 'TMOUT': '86400', 15:54:36 INFO - 'USER': 'cltbld', 15:54:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 15:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:36 INFO - '_': '/tools/buildbot/bin/python'} 15:54:36 INFO - TEST-INFO | started process 4577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAyeCD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:37 INFO - PID 4577 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:54:37 INFO - PID 4577 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:54:38 INFO - PID 4577 | 15:54:38 INFO - PID 4577 | (/builds/slave/test/build/application/firefox/firefox:4637): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:54:38 INFO - PID 4577 | 15:54:48 INFO - PID 4577 | RSS: Main: 214097920 15:54:48 INFO - PID 4577 | 15:57:45 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55502/tests/dromaeo/cssquery-ext.html) 15:57:47 INFO - PID 4577 | RSS: Main: 224301056 15:57:47 INFO - PID 4577 | 16:00:49 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-ext.html (next: http://localhost:55502/tests/dromaeo/cssquery-jquery.html) 16:00:50 INFO - PID 4577 | RSS: Main: 224088064 16:00:50 INFO - PID 4577 | 16:03:52 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55502/tests/dromaeo/cssquery-mootools.html) 16:03:52 INFO - PID 4577 | RSS: Main: 226807808 16:03:52 INFO - PID 4577 | 16:06:55 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55502/tests/dromaeo/cssquery-prototype.html) 16:06:55 INFO - PID 4577 | RSS: Main: 224935936 16:06:55 INFO - PID 4577 | 16:09:59 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55502/tests/dromaeo/cssquery-yui.html) 16:10:00 INFO - PID 4577 | RSS: Main: 226893824 16:10:00 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | Cycle 1(1): loaded http://localhost:55502/tests/dromaeo/cssquery-yui.html (next: http://localhost:55502/tests/dromaeo/cssquery-dojo.html) 16:13:02 INFO - PID 4577 | RSS: Main: 231669760 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | __start_tp_report 16:13:02 INFO - PID 4577 | _x_x_mozilla_page_load 16:13:02 INFO - PID 4577 | _x_x_mozilla_page_load_details 16:13:02 INFO - PID 4577 | |i|pagename|runs| 16:13:02 INFO - PID 4577 | |0;dojo.html;3097.550855126006;3116.4857798463254;3138.089953913365;3140.3248301615154;3168.2712976015514;6002.219711437507;6139.754409823602;6151.354107818676;6177.722002509887;6241.126242326078;6102.359252278514;6128.601640893339;6135.601185922912;6148.10852426399;6155.199824022882;5637.830865074034;5638.267025286707;5657.434256574351;5663.461971112738;5670.5463562914865;5722.141678748179;5747.798827041054;5756.971215143939;5779.306483222019;5787.623804452718;5673.6879471629045;5693.060644993571;5756.079027355624;5775.942240577603;5779.566532510057;934.5927035063197;5578.163275508706;5581.8604534886545;5600.383957764642;5616.943830561724;5615.129654903456;5634.211210430543;5698.857528561819;5701.885962280772;5702.885942281173;6047.395260473962;6082.239720034996;6109.663968481732;6175.197224360849;6178.135061091451;6553.148090748172;6563.54055216135;6642.900356494656;6644.534882558223;6675.966620166917;6563.343665633446;6638.4689224861895;6641.136652235226;6710.932890671128;6712.395884370381;6007.789727359565;6153.569250152491;6173.1048997895505;6176.289726681399;6254.87490250197;6681.665916704243;6733.764318248838;6741.157355330583;6757.932420675828;6758.594484330956;6280.057991301342;6367.267764207176;6389.808305750835;6393.648349340738;6426.2931077581425;6565.8358541035905;6635.6350400728425;6702.430293425016;6703.463722902156;6706.463482921355;6547.770828020996;6557.868842623121;6583.0454584086;6590.2421221560135;6660.034295027291;6494.285628580852;6578.934210657928;6589.275179730226;6657.633830139389;6675.6662166891465;5123.692578445305;5145.794168233304;5149.2791009258735;5151.7166555839785;5183.870403239874;4498.640108791289;4516.796744146522;4549.613282870993;4582.5646563577075;4587.587117159405;5701.344345400249;5731.254936858265;5732.598718089777;5787.074068149076;5788.392218817048;6619.3380661933425;6641.966790166019;6656.334366563305;6699.39705426514;6745.527813053137;5602.719864006784;5669.291338582677;5681.261436013292;5690.4025077367105;5737.971310143423;5628;5642.830715078554;5665.688387138747;5674.914876276859;5691.544676425959;6352.14246076783;6400.967995159995;6410.326915673881;6420.967895160495;6449.032645103178;6537.378948999837;6652.201735791639;6670.799876003728;6686.364795344434;6704.66476676174;6350.872982540231;6354.459870911024;6360.4275615193;6416.935830641633;6446.935530644633;6305.274893387135;6421.8073457796345;6446.580972236789;6482.675866206577;6579.901301480578;6598.703058362289;6689.799306020827;6690.330966903271;6711.463082953254;6725.596464212163;6407.871842563216;6448;6449.580777249464;6459.644719540471;6505.902411463737;6353.872922541431;6359.618422894641;6419.582727122722;6442.033694945796;6498.122753428227;6214.316425193316;6356.872862542631;6357.904631430625;6361.61830290184;6437.581557198767;6327.873442531031;6383.234011918599;6404.199475065617;6470.061841033118;6605.57063790852;6249.78125765596;6310.6213627182515;6312.368763123651;6343.809685709436;6365.108884756045 16:13:02 INFO - PID 4577 | |1;ext.html;838.6226198210799;853.1724227499325;881.9382643214975;884.1777147253056;884.5267781736773;39291;39978.60021399785;40012.39981400281;40101.197976040465;40175.1964960701;36754.26491470169;36794.44808327871;38800;39521.80239098808;39657.80171099148;7678.616069196546;7825.334846538022;7841.059072911258;7845.33314668251;7849.843003139934;7613.961930190341;7779.611019449033;7810;7810.570418626973;7815.335696465807;7813.921860781376;7818.80452988677;7819.882701759479;7825.25660062296;7825.569593672346;7738.613069346538;7797.454178207528;7797.610119494031;7805.531668099932;7807.063152421689;7551.471397002212;7563.621818909088;7622.58075805836;7631.046119235096;7633;36072.81963590191;36641;36664.63335366666;36868.81565592182;36933;3550.928981420357;3553.3959226931224;3587.766795158306;3589.784612923233;3606.9098272543133;30578.38843223123;30723.539146912815;30729.69270307313;30873.228169295722;30953.226169345722;4984.352034235526;5133.897322053538;5186.170212765939;5193.948060519384;5224.895502089975;175611;178961;181593;183693;188634;47651.285230721565;47732.7613361931;47791.283130753065;47857.521424786006;48039;49764.502354975986;50094.248586271235;50181;50226.74886625617;50269;15746.370145194063;15750.68498630021;15750.9212453937;16057.678846423007;16079;13162.210267383987;13253.204807711569;13257.403416846266;13262.668433289246;13268.800967985488;12891.484340626457;12924.741505169844;12964;13000.609981700374;13149.737005259842;5222.634415590948;5223.529882310534;5282.867928301823;5283.101872681654;5341.706206158621;998.9200863930868;999.115782532464;1023.7594165371132;1023.924878877176;1027.106417416852;22316;22538.549229015327;22562.887185563966;22769.886150569142;22942.197023104112;1099.065794075046;1107.5569772091228;1115.4311301236266;1117.463617463622;1128.1031579894004;12066;12103.273803571814;12112.636620901387;12146.635600931986;12289.201201921847;218111;218743;220652;222917;223533;49569;49782.50217497851;49904.001919962124;50129.49870501321;50394.496055039715;1387.500499820064;1447.088334349353;1447.739406906746;1462.4881291547872;1465.8094447721942;21511.13955441765;21755.238566650092;21765.891170544044;22213.333599992027;22317.776822231568;34087.82956085303;34095.31809363848;34172.65827341695;34180.82909585436;34209.31581368309;185946;186465;187171;187717;188136;29286.707132928397;30119;33483;33704.1573960653;33736.66263337335;41454.792726036176;41546.16907661769;41774;42450.363244551976;43230.351544727484;30899.382012360078;30914.381712366077;31368.529472058395;31463.84268078645;31549.369012620078;30784.692153078184;31211;31224.21939451532;31416.842915785273;31892.84053579717;35132.64867351396;35136.64863351436;35203;35356.46965295574;35503.28993420169;30313.696863031088;30376.088717338516;30439;31049.68950310468;31229.219269518442;22675.682564433475;22941.85290735423;23400.531989360457;23412.414689632897;23644.29067127989 16:13:02 INFO - PID 4577 | |2;jquery.html;555.5083750880472;561.4133230773841;562.8030189433696;570.421022661998;571.9656820590767;21860;22824.771752282515;22837.885810570944;22865.4283642909;22878.88560557199;23861.64207536884;24619.876900615516;24891.37771555712;25038;25861.224163275085;6438.227412710481;6481.546291759579;6585.506087043467;6588.143541339643;6588.472922166239;6497.18785151856;6605.834854128637;6606.711691220214;6607.867842643144;6611.669416529178;6275.529335299848;6537.705803238842;6555.475561955056;6557.508186885979;6559.8032059038305;6472.870542589146;6478.352164783531;6494.577852439576;6537.77117800877;6547.803565893031;5936.406359364072;6023.728932198018;6062.636241825505;6078.361772013919;6114.908276375858;29052.41895162106;29622.555661665094;29682.40635187284;29690;29734.553981690293;1979.475439008664;1993.6212119697357;1995.311617491963;2005.7893921138216;2010.5576773110038;19617.411477655693;20114;20404.693929591067;20521.38435846927;20585.69121463179;2386;2412.6846177776188;2432.1244352033254;2478.120267305099;2480.503899220163;111190;118123;118190;133589;139022;14365.425382984773;14506.476819933967;14634.926825366018;14917.104973701613;15175.924120379548;22168.88915555412;23041.193558225717;23049.19327823518;23165.88417057904;23178.420539486648;10427.217958653131;10437.634682786065;10488.475576221312;10497.475126243657;10712.303700259457;9799.608015679292;9850.21198304134;9925.454100024424;9976.600935962626;10372.533236004247;9113.772155696028;9248.583813728264;9258.90741092594;9478.388673925312;9519.904800952041;2618.646482724846;2725.6320396746582;2737.3156710822295;2789.2608458758446;2803.831770093801;938.9906100938903;951.4957072751453;960.0015983377349;962.8170647576937;970.1947383671677;19569.60860782805;19587.09316385354;20008;20092.799072009093;20502.38492845217;1013.4426065663855;1025.9025392587691;1028.5320179318392;1033.1528146919454;1036.1814166808138;10819.080378167786;11107.555697771999;11209.271397359145;11237.494312755945;11285.153613479022;429030;437294;438973;452808;458838;107966;109364;111996.4400177994;112581;113296.43351783189;1138.5502726423183;1160.23424539805;1163.0463020323423;1168.8422063021383;1170.9414529273502;17386.652266954337;17673.911630441766;17674;17748.3788067417;18101;53485;53893.73053134866;54400.72799635977;54663;56277.718611408316;68633.65683171552;69293;69718.30281697118;69815.30184698087;71163;14333.784993224901;14496.927515362355;14547.41810327575;14559.92720036393;14701.485448009269;22836.31491055271;23036.654450182927;23251.651225231974;23488.765112348658;23707;17754.28982840672;17918.5520361992;17975.370862019765;17976.37082702099;18097.819021809613;14679.853201468275;15838.762418563962;16159.353625854834;16515.504534863972;17205.397811076553;18636.627267454303;18714.251429943193;18886.622267554296;19030.809691903458;19157.904210478857;13489.662758431117;14124.929375353058;14134;14261.42954281817;14306.642333941734;18413;18537.81462185361;18561.81438185601;18629;18683.15925783316 16:13:02 INFO - PID 4577 | |3;mootools.html;1279.596926968005;1356.6404902700783;1361.754884120858;1363.3319673360056;1364.4337599896044;14617.853821461795;15064.472743453982;15954.680906381865;15985.440509582168;16165.272562734675;15526.534203973899;15701.214939253048;15833.683326333467;15834.129122898235;15846.920765396186;2538.428853507955;2626.606009098636;2699.8920043198345;2713.7693296069856;2716.5381885079582;2758.2001219646277;2773.736495032969;2783.039851251315;2790.4279622677304;2790.6511686039244;2762.2127693607326;2765.2119146043383;2766.9308267293377;2806.3825958289144;2815.549512078068;2645.034562384725;2652.085030664437;2655.920322390322;2669.1858983010175;2677.0228866463794;2608.6087086936923;2629.53983052965;2634.736526347369;2638.5514462541223;2644.2728249731476;14435.639109022253;14628;14709.338079786436;14716.264186790617;14803.66766990976;7600.011998440223;7841.490303130336;7845.646945887449;7885.605719713992;7925.643346049442;5430.239766432703;5694.402087780806;5729.598928075036;5812.215350927655;5875.059990401558;1910.923563057476;1939.41817454763;1951.9024048797503;1963.7545306836646;2004.39868039589;26030;26086.73913260881;26249.73750262511;26336.20991370262;26338.473230535474;6478.805635830932;6611.305812889577;6729.553146073617;6881.793546193522;6918.377346038881;17114.229859656345;17159.227834747468;17159.828401716073;17181.484555463107;17205.483835484956;7934.484258523177;8002.239787220205;8042.316403105685;8054.275115239657;8116.8782468263025;7275;7295;7415.1472580652835;7483.775486735407;7504.061992250969;5023.095842748267;5162.5869930406225;5175.896482070338;5197.558207552401;5201.531862132426;1499.4302165177162;1503.9998401063172;1507.5402002389376;1520.6046427928597;1527.9465218717291;804.9396295277878;829.3986859526915;833.0919297965125;846.3440833354076;863.7106569299355;6664.400203981665;6723.428508576826;6845.5550389224545;6875.759348422781;6929.480288978347;703.9296070393023;724.4602770935687;726.0670038999859;730.9415246780351;738.0257314362199;4719.716816990923;4731.361266229015;4782.856514304576;5074.543291103819;5283.1546952487415;20207.797922020887;21432;21494.355169344944;21499;21586.78413215848;20322.796772032092;20875.686864697043;20886.268980585606;21002.579948400948;21216.151353945977;10480.63317783874;10502.842457363146;10645.73385665349;10675.57297708083;10700.357978521313;8270.048944371474;8287.088420273885;8310.459820111673;8382.203690649378;8426.957865210634;17352.219150138022;17427.56431089233;17687;18164.90917545404;18370;18127.546811329823;18193.181306840957;18414.631707366047;18495.352662656744;18517.44447666572;10727.40999245049;10802.783944321227;10809.621663241749;10867.239293249397;10873.184511161853;13239.66900827487;13261.66845828862;13316.600501984956;13466;13534.458621655023;10596.8940310599;10645.520951557353;10857.511411986638;10949.50727217293;11079.944600276947;10436.165106791286;10704.518296676824;10706.304090234109;10718;10924.071453926188;9946.35348702332;10020.448875311928;10065.597376104874;10108;10113.443760593238;7188.784336469915;7243.710251589878;7262.3826974707745;7358.374538164316;7388.113426388652;6859.657017149222;6893.931060689329;6955.617441040791;7048.612326321896;7074.858502830018 16:13:02 INFO - PID 4577 | |4;prototype.html;493.9577491492949;508.9516495932886;522.0446582753561;526.3368156123285;529.5551736541307;6063.029915213567;6146.508279337648;6171.734794367155;6194.845128871769;6232.781852635158;5990.281166260055;6008.609440386372;6025.276966763983;6111.786087486938;6138.662373569452;4931.309616653672;4958.900821983558;4995.650304478688;5004.524570165847;5043.646944713872;4793.496682848303;4917.139500587383;4921.038563956014;4955.355803745526;4997.925031124536;4891.679246603415;4917.82787602434;4943.802247910097;4955.727434991092;4976.427710813248;4911.042346742387;4914.336564563774;4952.479989601076;4955.182394904855;4994.475580064113;4343.543927887558;4393.780310984438;4399.756124376591;4434.17967675981;4440.911181776346;5980.893534696095;6024.415472793681;6033.215681961361;6085.9391406085815;6129.295131059941;5684.147377893349;5719.28508936383;5727.856803579903;5729.799457019026;5735.340435849889;6521.250056243545;6521.445677117451;6549.508786840958;6571.047198156289;6571.769988050443;4803.159447096779;4817.410254615968;4820.891195025129;4827.493113223096;4854.83008094715;6768.8984665230555;6794.932050679528;6816.318368163194;6844.657767111675;6926.411255043327;4885.706857588485;4932.4081110267;4934.703917764946;4963.305137280783;4965.4041515018425;5045.8738531537;5053.67151135175;5059.215821547666;5090.2364645303505;5102.617303702237;5602.85992850182;5614.270144881221;5629.2681951346885;5688.829335119953;5729.312482502127;6460;6460.3216662250725;6497.902531462032;6510.641914694737;6527.36815796051;1591.2123498867902;1644.1779110444777;1670.2149989504912;1692.9492115236562;1700.2858799304322;1166.4401087478059;1177.3171560494893;1214.9247915594763;1218.8110842819376;1226.4726167747776;5433;5527.53015993637;5541.007855757845;5566.192902029183;5648.85877853057;6403.423691867754;6430.356964303533;6599.083682656355;6617.272100068989;6619.139511863427;5570.108782594765;5627.465390787868;5652.293463317085;5704.8859022819315;5723.513501352349;3441.969238149504;3458.5849698036395;3492.2666240089357;3536;3562.1628917204434;6310.5267104967315;6343.429091381798;6353.428191462791;6417;6473.093766872642;6750.919852823525;6816;6843.486738494533;6848.14398200225;6899.413549848218;6230.501559875199;6326.272478665012;6353.142325786052;6403.583767055126;6431;6443.903341449975;6465.321141280097;6546.18172728409;6553.639549824806;6557.704903279459;6496.382843629847;6526.24948130952;6546.738130474918;6602.7689030883685;6659.7003134860015;6420.357964203542;6439.227292724903;6450.870982580228;6483.902741458976;6505.5446118773125;4950.188354966727;4955.306257124078;4959.900801984012;4965.950340496549;4977.054359671651;6265.373462653881;6572.737090516326;6651.567648102858;6717.731290748316;6748.156480439945;5967.403259673998;6278.560500765086;6280.937190628218;6365.649889256136;6403.423691867754;6274.654893980693;6330.430261276507;6331.113644089924;6434.131392261985;6471.094046833353;6179.598326108789;6235.8197319366545;6263.4362907338555;6311.558190926591;6331.398517140864;6463.9980802975615;6486.054183744764;6488.610683359014;6493.084540060788;6502.219733631994;6219.160413344322;6228.408301211378;6234.573452848528;6252.812415627538;6288.6855657217875 16:13:02 INFO - PID 4577 | |5;yui.html;877.6752601537432;921.8064206516631;926.1201858234671;932.5943214701601;935.5696379665353;18800.341988030388;20114.396568102944;20658.38024859253;20763.377098687026;20769.688454673193;18153.90923045386;18694.53263668409;18716.344927927526;18721.719174212398;18773.62452750944;959.5490119643773;977.8582105594685;979.7942432089234;980.2452111873853;983.5082458770614;954.2413781044052;983.626222035629;994.6021591363476;998.3361064891839;1003.5584342889142;1047.544318221576;1057.3814318623615;1058.7935352606246;1059.8039362717884;1065.733566608348;1050.4642632257528;1051.8211903976342;1059.7085801404598;1060.199549340251;1061.930974486656;718.4503854551273;749.8125468632842;760.5550752809613;760.9885851712229;776.4875182379659;20266.392008239778;20426.489337766525;20440;20459.48851278715;20482.795172048387;21901.123955041778;22064.88967555168;22553.436164095863;22744.772552274597;22831.08675652972;17475.650486990187;17645.911770441195;17671.293148274053;17726.645467090715;17890.642187156314;3841.769493830379;3842.8270727817317;3864.3430616795213;3868.400397938324;3875.8837234883;140534;140762.29618851942;143181;144033.27983360016;145756.27121864428;17098.316067357166;17293;17362.13189340528;17518.211680474153;17537.473875783748;31543.842280788907;31823.204419889687;32791.836040819646;33102;33162.66837331644;8524.701635442854;8546.743597692079;8581.399302048922;8613.26787223093;8624.655013799504;4305.16049370376;4367.366731823931;4404.779761011937;4437.556244375602;4438.378626992224;5348.545373643284;5484.095124304525;5515.586331025189;5520.972395137998;5534.363548191929;981.283662926068;1009.6012075230243;1011.9494025298706;1022.616518805448;1033.0599154769125;669.3440428380214;712.975045873392;714.9034880291198;722.2091809468624;724.9130104387402;11691.356975366267;12216.816747748791;12475.812862807064;12800.551980680631;13088.476460941647;682.7234969837224;689.5104475822222;709.8757717399537;713.7573225103386;720.2185628593036;5469.425710300441;5494.780208791683;5548;5657.038303488417;5671.2060311556415;112950;116537;117241.4137929322;117601;121475;106341.46829265804;107481.4625926881;109105.47104297036;109541;110448.4477577607;92383.53808230915;92677;95660;96455.51772241094;97064.0293597055;10140.391576505433;10275.897241027495;10353.17174626013;10414.271001029856;10424;43551.34672979971;44064.55935440733;44142.77928610337;44949;45302.54697452983;57469.71265143647;58708.706456467444;59234.40765592289;59564.404355955885;59706.40293597009;15953.601159971093;16098.11460369691;16102.194890255207;16291;16414.42549510809;17795.644087118446;17888.91055544766;17978.19098140613;17981.280748770427;18110.185041672892;14787.630309242355;15199.31603077842;15204.16377099226;15326.310316035582;15531.22343882824;15453.690926181638;15504.689906202038;15525.689486209987;15607.843921561092;15691.45079922243;16070.758938615696;16176.514704558882;16230.51308460748;16344.264508097402;16671.416500422427;11653.359065251154;12004;12067.75864482723;12157.270563766202;12336.198147120409;11136.665900023012;11170.441477926233;11175.273607215506;11189.713182984062;11496.82754758696 16:13:02 INFO - PID 4577 | __end_tp_report 16:13:02 INFO - PID 4577 | __start_cc_report 16:13:02 INFO - PID 4577 | _x_x_mozilla_cycle_collect,367 16:13:02 INFO - PID 4577 | __end_cc_report 16:13:02 INFO - PID 4577 | __startTimestamp1505430782394__endTimestamp 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | ------- Summary: start ------- 16:13:02 INFO - PID 4577 | Number of tests: 6 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#0] dojo.html Cycles:165 Average:6041.94 Median:6350.87 stddev:825.14 (13.0%) stddev-sans-first:794.68 16:13:02 INFO - PID 4577 | Values: 3097.6 3116.5 3138.1 3140.3 3168.3 6002.2 6139.8 6151.4 6177.7 6241.1 6102.4 6128.6 6135.6 6148.1 6155.2 5637.8 5638.3 5657.4 5663.5 5670.5 5722.1 5747.8 5757.0 5779.3 5787.6 5673.7 5693.1 5756.1 5775.9 5779.6 934.6 5578.2 5581.9 5600.4 5616.9 5615.1 5634.2 5698.9 5701.9 5702.9 6047.4 6082.2 6109.7 6175.2 6178.1 6553.1 6563.5 6642.9 6644.5 6676.0 6563.3 6638.5 6641.1 6710.9 6712.4 6007.8 6153.6 6173.1 6176.3 6254.9 6681.7 6733.8 6741.2 6757.9 6758.6 6280.1 6367.3 6389.8 6393.6 6426.3 6565.8 6635.6 6702.4 6703.5 6706.5 6547.8 6557.9 6583.0 6590.2 6660.0 6494.3 6578.9 6589.3 6657.6 6675.7 5123.7 5145.8 5149.3 5151.7 5183.9 4498.6 4516.8 4549.6 4582.6 4587.6 5701.3 5731.3 5732.6 5787.1 5788.4 6619.3 6642.0 6656.3 6699.4 6745.5 5602.7 5669.3 5681.3 5690.4 5738.0 5628.0 5642.8 5665.7 5674.9 5691.5 6352.1 6401.0 6410.3 6421.0 6449.0 6537.4 6652.2 6670.8 6686.4 6704.7 6350.9 6354.5 6360.4 6416.9 6446.9 6305.3 6421.8 6446.6 6482.7 6579.9 6598.7 6689.8 6690.3 6711.5 6725.6 6407.9 6448.0 6449.6 6459.6 6505.9 6353.9 6359.6 6419.6 6442.0 6498.1 6214.3 6356.9 6357.9 6361.6 6437.6 6327.9 6383.2 6404.2 6470.1 6605.6 6249.8 6310.6 6312.4 6343.8 6365.1 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#1] ext.html Cycles:180 Average:36085.98 Median:34176.74 stddev:51054.14 (149.4%) stddev-sans-first:51128.76 16:13:02 INFO - PID 4577 | Values: 838.6 853.2 881.9 884.2 884.5 39291.0 39978.6 40012.4 40101.2 40175.2 36754.3 36794.4 38800.0 39521.8 39657.8 7678.6 7825.3 7841.1 7845.3 7849.8 7614.0 7779.6 7810.0 7810.6 7815.3 7813.9 7818.8 7819.9 7825.3 7825.6 7738.6 7797.5 7797.6 7805.5 7807.1 7551.5 7563.6 7622.6 7631.0 7633.0 36072.8 36641.0 36664.6 36868.8 36933.0 3550.9 3553.4 3587.8 3589.8 3606.9 30578.4 30723.5 30729.7 30873.2 30953.2 4984.4 5133.9 5186.2 5193.9 5224.9 175611.0 178961.0 181593.0 183693.0 188634.0 47651.3 47732.8 47791.3 47857.5 48039.0 49764.5 50094.2 50181.0 50226.7 50269.0 15746.4 15750.7 15750.9 16057.7 16079.0 13162.2 13253.2 13257.4 13262.7 13268.8 12891.5 12924.7 12964.0 13000.6 13149.7 5222.6 5223.5 5282.9 5283.1 5341.7 998.9 999.1 1023.8 1023.9 1027.1 22316.0 22538.5 22562.9 22769.9 22942.2 1099.1 1107.6 1115.4 1117.5 1128.1 12066.0 12103.3 12112.6 12146.6 12289.2 218111.0 218743.0 220652.0 222917.0 223533.0 49569.0 49782.5 49904.0 50129.5 50394.5 1387.5 1447.1 1447.7 1462.5 1465.8 21511.1 21755.2 21765.9 22213.3 22317.8 34087.8 34095.3 34172.7 34180.8 34209.3 185946.0 186465.0 187171.0 187717.0 188136.0 29286.7 30119.0 33483.0 33704.2 33736.7 41454.8 41546.2 41774.0 42450.4 43230.4 30899.4 30914.4 31368.5 31463.8 31549.4 30784.7 31211.0 31224.2 31416.8 31892.8 35132.6 35136.6 35203.0 35356.5 35503.3 30313.7 30376.1 30439.0 31049.7 31229.2 22675.7 22941.9 23400.5 23412.4 23644.3 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#2] jquery.html Cycles:180 Average:32852.05 Median:22851.66 stddev:74794.73 (327.3%) stddev-sans-first:74965.25 16:13:02 INFO - PID 4577 | Values: 555.5 561.4 562.8 570.4 572.0 21860.0 22824.8 22837.9 22865.4 22878.9 23861.6 24619.9 24891.4 25038.0 25861.2 6438.2 6481.5 6585.5 6588.1 6588.5 6497.2 6605.8 6606.7 6607.9 6611.7 6275.5 6537.7 6555.5 6557.5 6559.8 6472.9 6478.4 6494.6 6537.8 6547.8 5936.4 6023.7 6062.6 6078.4 6114.9 29052.4 29622.6 29682.4 29690.0 29734.6 1979.5 1993.6 1995.3 2005.8 2010.6 19617.4 20114.0 20404.7 20521.4 20585.7 2386.0 2412.7 2432.1 2478.1 2480.5 111190.0 118123.0 118190.0 133589.0 139022.0 14365.4 14506.5 14634.9 14917.1 15175.9 22168.9 23041.2 23049.2 23165.9 23178.4 10427.2 10437.6 10488.5 10497.5 10712.3 9799.6 9850.2 9925.5 9976.6 10372.5 9113.8 9248.6 9258.9 9478.4 9519.9 2618.6 2725.6 2737.3 2789.3 2803.8 939.0 951.5 960.0 962.8 970.2 19569.6 19587.1 20008.0 20092.8 20502.4 1013.4 1025.9 1028.5 1033.2 1036.2 10819.1 11107.6 11209.3 11237.5 11285.2 429030.0 437294.0 438973.0 452808.0 458838.0 107966.0 109364.0 111996.4 112581.0 113296.4 1138.6 1160.2 1163.0 1168.8 1170.9 17386.7 17673.9 17674.0 17748.4 18101.0 53485.0 53893.7 54400.7 54663.0 56277.7 68633.7 69293.0 69718.3 69815.3 71163.0 14333.8 14496.9 14547.4 14559.9 14701.5 22836.3 23036.7 23251.7 23488.8 23707.0 17754.3 17918.6 17975.4 17976.4 18097.8 14679.9 15838.8 16159.4 16515.5 17205.4 18636.6 18714.3 18886.6 19030.8 19157.9 13489.7 14124.9 14134.0 14261.4 14306.6 18413.0 18537.8 18561.8 18629.0 18683.2 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#3] mootools.html Cycles:180 Average:9138.21 Median:14482.87 stddev:6545.95 (45.2%) stddev-sans-first:6537.68 16:13:02 INFO - PID 4577 | Values: 1279.6 1356.6 1361.8 1363.3 1364.4 14617.9 15064.5 15954.7 15985.4 16165.3 15526.5 15701.2 15833.7 15834.1 15846.9 2538.4 2626.6 2699.9 2713.8 2716.5 2758.2 2773.7 2783.0 2790.4 2790.7 2762.2 2765.2 2766.9 2806.4 2815.5 2645.0 2652.1 2655.9 2669.2 2677.0 2608.6 2629.5 2634.7 2638.6 2644.3 14435.6 14628.0 14709.3 14716.3 14803.7 7600.0 7841.5 7845.6 7885.6 7925.6 5430.2 5694.4 5729.6 5812.2 5875.1 1910.9 1939.4 1951.9 1963.8 2004.4 26030.0 26086.7 26249.7 26336.2 26338.5 6478.8 6611.3 6729.6 6881.8 6918.4 17114.2 17159.2 17159.8 17181.5 17205.5 7934.5 8002.2 8042.3 8054.3 8116.9 7275.0 7295.0 7415.1 7483.8 7504.1 5023.1 5162.6 5175.9 5197.6 5201.5 1499.4 1504.0 1507.5 1520.6 1527.9 804.9 829.4 833.1 846.3 863.7 6664.4 6723.4 6845.6 6875.8 6929.5 703.9 724.5 726.1 730.9 738.0 4719.7 4731.4 4782.9 5074.5 5283.2 20207.8 21432.0 21494.4 21499.0 21586.8 20322.8 20875.7 20886.3 21002.6 21216.2 10480.6 10502.8 10645.7 10675.6 10700.4 8270.0 8287.1 8310.5 8382.2 8427.0 17352.2 17427.6 17687.0 18164.9 18370.0 18127.5 18193.2 18414.6 18495.4 18517.4 10727.4 10802.8 10809.6 10867.2 10873.2 13239.7 13261.7 13316.6 13466.0 13534.5 10596.9 10645.5 10857.5 10949.5 11079.9 10436.2 10704.5 10706.3 10718.0 10924.1 9946.4 10020.4 10065.6 10108.0 10113.4 7188.8 7243.7 7262.4 7358.4 7388.1 6859.7 6893.9 6955.6 7048.6 7074.9 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#4] prototype.html Cycles:180 Average:5428.11 Median:6029.25 stddev:1520.34 (25.2%) stddev-sans-first:1478.81 16:13:02 INFO - PID 4577 | Values: 494.0 509.0 522.0 526.3 529.6 6063.0 6146.5 6171.7 6194.8 6232.8 5990.3 6008.6 6025.3 6111.8 6138.7 4931.3 4958.9 4995.7 5004.5 5043.6 4793.5 4917.1 4921.0 4955.4 4997.9 4891.7 4917.8 4943.8 4955.7 4976.4 4911.0 4914.3 4952.5 4955.2 4994.5 4343.5 4393.8 4399.8 4434.2 4440.9 5980.9 6024.4 6033.2 6085.9 6129.3 5684.1 5719.3 5727.9 5729.8 5735.3 6521.3 6521.4 6549.5 6571.0 6571.8 4803.2 4817.4 4820.9 4827.5 4854.8 6768.9 6794.9 6816.3 6844.7 6926.4 4885.7 4932.4 4934.7 4963.3 4965.4 5045.9 5053.7 5059.2 5090.2 5102.6 5602.9 5614.3 5629.3 5688.8 5729.3 6460.0 6460.3 6497.9 6510.6 6527.4 1591.2 1644.2 1670.2 1692.9 1700.3 1166.4 1177.3 1214.9 1218.8 1226.5 5433.0 5527.5 5541.0 5566.2 5648.9 6403.4 6430.4 6599.1 6617.3 6619.1 5570.1 5627.5 5652.3 5704.9 5723.5 3442.0 3458.6 3492.3 3536.0 3562.2 6310.5 6343.4 6353.4 6417.0 6473.1 6750.9 6816.0 6843.5 6848.1 6899.4 6230.5 6326.3 6353.1 6403.6 6431.0 6443.9 6465.3 6546.2 6553.6 6557.7 6496.4 6526.2 6546.7 6602.8 6659.7 6420.4 6439.2 6450.9 6483.9 6505.5 4950.2 4955.3 4959.9 4966.0 4977.1 6265.4 6572.7 6651.6 6717.7 6748.2 5967.4 6278.6 6280.9 6365.6 6403.4 6274.7 6330.4 6331.1 6434.1 6471.1 6179.6 6235.8 6263.4 6311.6 6331.4 6464.0 6486.1 6488.6 6493.1 6502.2 6219.2 6228.4 6234.6 6252.8 6288.7 16:13:02 INFO - PID 4577 | 16:13:02 INFO - PID 4577 | [#5] yui.html Cycles:180 Average:24424.22 Median:19457.37 stddev:35171.57 (180.8%) stddev-sans-first:35225.80 16:13:02 INFO - PID 4577 | Values: 877.7 921.8 926.1 932.6 935.6 18800.3 20114.4 20658.4 20763.4 20769.7 18153.9 18694.5 18716.3 18721.7 18773.6 959.5 977.9 979.8 980.2 983.5 954.2 983.6 994.6 998.3 1003.6 1047.5 1057.4 1058.8 1059.8 1065.7 1050.5 1051.8 1059.7 1060.2 1061.9 718.5 749.8 760.6 761.0 776.5 20266.4 20426.5 20440.0 20459.5 20482.8 21901.1 22064.9 22553.4 22744.8 22831.1 17475.7 17645.9 17671.3 17726.6 17890.6 3841.8 3842.8 3864.3 3868.4 3875.9 140534.0 140762.3 143181.0 144033.3 145756.3 17098.3 17293.0 17362.1 17518.2 17537.5 31543.8 31823.2 32791.8 33102.0 33162.7 8524.7 8546.7 8581.4 8613.3 8624.7 4305.2 4367.4 4404.8 4437.6 4438.4 5348.5 5484.1 5515.6 5521.0 5534.4 981.3 1009.6 1011.9 1022.6 1033.1 669.3 713.0 714.9 722.2 724.9 11691.4 12216.8 12475.8 12800.6 13088.5 682.7 689.5 709.9 713.8 720.2 5469.4 5494.8 5548.0 5657.0 5671.2 112950.0 116537.0 117241.4 117601.0 121475.0 106341.5 107481.5 109105.5 109541.0 110448.4 92383.5 92677.0 95660.0 96455.5 97064.0 10140.4 10275.9 10353.2 10414.3 10424.0 43551.3 44064.6 44142.8 44949.0 45302.5 57469.7 58708.7 59234.4 59564.4 59706.4 15953.6 16098.1 16102.2 16291.0 16414.4 17795.6 17888.9 17978.2 17981.3 18110.2 14787.6 15199.3 15204.2 15326.3 15531.2 15453.7 15504.7 15525.7 15607.8 15691.5 16070.8 16176.5 16230.5 16344.3 16671.4 11653.4 12004.0 12067.8 12157.3 12336.2 11136.7 11170.4 11175.3 11189.7 11496.8 16:13:02 INFO - PID 4577 | -------- Summary: end -------- 16:13:02 INFO - PID 4577 | 16:13:03 INFO - TEST-INFO | 4577: exit 0 16:13:03 INFO - TEST-OK | dromaeo_css | took 1114116ms 16:13:03 INFO - TEST-START | kraken 16:13:03 INFO - Initialising browser for kraken test... 16:13:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html -profile /tmp/tmp51sDKb/profile 16:13:03 INFO - TEST-INFO | started process 4961 (/builds/slave/test/build/application/firefox/firefox http://localhost:55502/getInfo.html) 16:13:09 INFO - TEST-INFO | 4961: exit 0 16:13:09 INFO - Browser initialized. 16:13:09 INFO - Running cycle 1/1 for kraken test... 16:13:09 INFO - Using env: {'DISPLAY': ':0', 16:13:09 INFO - 'HOME': '/home/cltbld', 16:13:09 INFO - 'JSGC_DISABLE_POISONING': '1', 16:13:09 INFO - 'LANG': 'en_US.UTF-8', 16:13:09 INFO - 'LANGUAGE': 'en_US:en', 16:13:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:13:09 INFO - 'LOGNAME': 'cltbld', 16:13:09 INFO - 'MAIL': '/var/mail/cltbld', 16:13:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:09 INFO - 'MOZ_ACCELERATED': '1', 16:13:09 INFO - 'MOZ_CRASHREPORTER': '1', 16:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:13:09 INFO - 'MOZ_NO_REMOTE': '1', 16:13:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:09 INFO - 'MOZ_WEBRENDER': '1', 16:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:09 INFO - 'NO_EM_RESTART': '1', 16:13:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:09 INFO - 'PWD': '/builds/slave/test', 16:13:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:09 INFO - 'RUST_BACKTRACE': 'full', 16:13:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:13:09 INFO - 'SHELL': '/bin/bash', 16:13:09 INFO - 'SHLVL': '1', 16:13:09 INFO - 'TERM': 'linux', 16:13:09 INFO - 'TMOUT': '86400', 16:13:09 INFO - 'USER': 'cltbld', 16:13:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516', 16:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:09 INFO - '_': '/tools/buildbot/bin/python'} 16:13:09 INFO - TEST-INFO | started process 5208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp51sDKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:10 INFO - PID 5208 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:13:10 INFO - PID 5208 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:13:10 INFO - PID 5208 | 16:13:10 INFO - PID 5208 | (/builds/slave/test/build/application/firefox/firefox:5268): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:13:10 INFO - PID 5208 | 16:13:21 INFO - PID 5208 | RSS: Main: 214110208 16:13:21 INFO - PID 5208 | 16:13:24 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:25 INFO - PID 5208 | RSS: Main: 220471296 16:13:25 INFO - PID 5208 | 16:13:27 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-dft) 16:13:28 INFO - PID 5208 | RSS: Main: 221188096 16:13:28 INFO - PID 5208 | 16:13:31 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-fft) 16:13:32 INFO - PID 5208 | RSS: Main: 216666112 16:13:32 INFO - PID 5208 | 16:13:34 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55502/tests/kraken/driver.html?testName=audio-oscillator) 16:13:34 INFO - PID 5208 | RSS: Main: 216784896 16:13:34 INFO - PID 5208 | 16:13:37 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:37 INFO - PID 5208 | RSS: Main: 218251264 16:13:37 INFO - PID 5208 | 16:13:41 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:41 INFO - PID 5208 | RSS: Main: 220033024 16:13:41 INFO - PID 5208 | 16:13:45 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55502/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:46 INFO - PID 5208 | RSS: Main: 218730496 16:13:46 INFO - PID 5208 | 16:13:49 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55502/tests/kraken/driver.html?testName=json-parse-financial) 16:13:49 INFO - PID 5208 | RSS: Main: 220962816 16:13:49 INFO - PID 5208 | 16:13:51 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:52 INFO - PID 5208 | RSS: Main: 221523968 16:13:52 INFO - PID 5208 | 16:13:53 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:54 INFO - PID 5208 | RSS: Main: 220733440 16:13:54 INFO - PID 5208 | 16:13:56 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:57 INFO - PID 5208 | RSS: Main: 221458432 16:13:57 INFO - PID 5208 | 16:13:59 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:00 INFO - PID 5208 | RSS: Main: 221782016 16:14:00 INFO - PID 5208 | 16:14:03 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:04 INFO - PID 5208 | RSS: Main: 220835840 16:14:04 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | Cycle 1(1): loaded http://localhost:55502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55502/tests/kraken/driver.html?testName=ai-astar) 16:14:06 INFO - PID 5208 | RSS: Main: 223301632 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | __start_tp_report 16:14:06 INFO - PID 5208 | _x_x_mozilla_page_load 16:14:06 INFO - PID 5208 | _x_x_mozilla_page_load_details 16:14:06 INFO - PID 5208 | |i|pagename|runs| 16:14:06 INFO - PID 5208 | |0;ai-astar;116;115;114;109;127;116;115;112;108;112 16:14:06 INFO - PID 5208 | |1;audio-beat-detection;118;118;117;126;126;146;128;123;128;117 16:14:06 INFO - PID 5208 | |2;audio-dft;162;164;166;163;172;163;167;164;165;176 16:14:06 INFO - PID 5208 | |3;audio-fft;75;76;84;74;80;74;82;77;81;80 16:14:06 INFO - PID 5208 | |4;audio-oscillator;80;81;87;80;80;79;86;79;87;85 16:14:06 INFO - PID 5208 | |5;imaging-gaussian-blur;111;122;114;114;114;121;152;110;116;119 16:14:06 INFO - PID 5208 | |6;imaging-darkroom;148;150;149;147;149;148;148;151;152;155 16:14:06 INFO - PID 5208 | |7;imaging-desaturate;95;99;95;95;95;95;95;98;101;98 16:14:06 INFO - PID 5208 | |8;json-parse-financial;65;57;55;55;55;58;58;54;54;55 16:14:06 INFO - PID 5208 | |9;json-stringify-tinderbox;42;42;39;49;47;47;43;44;38;40 16:14:06 INFO - PID 5208 | |10;stanford-crypto-aes;79;77;84;76;74;76;75;84;88;84 16:14:06 INFO - PID 5208 | |11;stanford-crypto-ccm;118;113;113;118;123;125;113;116;112;121 16:14:06 INFO - PID 5208 | |12;stanford-crypto-pbkdf2;169;173;175;176;176;173;167;176;168;170 16:14:06 INFO - PID 5208 | |13;stanford-crypto-sha256-iterative;70;64;70;66;67;65;65;68;66;67 16:14:06 INFO - PID 5208 | __end_tp_report 16:14:06 INFO - PID 5208 | __start_cc_report 16:14:06 INFO - PID 5208 | _x_x_mozilla_cycle_collect,965 16:14:06 INFO - PID 5208 | __end_cc_report 16:14:06 INFO - PID 5208 | __startTimestamp1505430846282__endTimestamp 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | ------- Summary: start ------- 16:14:06 INFO - PID 5208 | Number of tests: 14 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:5.23 (4.5%) stddev-sans-first:5.52 16:14:06 INFO - PID 5208 | Values: 116.0 115.0 114.0 109.0 127.0 116.0 115.0 112.0 108.0 112.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:126.00 stddev:8.76 (6.9%) stddev-sans-first:8.95 16:14:06 INFO - PID 5208 | Values: 118.0 118.0 117.0 126.0 126.0 146.0 128.0 123.0 128.0 117.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.50 stddev:4.47 (2.7%) stddev-sans-first:4.47 16:14:06 INFO - PID 5208 | Values: 162.0 164.0 166.0 163.0 172.0 163.0 167.0 164.0 165.0 176.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#3] audio-fft Cycles:10 Average:78.30 Median:80.00 stddev:3.56 (4.5%) stddev-sans-first:3.57 16:14:06 INFO - PID 5208 | Values: 75.0 76.0 84.0 74.0 80.0 74.0 82.0 77.0 81.0 80.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:83.00 stddev:3.41 (4.1%) stddev-sans-first:3.50 16:14:06 INFO - PID 5208 | Values: 80.0 81.0 87.0 80.0 80.0 79.0 86.0 79.0 87.0 85.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#5] imaging-gaussian-blur Cycles:10 Average:119.30 Median:117.50 stddev:12.16 (10.3%) stddev-sans-first:12.52 16:14:06 INFO - PID 5208 | Values: 111.0 122.0 114.0 114.0 114.0 121.0 152.0 110.0 116.0 119.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:149.50 stddev:2.41 (1.6%) stddev-sans-first:2.47 16:14:06 INFO - PID 5208 | Values: 148.0 150.0 149.0 147.0 149.0 148.0 148.0 151.0 152.0 155.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.00 stddev:2.22 (2.3%) stddev-sans-first:2.28 16:14:06 INFO - PID 5208 | Values: 95.0 99.0 95.0 95.0 95.0 95.0 95.0 98.0 101.0 98.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.31 (5.9%) stddev-sans-first:1.58 16:14:06 INFO - PID 5208 | Values: 65.0 57.0 55.0 55.0 55.0 58.0 58.0 54.0 54.0 55.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#9] json-stringify-tinderbox Cycles:10 Average:43.10 Median:43.50 stddev:3.67 (8.4%) stddev-sans-first:3.87 16:14:06 INFO - PID 5208 | Values: 42.0 42.0 39.0 49.0 47.0 47.0 43.0 44.0 38.0 40.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:81.50 stddev:4.88 (6.0%) stddev-sans-first:5.17 16:14:06 INFO - PID 5208 | Values: 79.0 77.0 84.0 76.0 74.0 76.0 75.0 84.0 88.0 84.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:118.00 stddev:4.61 (3.9%) stddev-sans-first:4.88 16:14:06 INFO - PID 5208 | Values: 118.0 113.0 113.0 118.0 123.0 125.0 113.0 116.0 112.0 121.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:174.00 stddev:3.53 (2.0%) stddev-sans-first:3.54 16:14:06 INFO - PID 5208 | Values: 169.0 173.0 175.0 176.0 176.0 173.0 167.0 176.0 168.0 170.0 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:2.04 (3.1%) stddev-sans-first:1.81 16:14:06 INFO - PID 5208 | Values: 70.0 64.0 70.0 66.0 67.0 65.0 65.0 68.0 66.0 67.0 16:14:06 INFO - PID 5208 | -------- Summary: end -------- 16:14:06 INFO - PID 5208 | 16:14:06 INFO - PID 5208 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:14:07 INFO - TEST-INFO | 5208: exit 0 16:14:07 INFO - TEST-OK | kraken | took 63987ms 16:14:07 INFO - SUITE-END | took 1178s 16:14:07 INFO - Completed test suite (00:19:38) 16:14:07 INFO - javascript benchmark 16:14:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8383.666202005828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.550855126006, 3116.4857798463254, 3138.089953913365, 3140.3248301615154, 3168.2712976015514, 6002.219711437507, 6139.754409823602, 6151.354107818676, 6177.722002509887, 6241.126242326078, 6102.359252278514, 6128.601640893339, 6135.601185922912, 6148.10852426399, 6155.199824022882, 5637.830865074034, 5638.267025286707, 5657.434256574351, 5663.461971112738, 5670.5463562914865, 5722.141678748179, 5747.798827041054, 5756.971215143939, 5779.306483222019, 5787.623804452718, 5673.6879471629045, 5693.060644993571, 5756.079027355624, 5775.942240577603, 5779.566532510057, 934.5927035063197, 5578.163275508706, 5581.8604534886545, 5600.383957764642, 5616.943830561724, 5615.129654903456, 5634.211210430543, 5698.857528561819, 5701.885962280772, 5702.885942281173, 6047.395260473962, 6082.239720034996, 6109.663968481732, 6175.197224360849, 6178.135061091451, 6553.148090748172, 6563.54055216135, 6642.900356494656, 6644.534882558223, 6675.966620166917, 6563.343665633446, 6638.4689224861895, 6641.136652235226, 6710.932890671128, 6712.395884370381, 6007.789727359565, 6153.569250152491, 6173.1048997895505, 6176.289726681399, 6254.87490250197, 6681.665916704243, 6733.764318248838, 6741.157355330583, 6757.932420675828, 6758.594484330956, 6280.057991301342, 6367.267764207176, 6389.808305750835, 6393.648349340738, 6426.2931077581425, 6565.8358541035905, 6635.6350400728425, 6702.430293425016, 6703.463722902156, 6706.463482921355, 6547.770828020996, 6557.868842623121, 6583.0454584086, 6590.2421221560135, 6660.034295027291, 6494.285628580852, 6578.934210657928, 6589.275179730226, 6657.633830139389, 6675.6662166891465, 5123.692578445305, 5145.794168233304, 5149.2791009258735, 5151.7166555839785, 5183.870403239874, 4498.640108791289, 4516.796744146522, 4549.613282870993, 4582.5646563577075, 4587.587117159405, 5701.344345400249, 5731.254936858265, 5732.598718089777, 5787.074068149076, 5788.392218817048, 6619.3380661933425, 6641.966790166019, 6656.334366563305, 6699.39705426514, 6745.527813053137, 5602.719864006784, 5669.291338582677, 5681.261436013292, 5690.4025077367105, 5737.971310143423, 5628.0, 5642.830715078554, 5665.688387138747, 5674.914876276859, 5691.544676425959, 6352.14246076783, 6400.967995159995, 6410.326915673881, 6420.967895160495, 6449.032645103178, 6537.378948999837, 6652.201735791639, 6670.799876003728, 6686.364795344434, 6704.66476676174, 6350.872982540231, 6354.459870911024, 6360.4275615193, 6416.935830641633, 6446.935530644633, 6305.274893387135, 6421.8073457796345, 6446.580972236789, 6482.675866206577, 6579.901301480578, 6598.703058362289, 6689.799306020827, 6690.330966903271, 6711.463082953254, 6725.596464212163, 6407.871842563216, 6448.0, 6449.580777249464, 6459.644719540471, 6505.902411463737, 6353.872922541431, 6359.618422894641, 6419.582727122722, 6442.033694945796, 6498.122753428227, 6214.316425193316, 6356.872862542631, 6357.904631430625, 6361.61830290184, 6437.581557198767, 6327.873442531031, 6383.234011918599, 6404.199475065617, 6470.061841033118, 6605.57063790852, 6249.78125765596, 6310.6213627182515, 6312.368763123651, 6343.809685709436, 6365.108884756045], "value": 5982.596689169998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.6226198210799, 853.1724227499325, 881.9382643214975, 884.1777147253056, 884.5267781736773, 39291.0, 39978.60021399785, 40012.39981400281, 40101.197976040465, 40175.1964960701, 36754.26491470169, 36794.44808327871, 38800.0, 39521.80239098808, 39657.80171099148, 7678.616069196546, 7825.334846538022, 7841.059072911258, 7845.33314668251, 7849.843003139934, 7613.961930190341, 7779.611019449033, 7810.0, 7810.570418626973, 7815.335696465807, 7813.921860781376, 7818.80452988677, 7819.882701759479, 7825.25660062296, 7825.569593672346, 7738.613069346538, 7797.454178207528, 7797.610119494031, 7805.531668099932, 7807.063152421689, 7551.471397002212, 7563.621818909088, 7622.58075805836, 7631.046119235096, 7633.0, 36072.81963590191, 36641.0, 36664.63335366666, 36868.81565592182, 36933.0, 3550.928981420357, 3553.3959226931224, 3587.766795158306, 3589.784612923233, 3606.9098272543133, 30578.38843223123, 30723.539146912815, 30729.69270307313, 30873.228169295722, 30953.226169345722, 4984.352034235526, 5133.897322053538, 5186.170212765939, 5193.948060519384, 5224.895502089975, 175611.0, 178961.0, 181593.0, 183693.0, 188634.0, 47651.285230721565, 47732.7613361931, 47791.283130753065, 47857.521424786006, 48039.0, 49764.502354975986, 50094.248586271235, 50181.0, 50226.74886625617, 50269.0, 15746.370145194063, 15750.68498630021, 15750.9212453937, 16057.678846423007, 16079.0, 13162.210267383987, 13253.204807711569, 13257.403416846266, 13262.668433289246, 13268.800967985488, 12891.484340626457, 12924.741505169844, 12964.0, 13000.609981700374, 13149.737005259842, 5222.634415590948, 5223.529882310534, 5282.867928301823, 5283.101872681654, 5341.706206158621, 998.9200863930868, 999.115782532464, 1023.7594165371132, 1023.924878877176, 1027.106417416852, 22316.0, 22538.549229015327, 22562.887185563966, 22769.886150569142, 22942.197023104112, 1099.065794075046, 1107.5569772091228, 1115.4311301236266, 1117.463617463622, 1128.1031579894004, 12066.0, 12103.273803571814, 12112.636620901387, 12146.635600931986, 12289.201201921847, 218111.0, 218743.0, 220652.0, 222917.0, 223533.0, 49569.0, 49782.50217497851, 49904.001919962124, 50129.49870501321, 50394.496055039715, 1387.500499820064, 1447.088334349353, 1447.739406906746, 1462.4881291547872, 1465.8094447721942, 21511.13955441765, 21755.238566650092, 21765.891170544044, 22213.333599992027, 22317.776822231568, 34087.82956085303, 34095.31809363848, 34172.65827341695, 34180.82909585436, 34209.31581368309, 185946.0, 186465.0, 187171.0, 187717.0, 188136.0, 29286.707132928397, 30119.0, 33483.0, 33704.1573960653, 33736.66263337335, 41454.792726036176, 41546.16907661769, 41774.0, 42450.363244551976, 43230.351544727484, 30899.382012360078, 30914.381712366077, 31368.529472058395, 31463.84268078645, 31549.369012620078, 30784.692153078184, 31211.0, 31224.21939451532, 31416.842915785273, 31892.84053579717, 35132.64867351396, 35136.64863351436, 35203.0, 35356.46965295574, 35503.28993420169, 30313.696863031088, 30376.088717338516, 30439.0, 31049.68950310468, 31229.219269518442, 22675.682564433475, 22941.85290735423, 23400.531989360457, 23412.414689632897, 23644.29067127989], "value": 16731.33728219569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5083750880472, 561.4133230773841, 562.8030189433696, 570.421022661998, 571.9656820590767, 21860.0, 22824.771752282515, 22837.885810570944, 22865.4283642909, 22878.88560557199, 23861.64207536884, 24619.876900615516, 24891.37771555712, 25038.0, 25861.224163275085, 6438.227412710481, 6481.546291759579, 6585.506087043467, 6588.143541339643, 6588.472922166239, 6497.18785151856, 6605.834854128637, 6606.711691220214, 6607.867842643144, 6611.669416529178, 6275.529335299848, 6537.705803238842, 6555.475561955056, 6557.508186885979, 6559.8032059038305, 6472.870542589146, 6478.352164783531, 6494.577852439576, 6537.77117800877, 6547.803565893031, 5936.406359364072, 6023.728932198018, 6062.636241825505, 6078.361772013919, 6114.908276375858, 29052.41895162106, 29622.555661665094, 29682.40635187284, 29690.0, 29734.553981690293, 1979.475439008664, 1993.6212119697357, 1995.311617491963, 2005.7893921138216, 2010.5576773110038, 19617.411477655693, 20114.0, 20404.693929591067, 20521.38435846927, 20585.69121463179, 2386.0, 2412.6846177776188, 2432.1244352033254, 2478.120267305099, 2480.503899220163, 111190.0, 118123.0, 118190.0, 133589.0, 139022.0, 14365.425382984773, 14506.476819933967, 14634.926825366018, 14917.104973701613, 15175.924120379548, 22168.88915555412, 23041.193558225717, 23049.19327823518, 23165.88417057904, 23178.420539486648, 10427.217958653131, 10437.634682786065, 10488.475576221312, 10497.475126243657, 10712.303700259457, 9799.608015679292, 9850.21198304134, 9925.454100024424, 9976.600935962626, 10372.533236004247, 9113.772155696028, 9248.583813728264, 9258.90741092594, 9478.388673925312, 9519.904800952041, 2618.646482724846, 2725.6320396746582, 2737.3156710822295, 2789.2608458758446, 2803.831770093801, 938.9906100938903, 951.4957072751453, 960.0015983377349, 962.8170647576937, 970.1947383671677, 19569.60860782805, 19587.09316385354, 20008.0, 20092.799072009093, 20502.38492845217, 1013.4426065663855, 1025.9025392587691, 1028.5320179318392, 1033.1528146919454, 1036.1814166808138, 10819.080378167786, 11107.555697771999, 11209.271397359145, 11237.494312755945, 11285.153613479022, 429030.0, 437294.0, 438973.0, 452808.0, 458838.0, 107966.0, 109364.0, 111996.4400177994, 112581.0, 113296.43351783189, 1138.5502726423183, 1160.23424539805, 1163.0463020323423, 1168.8422063021383, 1170.9414529273502, 17386.652266954337, 17673.911630441766, 17674.0, 17748.3788067417, 18101.0, 53485.0, 53893.73053134866, 54400.72799635977, 54663.0, 56277.718611408316, 68633.65683171552, 69293.0, 69718.30281697118, 69815.30184698087, 71163.0, 14333.784993224901, 14496.927515362355, 14547.41810327575, 14559.92720036393, 14701.485448009269, 22836.31491055271, 23036.654450182927, 23251.651225231974, 23488.765112348658, 23707.0, 17754.28982840672, 17918.5520361992, 17975.370862019765, 17976.37082702099, 18097.819021809613, 14679.853201468275, 15838.762418563962, 16159.353625854834, 16515.504534863972, 17205.397811076553, 18636.627267454303, 18714.251429943193, 18886.622267554296, 19030.809691903458, 19157.904210478857, 13489.662758431117, 14124.929375353058, 14134.0, 14261.42954281817, 14306.642333941734, 18413.0, 18537.81462185361, 18561.81438185601, 18629.0, 18683.15925783316], "value": 11858.94786047611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.596926968005, 1356.6404902700783, 1361.754884120858, 1363.3319673360056, 1364.4337599896044, 14617.853821461795, 15064.472743453982, 15954.680906381865, 15985.440509582168, 16165.272562734675, 15526.534203973899, 15701.214939253048, 15833.683326333467, 15834.129122898235, 15846.920765396186, 2538.428853507955, 2626.606009098636, 2699.8920043198345, 2713.7693296069856, 2716.5381885079582, 2758.2001219646277, 2773.736495032969, 2783.039851251315, 2790.4279622677304, 2790.6511686039244, 2762.2127693607326, 2765.2119146043383, 2766.9308267293377, 2806.3825958289144, 2815.549512078068, 2645.034562384725, 2652.085030664437, 2655.920322390322, 2669.1858983010175, 2677.0228866463794, 2608.6087086936923, 2629.53983052965, 2634.736526347369, 2638.5514462541223, 2644.2728249731476, 14435.639109022253, 14628.0, 14709.338079786436, 14716.264186790617, 14803.66766990976, 7600.011998440223, 7841.490303130336, 7845.646945887449, 7885.605719713992, 7925.643346049442, 5430.239766432703, 5694.402087780806, 5729.598928075036, 5812.215350927655, 5875.059990401558, 1910.923563057476, 1939.41817454763, 1951.9024048797503, 1963.7545306836646, 2004.39868039589, 26030.0, 26086.73913260881, 26249.73750262511, 26336.20991370262, 26338.473230535474, 6478.805635830932, 6611.305812889577, 6729.553146073617, 6881.793546193522, 6918.377346038881, 17114.229859656345, 17159.227834747468, 17159.828401716073, 17181.484555463107, 17205.483835484956, 7934.484258523177, 8002.239787220205, 8042.316403105685, 8054.275115239657, 8116.8782468263025, 7275.0, 7295.0, 7415.1472580652835, 7483.775486735407, 7504.061992250969, 5023.095842748267, 5162.5869930406225, 5175.896482070338, 5197.558207552401, 5201.531862132426, 1499.4302165177162, 1503.9998401063172, 1507.5402002389376, 1520.6046427928597, 1527.9465218717291, 804.9396295277878, 829.3986859526915, 833.0919297965125, 846.3440833354076, 863.7106569299355, 6664.400203981665, 6723.428508576826, 6845.5550389224545, 6875.759348422781, 6929.480288978347, 703.9296070393023, 724.4602770935687, 726.0670038999859, 730.9415246780351, 738.0257314362199, 4719.716816990923, 4731.361266229015, 4782.856514304576, 5074.543291103819, 5283.1546952487415, 20207.797922020887, 21432.0, 21494.355169344944, 21499.0, 21586.78413215848, 20322.796772032092, 20875.686864697043, 20886.268980585606, 21002.579948400948, 21216.151353945977, 10480.63317783874, 10502.842457363146, 10645.73385665349, 10675.57297708083, 10700.357978521313, 8270.048944371474, 8287.088420273885, 8310.459820111673, 8382.203690649378, 8426.957865210634, 17352.219150138022, 17427.56431089233, 17687.0, 18164.90917545404, 18370.0, 18127.546811329823, 18193.181306840957, 18414.631707366047, 18495.352662656744, 18517.44447666572, 10727.40999245049, 10802.783944321227, 10809.621663241749, 10867.239293249397, 10873.184511161853, 13239.66900827487, 13261.66845828862, 13316.600501984956, 13466.0, 13534.458621655023, 10596.8940310599, 10645.520951557353, 10857.511411986638, 10949.50727217293, 11079.944600276947, 10436.165106791286, 10704.518296676824, 10706.304090234109, 10718.0, 10924.071453926188, 9946.35348702332, 10020.448875311928, 10065.597376104874, 10108.0, 10113.443760593238, 7188.784336469915, 7243.710251589878, 7262.3826974707745, 7358.374538164316, 7388.113426388652, 6859.657017149222, 6893.931060689329, 6955.617441040791, 7048.612326321896, 7074.858502830018], "value": 6504.471983468313, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.9577491492949, 508.9516495932886, 522.0446582753561, 526.3368156123285, 529.5551736541307, 6063.029915213567, 6146.508279337648, 6171.734794367155, 6194.845128871769, 6232.781852635158, 5990.281166260055, 6008.609440386372, 6025.276966763983, 6111.786087486938, 6138.662373569452, 4931.309616653672, 4958.900821983558, 4995.650304478688, 5004.524570165847, 5043.646944713872, 4793.496682848303, 4917.139500587383, 4921.038563956014, 4955.355803745526, 4997.925031124536, 4891.679246603415, 4917.82787602434, 4943.802247910097, 4955.727434991092, 4976.427710813248, 4911.042346742387, 4914.336564563774, 4952.479989601076, 4955.182394904855, 4994.475580064113, 4343.543927887558, 4393.780310984438, 4399.756124376591, 4434.17967675981, 4440.911181776346, 5980.893534696095, 6024.415472793681, 6033.215681961361, 6085.9391406085815, 6129.295131059941, 5684.147377893349, 5719.28508936383, 5727.856803579903, 5729.799457019026, 5735.340435849889, 6521.250056243545, 6521.445677117451, 6549.508786840958, 6571.047198156289, 6571.769988050443, 4803.159447096779, 4817.410254615968, 4820.891195025129, 4827.493113223096, 4854.83008094715, 6768.8984665230555, 6794.932050679528, 6816.318368163194, 6844.657767111675, 6926.411255043327, 4885.706857588485, 4932.4081110267, 4934.703917764946, 4963.305137280783, 4965.4041515018425, 5045.8738531537, 5053.67151135175, 5059.215821547666, 5090.2364645303505, 5102.617303702237, 5602.85992850182, 5614.270144881221, 5629.2681951346885, 5688.829335119953, 5729.312482502127, 6460.0, 6460.3216662250725, 6497.902531462032, 6510.641914694737, 6527.36815796051, 1591.2123498867902, 1644.1779110444777, 1670.2149989504912, 1692.9492115236562, 1700.2858799304322, 1166.4401087478059, 1177.3171560494893, 1214.9247915594763, 1218.8110842819376, 1226.4726167747776, 5433.0, 5527.53015993637, 5541.007855757845, 5566.192902029183, 5648.85877853057, 6403.423691867754, 6430.356964303533, 6599.083682656355, 6617.272100068989, 6619.139511863427, 5570.108782594765, 5627.465390787868, 5652.293463317085, 5704.8859022819315, 5723.513501352349, 3441.969238149504, 3458.5849698036395, 3492.2666240089357, 3536.0, 3562.1628917204434, 6310.5267104967315, 6343.429091381798, 6353.428191462791, 6417.0, 6473.093766872642, 6750.919852823525, 6816.0, 6843.486738494533, 6848.14398200225, 6899.413549848218, 6230.501559875199, 6326.272478665012, 6353.142325786052, 6403.583767055126, 6431.0, 6443.903341449975, 6465.321141280097, 6546.18172728409, 6553.639549824806, 6557.704903279459, 6496.382843629847, 6526.24948130952, 6546.738130474918, 6602.7689030883685, 6659.7003134860015, 6420.357964203542, 6439.227292724903, 6450.870982580228, 6483.902741458976, 6505.5446118773125, 4950.188354966727, 4955.306257124078, 4959.900801984012, 4965.950340496549, 4977.054359671651, 6265.373462653881, 6572.737090516326, 6651.567648102858, 6717.731290748316, 6748.156480439945, 5967.403259673998, 6278.560500765086, 6280.937190628218, 6365.649889256136, 6403.423691867754, 6274.654893980693, 6330.430261276507, 6331.113644089924, 6434.131392261985, 6471.094046833353, 6179.598326108789, 6235.8197319366545, 6263.4362907338555, 6311.558190926591, 6331.398517140864, 6463.9980802975615, 6486.054183744764, 6488.610683359014, 6493.084540060788, 6502.219733631994, 6219.160413344322, 6228.408301211378, 6234.573452848528, 6252.812415627538, 6288.6855657217875], "value": 4979.978601759489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.6752601537432, 921.8064206516631, 926.1201858234671, 932.5943214701601, 935.5696379665353, 18800.341988030388, 20114.396568102944, 20658.38024859253, 20763.377098687026, 20769.688454673193, 18153.90923045386, 18694.53263668409, 18716.344927927526, 18721.719174212398, 18773.62452750944, 959.5490119643773, 977.8582105594685, 979.7942432089234, 980.2452111873853, 983.5082458770614, 954.2413781044052, 983.626222035629, 994.6021591363476, 998.3361064891839, 1003.5584342889142, 1047.544318221576, 1057.3814318623615, 1058.7935352606246, 1059.8039362717884, 1065.733566608348, 1050.4642632257528, 1051.8211903976342, 1059.7085801404598, 1060.199549340251, 1061.930974486656, 718.4503854551273, 749.8125468632842, 760.5550752809613, 760.9885851712229, 776.4875182379659, 20266.392008239778, 20426.489337766525, 20440.0, 20459.48851278715, 20482.795172048387, 21901.123955041778, 22064.88967555168, 22553.436164095863, 22744.772552274597, 22831.08675652972, 17475.650486990187, 17645.911770441195, 17671.293148274053, 17726.645467090715, 17890.642187156314, 3841.769493830379, 3842.8270727817317, 3864.3430616795213, 3868.400397938324, 3875.8837234883, 140534.0, 140762.29618851942, 143181.0, 144033.27983360016, 145756.27121864428, 17098.316067357166, 17293.0, 17362.13189340528, 17518.211680474153, 17537.473875783748, 31543.842280788907, 31823.204419889687, 32791.836040819646, 33102.0, 33162.66837331644, 8524.701635442854, 8546.743597692079, 8581.399302048922, 8613.26787223093, 8624.655013799504, 4305.16049370376, 4367.366731823931, 4404.779761011937, 4437.556244375602, 4438.378626992224, 5348.545373643284, 5484.095124304525, 5515.586331025189, 5520.972395137998, 5534.363548191929, 981.283662926068, 1009.6012075230243, 1011.9494025298706, 1022.616518805448, 1033.0599154769125, 669.3440428380214, 712.975045873392, 714.9034880291198, 722.2091809468624, 724.9130104387402, 11691.356975366267, 12216.816747748791, 12475.812862807064, 12800.551980680631, 13088.476460941647, 682.7234969837224, 689.5104475822222, 709.8757717399537, 713.7573225103386, 720.2185628593036, 5469.425710300441, 5494.780208791683, 5548.0, 5657.038303488417, 5671.2060311556415, 112950.0, 116537.0, 117241.4137929322, 117601.0, 121475.0, 106341.46829265804, 107481.4625926881, 109105.47104297036, 109541.0, 110448.4477577607, 92383.53808230915, 92677.0, 95660.0, 96455.51772241094, 97064.0293597055, 10140.391576505433, 10275.897241027495, 10353.17174626013, 10414.271001029856, 10424.0, 43551.34672979971, 44064.55935440733, 44142.77928610337, 44949.0, 45302.54697452983, 57469.71265143647, 58708.706456467444, 59234.40765592289, 59564.404355955885, 59706.40293597009, 15953.601159971093, 16098.11460369691, 16102.194890255207, 16291.0, 16414.42549510809, 17795.644087118446, 17888.91055544766, 17978.19098140613, 17981.280748770427, 18110.185041672892, 14787.630309242355, 15199.31603077842, 15204.16377099226, 15326.310316035582, 15531.22343882824, 15453.690926181638, 15504.689906202038, 15525.689486209987, 15607.843921561092, 15691.45079922243, 16070.758938615696, 16176.514704558882, 16230.51308460748, 16344.264508097402, 16671.416500422427, 11653.359065251154, 12004.0, 12067.75864482723, 12157.270563766202, 12336.198147120409, 11136.665900023012, 11170.441477926233, 11175.273607215506, 11189.713182984062, 11496.82754758696], "value": 9029.659688485794, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 109.0, 127.0, 116.0, 115.0, 112.0, 108.0, 112.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 126.0, 126.0, 146.0, 128.0, 123.0, 128.0, 117.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 163.0, 172.0, 163.0, 167.0, 164.0, 165.0, 176.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 84.0, 74.0, 80.0, 74.0, 82.0, 77.0, 81.0, 80.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 87.0, 80.0, 80.0, 79.0, 86.0, 79.0, 87.0, 85.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 114.0, 114.0, 114.0, 121.0, 152.0, 110.0, 116.0, 119.0], "value": 119.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 147.0, 149.0, 148.0, 148.0, 151.0, 152.0, 155.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 101.0, 98.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 57.0, 55.0, 55.0, 55.0, 58.0, 58.0, 54.0, 54.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 39.0, 49.0, 47.0, 47.0, 43.0, 44.0, 38.0, 40.0], "value": 43.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 84.0, 76.0, 74.0, 76.0, 75.0, 84.0, 88.0, 84.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 113.0, 113.0, 118.0, 123.0, 125.0, 113.0, 116.0, 112.0, 121.0], "value": 117.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 175.0, 176.0, 176.0, 173.0, 167.0, 176.0, 168.0, 170.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 70.0, 66.0, 67.0, 65.0, 65.0, 68.0, 66.0, 67.0], "value": 66.8, "unit": "score"}]}]} 16:14:07 INFO - Return code: 0 16:14:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:07 INFO - # TBPL SUCCESS # 16:14:07 INFO - Running post-action listener: _package_coverage_data 16:14:07 INFO - Running post-action listener: _resource_record_post_action 16:14:07 INFO - [mozharness: 2017-09-14 23:14:07.555940Z] Finished run-tests step (success) 16:14:07 INFO - Running post-run listener: _resource_record_post_run 16:14:07 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 3256320; Write bytes: 345784320; Read time: 612; Write time: 250924 16:14:07 INFO - TinderboxPrint: CPU usage
13.3% 16:14:07 INFO - TinderboxPrint: I/O read bytes / time
3,256,320 / 612 16:14:07 INFO - TinderboxPrint: I/O write bytes / time
345,784,320 / 250,924 16:14:07 INFO - TinderboxPrint: CPU idle
8,264.1 (86.7%) 16:14:07 INFO - TinderboxPrint: CPU user
1,204.9 (12.6%) 16:14:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13164544; Read time: 0; Write time: 904 16:14:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:14:07 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3252224; Write bytes: 332619776; Read time: 608; Write time: 250020 16:14:08 INFO - Running post-run listener: _upload_blobber_files 16:14:08 INFO - Blob upload gear active. 16:14:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:08 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 16:14:08 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'] 16:14:08 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 16:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:09 INFO - (blobuploader) - INFO - Done attempting. 16:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:10 INFO - (blobuploader) - INFO - Done attempting. 16:14:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:14:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:11 INFO - (blobuploader) - INFO - Done attempting. 16:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:18 INFO - (blobuploader) - INFO - Done attempting. 16:14:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:18 INFO - Return code: 0 16:14:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:14:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/068744cc8b38119c83c0a5b2e533c247af002872b33bfff3ea707cbc9bb4d533d8f9d8f04c3bef1af8d376ed0412b61f90c214c4a3892cededc8902717c8102d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dd977cb00609ea52efcfb83fbb5566c2483e3dc6cfe4a6f2e53ba54e494fdc4202d2d36a462f4993d4f2a325346f5e4f91cffe4f355313f55655a5dc542b8f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76b7526852579c7c8d5fe200fe29fae5f29be21ca9f90f44466e36fae5449b92f03871e7f2a4fe6e94ccc2c73bfa3aa5d4dc4df95f2eb5a517aa0d5ea6edc91a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993c7f177dfb7364420534bd3c916c13e81a41d055be4bc2635c834c3c116ceeea7f2238e4cbc4579fa6c0d85e2e76fcd715289111dcc07daa6161a1d2eb8c2d"} 16:14:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:14:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:14:18 INFO - Contents: 16:14:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/068744cc8b38119c83c0a5b2e533c247af002872b33bfff3ea707cbc9bb4d533d8f9d8f04c3bef1af8d376ed0412b61f90c214c4a3892cededc8902717c8102d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dd977cb00609ea52efcfb83fbb5566c2483e3dc6cfe4a6f2e53ba54e494fdc4202d2d36a462f4993d4f2a325346f5e4f91cffe4f355313f55655a5dc542b8f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76b7526852579c7c8d5fe200fe29fae5f29be21ca9f90f44466e36fae5449b92f03871e7f2a4fe6e94ccc2c73bfa3aa5d4dc4df95f2eb5a517aa0d5ea6edc91a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993c7f177dfb7364420534bd3c916c13e81a41d055be4bc2635c834c3c116ceeea7f2238e4cbc4579fa6c0d85e2e76fcd715289111dcc07daa6161a1d2eb8c2d"} 16:14:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:18 INFO - Copying logs to upload dir... 16:14:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:14:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.029343 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-14 16:14:18.753407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:14:18.757413) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/068744cc8b38119c83c0a5b2e533c247af002872b33bfff3ea707cbc9bb4d533d8f9d8f04c3bef1af8d376ed0412b61f90c214c4a3892cededc8902717c8102d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dd977cb00609ea52efcfb83fbb5566c2483e3dc6cfe4a6f2e53ba54e494fdc4202d2d36a462f4993d4f2a325346f5e4f91cffe4f355313f55655a5dc542b8f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76b7526852579c7c8d5fe200fe29fae5f29be21ca9f90f44466e36fae5449b92f03871e7f2a4fe6e94ccc2c73bfa3aa5d4dc4df95f2eb5a517aa0d5ea6edc91a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993c7f177dfb7364420534bd3c916c13e81a41d055be4bc2635c834c3c116ceeea7f2238e4cbc4579fa6c0d85e2e76fcd715289111dcc07daa6161a1d2eb8c2d"} build_url:https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/SB_Iszi2RUqvi8dFYD-q6Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/068744cc8b38119c83c0a5b2e533c247af002872b33bfff3ea707cbc9bb4d533d8f9d8f04c3bef1af8d376ed0412b61f90c214c4a3892cededc8902717c8102d", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dd977cb00609ea52efcfb83fbb5566c2483e3dc6cfe4a6f2e53ba54e494fdc4202d2d36a462f4993d4f2a325346f5e4f91cffe4f355313f55655a5dc542b8f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76b7526852579c7c8d5fe200fe29fae5f29be21ca9f90f44466e36fae5449b92f03871e7f2a4fe6e94ccc2c73bfa3aa5d4dc4df95f2eb5a517aa0d5ea6edc91a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/993c7f177dfb7364420534bd3c916c13e81a41d055be4bc2635c834c3c116ceeea7f2238e4cbc4579fa6c0d85e2e76fcd715289111dcc07daa6161a1d2eb8c2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:14:18.785589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:14:18.785915) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505415254.327565-419694516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:14:18.868879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:14:18.871223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:14:18.871538) ========= ========= Total master_lag: 0.30 =========