builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1506190824.86 results: success (0) revision: 49c307de076f6e16ffc64de9e45c3bc54573f64a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:24.861511) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:24.861951) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:24.862221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:24.906640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:24.906960) ========= 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=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 11:20:24-- 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% 109M=0s 2017-09-23 11:20:25 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.306943 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:25.241134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:25.241406) ========= 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=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015673 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:25.297479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:25.297770) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49c307de076f6e16ffc64de9e45c3bc54573f64a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49c307de076f6e16ffc64de9e45c3bc54573f64a --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=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 11:20:25,369 truncating revision to first 12 chars 2017-09-23 11:20:25,369 Setting DEBUG logging. 2017-09-23 11:20:25,369 attempt 1/10 2017-09-23 11:20:25,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/49c307de076f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 11:20:25,811 unpacking tar archive at: mozilla-beta-49c307de076f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:26.044425) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:26.044754) ========= script_repo_revision: 49c307de076f6e16ffc64de9e45c3bc54573f64a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:26.048193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:26.048477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 11:20:26.062062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-23 11:20:26.062630) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:26 INFO - MultiFileLogger online at 20170923 11:20:26 in /builds/slave/test 11:20:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:26 INFO - {'append_to_log': False, 11:20:26 INFO - 'base_work_dir': '/builds/slave/test', 11:20:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:26 INFO - 'code_coverage': False, 11:20:26 INFO - 'config_files': ('talos/linux_config.py',), 11:20:26 INFO - 'default_actions': ('clobber', 11:20:26 INFO - 'read-buildbot-config', 11:20:26 INFO - 'download-and-extract', 11:20:26 INFO - 'populate-webroot', 11:20:26 INFO - 'create-virtualenv', 11:20:26 INFO - 'install', 11:20:26 INFO - 'setup-mitmproxy', 11:20:26 INFO - 'run-tests'), 11:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:26 INFO - 'disable_ccov_upload': False, 11:20:26 INFO - 'disable_stylo': False, 11:20:26 INFO - 'download_minidump_stackwalk': True, 11:20:26 INFO - 'download_symbols': 'ondemand', 11:20:26 INFO - 'enable_stylo': False, 11:20:26 INFO - 'enable_webrender': False, 11:20:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:26 INFO - 'gecko_profile': False, 11:20:26 INFO - 'gecko_profile_interval': 0, 11:20:26 INFO - 'installer_path': 'installer.exe', 11:20:26 INFO - 'log_level': 'info', 11:20:26 INFO - 'log_name': 'talos', 11:20:26 INFO - 'log_to_console': True, 11:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:26 INFO - 'opt_config_files': (), 11:20:26 INFO - 'pip_index': False, 11:20:26 INFO - 'suite': 'dromaeojs-e10s', 11:20:26 INFO - 'system_bits': '32', 11:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:26 INFO - 'title': 'talos-linux64-ix-035', 11:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:26 INFO - 'use_talos_json': True, 11:20:26 INFO - 'verify': 'False', 11:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:26 INFO - 'work_dir': 'build'} 11:20:26 INFO - [mozharness: 2017-09-23 18:20:26.275262Z] Running clobber step. 11:20:26 INFO - Running pre-action listener: _resource_record_pre_action 11:20:26 INFO - Running main action method: clobber 11:20:26 INFO - rmtree: /builds/slave/test/build 11:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:27 INFO - Running post-action listener: _resource_record_post_action 11:20:27 INFO - [mozharness: 2017-09-23 18:20:27.273398Z] Finished clobber step (success) 11:20:27 INFO - [mozharness: 2017-09-23 18:20:27.273495Z] Running read-buildbot-config step. 11:20:27 INFO - Running pre-action listener: _resource_record_pre_action 11:20:27 INFO - Running main action method: read_buildbot_config 11:20:27 INFO - Using buildbot properties: 11:20:27 INFO - { 11:20:27 INFO - "project": "", 11:20:27 INFO - "product": "firefox", 11:20:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:20:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:20:27 INFO - "stage_platform": "linux64", 11:20:27 INFO - "basedir": "/builds/slave/test", 11:20:27 INFO - "buildnumber": 112, 11:20:27 INFO - "platform": "ubuntu64_hw", 11:20:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:27 INFO - "slavebuilddir": "test", 11:20:27 INFO - "taskId": "ZFZjFuS8QGaIWlj8TEDyLg", 11:20:27 INFO - "branch": "mozilla-beta", 11:20:27 INFO - "script_repo_revision": "production", 11:20:27 INFO - "revision": "49c307de076f6e16ffc64de9e45c3bc54573f64a", 11:20:27 INFO - "slavename": "talos-linux64-ix-035", 11:20:27 INFO - "repo_path": "releases/mozilla-beta" 11:20:27 INFO - } 11:20:27 INFO - Finding installer, test and symbols from parent task. 11:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFZjFuS8QGaIWlj8TEDyLg'}, attempt #1 11:20:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZFZjFuS8QGaIWlj8TEDyLg'}, attempt #1 11:20:28 INFO - Task dependencies: NK5WZIhOTKW0xbcQL__QCg 11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg'}, attempt #1 11:20:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 11:20:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.test_packages.json 11:20:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.crashreporter-symbols.zip 11:20:28 INFO - Running post-action listener: _resource_record_post_action 11:20:28 INFO - [mozharness: 2017-09-23 18:20:28.667119Z] Finished read-buildbot-config step (success) 11:20:28 INFO - [mozharness: 2017-09-23 18:20:28.667337Z] Running download-and-extract step. 11:20:28 INFO - Running pre-action listener: _resource_record_pre_action 11:20:28 INFO - Running main action method: download_and_extract 11:20:28 INFO - mkdir: /builds/slave/test/build/tests 11:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:28 INFO - trying https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.test_packages.json 11:20:28 INFO - Downloading https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:29 INFO - Downloaded 989 bytes. 11:20:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:29 INFO - Using the following test package requirements: 11:20:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:29 INFO - u'common': [u'target.common.tests.zip'], 11:20:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:29 INFO - u'target.web-platform.tests.tar.gz'], 11:20:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:20:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.common.tests.zip 11:20:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:29 INFO - Fetch https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.common.tests.zip into memory 11:20:31 INFO - Content-Length response header: 55177633 11:20:31 INFO - Bytes received: 55177633 11:20:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.talos.tests.zip 11:20:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:42 INFO - Fetch https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.talos.tests.zip into memory 11:20:44 INFO - Content-Length response header: 14509184 11:20:44 INFO - Bytes received: 14509184 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - trying https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 11:20:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:46 INFO - Downloaded 53585219 bytes. 11:20:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 11:20:46 INFO - mkdir: /builds/slave/test/properties 11:20:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:46 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:46 INFO - Contents: 11:20:46 INFO - build_url:https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 11:20:46 INFO - Running post-action listener: _resource_record_post_action 11:20:46 INFO - Running post-action listener: find_tests_for_verification 11:20:46 INFO - Running post-action listener: set_extra_try_arguments 11:20:46 INFO - [mozharness: 2017-09-23 18:20:46.417963Z] Finished download-and-extract step (success) 11:20:46 INFO - [mozharness: 2017-09-23 18:20:46.418062Z] Running populate-webroot step. 11:20:46 INFO - Running pre-action listener: _resource_record_pre_action 11:20:46 INFO - Running main action method: populate_webroot 11:20:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['tresize', 11:20:46 INFO - 'tcanvasmark']}, 11:20:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['dromaeo_css', 11:20:46 INFO - 'kraken']}, 11:20:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'tests': ['damp', 'tps']}, 11:20:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['damp', 'tps']}, 11:20:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['dromaeo_dom']}, 11:20:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['basic_compositor_video', 11:20:46 INFO - 'glvideo']}, 11:20:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['ts_paint_webext', 11:20:46 INFO - 'tp5o_webext']}, 11:20:46 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:46 INFO - 'ts_paint', 11:20:46 INFO - 'tpaint', 11:20:46 INFO - 'sessionrestore', 11:20:46 INFO - 'sessionrestore_many_windows', 11:20:46 INFO - 'sessionrestore_no_auto_restore', 11:20:46 INFO - 'tabpaint']}, 11:20:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['a11yr', 11:20:46 INFO - 'ts_paint', 11:20:46 INFO - 'tpaint', 11:20:46 INFO - 'sessionrestore', 11:20:46 INFO - 'sessionrestore_many_windows', 11:20:46 INFO - 'sessionrestore_no_auto_restore', 11:20:46 INFO - 'tabpaint']}, 11:20:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:20:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['perf_reftest_singletons']}, 11:20:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['bloom_basic']}, 11:20:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:46 INFO - 'tsvgr_opacity', 11:20:46 INFO - 'tart', 11:20:46 INFO - 'tscrollx', 11:20:46 INFO - 'tsvg_static']}, 11:20:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['tsvgx', 11:20:46 INFO - 'tsvgr_opacity', 11:20:46 INFO - 'tart', 11:20:46 INFO - 'tscrollx', 11:20:46 INFO - 'tsvg_static']}, 11:20:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo'], 11:20:46 INFO - 'tests': ['tp5o']}, 11:20:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:46 INFO - 'talos_options': ['--mitmproxy', 11:20:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:46 INFO - '--firstNonBlankPaint'], 11:20:46 INFO - 'tests': ['tp6_google', 11:20:46 INFO - 'tp6_youtube', 11:20:46 INFO - 'tp6_amazon', 11:20:46 INFO - 'tp6_facebook']}, 11:20:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo', 11:20:46 INFO - '--mitmproxy', 11:20:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:46 INFO - '--firstNonBlankPaint'], 11:20:46 INFO - 'tests': ['tp6_google', 11:20:46 INFO - 'tp6_youtube', 11:20:46 INFO - 'tp6_amazon', 11:20:46 INFO - 'tp6_facebook']}, 11:20:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:46 INFO - 'talos_options': ['--stylo-threads=1', 11:20:46 INFO - '--mitmproxy', 11:20:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:46 INFO - '--firstNonBlankPaint'], 11:20:46 INFO - 'tests': ['tp6_google', 11:20:46 INFO - 'tp6_youtube', 11:20:46 INFO - 'tp6_amazon', 11:20:46 INFO - 'tp6_facebook']}, 11:20:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--xperf_path', 11:20:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:46 INFO - 'tests': ['tp5n']}, 11:20:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:46 INFO - 'talos_options': ['--disable-stylo', 11:20:46 INFO - '--xperf_path', 11:20:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:46 INFO - 'tests': ['tp5n']}}} 11:20:46 INFO - Running post-action listener: _resource_record_post_action 11:20:46 INFO - [mozharness: 2017-09-23 18:20:46.436042Z] Finished populate-webroot step (success) 11:20:46 INFO - [mozharness: 2017-09-23 18:20:46.436132Z] Running create-virtualenv step. 11:20:46 INFO - Running pre-action listener: _resource_record_pre_action 11:20:46 INFO - Running main action method: create_virtualenv 11:20:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:20:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:47 INFO - Installing pip...............done. 11:20:47 INFO - Return code: 0 11:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:47 INFO - Reading from file tmpfile_stdout 11:20:47 INFO - Output received: 11:20:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:20:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:47 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:47 INFO - Using env: {'DISPLAY': ':0', 11:20:47 INFO - 'HOME': '/home/cltbld', 11:20:47 INFO - 'LANG': 'en_US.UTF-8', 11:20:47 INFO - 'LANGUAGE': 'en_US:en', 11:20:47 INFO - 'LOGNAME': 'cltbld', 11:20:47 INFO - 'MAIL': '/var/mail/cltbld', 11:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:47 INFO - 'MOZ_NO_REMOTE': '1', 11:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:47 INFO - 'NO_EM_RESTART': '1', 11:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:47 INFO - 'PWD': '/builds/slave/test', 11:20:47 INFO - 'SHELL': '/bin/bash', 11:20:47 INFO - 'SHLVL': '1', 11:20:47 INFO - 'TERM': 'linux', 11:20:47 INFO - 'TMOUT': '86400', 11:20:47 INFO - 'USER': 'cltbld', 11:20:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:47 INFO - '_': '/tools/buildbot/bin/python'} 11:20:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:20:48 INFO - Downloading/unpacking pip>=1.5 11:20:48 INFO - Running setup.py egg_info for package pip 11:20:48 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:48 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:48 INFO - Installing collected packages: pip 11:20:48 INFO - Found existing installation: pip 1.1 11:20:48 INFO - Uninstalling pip: 11:20:48 INFO - Successfully uninstalled pip 11:20:48 INFO - Running setup.py install for pip 11:20:48 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:48 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:20:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:20:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:20:48 INFO - Successfully installed pip 11:20:48 INFO - Cleaning up... 11:20:48 INFO - Return code: 0 11:20:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:48 INFO - Using env: {'DISPLAY': ':0', 11:20:48 INFO - 'HOME': '/home/cltbld', 11:20:48 INFO - 'LANG': 'en_US.UTF-8', 11:20:48 INFO - 'LANGUAGE': 'en_US:en', 11:20:48 INFO - 'LOGNAME': 'cltbld', 11:20:48 INFO - 'MAIL': '/var/mail/cltbld', 11:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:48 INFO - 'MOZ_NO_REMOTE': '1', 11:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:48 INFO - 'NO_EM_RESTART': '1', 11:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:48 INFO - 'PWD': '/builds/slave/test', 11:20:48 INFO - 'SHELL': '/bin/bash', 11:20:48 INFO - 'SHLVL': '1', 11:20:48 INFO - 'TERM': 'linux', 11:20:48 INFO - 'TMOUT': '86400', 11:20:48 INFO - 'USER': 'cltbld', 11:20:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:48 INFO - '_': '/tools/buildbot/bin/python'} 11:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:49 INFO - Downloading/unpacking psutil>=3.1.1 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:50 INFO - Installing collected packages: psutil 11:20:50 INFO - Running setup.py install for psutil 11:20:50 INFO - building 'psutil._psutil_linux' extension 11:20:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:20:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:20:50 INFO - building 'psutil._psutil_posix' extension 11:20:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:20:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:50 INFO - Successfully installed psutil 11:20:50 INFO - Cleaning up... 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:52 INFO - Installing collected packages: mozsystemmonitor 11:20:52 INFO - Running setup.py install for mozsystemmonitor 11:20:52 INFO - Successfully installed mozsystemmonitor 11:20:52 INFO - Cleaning up... 11:20:52 INFO - Return code: 0 11:20:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', '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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20: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 jsonschema==2.5.1 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:20: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 11:20: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 11:20: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 11:20: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 11:20:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:55 INFO - warning: no files found matching '*.txt' 11:20:55 INFO - no previously-included directories found matching 'build' 11:20:55 INFO - no previously-included directories found matching 'dist' 11:20:55 INFO - no previously-included directories found matching '.git*' 11:20:55 INFO - Installing collected packages: jsonschema, functools32 11:20:55 INFO - Running setup.py install for functools32 11:20:55 INFO - warning: no files found matching '*.txt' 11:20:55 INFO - no previously-included directories found matching 'build' 11:20:55 INFO - no previously-included directories found matching 'dist' 11:20:55 INFO - no previously-included directories found matching '.git*' 11:20:55 INFO - Successfully installed jsonschema functools32 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', '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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:20: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 functools32==3.2.3-2 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:55 INFO - Cleaning up... 11:20:55 INFO - Return code: 0 11:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', '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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:20: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 blobuploader==1.2.4 11:20:55 INFO - Using env: {'DISPLAY': ':0', 11:20:55 INFO - 'HOME': '/home/cltbld', 11:20:55 INFO - 'LANG': 'en_US.UTF-8', 11:20:55 INFO - 'LANGUAGE': 'en_US:en', 11:20:55 INFO - 'LOGNAME': 'cltbld', 11:20:55 INFO - 'MAIL': '/var/mail/cltbld', 11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:55 INFO - 'MOZ_NO_REMOTE': '1', 11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:55 INFO - 'NO_EM_RESTART': '1', 11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:55 INFO - 'PWD': '/builds/slave/test', 11:20:55 INFO - 'SHELL': '/bin/bash', 11:20:55 INFO - 'SHLVL': '1', 11:20:55 INFO - 'TERM': 'linux', 11:20:55 INFO - 'TMOUT': '86400', 11:20:55 INFO - 'USER': 'cltbld', 11:20:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:55 INFO - '_': '/tools/buildbot/bin/python'} 11:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Downloading docopt-0.6.1.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:57 INFO - Running setup.py install for blobuploader 11:20:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:57 INFO - Running setup.py install for requests 11:20:57 INFO - Running setup.py install for docopt 11:20:58 INFO - Successfully installed blobuploader requests docopt 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:58 INFO - Running setup.py (path:/tmp/pip-qGPIeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:58 INFO - Running setup.py (path:/tmp/pip-88Bolk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:58 INFO - Running setup.py (path:/tmp/pip-EyymiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:58 INFO - Running setup.py (path:/tmp/pip-N4CISm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:58 INFO - Running setup.py (path:/tmp/pip-qQFt7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:58 INFO - Running setup.py (path:/tmp/pip-11bDm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:58 INFO - Running setup.py (path:/tmp/pip-c0Mg_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:58 INFO - Running setup.py (path:/tmp/pip-D1QaP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:58 INFO - Running setup.py (path:/tmp/pip-ukGS6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:58 INFO - Running setup.py (path:/tmp/pip-ggBvFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 INFO - Running setup.py (path:/tmp/pip-NZREUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:59 INFO - Running setup.py (path:/tmp/pip-YBDIz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:59 INFO - Running setup.py (path:/tmp/pip-kNu9U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:59 INFO - Running setup.py (path:/tmp/pip-AYg4lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:59 INFO - Running setup.py (path:/tmp/pip-2pgbEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:59 INFO - Running setup.py (path:/tmp/pip-acv4v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:59 INFO - Running setup.py (path:/tmp/pip-uFpOaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:59 INFO - Running setup.py install for manifestparser 11:20:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:59 INFO - Running setup.py install for mozcrash 11:20:59 INFO - Running setup.py install for mozdebug 11:20:59 INFO - Running setup.py install for mozdevice 11:20:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:59 INFO - Running setup.py install for mozfile 11:21:00 INFO - Running setup.py install for mozhttpd 11:21:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozinfo 11:21:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozInstall 11:21:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozleak 11:21:00 INFO - Running setup.py install for mozlog 11:21:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for moznetwork 11:21:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozprocess 11:21:00 INFO - Running setup.py install for mozprofile 11:21:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozrunner 11:21:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:00 INFO - Running setup.py install for mozscreenshot 11:21:01 INFO - Running setup.py install for moztest 11:21:01 INFO - Running setup.py install for mozversion 11:21:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:01 INFO - Using env: {'DISPLAY': ':0', 11:21:01 INFO - 'HOME': '/home/cltbld', 11:21:01 INFO - 'LANG': 'en_US.UTF-8', 11:21:01 INFO - 'LANGUAGE': 'en_US:en', 11:21:01 INFO - 'LOGNAME': 'cltbld', 11:21:01 INFO - 'MAIL': '/var/mail/cltbld', 11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:01 INFO - 'MOZ_NO_REMOTE': '1', 11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:01 INFO - 'NO_EM_RESTART': '1', 11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:01 INFO - 'PWD': '/builds/slave/test', 11:21:01 INFO - 'SHELL': '/bin/bash', 11:21:01 INFO - 'SHLVL': '1', 11:21:01 INFO - 'TERM': 'linux', 11:21:01 INFO - 'TMOUT': '86400', 11:21:01 INFO - 'USER': 'cltbld', 11:21:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:01 INFO - '_': '/tools/buildbot/bin/python'} 11:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:01 INFO - Running setup.py (path:/tmp/pip-09Mc3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:01 INFO - Running setup.py (path:/tmp/pip-wT3hbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:01 INFO - Running setup.py (path:/tmp/pip-n9F3Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:01 INFO - Running setup.py (path:/tmp/pip-cPvt8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:01 INFO - Running setup.py (path:/tmp/pip-ZNr7LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:01 INFO - Running setup.py (path:/tmp/pip-jj5y28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:01 INFO - Running setup.py (path:/tmp/pip-jBjNOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:01 INFO - Running setup.py (path:/tmp/pip-Nq8m4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:02 INFO - Running setup.py (path:/tmp/pip-nBTyTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:02 INFO - Running setup.py (path:/tmp/pip-jqKnD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:02 INFO - Running setup.py (path:/tmp/pip-8uSXpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:02 INFO - Running setup.py (path:/tmp/pip-16DlSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:02 INFO - Running setup.py (path:/tmp/pip-mf2e__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:02 INFO - Running setup.py (path:/tmp/pip-8UgxiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:02 INFO - Running setup.py (path:/tmp/pip-_7jap0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:02 INFO - Running setup.py (path:/tmp/pip-XuBLBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:02 INFO - Running setup.py (path:/tmp/pip-njKTAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading blessings-1.6.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:03 INFO - Installing collected packages: blessings 11:21:03 INFO - Running setup.py install for blessings 11:21:04 INFO - Successfully installed blessings 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:04 INFO - Reading from file tmpfile_stdout 11:21:04 INFO - Current package versions: 11:21:04 INFO - argparse == 1.2.1 11:21:04 INFO - blessings == 1.6 11:21:04 INFO - blobuploader == 1.2.4 11:21:04 INFO - docopt == 0.6.1 11:21:04 INFO - functools32 == 3.2.3-2 11:21:04 INFO - jsonschema == 2.5.1 11:21:04 INFO - manifestparser == 1.1 11:21:04 INFO - mozInstall == 1.13 11:21:04 INFO - mozcrash == 1.0 11:21:04 INFO - mozdebug == 0.1 11:21:04 INFO - mozdevice == 0.51 11:21:04 INFO - mozfile == 1.2 11:21:04 INFO - mozhttpd == 0.7 11:21:04 INFO - mozinfo == 0.10 11:21:04 INFO - mozleak == 0.1 11:21:04 INFO - mozlog == 3.5 11:21:04 INFO - moznetwork == 0.27 11:21:04 INFO - mozprocess == 0.25 11:21:04 INFO - mozprofile == 0.28 11:21:04 INFO - mozrunner == 6.13 11:21:04 INFO - mozscreenshot == 0.1 11:21:04 INFO - mozsystemmonitor == 0.3 11:21:04 INFO - moztest == 0.8 11:21:04 INFO - mozversion == 1.4 11:21:04 INFO - psutil == 3.1.1 11:21:04 INFO - requests == 1.2.3 11:21:04 INFO - wsgiref == 0.1.2 11:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:04 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 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:04 INFO - Using env: {'DISPLAY': ':0', 11:21:04 INFO - 'HOME': '/home/cltbld', 11:21:04 INFO - 'LANG': 'en_US.UTF-8', 11:21:04 INFO - 'LANGUAGE': 'en_US:en', 11:21:04 INFO - 'LOGNAME': 'cltbld', 11:21:04 INFO - 'MAIL': '/var/mail/cltbld', 11:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:04 INFO - 'MOZ_NO_REMOTE': '1', 11:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:04 INFO - 'NO_EM_RESTART': '1', 11:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:04 INFO - 'PWD': '/builds/slave/test', 11:21:04 INFO - 'SHELL': '/bin/bash', 11:21:04 INFO - 'SHLVL': '1', 11:21:04 INFO - 'TERM': 'linux', 11:21:04 INFO - 'TMOUT': '86400', 11:21:04 INFO - 'USER': 'cltbld', 11:21:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:04 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:05 INFO - Installing collected packages: simplejson 11:21:05 INFO - Running setup.py install for simplejson 11:21:05 INFO - building 'simplejson._speedups' extension 11:21:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:21:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:21:06 INFO - Successfully installed simplejson 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, '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': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:06 INFO - Using env: {'DISPLAY': ':0', 11:21:06 INFO - 'HOME': '/home/cltbld', 11:21:06 INFO - 'LANG': 'en_US.UTF-8', 11:21:06 INFO - 'LANGUAGE': 'en_US:en', 11:21:06 INFO - 'LOGNAME': 'cltbld', 11:21:06 INFO - 'MAIL': '/var/mail/cltbld', 11:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:06 INFO - 'MOZ_NO_REMOTE': '1', 11:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:06 INFO - 'NO_EM_RESTART': '1', 11:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:06 INFO - 'PWD': '/builds/slave/test', 11:21:06 INFO - 'SHELL': '/bin/bash', 11:21:06 INFO - 'SHLVL': '1', 11:21:06 INFO - 'TERM': 'linux', 11:21:06 INFO - 'TMOUT': '86400', 11:21:06 INFO - 'USER': 'cltbld', 11:21:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:06 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Running post-action listener: _resource_record_post_action 11:21:06 INFO - Running post-action listener: _start_resource_monitoring 11:21:06 INFO - Starting resource monitoring. 11:21:07 INFO - [mozharness: 2017-09-23 18:21:07.000432Z] Finished create-virtualenv step (success) 11:21:07 INFO - [mozharness: 2017-09-23 18:21:07.000943Z] Running install step. 11:21:07 INFO - Running pre-action listener: _resource_record_pre_action 11:21:07 INFO - Running main action method: install 11:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:07 INFO - Reading from file tmpfile_stdout 11:21:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:07 INFO - Reading from file tmpfile_stdout 11:21:07 INFO - Output received: 11:21:07 INFO - Usage: mozinstall [options] installer 11:21:07 INFO - Options: 11:21:07 INFO - -h, --help show this help message and exit 11:21:07 INFO - -d DEST, --destination=DEST 11:21:07 INFO - Directory to install application into. [default: 11:21:07 INFO - "/builds/slave/test"] 11:21:07 INFO - --app=APP Application being installed. [default: firefox] 11:21:07 INFO - mkdir: /builds/slave/test/build/application 11:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:21 INFO - Reading from file tmpfile_stdout 11:21:21 INFO - Output received: 11:21:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:21 INFO - Running post-action listener: _resource_record_post_action 11:21:21 INFO - [mozharness: 2017-09-23 18:21:21.958311Z] Finished install step (success) 11:21:21 INFO - [mozharness: 2017-09-23 18:21:21.958636Z] Running setup-mitmproxy step. 11:21:21 INFO - Running pre-action listener: _resource_record_pre_action 11:21:21 INFO - Running main action method: setup_mitmproxy 11:21:21 INFO - Skipping: mitmproxy is not required 11:21:21 INFO - Running post-action listener: _resource_record_post_action 11:21:21 INFO - [mozharness: 2017-09-23 18:21:21.959769Z] Finished setup-mitmproxy step (success) 11:21:21 INFO - [mozharness: 2017-09-23 18:21:21.959997Z] Running run-tests step. 11:21:21 INFO - Running pre-action listener: _resource_record_pre_action 11:21:21 INFO - Running pre-action listener: _set_gcov_prefix 11:21:21 INFO - Running main action method: run_tests 11:21:21 WARNING - Try message not found. 11:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:21 INFO - Python 2.7.3 11:21:21 INFO - Return code: 0 11:21:21 INFO - grabbing minidump binary from tooltool 11:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:21 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 0x135f090>, '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 0x135fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1359f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:21 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:22 INFO - Return code: 0 11:21:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - ENV: RUST_BACKTRACE is now full 11:21:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:22 INFO - Using env: {'DISPLAY': ':0', 11:21:22 INFO - 'HOME': '/home/cltbld', 11:21:22 INFO - 'LANG': 'en_US.UTF-8', 11:21:22 INFO - 'LANGUAGE': 'en_US:en', 11:21:22 INFO - 'LOGNAME': 'cltbld', 11:21:22 INFO - 'MAIL': '/var/mail/cltbld', 11:21:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:22 INFO - 'MOZ_NO_REMOTE': '1', 11:21:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:22 INFO - 'NO_EM_RESTART': '1', 11:21:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:22 INFO - 'PWD': '/builds/slave/test', 11:21:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:22 INFO - 'RUST_BACKTRACE': 'full', 11:21:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:22 INFO - 'SHELL': '/bin/bash', 11:21:22 INFO - 'SHLVL': '1', 11:21:22 INFO - 'TERM': 'linux', 11:21:22 INFO - 'TMOUT': '86400', 11:21:22 INFO - 'USER': 'cltbld', 11:21:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:22 INFO - '_': '/tools/buildbot/bin/python'} 11:21:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:22 INFO - mozversion application_buildid: 20170923170025 11:21:22 INFO - mozversion application_changeset: 49c307de076f6e16ffc64de9e45c3bc54573f64a 11:21:22 INFO - mozversion application_display_name: Firefox 11:21:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:22 INFO - mozversion application_name: Firefox 11:21:22 INFO - mozversion application_remotingname: firefox 11:21:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:22 INFO - mozversion application_vendor: Mozilla 11:21:22 INFO - mozversion application_version: 57.0 11:21:22 INFO - mozversion platform_buildid: 20170923170025 11:21:22 INFO - mozversion platform_changeset: 49c307de076f6e16ffc64de9e45c3bc54573f64a 11:21:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:21:22 INFO - mozversion platform_version: 57.0 11:21:22 INFO - using testdate: 1506190882 11:21:22 INFO - actual date: 1506190882 11:21:22 INFO - starting webserver on 'localhost:56110' 11:21:22 INFO - SUITE-START | Running 2 tests 11:21:22 INFO - TEST-START | dromaeo_css 11:21:22 INFO - Initialising browser for dromaeo_css test... 11:21:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56110/getInfo.html -profile /tmp/tmp61GYtl/profile 11:21:22 INFO - TEST-INFO | started process 12541 (/builds/slave/test/build/application/firefox/firefox http://localhost:56110/getInfo.html) 11:21:27 INFO - TEST-INFO | 12541: exit 0 11:21:27 INFO - Browser initialized. 11:21:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:27 INFO - Using env: {'DISPLAY': ':0', 11:21:27 INFO - 'HOME': '/home/cltbld', 11:21:27 INFO - 'JSGC_DISABLE_POISONING': '1', 11:21:27 INFO - 'LANG': 'en_US.UTF-8', 11:21:27 INFO - 'LANGUAGE': 'en_US:en', 11:21:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:21:27 INFO - 'LOGNAME': 'cltbld', 11:21:27 INFO - 'MAIL': '/var/mail/cltbld', 11:21:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:27 INFO - 'MOZ_CRASHREPORTER': '1', 11:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:21:27 INFO - 'MOZ_NO_REMOTE': '1', 11:21:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:27 INFO - 'NO_EM_RESTART': '1', 11:21:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:27 INFO - 'PWD': '/builds/slave/test', 11:21:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:27 INFO - 'RUST_BACKTRACE': 'full', 11:21:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:27 INFO - 'SHELL': '/bin/bash', 11:21:27 INFO - 'SHLVL': '1', 11:21:27 INFO - 'TERM': 'linux', 11:21:27 INFO - 'TMOUT': '86400', 11:21:27 INFO - 'USER': 'cltbld', 11:21:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:27 INFO - '_': '/tools/buildbot/bin/python'} 11:21:27 INFO - TEST-INFO | started process 12731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61GYtl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:38 INFO - PID 12731 | RSS: Main: 144506880 11:21:38 INFO - PID 12731 | 11:24:36 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56110/tests/dromaeo/cssquery-ext.html) 11:24:37 INFO - PID 12731 | RSS: Main: 147505152 11:24:37 INFO - PID 12731 | 11:27:38 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-ext.html (next: http://localhost:56110/tests/dromaeo/cssquery-jquery.html) 11:27:39 INFO - PID 12731 | RSS: Main: 145203200 11:27:39 INFO - PID 12731 | 11:30:40 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56110/tests/dromaeo/cssquery-mootools.html) 11:30:41 INFO - PID 12731 | RSS: Main: 147570688 11:30:41 INFO - PID 12731 | 11:33:43 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56110/tests/dromaeo/cssquery-prototype.html) 11:33:43 INFO - PID 12731 | RSS: Main: 147046400 11:33:43 INFO - PID 12731 | 11:36:46 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56110/tests/dromaeo/cssquery-yui.html) 11:36:47 INFO - PID 12731 | RSS: Main: 148819968 11:36:47 INFO - PID 12731 | 11:39:48 INFO - PID 12731 | Cycle 1(1): loaded http://localhost:56110/tests/dromaeo/cssquery-yui.html (next: http://localhost:56110/tests/dromaeo/cssquery-dojo.html) 11:39:49 INFO - PID 12731 | RSS: Main: 151486464 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | __start_tp_report 11:39:49 INFO - PID 12731 | _x_x_mozilla_page_load 11:39:49 INFO - PID 12731 | _x_x_mozilla_page_load_details 11:39:49 INFO - PID 12731 | |i|pagename|runs| 11:39:49 INFO - PID 12731 | |0;dojo.html;4037.4953130858644;4053.1893621275744;4056.3307054336037;4059.7158198926077;4059.959400405997;6509.842237980332;6554.016897465371;6645.368689974457;6645.800625981216;6664.833379165511;6577.473802095833;6579.210494740626;6586.8682626347445;6652.733890644368;6681.131452911115;5894.410558944114;5917.260342457193;5941.643501389931;5974.79088231912;5987.22166118404;5935.703214839263;5975.970120149394;5980.43185897339;5980.671063091529;6011.669358185298;5968.940310596882;6002.429769171922;6018.6990650467305;6023.668698221596;6027.09593560965;5889.705514724289;6036.15493830864;6042.274927008765;6052.122442245894;6066.939330606704;5878.323992740847;5950.523958083343;5966.97016514919;6030.547708921848;6050.54620903434;6485.351464853524;6540.149780528548;6577.210734711817;6583.967080164569;6661.16735408074;7178.928210717931;7224.4581656375985;7263.273672632748;7268.345848873574;7272.527285726411;7250.3112204340505;7265;7267.49127561071;7276.708931642728;7367.852642947165;6626.2048554173325;6693.631850248283;6707.530472866902;6712.429443497309;6775.1531058617675;7348.595827229554;7361.668724907392;7364;7364.22675619063;7366.889496657554;7061.470389720792;7063.823404414828;7136.072310599693;7147.571145731273;7163.42692584592;7216.927830721731;7235.493515453868;7295;7303.160136584254;7325.304096110861;7100.360967512948;7151.213366529678;7168.3548480635945;7168.924661300743;7235.963820180866;7119.1457025157315;7136.250693677193;7161.212266650664;7178.497505174692;7178.820529486805;5378.300820893337;5382.138857782736;5407.972485227794;5413.296271484761;5416.133418652997;4851.733154676526;4852.223644216909;4857.1742803723455;4879.950810575743;4880.511948805091;6556.409923106943;6642.1033160523675;6674.16572928384;6675.899861502081;6731.057651928734;7239.8552028960175;7249.927500724925;7259.564426134449;7276.745313913988;7282.198958114604;6650.933490665128;6654.6672666366485;6666.200055993312;6671.933280667228;6760.7295708172105;6054.364291749391;6120.632762034292;6198.690065496798;6199.938000619936;6218.968905155445;7378.520396174232;7413.740519081806;7477.4391920605085;7478.140013898471;7509.17399086111;7085.929140708527;7199.217931708776;7266.781996540112;7295.379892709179;7308.634568271672;7396.519226250277;7418.666160022704;7439.55362678241;7511.887321690069;7532.924670753441;6983.476239281973;7065.2934706531;7095.290470952863;7165.319294666998;7170.856582868418;7273.199948005821;7276.7089316428865;7279.1265048194555;7296.270372962661;7304.598247096461;6929.861402772017;6959.826004349729;6961.477889158232;7017.964910175417;7020.157581090302;6879.140107486564;6959.547629404073;6959.965200173967;6989.30106989297;6990.580565166107;6891.276415976451;6909.2399836019;6924.757633482804;6935.583864968118;6938.306169383021;6995.055667485028;7025.543339682904;7047.400970917324;7051.5063945523325;7057.541259818096;6651.235107962452;6756.425703815231;6817.352351526597;6908.723651053901;6918.654067296515 11:39:49 INFO - PID 12731 | |1;ext.html;973.7711637765128;988.3871999360398;1020.8928062553432;1045.9058684718377;1048.528162326953;45103.548964510344;45719.77140114295;45751.313730294074;45866.312005319865;45980.999999999956;43215.567844321544;43479.78260108695;43519.34720979188;43525.78237108818;43581.7820910895;8091.514509129456;8284.83430331393;8289.668413263462;8291.08798032216;8295.709650162245;8014.5591992440395;8142.43002989791;8151.347892168612;8164.836703265931;8170.142135075791;8759.080296568864;8883.378163528556;8887.244584210317;8900.73297801067;8908.797312362813;8824.249938755182;8842.778930526723;8883.911160888438;8887.511186884718;8889.022207557164;8661.783455413602;8828.823423531558;8829;8830.337724670675;8833.955830220872;41495.7925210375;41749.79125104355;41817.37273940894;42031;42129.789351053354;3891.8832435026993;3959;3960.148568057881;3961.445397644332;3972.3644216925154;35682.82158589216;35744.46383304252;35759.64240357615;35813.92558223257;35859.10352241189;5559.11054231321;5709.115087161455;5727.140928860663;5779.306483221998;5855.443732845373;228560;228743;229643;230088;230447;55131;55139.724301379036;55236.44763552393;57363.13955290674;57865.421345786;59033.40966590365;59667.70166149142;59718.40281597128;59728.402715973156;59832;18421.447356579323;18485.53786155357;18597.90701046486;18626.254949801856;18634.53413664642;15216.847831521543;15297.617559560877;15298.541043768704;15341.079535227922;15347.309371078329;15646.687066258839;15683.372665093497;15822.525324240061;15897.602559936095;15940.362385504683;5851.385604511465;5942.70286485674;5977.3126090500145;5998.490128339053;6001.279846418458;1126.2566705974018;1143.8341440491083;1148.6439203846835;1151.4703236511298;1151.7120719820045;26498;26704.06535771239;26881.596776048376;26943.326416839343;27029.324266893484;1247.7379750252367;1259.6284096191462;1259.9685007874693;1263.6524955637274;1270.244204698203;14229.28853557318;14270.571882843531;14271;14338.354774035193;14583.416663333348;326715;326849;326928;327862;328341;60846.69576652088;61317.69341153266;64590;65293.67353163204;65348.34651653423;1532.7930729351617;1552.185102821028;1558.4078050340797;1574.0083747239166;1591.2441590244773;31762.364752705278;31904.84047579747;32581.674183257863;32728.34543309168;33005.66994330026;44207.55792442035;44261.11477770491;44401.999999998705;44539.10921781482;44575.77712111548;282585;283876;284321;284666;285257;39129.6087039126;39209.607903920594;39318.803405982784;39402.2119557613;39447.802760986015;47911;49789.751051244515;50281.24578131404;50469.74765126151;50570.74714626403;36531;36667.81666091759;36719.45114776412;36853.44719829151;37070.44394334033;36176.45735314025;36650.8167459161;36721;36768.05855531605;37120.07199820026;42316;42450.575494244666;42760;42784.14431711286;42849.57150428581;34861.65138348584;34930.301393972484;34980.65019349774;35205.471917921765;35431.11422214465;26057.348566285993;26518.204453866416;26584.734152659;26711.599326010513;26778.062767803032 11:39:49 INFO - PID 12731 | |2;jquery.html;649.9860218059827;661.1174082599729;663.4938689175572;673.6261374936909;674.5076094451053;24505.142320018804;25221.74778252217;25307.62038569423;25312;25345.493090138185;26932.461350772974;26999.325016874587;27069.1879243623;27446.313842153955;27455.450890982167;6597.868042639145;6769.255381907986;6792.218894827084;6803.081583986148;6814.318568143196;6687.799366019003;6736.663166841663;6784.72861085556;6796.966015169917;6804.18349798025;6242.719077641517;6864.622445765481;6907.620080895574;6910.5853648780985;6914.274001229874;6827.351401616838;6864.176298844171;6884.690188941485;6885.518013739015;6890.655467226618;6428.742850285983;6465.4827613790785;6471.708773105222;6480.967595161994;6483.059956306356;30930;31359.37281254362;31362.372752544823;31457;31516.842415788004;2169.9891500542394;2174.6411842046045;2186.8797216153107;2187.84685072045;2188.1356864038776;21581.784182158135;21851.235206767848;21912.342629721134;21925.342239732832;21971.890140549196;2553.6041913503436;2615.9869200654066;2684.315499547603;2712.389712314733;2713.1996061162004;146062;150779;158800.20599896926;164689.17655411645;165058;16677.332906683598;17496.737548936777;17587.384441544484;17616.119194040246;17714;27408.725912740618;27412;27494;27529;27594;11501.827472587918;11816.46825892837;11818.881811181951;11880.287182769061;11913.463894124785;10760.461976901124;10782.46087695612;10840.186985976083;10840.78318433627;10879.83680244797;10299.330543514647;10503.684889453329;10565.418901960466;10614.522346494427;10644.25490215693;3002.8198308101582;3005.911959734759;3078.2766049978236;3123.6095488063993;3222.581064461605;1032.8244198486275;1049.1449468683;1059.7986382587283;1066.3921564708041;1069.7432616172064;20780.27269045576;21368.893155534435;21645.025973831216;21728.891355543437;21836.23573174931;1136.6419577832955;1138.635636596298;1139.1171841822488;1141.7602303516355;1149.0749946293147;11528.538858445736;11709.121815863844;11781.941090294493;11825.526978920747;11924.224925379822;652893;655382;658848;660925;691619;135821.32089339689;137155;137686;140329;141426;1291.702908331089;1313.9211647301192;1364.6315494816345;1380.2339701465582;1391.6173052410668;23257.651135233322;23267.76732232656;23314.766852331937;23329.533409332056;23430.76569234354;69223.65388173026;69411.95882061672;69469;72214.63892680503;72271.63864180645;83922.16077839144;84542;84677.57661211655;85648.57175714082;86651;16098.11460369644;16299.511014669579;16426;16482.34070637161;16489.09309987962;24191.879040604683;24529.632055518825;24818.627720583845;24937.127200547893;25175;19872.50318742043;20271.59456810885;20298.289559865334;20307.898460508193;20324.390268291976;17485.65028699444;17568.73646895272;18121.90939045296;18181.45455636333;18473.983930883394;19693.212271509554;19920;20319.79680203179;20352.389428317176;20381.49046273855;15958;16064.518064458085;16132.19339033067;16163.67672646564;16248.268827902537;19712.21151153938;19755.308564200182;19771;19778.208871644973;19827.30604428838 11:39:49 INFO - PID 12731 | |3;mootools.html;1482.392219190132;1552.441121196369;1555.18352864746;1566.9373225070997;1571.0181136789506;18142.3650172244;18684.346047888328;18695;18708.53228669284;18716.251349945986;18307.816921830778;18384.816151838477;18410.631787364277;18427.90786046068;18437.262509499604;3155.9526607100856;3247.561579186815;3249.772515923886;3255.300110476247;3255.9348813023726;3141.968580314202;3155.9053228403186;3190.7606929480266;3192.122166404234;3192.632847222576;3170.3183815479665;3194.7284480819044;3199.728023118038;3224.4196044711944;3225.080851957193;3137.0902438292983;3147.410557668363;3198.328351046283;3198.760092993035;3201.135693362791;2977.3152174999873;2993.206800197949;3000.4599172149005;3004.7295743382983;3014.3368458939;17330.220140093727;17559.12204389788;17628.383006594708;17670.381536646284;17712.29150833965;8989.190972812477;9339.626414943394;9347.579358928797;9353.953230233805;9354.67258645951;5939.910901336483;6125.754969801203;6377.904331435032;6435.742570297182;6445.129907462479;2107.2097963263777;2159.686845407423;2165.1664109318026;2203.889805509718;2204.272590045281;31599;31623.525647115082;31626.367472650647;31639.36721265562;31822.840885795424;7580.583067931317;7948.602569871483;7969.960150199212;8060.274575288135;8096.83806323882;20861.478463038242;20946.162153513687;20958.371248862557;20964.266250681154;20967.580648386946;8864.778380540538;9233.815323693489;9251.259899208047;9289.117533834275;9295.581698823435;8244.093149753522;8250.876236856451;8277.710280140287;8507.191816777397;8507.702230421906;6217.844553886189;6234.407731265523;6235.407636274546;6264.906026409608;6305.464035556937;1708.871834612409;1755.6313174233553;1815.110595808071;1842.8617853661028;1877.9624407511774;1020.9846852297221;1025.4975062219607;1026.8921763214905;1031.7730099378125;1041.037040737315;9466;9628.807423851484;9698.224142068617;9750.171235445066;9837.55730992107;1085.8262677971486;1095.7534554725123;1104.5471356743697;1106.9114470842314;1113.560143743217;5132.871678208075;5172.172452407597;5224.373075230997;5240.423553409122;5260.026895024433;26454.206373808818;26745.197644070708;27081.593776093374;27490.862545687545;27801.721982780316;26298.6055209172;27554.17337479879;27569.724302757117;27633.86183069112;27813.721862781516;13290.269035203157;13377.33113344329;13398.330083495981;13545.66135846592;13573.864261357458;9865.802683946138;10028.598856045677;10137.44244066554;10141.746456338651;10173.44046077473;22630.207942721925;23102.884485578135;23532;23543.529129416973;23717.762822371555;23834.16580419677;23981.640275395534;24099;24458.26625201247;24546.386340341633;13335.86664133385;13398.732025359242;13407.664808379479;13583.79624305656;13600.727985440039;15593.220338983232;15711.921440393182;15716.13561254142;15717.921410392875;15721.842781572037;12271.386430678609;13260.336983150997;13290.601281961557;13406.463741450232;13554.18674879471;12765.234085954873;12865.935670321589;12890.613281601567;13371.665708357368;13494.730105398034;11012.724681883017;11108.833367499656;11148;11239.60661376848;11242.044426223863;8759.211670949646;8772.429792063496;8802.471851688919;8943.418677786183;8966.23786978088;8612.71676300583;8695.956520217358;8736.388452808242;8794.736157915273;8825.867611985697 11:39:49 INFO - PID 12731 | |4;prototype.html;583.1893667801759;585.3765739487445;588.5027152056512;608.6895683201567;626.896562067259;6472.498376380075;6477.35226477352;6587.583669511054;6615.636140012298;6633.867322653544;6490.513211509132;6553.83615409615;6590.176227971504;6610.272869984298;6644.767433139841;5454.481824226692;5469.234307196995;5489.945100548994;5503.20203570482;5540.63985840921;5151.660568252244;5299.894002119955;5329.946700532983;5336.91994620081;5338.3060202173665;5205.453427390126;5227.111391063529;5253.238280449333;5260;5272.868178295535;5255.344566461552;5283.807220003694;5309.389420216686;5317.175837745156;5326.9612425577025;4783.3303337532425;4837.7097374157665;4847.418309802811;4849.1513985052825;4861.927071093936;6479.481641468671;6516.3157868423605;6537.313582073909;6578;6605.57063790852;6153.753849846001;6176.441202917365;6206.875862482725;6253.593516421418;6256.15541901842;7033.226345102034;7069.540479868792;7081;7095.964520177417;7139.286071392819;5232.607554433433;5427.158790387496;5434.809781657663;5442.12925931853;5451.155070964007;7138.321859423347;7243.674034668453;7404.4816862819625;7409.407247420193;7431.516951398142;5549.0867294669815;5575.191597218381;5587.1339942309005;5591.580631452576;5605.159226116034;5664.8867022659315;5672.688002159838;5683.630564013409;5686.402927692616;5721.713914304268;6298.118263443122;6307.972173356814;6329.525285603506;6337.873242535124;6340.144080549159;6979.511434199659;7055.400290975222;7062.258462861429;7167.820804479826;7191.89212161818;1908.1794828223997;1920.9615807684047;1933.3426634944187;1944.4263942137104;1952.2874150934806;1295.501232025677;1336.4386957477882;1373.7183877305129;1387.8681525255085;1392.060359257497;6369.299377068519;6400.327965563642;6410.423061924449;6583.934160658332;6590.110335104795;7076.433885289164;7119.644017799089;7150;7160.57036577807;7168.856622867514;6457.709403076873;6588.934110658928;6634.436072933855;6645.767398141042;6660.933390666129;3757.5490941087246;3785.072657198949;3811.294910441577;3833.2333533293454;3862.111714305669;7262.455315851333;7369.22623124575;7414.740484083031;7427.071616047994;7432.108147022392;7257.237990011078;7305.196428392873;7356.485046046725;7373.88939165913;7390.630468476555;7170.426365890612;7255.8911616325795;7300.138464691469;7396.190961654752;7396.9260307396235;6928.16861976566;7069.611171385417;7177.3133313670205;7206.927930720625;7220;7020.368166865007;7081.8937715935335;7136.785896423115;7191.604461754654;7199.280071992968;7383.704651814082;7453.906628749225;7467.887981680387;7472.140703818913;7475.2151024141685;5515.4760297771645;5530.364008139116;5550.417206193291;5581.218629391969;5592.328920529562;6898.965505172442;6981.5461994970165;7088.326608972346;7180.31786980236;7191.892121618075;6867.626474705179;6906.930930690629;6939.410150137295;6986.720531178696;6994.636045970987;6902.792916212522;6934.7226110955;6977;7022.508424410242;7046.330598593126;6884.724611015503;6888.655567221519;6892.862142757217;6906;6944.861102778017;7041;7042.577445353295;7065.399441047569;7093.609851458219;7120.394766444911;6782.728690852311;6799.660016999229;6827.795166145023;6830.248672646105;6842.213145488134 11:39:49 INFO - PID 12731 | |5;yui.html;1006.9848952265717;1007.9496025198738;1021.524990879241;1033.059915476916;1049.997252623744;24517.75482245177;25418.364540886465;25450.490990180184;25608.48783024343;25611.103611373605;22584.20955266562;24000.039998400087;24087.638685419734;24165.395865103383;24189.75810241897;1079.7624522605015;1099.351382684216;1105.7512059786563;1105.8451816745662;1110.955561777528;1070.272214893872;1099.2525082943596;1111.4220605285286;1111.6220485035087;1113.1150735165522;1181.4978634080524;1187.8752730963254;1187.994060029703;1191.213798892731;1191.475750669707;1170.625399872037;1170.8712041675408;1178.6699724077273;1180.7815554122471;1182.1901997131993;863.4603372891943;866.358894418126;867.5748883047262;869.543489667923;869.9347548933792;21698.674519882214;22052.338429847132;22113.889430552907;22253.44366390837;22322.441938951495;24059;24107.51784964291;24358.63462048071;24713.752862471505;24794.380140496633;18063.09684515769;18187.54531136719;18279.72580411295;18281.268749250146;18300.17649205789;4120.690948178869;4150.045489537393;4153.54311025787;4161.646260067898;4164.271252530795;159394;161427;162809;163583;166133.16933415257;18656.160472778756;18927.810721892605;18985.24059037623;19233.51916202078;19236.23055077809;29573.704262957093;30364;35295;36167.27665446676;36241.45637815435;9100.772480688036;9399.624015039459;9403.57683904226;9410.529473526296;9426;4711.764411779397;4751.429828420612;4788.449328327218;4802.399700037496;4811.615070794328;6147;6253.53098517613;6283.434490895841;6300.810975670737;6309.810705678745;1255.7990721484518;1308.8167656528094;1312.5734136405706;1320.1221187909932;1323.450767931317;740.3595889555496;742.5544673196039;745.656997781016;751.4063889527322;754.8792193249163;13597.592072237849;13597.660058498419;14041.85958140426;14649.487267945571;14694.853051469348;615.673692942741;631.1416473595906;632.7437387857925;634.6319134901746;658.7793089315134;6058.848818724428;6084.4828189603495;6087.634741915499;6214.906776398358;6236.75052997875;145412;148566;150039;154128;154220;132757;135714;136869.3156534211;137656;141841;122843;123588;123714;124028.37985810194;124219;11532.711682208012;11551;11581.189316747746;11662.591809286634;11863.940680296544;59057.704711476166;60117.69941150266;60373;60737.392626073175;62624.686876567146;74947.62526187334;76002.6199868997;77068;77083;77794.2220577787;16741.414050508174;17555.385561505285;17689.64620707553;17694.82305176932;17828.554286142433;19767.308144215458;20761.480962976046;20779.688304675743;20954.266600668903;21035.579288414454;18485.9075704626;18707.064646767878;18771;18787.34244301443;18888.244470221038;15738.606534836721;15794.289256983233;15911.681766364376;15932.362705492114;15945.282462288993;15898.68202635964;15993.8400615997;16073.276702548179;16122.677546448771;16148.757768633244;12095.455704493143;12393.504259829866;12427.627171184879;12457.937710311391;12588.622341329774;13521.157728517239;13832.515861944783;13860.029797914049;13870.791938120734;13871.4451421942 11:39:49 INFO - PID 12731 | __end_tp_report 11:39:49 INFO - PID 12731 | __start_cc_report 11:39:49 INFO - PID 12731 | _x_x_mozilla_cycle_collect,258 11:39:49 INFO - PID 12731 | __end_cc_report 11:39:49 INFO - PID 12731 | __startTimestamp1506191989037__endTimestamp 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | ------- Summary: start ------- 11:39:49 INFO - PID 12731 | Number of tests: 6 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#0] dojo.html Cycles:165 Average:6645.71 Median:6918.65 stddev:770.80 (11.1%) stddev-sans-first:745.51 11:39:49 INFO - PID 12731 | Values: 4037.5 4053.2 4056.3 4059.7 4060.0 6509.8 6554.0 6645.4 6645.8 6664.8 6577.5 6579.2 6586.9 6652.7 6681.1 5894.4 5917.3 5941.6 5974.8 5987.2 5935.7 5976.0 5980.4 5980.7 6011.7 5968.9 6002.4 6018.7 6023.7 6027.1 5889.7 6036.2 6042.3 6052.1 6066.9 5878.3 5950.5 5967.0 6030.5 6050.5 6485.4 6540.1 6577.2 6584.0 6661.2 7178.9 7224.5 7263.3 7268.3 7272.5 7250.3 7265.0 7267.5 7276.7 7367.9 6626.2 6693.6 6707.5 6712.4 6775.2 7348.6 7361.7 7364.0 7364.2 7366.9 7061.5 7063.8 7136.1 7147.6 7163.4 7216.9 7235.5 7295.0 7303.2 7325.3 7100.4 7151.2 7168.4 7168.9 7236.0 7119.1 7136.3 7161.2 7178.5 7178.8 5378.3 5382.1 5408.0 5413.3 5416.1 4851.7 4852.2 4857.2 4880.0 4880.5 6556.4 6642.1 6674.2 6675.9 6731.1 7239.9 7249.9 7259.6 7276.7 7282.2 6650.9 6654.7 6666.2 6671.9 6760.7 6054.4 6120.6 6198.7 6199.9 6219.0 7378.5 7413.7 7477.4 7478.1 7509.2 7085.9 7199.2 7266.8 7295.4 7308.6 7396.5 7418.7 7439.6 7511.9 7532.9 6983.5 7065.3 7095.3 7165.3 7170.9 7273.2 7276.7 7279.1 7296.3 7304.6 6929.9 6959.8 6961.5 7018.0 7020.2 6879.1 6959.5 6960.0 6989.3 6990.6 6891.3 6909.2 6924.8 6935.6 6938.3 6995.1 7025.5 7047.4 7051.5 7057.5 6651.2 6756.4 6817.4 6908.7 6918.7 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#1] ext.html Cycles:180 Average:46802.37 Median:39264.21 stddev:73832.72 (188.0%) stddev-sans-first:73959.65 11:39:49 INFO - PID 12731 | Values: 973.8 988.4 1020.9 1045.9 1048.5 45103.5 45719.8 45751.3 45866.3 45981.0 43215.6 43479.8 43519.3 43525.8 43581.8 8091.5 8284.8 8289.7 8291.1 8295.7 8014.6 8142.4 8151.3 8164.8 8170.1 8759.1 8883.4 8887.2 8900.7 8908.8 8824.2 8842.8 8883.9 8887.5 8889.0 8661.8 8828.8 8829.0 8830.3 8834.0 41495.8 41749.8 41817.4 42031.0 42129.8 3891.9 3959.0 3960.1 3961.4 3972.4 35682.8 35744.5 35759.6 35813.9 35859.1 5559.1 5709.1 5727.1 5779.3 5855.4 228560.0 228743.0 229643.0 230088.0 230447.0 55131.0 55139.7 55236.4 57363.1 57865.4 59033.4 59667.7 59718.4 59728.4 59832.0 18421.4 18485.5 18597.9 18626.3 18634.5 15216.8 15297.6 15298.5 15341.1 15347.3 15646.7 15683.4 15822.5 15897.6 15940.4 5851.4 5942.7 5977.3 5998.5 6001.3 1126.3 1143.8 1148.6 1151.5 1151.7 26498.0 26704.1 26881.6 26943.3 27029.3 1247.7 1259.6 1260.0 1263.7 1270.2 14229.3 14270.6 14271.0 14338.4 14583.4 326715.0 326849.0 326928.0 327862.0 328341.0 60846.7 61317.7 64590.0 65293.7 65348.3 1532.8 1552.2 1558.4 1574.0 1591.2 31762.4 31904.8 32581.7 32728.3 33005.7 44207.6 44261.1 44402.0 44539.1 44575.8 282585.0 283876.0 284321.0 284666.0 285257.0 39129.6 39209.6 39318.8 39402.2 39447.8 47911.0 49789.8 50281.2 50469.7 50570.7 36531.0 36667.8 36719.5 36853.4 37070.4 36176.5 36650.8 36721.0 36768.1 37120.1 42316.0 42450.6 42760.0 42784.1 42849.6 34861.7 34930.3 34980.7 35205.5 35431.1 26057.3 26518.2 26584.7 26711.6 26778.1 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#2] jquery.html Cycles:180 Average:42672.76 Median:2187.99 stddev:110849.71 (5066.3%) stddev-sans-first:111115.77 11:39:49 INFO - PID 12731 | Values: 650.0 661.1 663.5 673.6 674.5 24505.1 25221.7 25307.6 25312.0 25345.5 26932.5 26999.3 27069.2 27446.3 27455.5 6597.9 6769.3 6792.2 6803.1 6814.3 6687.8 6736.7 6784.7 6797.0 6804.2 6242.7 6864.6 6907.6 6910.6 6914.3 6827.4 6864.2 6884.7 6885.5 6890.7 6428.7 6465.5 6471.7 6481.0 6483.1 30930.0 31359.4 31362.4 31457.0 31516.8 2170.0 2174.6 2186.9 2187.8 2188.1 21581.8 21851.2 21912.3 21925.3 21971.9 2553.6 2616.0 2684.3 2712.4 2713.2 146062.0 150779.0 158800.2 164689.2 165058.0 16677.3 17496.7 17587.4 17616.1 17714.0 27408.7 27412.0 27494.0 27529.0 27594.0 11501.8 11816.5 11818.9 11880.3 11913.5 10760.5 10782.5 10840.2 10840.8 10879.8 10299.3 10503.7 10565.4 10614.5 10644.3 3002.8 3005.9 3078.3 3123.6 3222.6 1032.8 1049.1 1059.8 1066.4 1069.7 20780.3 21368.9 21645.0 21728.9 21836.2 1136.6 1138.6 1139.1 1141.8 1149.1 11528.5 11709.1 11781.9 11825.5 11924.2 652893.0 655382.0 658848.0 660925.0 691619.0 135821.3 137155.0 137686.0 140329.0 141426.0 1291.7 1313.9 1364.6 1380.2 1391.6 23257.7 23267.8 23314.8 23329.5 23430.8 69223.7 69412.0 69469.0 72214.6 72271.6 83922.2 84542.0 84677.6 85648.6 86651.0 16098.1 16299.5 16426.0 16482.3 16489.1 24191.9 24529.6 24818.6 24937.1 25175.0 19872.5 20271.6 20298.3 20307.9 20324.4 17485.7 17568.7 18121.9 18181.5 18474.0 19693.2 19920.0 20319.8 20352.4 20381.5 15958.0 16064.5 16132.2 16163.7 16248.3 19712.2 19755.3 19771.0 19778.2 19827.3 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#3] mootools.html Cycles:180 Average:11176.49 Median:26599.70 stddev:8269.52 (31.1%) stddev-sans-first:8260.64 11:39:49 INFO - PID 12731 | Values: 1482.4 1552.4 1555.2 1566.9 1571.0 18142.4 18684.3 18695.0 18708.5 18716.3 18307.8 18384.8 18410.6 18427.9 18437.3 3156.0 3247.6 3249.8 3255.3 3255.9 3142.0 3155.9 3190.8 3192.1 3192.6 3170.3 3194.7 3199.7 3224.4 3225.1 3137.1 3147.4 3198.3 3198.8 3201.1 2977.3 2993.2 3000.5 3004.7 3014.3 17330.2 17559.1 17628.4 17670.4 17712.3 8989.2 9339.6 9347.6 9354.0 9354.7 5939.9 6125.8 6377.9 6435.7 6445.1 2107.2 2159.7 2165.2 2203.9 2204.3 31599.0 31623.5 31626.4 31639.4 31822.8 7580.6 7948.6 7970.0 8060.3 8096.8 20861.5 20946.2 20958.4 20964.3 20967.6 8864.8 9233.8 9251.3 9289.1 9295.6 8244.1 8250.9 8277.7 8507.2 8507.7 6217.8 6234.4 6235.4 6264.9 6305.5 1708.9 1755.6 1815.1 1842.9 1878.0 1021.0 1025.5 1026.9 1031.8 1041.0 9466.0 9628.8 9698.2 9750.2 9837.6 1085.8 1095.8 1104.5 1106.9 1113.6 5132.9 5172.2 5224.4 5240.4 5260.0 26454.2 26745.2 27081.6 27490.9 27801.7 26298.6 27554.2 27569.7 27633.9 27813.7 13290.3 13377.3 13398.3 13545.7 13573.9 9865.8 10028.6 10137.4 10141.7 10173.4 22630.2 23102.9 23532.0 23543.5 23717.8 23834.2 23981.6 24099.0 24458.3 24546.4 13335.9 13398.7 13407.7 13583.8 13600.7 15593.2 15711.9 15716.1 15717.9 15721.8 12271.4 13260.3 13290.6 13406.5 13554.2 12765.2 12865.9 12890.6 13371.7 13494.7 11012.7 11108.8 11148.0 11239.6 11242.0 8759.2 8772.4 8802.5 8943.4 8966.2 8612.7 8696.0 8736.4 8794.7 8825.9 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#4] prototype.html Cycles:180 Average:5985.76 Median:6590.14 stddev:1662.23 (25.2%) stddev-sans-first:1616.67 11:39:49 INFO - PID 12731 | Values: 583.2 585.4 588.5 608.7 626.9 6472.5 6477.4 6587.6 6615.6 6633.9 6490.5 6553.8 6590.2 6610.3 6644.8 5454.5 5469.2 5489.9 5503.2 5540.6 5151.7 5299.9 5329.9 5336.9 5338.3 5205.5 5227.1 5253.2 5260.0 5272.9 5255.3 5283.8 5309.4 5317.2 5327.0 4783.3 4837.7 4847.4 4849.2 4861.9 6479.5 6516.3 6537.3 6578.0 6605.6 6153.8 6176.4 6206.9 6253.6 6256.2 7033.2 7069.5 7081.0 7096.0 7139.3 5232.6 5427.2 5434.8 5442.1 5451.2 7138.3 7243.7 7404.5 7409.4 7431.5 5549.1 5575.2 5587.1 5591.6 5605.2 5664.9 5672.7 5683.6 5686.4 5721.7 6298.1 6308.0 6329.5 6337.9 6340.1 6979.5 7055.4 7062.3 7167.8 7191.9 1908.2 1921.0 1933.3 1944.4 1952.3 1295.5 1336.4 1373.7 1387.9 1392.1 6369.3 6400.3 6410.4 6583.9 6590.1 7076.4 7119.6 7150.0 7160.6 7168.9 6457.7 6588.9 6634.4 6645.8 6660.9 3757.5 3785.1 3811.3 3833.2 3862.1 7262.5 7369.2 7414.7 7427.1 7432.1 7257.2 7305.2 7356.5 7373.9 7390.6 7170.4 7255.9 7300.1 7396.2 7396.9 6928.2 7069.6 7177.3 7206.9 7220.0 7020.4 7081.9 7136.8 7191.6 7199.3 7383.7 7453.9 7467.9 7472.1 7475.2 5515.5 5530.4 5550.4 5581.2 5592.3 6899.0 6981.5 7088.3 7180.3 7191.9 6867.6 6906.9 6939.4 6986.7 6994.6 6902.8 6934.7 6977.0 7022.5 7046.3 6884.7 6888.7 6892.9 6906.0 6944.9 7041.0 7042.6 7065.4 7093.6 7120.4 6782.7 6799.7 6827.8 6830.2 6842.2 11:39:49 INFO - PID 12731 | 11:39:49 INFO - PID 12731 | [#5] yui.html Cycles:180 Average:29385.53 Median:18571.03 stddev:43659.50 (235.1%) stddev-sans-first:43729.97 11:39:49 INFO - PID 12731 | Values: 1007.0 1007.9 1021.5 1033.1 1050.0 24517.8 25418.4 25450.5 25608.5 25611.1 22584.2 24000.0 24087.6 24165.4 24189.8 1079.8 1099.4 1105.8 1105.8 1111.0 1070.3 1099.3 1111.4 1111.6 1113.1 1181.5 1187.9 1188.0 1191.2 1191.5 1170.6 1170.9 1178.7 1180.8 1182.2 863.5 866.4 867.6 869.5 869.9 21698.7 22052.3 22113.9 22253.4 22322.4 24059.0 24107.5 24358.6 24713.8 24794.4 18063.1 18187.5 18279.7 18281.3 18300.2 4120.7 4150.0 4153.5 4161.6 4164.3 159394.0 161427.0 162809.0 163583.0 166133.2 18656.2 18927.8 18985.2 19233.5 19236.2 29573.7 30364.0 35295.0 36167.3 36241.5 9100.8 9399.6 9403.6 9410.5 9426.0 4711.8 4751.4 4788.4 4802.4 4811.6 6147.0 6253.5 6283.4 6300.8 6309.8 1255.8 1308.8 1312.6 1320.1 1323.5 740.4 742.6 745.7 751.4 754.9 13597.6 13597.7 14041.9 14649.5 14694.9 615.7 631.1 632.7 634.6 658.8 6058.8 6084.5 6087.6 6214.9 6236.8 145412.0 148566.0 150039.0 154128.0 154220.0 132757.0 135714.0 136869.3 137656.0 141841.0 122843.0 123588.0 123714.0 124028.4 124219.0 11532.7 11551.0 11581.2 11662.6 11863.9 59057.7 60117.7 60373.0 60737.4 62624.7 74947.6 76002.6 77068.0 77083.0 77794.2 16741.4 17555.4 17689.6 17694.8 17828.6 19767.3 20761.5 20779.7 20954.3 21035.6 18485.9 18707.1 18771.0 18787.3 18888.2 15738.6 15794.3 15911.7 15932.4 15945.3 15898.7 15993.8 16073.3 16122.7 16148.8 12095.5 12393.5 12427.6 12457.9 12588.6 13521.2 13832.5 13860.0 13870.8 13871.4 11:39:49 INFO - PID 12731 | -------- Summary: end -------- 11:39:49 INFO - PID 12731 | 11:39:49 INFO - TEST-INFO | 12731: exit 0 11:39:49 INFO - TEST-OK | dromaeo_css | took 1107294ms 11:39:49 INFO - TEST-START | kraken 11:39:49 INFO - Initialising browser for kraken test... 11:39:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56110/getInfo.html -profile /tmp/tmp3hn11D/profile 11:39:49 INFO - TEST-INFO | started process 13099 (/builds/slave/test/build/application/firefox/firefox http://localhost:56110/getInfo.html) 11:39:54 INFO - TEST-INFO | 13099: exit 0 11:39:54 INFO - Browser initialized. 11:39:54 INFO - Running cycle 1/1 for kraken test... 11:39:54 INFO - Using env: {'DISPLAY': ':0', 11:39:54 INFO - 'HOME': '/home/cltbld', 11:39:54 INFO - 'JSGC_DISABLE_POISONING': '1', 11:39:54 INFO - 'LANG': 'en_US.UTF-8', 11:39:54 INFO - 'LANGUAGE': 'en_US:en', 11:39:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:39:54 INFO - 'LOGNAME': 'cltbld', 11:39:54 INFO - 'MAIL': '/var/mail/cltbld', 11:39:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:39:54 INFO - 'MOZ_CRASHREPORTER': '1', 11:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:39:54 INFO - 'MOZ_NO_REMOTE': '1', 11:39:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:54 INFO - 'NO_EM_RESTART': '1', 11:39:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:54 INFO - 'PWD': '/builds/slave/test', 11:39:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:54 INFO - 'RUST_BACKTRACE': 'full', 11:39:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:39:54 INFO - 'SHELL': '/bin/bash', 11:39:54 INFO - 'SHLVL': '1', 11:39:54 INFO - 'TERM': 'linux', 11:39:54 INFO - 'TMOUT': '86400', 11:39:54 INFO - 'USER': 'cltbld', 11:39:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123', 11:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:54 INFO - '_': '/tools/buildbot/bin/python'} 11:39:54 INFO - TEST-INFO | started process 13283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3hn11D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:05 INFO - PID 13283 | RSS: Main: 146784256 11:40:05 INFO - PID 13283 | 11:40:07 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56110/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:08 INFO - PID 13283 | RSS: Main: 153526272 11:40:08 INFO - PID 13283 | 11:40:11 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56110/tests/kraken/driver.html?testName=audio-dft) 11:40:11 INFO - PID 13283 | RSS: Main: 153649152 11:40:11 INFO - PID 13283 | 11:40:14 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56110/tests/kraken/driver.html?testName=audio-fft) 11:40:15 INFO - PID 13283 | RSS: Main: 155316224 11:40:15 INFO - PID 13283 | 11:40:17 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56110/tests/kraken/driver.html?testName=audio-oscillator) 11:40:17 INFO - PID 13283 | RSS: Main: 155172864 11:40:17 INFO - PID 13283 | 11:40:19 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:20 INFO - PID 13283 | RSS: Main: 154902528 11:40:20 INFO - PID 13283 | 11:40:23 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56110/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:24 INFO - PID 13283 | RSS: Main: 154705920 11:40:24 INFO - PID 13283 | 11:40:27 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56110/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:28 INFO - PID 13283 | RSS: Main: 155488256 11:40:28 INFO - PID 13283 | 11:40:31 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56110/tests/kraken/driver.html?testName=json-parse-financial) 11:40:31 INFO - PID 13283 | RSS: Main: 157356032 11:40:31 INFO - PID 13283 | 11:40:33 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:33 INFO - PID 13283 | RSS: Main: 156995584 11:40:33 INFO - PID 13283 | 11:40:35 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:35 INFO - PID 13283 | RSS: Main: 157188096 11:40:35 INFO - PID 13283 | 11:40:37 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:38 INFO - PID 13283 | RSS: Main: 153894912 11:40:38 INFO - PID 13283 | 11:40:40 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:41 INFO - PID 13283 | RSS: Main: 153964544 11:40:41 INFO - PID 13283 | 11:40:44 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:44 INFO - PID 13283 | RSS: Main: 154148864 11:40:44 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | Cycle 1(1): loaded http://localhost:56110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56110/tests/kraken/driver.html?testName=ai-astar) 11:40:46 INFO - PID 13283 | RSS: Main: 156172288 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | __start_tp_report 11:40:46 INFO - PID 13283 | _x_x_mozilla_page_load 11:40:46 INFO - PID 13283 | _x_x_mozilla_page_load_details 11:40:46 INFO - PID 13283 | |i|pagename|runs| 11:40:46 INFO - PID 13283 | |0;ai-astar;105;105;104;106;107;105;107;105;106;104 11:40:46 INFO - PID 13283 | |1;audio-beat-detection;113;111;110;113;111;118;110;121;134;113 11:40:46 INFO - PID 13283 | |2;audio-dft;160;159;161;162;161;162;162;161;161;163 11:40:46 INFO - PID 13283 | |3;audio-fft;73;73;74;72;71;73;72;72;72;78 11:40:46 INFO - PID 13283 | |4;audio-oscillator;78;78;77;76;77;79;76;77;77;78 11:40:46 INFO - PID 13283 | |5;imaging-gaussian-blur;119;114;113;110;113;110;113;115;113;113 11:40:46 INFO - PID 13283 | |6;imaging-darkroom;148;147;148;147;148;148;148;149;148;149 11:40:46 INFO - PID 13283 | |7;imaging-desaturate;93;94;95;94;94;99;100;98;99;99 11:40:46 INFO - PID 13283 | |8;json-parse-financial;46;43;44;43;43;44;43;43;44;43 11:40:46 INFO - PID 13283 | |9;json-stringify-tinderbox;45;46;46;46;46;45;46;46;46;46 11:40:46 INFO - PID 13283 | |10;stanford-crypto-aes;69;69;69;74;77;69;68;69;69;71 11:40:46 INFO - PID 13283 | |11;stanford-crypto-ccm;103;100;104;101;117;97;109;100;100;107 11:40:46 INFO - PID 13283 | |12;stanford-crypto-pbkdf2;147;144;147;146;144;154;143;144;150;144 11:40:46 INFO - PID 13283 | |13;stanford-crypto-sha256-iterative;61;63;58;57;58;57;59;59;56;57 11:40:46 INFO - PID 13283 | __end_tp_report 11:40:46 INFO - PID 13283 | __start_cc_report 11:40:46 INFO - PID 13283 | _x_x_mozilla_cycle_collect,690 11:40:46 INFO - PID 13283 | __end_cc_report 11:40:46 INFO - PID 13283 | __startTimestamp1506192046618__endTimestamp 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | ------- Summary: start ------- 11:40:46 INFO - PID 13283 | Number of tests: 14 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#0] ai-astar Cycles:10 Average:105.40 Median:105.50 stddev:1.07 (1.0%) stddev-sans-first:1.13 11:40:46 INFO - PID 13283 | Values: 105.0 105.0 104.0 106.0 107.0 105.0 107.0 105.0 106.0 104.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#1] audio-beat-detection Cycles:10 Average:115.40 Median:113.00 stddev:7.44 (6.6%) stddev-sans-first:7.84 11:40:46 INFO - PID 13283 | Values: 113.0 111.0 110.0 113.0 111.0 118.0 110.0 121.0 134.0 113.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 11:40:46 INFO - PID 13283 | Values: 160.0 159.0 161.0 162.0 161.0 162.0 162.0 161.0 161.0 163.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:1.94 (2.7%) stddev-sans-first:2.06 11:40:46 INFO - PID 13283 | Values: 73.0 73.0 74.0 72.0 71.0 73.0 72.0 72.0 72.0 78.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:0.95 (1.2%) stddev-sans-first:0.97 11:40:46 INFO - PID 13283 | Values: 78.0 78.0 77.0 76.0 77.0 79.0 76.0 77.0 77.0 78.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:2.54 (2.2%) stddev-sans-first:1.66 11:40:46 INFO - PID 13283 | Values: 119.0 114.0 113.0 110.0 113.0 110.0 113.0 115.0 113.0 113.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:40:46 INFO - PID 13283 | Values: 148.0 147.0 148.0 147.0 148.0 148.0 148.0 149.0 148.0 149.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:2.72 (2.8%) stddev-sans-first:2.57 11:40:46 INFO - PID 13283 | Values: 93.0 94.0 95.0 94.0 94.0 99.0 100.0 98.0 99.0 99.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#8] json-parse-financial Cycles:10 Average:43.60 Median:43.50 stddev:0.97 (2.2%) stddev-sans-first:0.50 11:40:46 INFO - PID 13283 | Values: 46.0 43.0 44.0 43.0 43.0 44.0 43.0 43.0 44.0 43.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#9] json-stringify-tinderbox Cycles:10 Average:45.80 Median:46.00 stddev:0.42 (0.9%) stddev-sans-first:0.33 11:40:46 INFO - PID 13283 | Values: 45.0 46.0 46.0 46.0 46.0 45.0 46.0 46.0 46.0 46.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#10] stanford-crypto-aes Cycles:10 Average:70.40 Median:69.00 stddev:2.88 (4.2%) stddev-sans-first:3.00 11:40:46 INFO - PID 13283 | Values: 69.0 69.0 69.0 74.0 77.0 69.0 68.0 69.0 69.0 71.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#11] stanford-crypto-ccm Cycles:10 Average:103.80 Median:105.50 stddev:5.87 (5.6%) stddev-sans-first:6.21 11:40:46 INFO - PID 13283 | Values: 103.0 100.0 104.0 101.0 117.0 97.0 109.0 100.0 100.0 107.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:146.50 stddev:3.43 (2.3%) stddev-sans-first:3.63 11:40:46 INFO - PID 13283 | Values: 147.0 144.0 147.0 146.0 144.0 154.0 143.0 144.0 150.0 144.0 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.50 Median:58.50 stddev:2.12 (3.6%) stddev-sans-first:2.05 11:40:46 INFO - PID 13283 | Values: 61.0 63.0 58.0 57.0 58.0 57.0 59.0 59.0 56.0 57.0 11:40:46 INFO - PID 13283 | -------- Summary: end -------- 11:40:46 INFO - PID 13283 | 11:40:46 INFO - PID 13283 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:40:47 INFO - TEST-INFO | 13283: exit 0 11:40:47 INFO - TEST-OK | kraken | took 57559ms 11:40:47 INFO - SUITE-END | took 1164s 11:40:47 INFO - Completed test suite (00:19:24) 11:40:47 INFO - javascript benchmark 11:40:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9587.28484517376, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4037.4953130858644, 4053.1893621275744, 4056.3307054336037, 4059.7158198926077, 4059.959400405997, 6509.842237980332, 6554.016897465371, 6645.368689974457, 6645.800625981216, 6664.833379165511, 6577.473802095833, 6579.210494740626, 6586.8682626347445, 6652.733890644368, 6681.131452911115, 5894.410558944114, 5917.260342457193, 5941.643501389931, 5974.79088231912, 5987.22166118404, 5935.703214839263, 5975.970120149394, 5980.43185897339, 5980.671063091529, 6011.669358185298, 5968.940310596882, 6002.429769171922, 6018.6990650467305, 6023.668698221596, 6027.09593560965, 5889.705514724289, 6036.15493830864, 6042.274927008765, 6052.122442245894, 6066.939330606704, 5878.323992740847, 5950.523958083343, 5966.97016514919, 6030.547708921848, 6050.54620903434, 6485.351464853524, 6540.149780528548, 6577.210734711817, 6583.967080164569, 6661.16735408074, 7178.928210717931, 7224.4581656375985, 7263.273672632748, 7268.345848873574, 7272.527285726411, 7250.3112204340505, 7265.0, 7267.49127561071, 7276.708931642728, 7367.852642947165, 6626.2048554173325, 6693.631850248283, 6707.530472866902, 6712.429443497309, 6775.1531058617675, 7348.595827229554, 7361.668724907392, 7364.0, 7364.22675619063, 7366.889496657554, 7061.470389720792, 7063.823404414828, 7136.072310599693, 7147.571145731273, 7163.42692584592, 7216.927830721731, 7235.493515453868, 7295.0, 7303.160136584254, 7325.304096110861, 7100.360967512948, 7151.213366529678, 7168.3548480635945, 7168.924661300743, 7235.963820180866, 7119.1457025157315, 7136.250693677193, 7161.212266650664, 7178.497505174692, 7178.820529486805, 5378.300820893337, 5382.138857782736, 5407.972485227794, 5413.296271484761, 5416.133418652997, 4851.733154676526, 4852.223644216909, 4857.1742803723455, 4879.950810575743, 4880.511948805091, 6556.409923106943, 6642.1033160523675, 6674.16572928384, 6675.899861502081, 6731.057651928734, 7239.8552028960175, 7249.927500724925, 7259.564426134449, 7276.745313913988, 7282.198958114604, 6650.933490665128, 6654.6672666366485, 6666.200055993312, 6671.933280667228, 6760.7295708172105, 6054.364291749391, 6120.632762034292, 6198.690065496798, 6199.938000619936, 6218.968905155445, 7378.520396174232, 7413.740519081806, 7477.4391920605085, 7478.140013898471, 7509.17399086111, 7085.929140708527, 7199.217931708776, 7266.781996540112, 7295.379892709179, 7308.634568271672, 7396.519226250277, 7418.666160022704, 7439.55362678241, 7511.887321690069, 7532.924670753441, 6983.476239281973, 7065.2934706531, 7095.290470952863, 7165.319294666998, 7170.856582868418, 7273.199948005821, 7276.7089316428865, 7279.1265048194555, 7296.270372962661, 7304.598247096461, 6929.861402772017, 6959.826004349729, 6961.477889158232, 7017.964910175417, 7020.157581090302, 6879.140107486564, 6959.547629404073, 6959.965200173967, 6989.30106989297, 6990.580565166107, 6891.276415976451, 6909.2399836019, 6924.757633482804, 6935.583864968118, 6938.306169383021, 6995.055667485028, 7025.543339682904, 7047.400970917324, 7051.5063945523325, 7057.541259818096, 6651.235107962452, 6756.425703815231, 6817.352351526597, 6908.723651053901, 6918.654067296515], "value": 6594.169421329222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [973.7711637765128, 988.3871999360398, 1020.8928062553432, 1045.9058684718377, 1048.528162326953, 45103.548964510344, 45719.77140114295, 45751.313730294074, 45866.312005319865, 45980.999999999956, 43215.567844321544, 43479.78260108695, 43519.34720979188, 43525.78237108818, 43581.7820910895, 8091.514509129456, 8284.83430331393, 8289.668413263462, 8291.08798032216, 8295.709650162245, 8014.5591992440395, 8142.43002989791, 8151.347892168612, 8164.836703265931, 8170.142135075791, 8759.080296568864, 8883.378163528556, 8887.244584210317, 8900.73297801067, 8908.797312362813, 8824.249938755182, 8842.778930526723, 8883.911160888438, 8887.511186884718, 8889.022207557164, 8661.783455413602, 8828.823423531558, 8829.0, 8830.337724670675, 8833.955830220872, 41495.7925210375, 41749.79125104355, 41817.37273940894, 42031.0, 42129.789351053354, 3891.8832435026993, 3959.0, 3960.148568057881, 3961.445397644332, 3972.3644216925154, 35682.82158589216, 35744.46383304252, 35759.64240357615, 35813.92558223257, 35859.10352241189, 5559.11054231321, 5709.115087161455, 5727.140928860663, 5779.306483221998, 5855.443732845373, 228560.0, 228743.0, 229643.0, 230088.0, 230447.0, 55131.0, 55139.724301379036, 55236.44763552393, 57363.13955290674, 57865.421345786, 59033.40966590365, 59667.70166149142, 59718.40281597128, 59728.402715973156, 59832.0, 18421.447356579323, 18485.53786155357, 18597.90701046486, 18626.254949801856, 18634.53413664642, 15216.847831521543, 15297.617559560877, 15298.541043768704, 15341.079535227922, 15347.309371078329, 15646.687066258839, 15683.372665093497, 15822.525324240061, 15897.602559936095, 15940.362385504683, 5851.385604511465, 5942.70286485674, 5977.3126090500145, 5998.490128339053, 6001.279846418458, 1126.2566705974018, 1143.8341440491083, 1148.6439203846835, 1151.4703236511298, 1151.7120719820045, 26498.0, 26704.06535771239, 26881.596776048376, 26943.326416839343, 27029.324266893484, 1247.7379750252367, 1259.6284096191462, 1259.9685007874693, 1263.6524955637274, 1270.244204698203, 14229.28853557318, 14270.571882843531, 14271.0, 14338.354774035193, 14583.416663333348, 326715.0, 326849.0, 326928.0, 327862.0, 328341.0, 60846.69576652088, 61317.69341153266, 64590.0, 65293.67353163204, 65348.34651653423, 1532.7930729351617, 1552.185102821028, 1558.4078050340797, 1574.0083747239166, 1591.2441590244773, 31762.364752705278, 31904.84047579747, 32581.674183257863, 32728.34543309168, 33005.66994330026, 44207.55792442035, 44261.11477770491, 44401.999999998705, 44539.10921781482, 44575.77712111548, 282585.0, 283876.0, 284321.0, 284666.0, 285257.0, 39129.6087039126, 39209.607903920594, 39318.803405982784, 39402.2119557613, 39447.802760986015, 47911.0, 49789.751051244515, 50281.24578131404, 50469.74765126151, 50570.74714626403, 36531.0, 36667.81666091759, 36719.45114776412, 36853.44719829151, 37070.44394334033, 36176.45735314025, 36650.8167459161, 36721.0, 36768.05855531605, 37120.07199820026, 42316.0, 42450.575494244666, 42760.0, 42784.14431711286, 42849.57150428581, 34861.65138348584, 34930.301393972484, 34980.65019349774, 35205.471917921765, 35431.11422214465, 26057.348566285993, 26518.204453866416, 26584.734152659, 26711.599326010513, 26778.062767803032], "value": 19826.00379834991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9860218059827, 661.1174082599729, 663.4938689175572, 673.6261374936909, 674.5076094451053, 24505.142320018804, 25221.74778252217, 25307.62038569423, 25312.0, 25345.493090138185, 26932.461350772974, 26999.325016874587, 27069.1879243623, 27446.313842153955, 27455.450890982167, 6597.868042639145, 6769.255381907986, 6792.218894827084, 6803.081583986148, 6814.318568143196, 6687.799366019003, 6736.663166841663, 6784.72861085556, 6796.966015169917, 6804.18349798025, 6242.719077641517, 6864.622445765481, 6907.620080895574, 6910.5853648780985, 6914.274001229874, 6827.351401616838, 6864.176298844171, 6884.690188941485, 6885.518013739015, 6890.655467226618, 6428.742850285983, 6465.4827613790785, 6471.708773105222, 6480.967595161994, 6483.059956306356, 30930.0, 31359.37281254362, 31362.372752544823, 31457.0, 31516.842415788004, 2169.9891500542394, 2174.6411842046045, 2186.8797216153107, 2187.84685072045, 2188.1356864038776, 21581.784182158135, 21851.235206767848, 21912.342629721134, 21925.342239732832, 21971.890140549196, 2553.6041913503436, 2615.9869200654066, 2684.315499547603, 2712.389712314733, 2713.1996061162004, 146062.0, 150779.0, 158800.20599896926, 164689.17655411645, 165058.0, 16677.332906683598, 17496.737548936777, 17587.384441544484, 17616.119194040246, 17714.0, 27408.725912740618, 27412.0, 27494.0, 27529.0, 27594.0, 11501.827472587918, 11816.46825892837, 11818.881811181951, 11880.287182769061, 11913.463894124785, 10760.461976901124, 10782.46087695612, 10840.186985976083, 10840.78318433627, 10879.83680244797, 10299.330543514647, 10503.684889453329, 10565.418901960466, 10614.522346494427, 10644.25490215693, 3002.8198308101582, 3005.911959734759, 3078.2766049978236, 3123.6095488063993, 3222.581064461605, 1032.8244198486275, 1049.1449468683, 1059.7986382587283, 1066.3921564708041, 1069.7432616172064, 20780.27269045576, 21368.893155534435, 21645.025973831216, 21728.891355543437, 21836.23573174931, 1136.6419577832955, 1138.635636596298, 1139.1171841822488, 1141.7602303516355, 1149.0749946293147, 11528.538858445736, 11709.121815863844, 11781.941090294493, 11825.526978920747, 11924.224925379822, 652893.0, 655382.0, 658848.0, 660925.0, 691619.0, 135821.32089339689, 137155.0, 137686.0, 140329.0, 141426.0, 1291.702908331089, 1313.9211647301192, 1364.6315494816345, 1380.2339701465582, 1391.6173052410668, 23257.651135233322, 23267.76732232656, 23314.766852331937, 23329.533409332056, 23430.76569234354, 69223.65388173026, 69411.95882061672, 69469.0, 72214.63892680503, 72271.63864180645, 83922.16077839144, 84542.0, 84677.57661211655, 85648.57175714082, 86651.0, 16098.11460369644, 16299.511014669579, 16426.0, 16482.34070637161, 16489.09309987962, 24191.879040604683, 24529.632055518825, 24818.627720583845, 24937.127200547893, 25175.0, 19872.50318742043, 20271.59456810885, 20298.289559865334, 20307.898460508193, 20324.390268291976, 17485.65028699444, 17568.73646895272, 18121.90939045296, 18181.45455636333, 18473.983930883394, 19693.212271509554, 19920.0, 20319.79680203179, 20352.389428317176, 20381.49046273855, 15958.0, 16064.518064458085, 16132.19339033067, 16163.67672646564, 16248.268827902537, 19712.21151153938, 19755.308564200182, 19771.0, 19778.208871644973, 19827.30604428838], "value": 13407.93473205056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.392219190132, 1552.441121196369, 1555.18352864746, 1566.9373225070997, 1571.0181136789506, 18142.3650172244, 18684.346047888328, 18695.0, 18708.53228669284, 18716.251349945986, 18307.816921830778, 18384.816151838477, 18410.631787364277, 18427.90786046068, 18437.262509499604, 3155.9526607100856, 3247.561579186815, 3249.772515923886, 3255.300110476247, 3255.9348813023726, 3141.968580314202, 3155.9053228403186, 3190.7606929480266, 3192.122166404234, 3192.632847222576, 3170.3183815479665, 3194.7284480819044, 3199.728023118038, 3224.4196044711944, 3225.080851957193, 3137.0902438292983, 3147.410557668363, 3198.328351046283, 3198.760092993035, 3201.135693362791, 2977.3152174999873, 2993.206800197949, 3000.4599172149005, 3004.7295743382983, 3014.3368458939, 17330.220140093727, 17559.12204389788, 17628.383006594708, 17670.381536646284, 17712.29150833965, 8989.190972812477, 9339.626414943394, 9347.579358928797, 9353.953230233805, 9354.67258645951, 5939.910901336483, 6125.754969801203, 6377.904331435032, 6435.742570297182, 6445.129907462479, 2107.2097963263777, 2159.686845407423, 2165.1664109318026, 2203.889805509718, 2204.272590045281, 31599.0, 31623.525647115082, 31626.367472650647, 31639.36721265562, 31822.840885795424, 7580.583067931317, 7948.602569871483, 7969.960150199212, 8060.274575288135, 8096.83806323882, 20861.478463038242, 20946.162153513687, 20958.371248862557, 20964.266250681154, 20967.580648386946, 8864.778380540538, 9233.815323693489, 9251.259899208047, 9289.117533834275, 9295.581698823435, 8244.093149753522, 8250.876236856451, 8277.710280140287, 8507.191816777397, 8507.702230421906, 6217.844553886189, 6234.407731265523, 6235.407636274546, 6264.906026409608, 6305.464035556937, 1708.871834612409, 1755.6313174233553, 1815.110595808071, 1842.8617853661028, 1877.9624407511774, 1020.9846852297221, 1025.4975062219607, 1026.8921763214905, 1031.7730099378125, 1041.037040737315, 9466.0, 9628.807423851484, 9698.224142068617, 9750.171235445066, 9837.55730992107, 1085.8262677971486, 1095.7534554725123, 1104.5471356743697, 1106.9114470842314, 1113.560143743217, 5132.871678208075, 5172.172452407597, 5224.373075230997, 5240.423553409122, 5260.026895024433, 26454.206373808818, 26745.197644070708, 27081.593776093374, 27490.862545687545, 27801.721982780316, 26298.6055209172, 27554.17337479879, 27569.724302757117, 27633.86183069112, 27813.721862781516, 13290.269035203157, 13377.33113344329, 13398.330083495981, 13545.66135846592, 13573.864261357458, 9865.802683946138, 10028.598856045677, 10137.44244066554, 10141.746456338651, 10173.44046077473, 22630.207942721925, 23102.884485578135, 23532.0, 23543.529129416973, 23717.762822371555, 23834.16580419677, 23981.640275395534, 24099.0, 24458.26625201247, 24546.386340341633, 13335.86664133385, 13398.732025359242, 13407.664808379479, 13583.79624305656, 13600.727985440039, 15593.220338983232, 15711.921440393182, 15716.13561254142, 15717.921410392875, 15721.842781572037, 12271.386430678609, 13260.336983150997, 13290.601281961557, 13406.463741450232, 13554.18674879471, 12765.234085954873, 12865.935670321589, 12890.613281601567, 13371.665708357368, 13494.730105398034, 11012.724681883017, 11108.833367499656, 11148.0, 11239.60661376848, 11242.044426223863, 8759.211670949646, 8772.429792063496, 8802.471851688919, 8943.418677786183, 8966.23786978088, 8612.71676300583, 8695.956520217358, 8736.388452808242, 8794.736157915273, 8825.867611985697], "value": 7856.3925869313525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.1893667801759, 585.3765739487445, 588.5027152056512, 608.6895683201567, 626.896562067259, 6472.498376380075, 6477.35226477352, 6587.583669511054, 6615.636140012298, 6633.867322653544, 6490.513211509132, 6553.83615409615, 6590.176227971504, 6610.272869984298, 6644.767433139841, 5454.481824226692, 5469.234307196995, 5489.945100548994, 5503.20203570482, 5540.63985840921, 5151.660568252244, 5299.894002119955, 5329.946700532983, 5336.91994620081, 5338.3060202173665, 5205.453427390126, 5227.111391063529, 5253.238280449333, 5260.0, 5272.868178295535, 5255.344566461552, 5283.807220003694, 5309.389420216686, 5317.175837745156, 5326.9612425577025, 4783.3303337532425, 4837.7097374157665, 4847.418309802811, 4849.1513985052825, 4861.927071093936, 6479.481641468671, 6516.3157868423605, 6537.313582073909, 6578.0, 6605.57063790852, 6153.753849846001, 6176.441202917365, 6206.875862482725, 6253.593516421418, 6256.15541901842, 7033.226345102034, 7069.540479868792, 7081.0, 7095.964520177417, 7139.286071392819, 5232.607554433433, 5427.158790387496, 5434.809781657663, 5442.12925931853, 5451.155070964007, 7138.321859423347, 7243.674034668453, 7404.4816862819625, 7409.407247420193, 7431.516951398142, 5549.0867294669815, 5575.191597218381, 5587.1339942309005, 5591.580631452576, 5605.159226116034, 5664.8867022659315, 5672.688002159838, 5683.630564013409, 5686.402927692616, 5721.713914304268, 6298.118263443122, 6307.972173356814, 6329.525285603506, 6337.873242535124, 6340.144080549159, 6979.511434199659, 7055.400290975222, 7062.258462861429, 7167.820804479826, 7191.89212161818, 1908.1794828223997, 1920.9615807684047, 1933.3426634944187, 1944.4263942137104, 1952.2874150934806, 1295.501232025677, 1336.4386957477882, 1373.7183877305129, 1387.8681525255085, 1392.060359257497, 6369.299377068519, 6400.327965563642, 6410.423061924449, 6583.934160658332, 6590.110335104795, 7076.433885289164, 7119.644017799089, 7150.0, 7160.57036577807, 7168.856622867514, 6457.709403076873, 6588.934110658928, 6634.436072933855, 6645.767398141042, 6660.933390666129, 3757.5490941087246, 3785.072657198949, 3811.294910441577, 3833.2333533293454, 3862.111714305669, 7262.455315851333, 7369.22623124575, 7414.740484083031, 7427.071616047994, 7432.108147022392, 7257.237990011078, 7305.196428392873, 7356.485046046725, 7373.88939165913, 7390.630468476555, 7170.426365890612, 7255.8911616325795, 7300.138464691469, 7396.190961654752, 7396.9260307396235, 6928.16861976566, 7069.611171385417, 7177.3133313670205, 7206.927930720625, 7220.0, 7020.368166865007, 7081.8937715935335, 7136.785896423115, 7191.604461754654, 7199.280071992968, 7383.704651814082, 7453.906628749225, 7467.887981680387, 7472.140703818913, 7475.2151024141685, 5515.4760297771645, 5530.364008139116, 5550.417206193291, 5581.218629391969, 5592.328920529562, 6898.965505172442, 6981.5461994970165, 7088.326608972346, 7180.31786980236, 7191.892121618075, 6867.626474705179, 6906.930930690629, 6939.410150137295, 6986.720531178696, 6994.636045970987, 6902.792916212522, 6934.7226110955, 6977.0, 7022.508424410242, 7046.330598593126, 6884.724611015503, 6888.655567221519, 6892.862142757217, 6906.0, 6944.861102778017, 7041.0, 7042.577445353295, 7065.399441047569, 7093.609851458219, 7120.394766444911, 6782.728690852311, 6799.660016999229, 6827.795166145023, 6830.248672646105, 6842.213145488134], "value": 5506.8509369584535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1006.9848952265717, 1007.9496025198738, 1021.524990879241, 1033.059915476916, 1049.997252623744, 24517.75482245177, 25418.364540886465, 25450.490990180184, 25608.48783024343, 25611.103611373605, 22584.20955266562, 24000.039998400087, 24087.638685419734, 24165.395865103383, 24189.75810241897, 1079.7624522605015, 1099.351382684216, 1105.7512059786563, 1105.8451816745662, 1110.955561777528, 1070.272214893872, 1099.2525082943596, 1111.4220605285286, 1111.6220485035087, 1113.1150735165522, 1181.4978634080524, 1187.8752730963254, 1187.994060029703, 1191.213798892731, 1191.475750669707, 1170.625399872037, 1170.8712041675408, 1178.6699724077273, 1180.7815554122471, 1182.1901997131993, 863.4603372891943, 866.358894418126, 867.5748883047262, 869.543489667923, 869.9347548933792, 21698.674519882214, 22052.338429847132, 22113.889430552907, 22253.44366390837, 22322.441938951495, 24059.0, 24107.51784964291, 24358.63462048071, 24713.752862471505, 24794.380140496633, 18063.09684515769, 18187.54531136719, 18279.72580411295, 18281.268749250146, 18300.17649205789, 4120.690948178869, 4150.045489537393, 4153.54311025787, 4161.646260067898, 4164.271252530795, 159394.0, 161427.0, 162809.0, 163583.0, 166133.16933415257, 18656.160472778756, 18927.810721892605, 18985.24059037623, 19233.51916202078, 19236.23055077809, 29573.704262957093, 30364.0, 35295.0, 36167.27665446676, 36241.45637815435, 9100.772480688036, 9399.624015039459, 9403.57683904226, 9410.529473526296, 9426.0, 4711.764411779397, 4751.429828420612, 4788.449328327218, 4802.399700037496, 4811.615070794328, 6147.0, 6253.53098517613, 6283.434490895841, 6300.810975670737, 6309.810705678745, 1255.7990721484518, 1308.8167656528094, 1312.5734136405706, 1320.1221187909932, 1323.450767931317, 740.3595889555496, 742.5544673196039, 745.656997781016, 751.4063889527322, 754.8792193249163, 13597.592072237849, 13597.660058498419, 14041.85958140426, 14649.487267945571, 14694.853051469348, 615.673692942741, 631.1416473595906, 632.7437387857925, 634.6319134901746, 658.7793089315134, 6058.848818724428, 6084.4828189603495, 6087.634741915499, 6214.906776398358, 6236.75052997875, 145412.0, 148566.0, 150039.0, 154128.0, 154220.0, 132757.0, 135714.0, 136869.3156534211, 137656.0, 141841.0, 122843.0, 123588.0, 123714.0, 124028.37985810194, 124219.0, 11532.711682208012, 11551.0, 11581.189316747746, 11662.591809286634, 11863.940680296544, 59057.704711476166, 60117.69941150266, 60373.0, 60737.392626073175, 62624.686876567146, 74947.62526187334, 76002.6199868997, 77068.0, 77083.0, 77794.2220577787, 16741.414050508174, 17555.385561505285, 17689.64620707553, 17694.82305176932, 17828.554286142433, 19767.308144215458, 20761.480962976046, 20779.688304675743, 20954.266600668903, 21035.579288414454, 18485.9075704626, 18707.064646767878, 18771.0, 18787.34244301443, 18888.244470221038, 15738.606534836721, 15794.289256983233, 15911.681766364376, 15932.362705492114, 15945.282462288993, 15898.68202635964, 15993.8400615997, 16073.276702548179, 16122.677546448771, 16148.757768633244, 12095.455704493143, 12393.504259829866, 12427.627171184879, 12457.937710311391, 12588.622341329774, 13521.157728517239, 13832.515861944783, 13860.029797914049, 13870.791938120734, 13871.4451421942], "value": 10239.180466452812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1358.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 106.0, 107.0, 105.0, 107.0, 105.0, 106.0, 104.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 110.0, 113.0, 111.0, 118.0, 110.0, 121.0, 134.0, 113.0], "value": 115.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 71.0, 73.0, 72.0, 72.0, 72.0, 78.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 76.0, 77.0, 79.0, 76.0, 77.0, 77.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 113.0, 110.0, 113.0, 110.0, 113.0, 115.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 94.0, 99.0, 100.0, 98.0, 99.0, 99.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 43.0, 44.0, 43.0, 43.0, 44.0, 43.0, 43.0, 44.0, 43.0], "value": 43.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 46.0, 46.0, 45.0, 46.0, 46.0, 46.0, 46.0], "value": 45.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 74.0, 77.0, 69.0, 68.0, 69.0, 69.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 100.0, 104.0, 101.0, 117.0, 97.0, 109.0, 100.0, 100.0, 107.0], "value": 103.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 144.0, 147.0, 146.0, 144.0, 154.0, 143.0, 144.0, 150.0, 144.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 58.0, 57.0, 58.0, 57.0, 59.0, 59.0, 56.0, 57.0], "value": 58.5, "unit": "score"}]}]} 11:40:47 INFO - Return code: 0 11:40:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:40:47 INFO - # TBPL SUCCESS # 11:40:47 INFO - Running post-action listener: _package_coverage_data 11:40:47 INFO - Running post-action listener: _resource_record_post_action 11:40:47 INFO - [mozharness: 2017-09-23 18:40:47.433427Z] Finished run-tests step (success) 11:40:47 INFO - Running post-run listener: _resource_record_post_run 11:40:47 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291336192; Read time: 108; Write time: 153952 11:40:47 INFO - TinderboxPrint: CPU usage
13.0% 11:40:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 108 11:40:47 INFO - TinderboxPrint: I/O write bytes / time
291,336,192 / 153,952 11:40:47 INFO - TinderboxPrint: CPU idle
8,183.0 (87.0%) 11:40:47 INFO - TinderboxPrint: CPU user
1,178.9 (12.5%) 11:40:47 INFO - TinderboxPrint: Swap in / out
0 / 0 11:40:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9089024; Read time: 0; Write time: 1344 11:40:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:40:47 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281858048; Read time: 108; Write time: 152580 11:40:48 INFO - Running post-run listener: _upload_blobber_files 11:40:48 INFO - Blob upload gear active. 11:40:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:40:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:40:48 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:40:48 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:40:48 INFO - (blobuploader) - INFO - Open directory for files ... 11:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:49 INFO - (blobuploader) - INFO - Done attempting. 11:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:52 INFO - (blobuploader) - INFO - Done attempting. 11:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:54 INFO - (blobuploader) - INFO - Done attempting. 11:40:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:40:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:40:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:40:55 INFO - (blobuploader) - INFO - Done attempting. 11:40:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:40:55 INFO - Return code: 0 11:40:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:40:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:40:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/daee1d7cbdc98643542a0028a3dba87d020378496714f3d31840ab4f3c55ce9ed47d58a49511f62f815b9b461113b96ecd84ee8f9b4ce3a68ee6b0c935496416", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6d48ba70599d6165383890c1830132587027a33adfb45905d0470625b5435c322cd77163bd06134810adf2da13b194c94eb0b02100fbd080518dd3a4ddb4e8cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1cbbfd6835a277d0a5ea4f81f6f5c9824ac267c3bb01a6aa0b3bb7519cbdaa7c01fdabb260cf44efabf65f68aab7dc7a209c0da2fbc865c5eb8cf472a88627d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03c48ccf1ba552fa5f0fea17620b8a3c4c7d1aef431c0d10a56aa07778bd64638eacc1fff56de5bbf5291702b74fddc1baa45ff145a166991402deadd108a58f"} 11:40:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:40:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:40:55 INFO - Contents: 11:40:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/daee1d7cbdc98643542a0028a3dba87d020378496714f3d31840ab4f3c55ce9ed47d58a49511f62f815b9b461113b96ecd84ee8f9b4ce3a68ee6b0c935496416", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6d48ba70599d6165383890c1830132587027a33adfb45905d0470625b5435c322cd77163bd06134810adf2da13b194c94eb0b02100fbd080518dd3a4ddb4e8cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1cbbfd6835a277d0a5ea4f81f6f5c9824ac267c3bb01a6aa0b3bb7519cbdaa7c01fdabb260cf44efabf65f68aab7dc7a209c0da2fbc865c5eb8cf472a88627d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03c48ccf1ba552fa5f0fea17620b8a3c4c7d1aef431c0d10a56aa07778bd64638eacc1fff56de5bbf5291702b74fddc1baa45ff145a166991402deadd108a58f"} 11:40:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:40:55 INFO - Copying logs to upload dir... 11:40:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:40:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.071019 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-23 11:40:55.029577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 11:40:55.037373) ========= 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=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 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/Mozilla-Beta-Non-PGO/sha512/daee1d7cbdc98643542a0028a3dba87d020378496714f3d31840ab4f3c55ce9ed47d58a49511f62f815b9b461113b96ecd84ee8f9b4ce3a68ee6b0c935496416", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6d48ba70599d6165383890c1830132587027a33adfb45905d0470625b5435c322cd77163bd06134810adf2da13b194c94eb0b02100fbd080518dd3a4ddb4e8cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1cbbfd6835a277d0a5ea4f81f6f5c9824ac267c3bb01a6aa0b3bb7519cbdaa7c01fdabb260cf44efabf65f68aab7dc7a209c0da2fbc865c5eb8cf472a88627d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03c48ccf1ba552fa5f0fea17620b8a3c4c7d1aef431c0d10a56aa07778bd64638eacc1fff56de5bbf5291702b74fddc1baa45ff145a166991402deadd108a58f"} build_url:https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/NK5WZIhOTKW0xbcQL__QCg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/daee1d7cbdc98643542a0028a3dba87d020378496714f3d31840ab4f3c55ce9ed47d58a49511f62f815b9b461113b96ecd84ee8f9b4ce3a68ee6b0c935496416", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6d48ba70599d6165383890c1830132587027a33adfb45905d0470625b5435c322cd77163bd06134810adf2da13b194c94eb0b02100fbd080518dd3a4ddb4e8cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/1cbbfd6835a277d0a5ea4f81f6f5c9824ac267c3bb01a6aa0b3bb7519cbdaa7c01fdabb260cf44efabf65f68aab7dc7a209c0da2fbc865c5eb8cf472a88627d1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/03c48ccf1ba552fa5f0fea17620b8a3c4c7d1aef431c0d10a56aa07778bd64638eacc1fff56de5bbf5291702b74fddc1baa45ff145a166991402deadd108a58f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 11:40:55.068697) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:40:55.069028) ========= 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=ed14279e38b05397cf4aa391000001a4-1506190631.422529-807100123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:40:55.148662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 11:40:55.151990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 11:40:55.152272) ========= ========= Total master_lag: 0.08 =========