builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1506079164.98 results: success (0) revision: e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:24.980530) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:24.981165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:24.981615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:25.025998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:25.026289) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 04:19: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.3M=0s 2017-09-22 04:19:25 (40.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.289912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:25.329661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:25.332978) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019153 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:25.382359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 04:19:25.382657) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae --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 e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae --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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 04:19:25,381 truncating revision to first 12 chars 2017-09-22 04:19:25,381 Setting DEBUG logging. 2017-09-22 04:19:25,381 attempt 1/10 2017-09-22 04:19:25,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e1fa8dd27228?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 04:19:26,456 unpacking tar archive at: mozilla-beta-e1fa8dd27228/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330503 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-22 04:19:26.735122) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:26.735419) ========= script_repo_revision: e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:26.735776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:26.736046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 04:19:26.749496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-22 04:19:26.749766) ========= /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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:26 INFO - MultiFileLogger online at 20170922 04:19:26 in /builds/slave/test 04:19: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 04:19:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:26 INFO - {'append_to_log': False, 04:19:26 INFO - 'base_work_dir': '/builds/slave/test', 04:19:26 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 04:19:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:26 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 04:19:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:26 INFO - 'code_coverage': False, 04:19:26 INFO - 'config_files': ('talos/linux_config.py',), 04:19:26 INFO - 'default_actions': ('clobber', 04:19:26 INFO - 'read-buildbot-config', 04:19:26 INFO - 'download-and-extract', 04:19:26 INFO - 'populate-webroot', 04:19:26 INFO - 'create-virtualenv', 04:19:26 INFO - 'install', 04:19:26 INFO - 'setup-mitmproxy', 04:19:26 INFO - 'run-tests'), 04:19:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:26 INFO - 'disable_ccov_upload': False, 04:19:26 INFO - 'disable_stylo': False, 04:19:26 INFO - 'download_minidump_stackwalk': True, 04:19:26 INFO - 'download_symbols': 'ondemand', 04:19:26 INFO - 'enable_stylo': False, 04:19:26 INFO - 'enable_webrender': False, 04:19:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:19:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:26 INFO - 'gecko_profile': False, 04:19:26 INFO - 'gecko_profile_interval': 0, 04:19:26 INFO - 'installer_path': 'installer.exe', 04:19:26 INFO - 'log_level': 'info', 04:19:26 INFO - 'log_name': 'talos', 04:19:26 INFO - 'log_to_console': True, 04:19:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:26 INFO - 'opt_config_files': (), 04:19:26 INFO - 'pip_index': False, 04:19:26 INFO - 'suite': 'dromaeojs-e10s', 04:19:26 INFO - 'system_bits': '32', 04:19:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:26 INFO - 'title': 'talos-linux64-ix-029', 04:19:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:26 INFO - 'use_talos_json': True, 04:19:26 INFO - 'verify': 'False', 04:19:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:26 INFO - 'work_dir': 'build'} 04:19:26 INFO - [mozharness: 2017-09-22 11:19:26.896664Z] Running clobber step. 04:19:26 INFO - Running pre-action listener: _resource_record_pre_action 04:19:26 INFO - Running main action method: clobber 04:19:26 INFO - rmtree: /builds/slave/test/build 04:19:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:27 INFO - Running post-action listener: _resource_record_post_action 04:19:27 INFO - [mozharness: 2017-09-22 11:19:27.885990Z] Finished clobber step (success) 04:19:27 INFO - [mozharness: 2017-09-22 11:19:27.886087Z] Running read-buildbot-config step. 04:19:27 INFO - Running pre-action listener: _resource_record_pre_action 04:19:27 INFO - Running main action method: read_buildbot_config 04:19:27 INFO - Using buildbot properties: 04:19:27 INFO - { 04:19:27 INFO - "project": "", 04:19:27 INFO - "product": "firefox", 04:19:27 INFO - "who": "ffxbld@noreply.mozilla.org", 04:19:27 INFO - "installer_path": "public/build/target.tar.bz2", 04:19:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:19:27 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 04:19:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 04:19:27 INFO - "stage_platform": "linux64", 04:19:27 INFO - "basedir": "/builds/slave/test", 04:19:27 INFO - "buildnumber": 105, 04:19:27 INFO - "platform": "ubuntu64_hw", 04:19:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:19:27 INFO - "slavebuilddir": "test", 04:19:27 INFO - "taskId": "cLr0xzQHQw6A7unmvBnO7Q", 04:19:27 INFO - "branch": "mozilla-beta", 04:19:27 INFO - "script_repo_revision": "production", 04:19:27 INFO - "revision": "e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae", 04:19:27 INFO - "slavename": "talos-linux64-ix-029", 04:19:27 INFO - "repo_path": "releases/mozilla-beta" 04:19:27 INFO - } 04:19:27 INFO - Finding installer, test and symbols from parent task. 04:19:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLr0xzQHQw6A7unmvBnO7Q'}, attempt #1 04:19:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLr0xzQHQw6A7unmvBnO7Q'}, attempt #1 04:19:28 INFO - Task dependencies: F_pZonTiTMOWCnfnEqvf0g 04:19:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g'}, attempt #1 04:19:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 04:19:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.test_packages.json 04:19:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.crashreporter-symbols.zip 04:19:29 INFO - Running post-action listener: _resource_record_post_action 04:19:29 INFO - [mozharness: 2017-09-22 11:19:29.213869Z] Finished read-buildbot-config step (success) 04:19:29 INFO - [mozharness: 2017-09-22 11:19:29.214085Z] Running download-and-extract step. 04:19:29 INFO - Running pre-action listener: _resource_record_pre_action 04:19:29 INFO - Running main action method: download_and_extract 04:19:29 INFO - mkdir: /builds/slave/test/build/tests 04:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:29 INFO - trying https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.test_packages.json 04:19:29 INFO - Downloading https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:19:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:19:29 INFO - Downloaded 989 bytes. 04:19:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:19:29 INFO - Using the following test package requirements: 04:19:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:19:29 INFO - u'common': [u'target.common.tests.zip'], 04:19:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:19:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:19:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:19:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:19:29 INFO - u'mozbase': [u'target.common.tests.zip'], 04:19:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:19:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:19:29 INFO - u'web-platform': [u'target.common.tests.zip', 04:19:29 INFO - u'target.web-platform.tests.tar.gz'], 04:19:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:19:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:19:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.common.tests.zip 04:19:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:19:29 INFO - Fetch https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.common.tests.zip into memory 04:19:32 INFO - Content-Length response header: 55174942 04:19:32 INFO - Bytes received: 55174942 04:19:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.talos.tests.zip 04:19:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:19:43 INFO - Fetch https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.talos.tests.zip into memory 04:19:44 INFO - Content-Length response header: 14509184 04:19:44 INFO - Bytes received: 14509184 04:19: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')]} 04:19:45 INFO - trying https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 04:19:45 INFO - Downloading https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:19:49 INFO - Downloaded 53423557 bytes. 04:19:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 04:19:49 INFO - mkdir: /builds/slave/test/properties 04:19:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:49 INFO - Contents: 04:19:49 INFO - build_url:https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 04:19:49 INFO - Running post-action listener: _resource_record_post_action 04:19:49 INFO - Running post-action listener: find_tests_for_verification 04:19:49 INFO - Running post-action listener: set_extra_try_arguments 04:19:49 INFO - [mozharness: 2017-09-22 11:19:49.718205Z] Finished download-and-extract step (success) 04:19:49 INFO - [mozharness: 2017-09-22 11:19:49.718433Z] Running populate-webroot step. 04:19:49 INFO - Running pre-action listener: _resource_record_pre_action 04:19:49 INFO - Running main action method: populate_webroot 04:19:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['tresize', 04:19:49 INFO - 'tcanvasmark']}, 04:19:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['dromaeo_css', 04:19:49 INFO - 'kraken']}, 04:19:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'tests': ['damp', 'tps']}, 04:19:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['damp', 'tps']}, 04:19:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['dromaeo_dom']}, 04:19:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:19:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['basic_compositor_video', 04:19:49 INFO - 'glvideo']}, 04:19:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:19:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['ts_paint_webext', 04:19:49 INFO - 'tp5o_webext']}, 04:19:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:49 INFO - 'ts_paint', 04:19:49 INFO - 'tpaint', 04:19:49 INFO - 'sessionrestore', 04:19:49 INFO - 'sessionrestore_many_windows', 04:19:49 INFO - 'sessionrestore_no_auto_restore', 04:19:49 INFO - 'tabpaint']}, 04:19:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['a11yr', 04:19:49 INFO - 'ts_paint', 04:19:49 INFO - 'tpaint', 04:19:49 INFO - 'sessionrestore', 04:19:49 INFO - 'sessionrestore_many_windows', 04:19:49 INFO - 'sessionrestore_no_auto_restore', 04:19:49 INFO - 'tabpaint']}, 04:19:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:19:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:19:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['perf_reftest_singletons']}, 04:19:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['bloom_basic']}, 04:19:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:49 INFO - 'tsvgr_opacity', 04:19:49 INFO - 'tart', 04:19:49 INFO - 'tscrollx', 04:19:49 INFO - 'tsvg_static']}, 04:19:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['tsvgx', 04:19:49 INFO - 'tsvgr_opacity', 04:19:49 INFO - 'tart', 04:19:49 INFO - 'tscrollx', 04:19:49 INFO - 'tsvg_static']}, 04:19:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:19:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo'], 04:19:49 INFO - 'tests': ['tp5o']}, 04:19:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:49 INFO - 'talos_options': ['--mitmproxy', 04:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:49 INFO - '--firstNonBlankPaint'], 04:19:49 INFO - 'tests': ['tp6_google', 04:19:49 INFO - 'tp6_youtube', 04:19:49 INFO - 'tp6_amazon', 04:19:49 INFO - 'tp6_facebook']}, 04:19:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo', 04:19:49 INFO - '--mitmproxy', 04:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:49 INFO - '--firstNonBlankPaint'], 04:19:49 INFO - 'tests': ['tp6_google', 04:19:49 INFO - 'tp6_youtube', 04:19:49 INFO - 'tp6_amazon', 04:19:49 INFO - 'tp6_facebook']}, 04:19:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:19:49 INFO - 'talos_options': ['--stylo-threads=1', 04:19:49 INFO - '--mitmproxy', 04:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:19:49 INFO - '--firstNonBlankPaint'], 04:19:49 INFO - 'tests': ['tp6_google', 04:19:49 INFO - 'tp6_youtube', 04:19:49 INFO - 'tp6_amazon', 04:19:49 INFO - 'tp6_facebook']}, 04:19:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--xperf_path', 04:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:49 INFO - 'tests': ['tp5n']}, 04:19:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:19:49 INFO - 'talos_options': ['--disable-stylo', 04:19:49 INFO - '--xperf_path', 04:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:49 INFO - 'tests': ['tp5n']}}} 04:19:49 INFO - Running post-action listener: _resource_record_post_action 04:19:49 INFO - [mozharness: 2017-09-22 11:19:49.739504Z] Finished populate-webroot step (success) 04:19:49 INFO - [mozharness: 2017-09-22 11:19:49.739594Z] Running create-virtualenv step. 04:19:49 INFO - Running pre-action listener: _resource_record_pre_action 04:19:49 INFO - Running main action method: create_virtualenv 04:19:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:19:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:19:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:19:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:50 INFO - Installing pip...............done. 04:19:50 INFO - Return code: 0 04:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:19:50 INFO - Reading from file tmpfile_stdout 04:19:50 INFO - Output received: 04:19:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:19:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19: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')]} 04:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19: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', 'pip>=1.5'] in /builds/slave/test/build 04:19: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 pip>=1.5 04:19:50 INFO - Using env: {'DISPLAY': ':0', 04:19:50 INFO - 'HOME': '/home/cltbld', 04:19:50 INFO - 'LANG': 'en_US.UTF-8', 04:19:50 INFO - 'LANGUAGE': 'en_US:en', 04:19:50 INFO - 'LOGNAME': 'cltbld', 04:19:50 INFO - 'MAIL': '/var/mail/cltbld', 04:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:50 INFO - 'MOZ_NO_REMOTE': '1', 04:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:50 INFO - 'NO_EM_RESTART': '1', 04:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:50 INFO - 'PWD': '/builds/slave/test', 04:19:50 INFO - 'SHELL': '/bin/bash', 04:19:50 INFO - 'SHLVL': '1', 04:19:50 INFO - 'TERM': 'linux', 04:19:50 INFO - 'TMOUT': '86400', 04:19:50 INFO - 'USER': 'cltbld', 04:19:50 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:50 INFO - '_': '/tools/buildbot/bin/python'} 04:19:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:19:51 INFO - Downloading/unpacking pip>=1.5 04:19:51 INFO - Running setup.py egg_info for package pip 04:19:51 INFO - warning: no files found matching 'pip/cacert.pem' 04:19:51 INFO - warning: no files found matching '*.html' under directory 'docs' 04:19:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:19:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:19:51 INFO - Installing collected packages: pip 04:19:51 INFO - Found existing installation: pip 1.1 04:19:51 INFO - Uninstalling pip: 04:19:51 INFO - Successfully uninstalled pip 04:19:51 INFO - Running setup.py install for pip 04:19:51 INFO - warning: no files found matching 'pip/cacert.pem' 04:19:51 INFO - warning: no files found matching '*.html' under directory 'docs' 04:19:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:19:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:19:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:19:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:19:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:19:51 INFO - Successfully installed pip 04:19:51 INFO - Cleaning up... 04:19:51 INFO - Return code: 0 04:19:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:19:51 INFO - Using env: {'DISPLAY': ':0', 04:19:51 INFO - 'HOME': '/home/cltbld', 04:19:51 INFO - 'LANG': 'en_US.UTF-8', 04:19:51 INFO - 'LANGUAGE': 'en_US:en', 04:19:51 INFO - 'LOGNAME': 'cltbld', 04:19:51 INFO - 'MAIL': '/var/mail/cltbld', 04:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:51 INFO - 'MOZ_NO_REMOTE': '1', 04:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:51 INFO - 'NO_EM_RESTART': '1', 04:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:51 INFO - 'PWD': '/builds/slave/test', 04:19:51 INFO - 'SHELL': '/bin/bash', 04:19:51 INFO - 'SHLVL': '1', 04:19:51 INFO - 'TERM': 'linux', 04:19:51 INFO - 'TMOUT': '86400', 04:19:51 INFO - 'USER': 'cltbld', 04:19:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:51 INFO - '_': '/tools/buildbot/bin/python'} 04:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:52 INFO - Downloading/unpacking psutil>=3.1.1 04:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:54 INFO - Installing collected packages: psutil 04:19:54 INFO - Running setup.py install for psutil 04:19:54 INFO - building 'psutil._psutil_linux' extension 04:19:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:19:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:19:54 INFO - building 'psutil._psutil_posix' extension 04:19:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:19:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:19:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:55 INFO - Successfully installed psutil 04:19:55 INFO - Cleaning up... 04:19:55 INFO - Return code: 0 04:19:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19: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')]} 04:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:19:55 INFO - Using env: {'DISPLAY': ':0', 04:19:55 INFO - 'HOME': '/home/cltbld', 04:19:55 INFO - 'LANG': 'en_US.UTF-8', 04:19:55 INFO - 'LANGUAGE': 'en_US:en', 04:19:55 INFO - 'LOGNAME': 'cltbld', 04:19:55 INFO - 'MAIL': '/var/mail/cltbld', 04:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:55 INFO - 'MOZ_NO_REMOTE': '1', 04:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:55 INFO - 'NO_EM_RESTART': '1', 04:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:55 INFO - 'PWD': '/builds/slave/test', 04:19:55 INFO - 'SHELL': '/bin/bash', 04:19:55 INFO - 'SHLVL': '1', 04:19:55 INFO - 'TERM': 'linux', 04:19:55 INFO - 'TMOUT': '86400', 04:19:55 INFO - 'USER': 'cltbld', 04:19:55 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:55 INFO - '_': '/tools/buildbot/bin/python'} 04:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:19: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 04:19: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 04:19: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 04:19: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 04:19:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:19:57 INFO - Installing collected packages: mozsystemmonitor 04:19:57 INFO - Running setup.py install for mozsystemmonitor 04:19:57 INFO - Successfully installed mozsystemmonitor 04:19:57 INFO - Cleaning up... 04:19:57 INFO - Return code: 0 04:19:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:57 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 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:19:57 INFO - Using env: {'DISPLAY': ':0', 04:19:57 INFO - 'HOME': '/home/cltbld', 04:19:57 INFO - 'LANG': 'en_US.UTF-8', 04:19:57 INFO - 'LANGUAGE': 'en_US:en', 04:19:57 INFO - 'LOGNAME': 'cltbld', 04:19:57 INFO - 'MAIL': '/var/mail/cltbld', 04:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:57 INFO - 'MOZ_NO_REMOTE': '1', 04:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:57 INFO - 'NO_EM_RESTART': '1', 04:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:57 INFO - 'PWD': '/builds/slave/test', 04:19:57 INFO - 'SHELL': '/bin/bash', 04:19:57 INFO - 'SHLVL': '1', 04:19:57 INFO - 'TERM': 'linux', 04:19:57 INFO - 'TMOUT': '86400', 04:19:57 INFO - 'USER': 'cltbld', 04:19:57 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:57 INFO - '_': '/tools/buildbot/bin/python'} 04:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:19: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 04:19: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 04:19: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 04:19: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 04:19:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:58 INFO - warning: no files found matching '*.txt' 04:19:58 INFO - no previously-included directories found matching 'build' 04:19:58 INFO - no previously-included directories found matching 'dist' 04:19:58 INFO - no previously-included directories found matching '.git*' 04:19:58 INFO - Installing collected packages: jsonschema, functools32 04:19:58 INFO - Running setup.py install for functools32 04:19:58 INFO - warning: no files found matching '*.txt' 04:19:58 INFO - no previously-included directories found matching 'build' 04:19:58 INFO - no previously-included directories found matching 'dist' 04:19:58 INFO - no previously-included directories found matching '.git*' 04:19:58 INFO - Successfully installed jsonschema functools32 04:19:58 INFO - Cleaning up... 04:19:58 INFO - Return code: 0 04:19:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19: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')]} 04:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:19:59 INFO - Using env: {'DISPLAY': ':0', 04:19:59 INFO - 'HOME': '/home/cltbld', 04:19:59 INFO - 'LANG': 'en_US.UTF-8', 04:19:59 INFO - 'LANGUAGE': 'en_US:en', 04:19:59 INFO - 'LOGNAME': 'cltbld', 04:19:59 INFO - 'MAIL': '/var/mail/cltbld', 04:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:59 INFO - 'MOZ_NO_REMOTE': '1', 04:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:59 INFO - 'NO_EM_RESTART': '1', 04:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:59 INFO - 'PWD': '/builds/slave/test', 04:19:59 INFO - 'SHELL': '/bin/bash', 04:19:59 INFO - 'SHLVL': '1', 04:19:59 INFO - 'TERM': 'linux', 04:19:59 INFO - 'TMOUT': '86400', 04:19:59 INFO - 'USER': 'cltbld', 04:19:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:59 INFO - '_': '/tools/buildbot/bin/python'} 04:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:19:59 INFO - Cleaning up... 04:19:59 INFO - Return code: 0 04:19:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:19:59 INFO - Using env: {'DISPLAY': ':0', 04:19:59 INFO - 'HOME': '/home/cltbld', 04:19:59 INFO - 'LANG': 'en_US.UTF-8', 04:19:59 INFO - 'LANGUAGE': 'en_US:en', 04:19:59 INFO - 'LOGNAME': 'cltbld', 04:19:59 INFO - 'MAIL': '/var/mail/cltbld', 04:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:59 INFO - 'MOZ_NO_REMOTE': '1', 04:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:59 INFO - 'NO_EM_RESTART': '1', 04:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:59 INFO - 'PWD': '/builds/slave/test', 04:19:59 INFO - 'SHELL': '/bin/bash', 04:19:59 INFO - 'SHLVL': '1', 04:19:59 INFO - 'TERM': 'linux', 04:19:59 INFO - 'TMOUT': '86400', 04:19:59 INFO - 'USER': 'cltbld', 04:19:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:59 INFO - '_': '/tools/buildbot/bin/python'} 04:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:01 INFO - Downloading docopt-0.6.1.tar.gz 04:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:01 INFO - Running setup.py install for blobuploader 04:20:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:01 INFO - Running setup.py install for requests 04:20:01 INFO - Running setup.py install for docopt 04:20:01 INFO - Successfully installed blobuploader requests docopt 04:20:01 INFO - Cleaning up... 04:20:01 INFO - Return code: 0 04:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:01 INFO - Using env: {'DISPLAY': ':0', 04:20:01 INFO - 'HOME': '/home/cltbld', 04:20:01 INFO - 'LANG': 'en_US.UTF-8', 04:20:01 INFO - 'LANGUAGE': 'en_US:en', 04:20:01 INFO - 'LOGNAME': 'cltbld', 04:20:01 INFO - 'MAIL': '/var/mail/cltbld', 04:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:01 INFO - 'MOZ_NO_REMOTE': '1', 04:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:01 INFO - 'NO_EM_RESTART': '1', 04:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:01 INFO - 'PWD': '/builds/slave/test', 04:20:01 INFO - 'SHELL': '/bin/bash', 04:20:01 INFO - 'SHLVL': '1', 04:20:01 INFO - 'TERM': 'linux', 04:20:01 INFO - 'TMOUT': '86400', 04:20:01 INFO - 'USER': 'cltbld', 04:20:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:01 INFO - '_': '/tools/buildbot/bin/python'} 04:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:02 INFO - Running setup.py (path:/tmp/pip-M8hb41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:02 INFO - Running setup.py (path:/tmp/pip-p0WxiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:02 INFO - Running setup.py (path:/tmp/pip-W_Hx_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:02 INFO - Running setup.py (path:/tmp/pip-hfKV0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:02 INFO - Running setup.py (path:/tmp/pip-VntQ5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:02 INFO - Running setup.py (path:/tmp/pip-gj4mZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:02 INFO - Running setup.py (path:/tmp/pip-EIS3yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:02 INFO - Running setup.py (path:/tmp/pip-1riqg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:02 INFO - Running setup.py (path:/tmp/pip-FGov_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:02 INFO - Running setup.py (path:/tmp/pip-j63pBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:02 INFO - Running setup.py (path:/tmp/pip-2FoO9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:02 INFO - Running setup.py (path:/tmp/pip-af0TYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:02 INFO - Running setup.py (path:/tmp/pip-faQcK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:03 INFO - Running setup.py (path:/tmp/pip-8St9ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:03 INFO - Running setup.py (path:/tmp/pip-35GHSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:03 INFO - Running setup.py (path:/tmp/pip-EBQrka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:03 INFO - Running setup.py (path:/tmp/pip-MqYsZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:03 INFO - Running setup.py install for manifestparser 04:20:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozcrash 04:20:03 INFO - Running setup.py install for mozdebug 04:20:03 INFO - Running setup.py install for mozdevice 04:20:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozfile 04:20:03 INFO - Running setup.py install for mozhttpd 04:20:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozinfo 04:20:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozInstall 04:20:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozleak 04:20:04 INFO - Running setup.py install for mozlog 04:20:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for moznetwork 04:20:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozprocess 04:20:04 INFO - Running setup.py install for mozprofile 04:20:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozrunner 04:20:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozscreenshot 04:20:04 INFO - Running setup.py install for moztest 04:20:04 INFO - Running setup.py install for mozversion 04:20:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:05 INFO - Cleaning up... 04:20:05 INFO - Return code: 0 04:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:05 INFO - Using env: {'DISPLAY': ':0', 04:20:05 INFO - 'HOME': '/home/cltbld', 04:20:05 INFO - 'LANG': 'en_US.UTF-8', 04:20:05 INFO - 'LANGUAGE': 'en_US:en', 04:20:05 INFO - 'LOGNAME': 'cltbld', 04:20:05 INFO - 'MAIL': '/var/mail/cltbld', 04:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:05 INFO - 'MOZ_NO_REMOTE': '1', 04:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:05 INFO - 'NO_EM_RESTART': '1', 04:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:05 INFO - 'PWD': '/builds/slave/test', 04:20:05 INFO - 'SHELL': '/bin/bash', 04:20:05 INFO - 'SHLVL': '1', 04:20:05 INFO - 'TERM': 'linux', 04:20:05 INFO - 'TMOUT': '86400', 04:20:05 INFO - 'USER': 'cltbld', 04:20:05 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:05 INFO - '_': '/tools/buildbot/bin/python'} 04:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:05 INFO - Running setup.py (path:/tmp/pip-B9F7DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:05 INFO - Running setup.py (path:/tmp/pip-v8Q3pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:05 INFO - Running setup.py (path:/tmp/pip-and6xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:05 INFO - Running setup.py (path:/tmp/pip-wRq1l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:05 INFO - Running setup.py (path:/tmp/pip-GR06CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:05 INFO - Running setup.py (path:/tmp/pip-AKBfaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:05 INFO - Running setup.py (path:/tmp/pip-wJby5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:05 INFO - Running setup.py (path:/tmp/pip-DVTt8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:05 INFO - Running setup.py (path:/tmp/pip-iCpnDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:05 INFO - Running setup.py (path:/tmp/pip-43v3yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:06 INFO - Running setup.py (path:/tmp/pip-xm75OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:06 INFO - Running setup.py (path:/tmp/pip-71bRJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:06 INFO - Running setup.py (path:/tmp/pip-1Fazw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:06 INFO - Running setup.py (path:/tmp/pip-4SL3Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:06 INFO - Running setup.py (path:/tmp/pip-UKySWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:06 INFO - Running setup.py (path:/tmp/pip-lbnjtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:06 INFO - Running setup.py (path:/tmp/pip-8N9dGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:07 INFO - Downloading blessings-1.6.tar.gz 04:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:07 INFO - Installing collected packages: blessings 04:20:07 INFO - Running setup.py install for blessings 04:20:07 INFO - Successfully installed blessings 04:20:07 INFO - Cleaning up... 04:20:07 INFO - Return code: 0 04:20:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:08 INFO - Reading from file tmpfile_stdout 04:20:08 INFO - Current package versions: 04:20:08 INFO - argparse == 1.2.1 04:20:08 INFO - blessings == 1.6 04:20:08 INFO - blobuploader == 1.2.4 04:20:08 INFO - docopt == 0.6.1 04:20:08 INFO - functools32 == 3.2.3-2 04:20:08 INFO - jsonschema == 2.5.1 04:20:08 INFO - manifestparser == 1.1 04:20:08 INFO - mozInstall == 1.13 04:20:08 INFO - mozcrash == 1.0 04:20:08 INFO - mozdebug == 0.1 04:20:08 INFO - mozdevice == 0.51 04:20:08 INFO - mozfile == 1.2 04:20:08 INFO - mozhttpd == 0.7 04:20:08 INFO - mozinfo == 0.10 04:20:08 INFO - mozleak == 0.1 04:20:08 INFO - mozlog == 3.5 04:20:08 INFO - moznetwork == 0.27 04:20:08 INFO - mozprocess == 0.25 04:20:08 INFO - mozprofile == 0.28 04:20:08 INFO - mozrunner == 6.13 04:20:08 INFO - mozscreenshot == 0.1 04:20:08 INFO - mozsystemmonitor == 0.3 04:20:08 INFO - moztest == 0.8 04:20:08 INFO - mozversion == 1.4 04:20:08 INFO - psutil == 3.1.1 04:20:08 INFO - requests == 1.2.3 04:20:08 INFO - wsgiref == 0.1.2 04:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:20:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:09 INFO - Installing collected packages: simplejson 04:20:09 INFO - Running setup.py install for simplejson 04:20:09 INFO - building 'simplejson._speedups' extension 04:20:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:20:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:20:10 INFO - Successfully installed simplejson 04:20:10 INFO - Cleaning up... 04:20:10 INFO - Return code: 0 04:20:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a53a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, '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': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:10 INFO - Using env: {'DISPLAY': ':0', 04:20:10 INFO - 'HOME': '/home/cltbld', 04:20:10 INFO - 'LANG': 'en_US.UTF-8', 04:20:10 INFO - 'LANGUAGE': 'en_US:en', 04:20:10 INFO - 'LOGNAME': 'cltbld', 04:20:10 INFO - 'MAIL': '/var/mail/cltbld', 04:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:10 INFO - 'MOZ_NO_REMOTE': '1', 04:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:10 INFO - 'NO_EM_RESTART': '1', 04:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:10 INFO - 'PWD': '/builds/slave/test', 04:20:10 INFO - 'SHELL': '/bin/bash', 04:20:10 INFO - 'SHLVL': '1', 04:20:10 INFO - 'TERM': 'linux', 04:20:10 INFO - 'TMOUT': '86400', 04:20:10 INFO - 'USER': 'cltbld', 04:20:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:10 INFO - '_': '/tools/buildbot/bin/python'} 04:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:10 INFO - Cleaning up... 04:20:10 INFO - Return code: 0 04:20:10 INFO - Running post-action listener: _resource_record_post_action 04:20:10 INFO - Running post-action listener: _start_resource_monitoring 04:20:10 INFO - Starting resource monitoring. 04:20:10 INFO - [mozharness: 2017-09-22 11:20:10.792341Z] Finished create-virtualenv step (success) 04:20:10 INFO - [mozharness: 2017-09-22 11:20:10.792800Z] Running install step. 04:20:10 INFO - Running pre-action listener: _resource_record_pre_action 04:20:10 INFO - Running main action method: install 04:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:11 INFO - Reading from file tmpfile_stdout 04:20:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:11 INFO - Reading from file tmpfile_stdout 04:20:11 INFO - Output received: 04:20:11 INFO - Usage: mozinstall [options] installer 04:20:11 INFO - Options: 04:20:11 INFO - -h, --help show this help message and exit 04:20:11 INFO - -d DEST, --destination=DEST 04:20:11 INFO - Directory to install application into. [default: 04:20:11 INFO - "/builds/slave/test"] 04:20:11 INFO - --app=APP Application being installed. [default: firefox] 04:20:11 INFO - mkdir: /builds/slave/test/build/application 04:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:20:25 INFO - Reading from file tmpfile_stdout 04:20:25 INFO - Output received: 04:20:25 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:25 INFO - Running post-action listener: _resource_record_post_action 04:20:25 INFO - [mozharness: 2017-09-22 11:20:25.697165Z] Finished install step (success) 04:20:25 INFO - [mozharness: 2017-09-22 11:20:25.697416Z] Running setup-mitmproxy step. 04:20:25 INFO - Running pre-action listener: _resource_record_pre_action 04:20:25 INFO - Running main action method: setup_mitmproxy 04:20:25 INFO - Skipping: mitmproxy is not required 04:20:25 INFO - Running post-action listener: _resource_record_post_action 04:20:25 INFO - [mozharness: 2017-09-22 11:20:25.698553Z] Finished setup-mitmproxy step (success) 04:20:25 INFO - [mozharness: 2017-09-22 11:20:25.698775Z] Running run-tests step. 04:20:25 INFO - Running pre-action listener: _resource_record_pre_action 04:20:25 INFO - Running pre-action listener: _set_gcov_prefix 04:20:25 INFO - Running main action method: run_tests 04:20:25 WARNING - Try message not found. 04:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:25 INFO - Python 2.7.3 04:20:25 INFO - Return code: 0 04:20:25 INFO - grabbing minidump binary from tooltool 04:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a57090>, '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 0x2a57d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a51f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:20:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:20:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:20:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:25 INFO - Return code: 0 04:20:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:25 INFO - ENV: RUST_BACKTRACE is now full 04:20:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:25 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/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:20:25 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/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:20:25 INFO - Using env: {'DISPLAY': ':0', 04:20:25 INFO - 'HOME': '/home/cltbld', 04:20:25 INFO - 'LANG': 'en_US.UTF-8', 04:20:25 INFO - 'LANGUAGE': 'en_US:en', 04:20:25 INFO - 'LOGNAME': 'cltbld', 04:20:25 INFO - 'MAIL': '/var/mail/cltbld', 04:20:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:25 INFO - 'MOZ_NO_REMOTE': '1', 04:20:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:25 INFO - 'NO_EM_RESTART': '1', 04:20:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:25 INFO - 'PWD': '/builds/slave/test', 04:20:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:25 INFO - 'RUST_BACKTRACE': 'full', 04:20:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:20:25 INFO - 'SHELL': '/bin/bash', 04:20:25 INFO - 'SHLVL': '1', 04:20:25 INFO - 'TERM': 'linux', 04:20:25 INFO - 'TMOUT': '86400', 04:20:25 INFO - 'USER': 'cltbld', 04:20:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:25 INFO - '_': '/tools/buildbot/bin/python'} 04:20:25 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/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:20:26 INFO - mozversion application_buildid: 20170922100024 04:20:26 INFO - mozversion application_changeset: e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae 04:20:26 INFO - mozversion application_display_name: Firefox 04:20:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:26 INFO - mozversion application_name: Firefox 04:20:26 INFO - mozversion application_remotingname: firefox 04:20:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:20:26 INFO - mozversion application_vendor: Mozilla 04:20:26 INFO - mozversion application_version: 57.0 04:20:26 INFO - mozversion platform_buildid: 20170922100024 04:20:26 INFO - mozversion platform_changeset: e1fa8dd27228a929f28524cfc1ad4e5fdcee0cae 04:20:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:20:26 INFO - mozversion platform_version: 57.0 04:20:26 INFO - using testdate: 1506079226 04:20:26 INFO - actual date: 1506079226 04:20:26 INFO - starting webserver on 'localhost:52980' 04:20:26 INFO - SUITE-START | Running 2 tests 04:20:26 INFO - TEST-START | dromaeo_css 04:20:26 INFO - Initialising browser for dromaeo_css test... 04:20:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52980/getInfo.html -profile /tmp/tmpqqORZH/profile 04:20:26 INFO - TEST-INFO | started process 5093 (/builds/slave/test/build/application/firefox/firefox http://localhost:52980/getInfo.html) 04:20:32 INFO - TEST-INFO | 5093: exit 0 04:20:32 INFO - Browser initialized. 04:20:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:32 INFO - Using env: {'DISPLAY': ':0', 04:20:32 INFO - 'HOME': '/home/cltbld', 04:20:32 INFO - 'JSGC_DISABLE_POISONING': '1', 04:20:32 INFO - 'LANG': 'en_US.UTF-8', 04:20:32 INFO - 'LANGUAGE': 'en_US:en', 04:20:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:20:32 INFO - 'LOGNAME': 'cltbld', 04:20:32 INFO - 'MAIL': '/var/mail/cltbld', 04:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:32 INFO - 'MOZ_CRASHREPORTER': '1', 04:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:20:32 INFO - 'MOZ_NO_REMOTE': '1', 04:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:32 INFO - 'NO_EM_RESTART': '1', 04:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:32 INFO - 'PWD': '/builds/slave/test', 04:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:32 INFO - 'RUST_BACKTRACE': 'full', 04:20:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:20:32 INFO - 'SHELL': '/bin/bash', 04:20:32 INFO - 'SHLVL': '1', 04:20:32 INFO - 'TERM': 'linux', 04:20:32 INFO - 'TMOUT': '86400', 04:20:32 INFO - 'USER': 'cltbld', 04:20:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:32 INFO - '_': '/tools/buildbot/bin/python'} 04:20:32 INFO - TEST-INFO | started process 5283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqqORZH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:43 INFO - PID 5283 | RSS: Main: 143339520 04:20:43 INFO - PID 5283 | 04:23:41 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52980/tests/dromaeo/cssquery-ext.html) 04:23:41 INFO - PID 5283 | RSS: Main: 146669568 04:23:41 INFO - PID 5283 | 04:26:43 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-ext.html (next: http://localhost:52980/tests/dromaeo/cssquery-jquery.html) 04:26:43 INFO - PID 5283 | RSS: Main: 145031168 04:26:43 INFO - PID 5283 | 04:29:45 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52980/tests/dromaeo/cssquery-mootools.html) 04:29:46 INFO - PID 5283 | RSS: Main: 146464768 04:29:46 INFO - PID 5283 | 04:32:47 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52980/tests/dromaeo/cssquery-prototype.html) 04:32:48 INFO - PID 5283 | RSS: Main: 146198528 04:32:48 INFO - PID 5283 | 04:35:50 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52980/tests/dromaeo/cssquery-yui.html) 04:35:51 INFO - PID 5283 | RSS: Main: 147841024 04:35:51 INFO - PID 5283 | 04:38:52 INFO - PID 5283 | Cycle 1(1): loaded http://localhost:52980/tests/dromaeo/cssquery-yui.html (next: http://localhost:52980/tests/dromaeo/cssquery-dojo.html) 04:38:53 INFO - PID 5283 | RSS: Main: 150851584 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | __start_tp_report 04:38:53 INFO - PID 5283 | _x_x_mozilla_page_load 04:38:53 INFO - PID 5283 | _x_x_mozilla_page_load_details 04:38:53 INFO - PID 5283 | |i|pagename|runs| 04:38:53 INFO - PID 5283 | |0;dojo.html;3986.342253528168;4008.498937632796;4034.6973976951735;4040.5757395473474;4050.9189816203675;6554.672266386686;6576.473882089422;6596.373344532274;6649.8005059848165;6681.265060843303;6596.934030659692;6598.208215014193;6633.369829866155;6691.765788197414;6701.329867013296;5908.586398952075;5925.2889653241455;5968.253968253968;5968.7015649217365;5986.940130598693;5852.619579727326;5927.614705044159;5981.49157321626;6044.455998960093;6062.333143354227;5974.133750606159;5982.760689572412;6001.159837622715;6019.367966363535;6052.667103309316;5899.5870289079785;5994.25071866019;6010.669413182273;6060.060690592965;6068.6358818471035;5788.739506722208;5847.0352391855295;5856.121581762727;5880.323762767251;5936.198613187207;6490.643014634194;6497.480201583862;6514.869702605969;6521.15225020749;6530.771423000219;7135.322144396326;7144.071270734823;7233;7235.927640723578;7249.057622509093;7186.568805871664;7188.928110718878;7273.490855640107;7276.090488688914;7330.780076597657;6606.306337834554;6645.634490103091;6658.300878407795;6720.32796720324;6771.356721111487;7326.890096648554;7334.376577990931;7344.155422126417;7349.448791340671;7407.48137644546;7057.435405167575;7097.645117744092;7131.144262688511;7160.820979475555;7177.210506844243;6845.315468453215;7021.824454388681;7232.276772322725;7314.268573142643;7352.04423424962;7121.359077683033;7181.35367816899;7188.17336006366;7210.423166146696;7213.278672132849;7130.108736407949;7145.642717864086;7152.141742990874;7195.208527062019;7205.603691797001;5278.234655974862;5287.206918962186;5355.705436201047;5370.946290537045;5374.328208973879;4756.096341695067;4787.521247875185;4840.782164802592;4848.612111031109;4960.528749768766;6790.11728475305;6845.589264644137;6846.7945961621235;6847.691853866588;6855.794326170223;7169.641517924188;7208.135023797178;7213.675384607705;7217.097862767154;7280.017197678351;6724.865502689919;6777.01733248686;6804.08144900442;6813.454923606099;6870.31296870309;6028.819135425944;6058.606190597597;6096.420840020191;6107.29766076898;6109.7861574844665;7484.513506622052;7486.737964171228;7544.0569928758905;7556.055493063367;7606.733764318223;6976.755813546704;7073.045138906182;7089.503734738519;7108.573485590881;7220.675069621774;7463.514871533333;7519.849603008019;7526.849463010819;7538.849223015619;7582.431317651309;6989.37095661393;7069.469789765685;7151.570905745672;7179.964100179465;7188.209296977433;7020.227774944854;7134.143902731706;7136.821579460555;7212.74755383559;7292.854142917005;6890.655467226718;6898.8620227596175;6907.171139463297;6921.757738479129;6931.757388491378;6867.622280774605;6911.101556797584;6990.965045174741;6992.0910281663055;7006.824829379307;6831.351021652935;6857.828554286183;6915.204751453647;6944.201416837129;6959.96520017417;6978.441724661913;6980.162380514371;7057.117860267466;7093.290670933072;7098.680559374738;6758.932410676027;6796.66016699173;6841.657917104224;6891.793246202421;6914.239433662193 04:38:53 INFO - PID 5283 | |1;ext.html;955.7610597350663;968.3802366485451;990.7523119220195;995.6266400099962;1023.6570748799152;43871.12257754847;44143.33784993228;44462.555374446245;44505.55494445059;44578.33132503015;44530.33204501927;44717.10565788682;45103.32345014819;45134.322985155246;45194;7983;8114.472559283628;8162.591870406485;8168.346532277418;8171;7839.451238413313;7912.327452166573;7927.04875414951;7934.127246002935;7945.562994035326;8760.8685869712;8927;8968.730938071836;9001.864972025392;9007.189352958232;8838.513881736502;8911.10888911107;8911.688090916787;8914.554272286392;8915.42049766763;8831.911680883173;8883.600237989305;8923.10768923109;8924.910750892537;8930.598123084477;40674.38988415176;40747.18505629901;41261.79369103135;41266.587334126576;41281;3706.4625629283605;3735.34631439497;3737.4580685800406;3741.906452338686;3749.9625003749884;33900.83049584761;33945.830270848484;33985.15037124067;34121.829390853134;34183;5622.634528755618;5674.404187560329;5685.573581981368;5692.857678558028;5699.287589051369;237571;238799;239033;239203.8039809807;240623;52488.47511524836;52506.21240681393;52971.73514132405;53239.46760532423;53569.46430535645;55877.44122558722;55978.720106400026;56002.71998639981;56081;56339.43660563342;18244.63510729778;18549.629007419775;18596.907015464836;18625.534361640795;18625.627487450176;15511;15511.689766204612;15562.221888905737;15563.688726225411;15571.221438928009;15014;15516;15518.767218491732;15618.843811561967;15695.2735199128;5976.790812321635;6010.308814486302;6086.878262434727;6225.750969961151;6247.781327653511;1093.5352475198008;1093.5844379135876;1102.5148934468807;1113.5434471866495;1114.1810769084716;25952.87023564908;26120.8693956529;26190.21429357122;26332.60501092485;26473.73526264751;1201.4773573495556;1209.9576514821938;1233.0998371188903;1233.5682511121215;1244.2472304255975;13647.590572282847;13705.246211458267;13749.862501375059;13875.028747987544;14154.292285385896;277679;307289;309529;309964;322738;56228.71885640546;56450.15324770132;56990.14514782282;57042.42957570371;57271.713641431525;1530.2042937672347;1537.085434166669;1558.4934896158568;1566.1229711361673;1573.0797483472068;31268;31575.84212078925;31656.05031849048;31669.683303166672;32257.838710806296;42319.36520952127;42528.14943701171;42681.57318426776;42701.57298426976;42735.3589696161;267641;267864;268633;268724;269270;37699.62300376961;38381;38629.613703863724;39104.608953910094;39176.60823391729;46363.304550431094;48055.519444805104;48247.27629085637;48512;48767.75616121897;35467.289022029465;35510.289794203454;35607.10982225465;35702.28595428129;35849;33242.66757332492;33489;33853.66146338505;33939;34319.828400857834;40284.3957340646;41088.58911410848;41343.58656413398;41514;41583.37624935689;33237;33398.33203335871;33806.32387352288;34308.65691343055;34519.30961380809;24869.741581285012;25087.498250035263;25210;25537.361565961;26025.869870650524 04:38:53 INFO - PID 5283 | |2;jquery.html;639.1514244917382;641.16533251977;642.195567093821;647.5681696096353;663.6283681138563;23999.520009599797;24892;24971.500569988635;24972.375690607743;25011.624825627583;23268.06927722889;23371.1820086297;23632.763672363315;23676;23756.168534101267;6359.55483116182;6628.834279143011;6641.070250164981;6686.1642294713165;6794.218664853555;6627.337266273383;6695.564788288746;6718.160229971254;6718.361755633207;6728.596284222962;6479.481641468671;6654.168228971379;6659.2008958925;6668.433183179435;6693.765718199864;6703.061571380011;6744.055832183498;6744.898826517606;6745.392914637681;6747.662616869186;6287.528435367366;6313.147725057104;6330.01884707871;6344.429001389897;6347;30484;31376.843115784504;31964.520532192037;31968.680313197037;31980;2351.400392899817;2390.2829151254555;2396.9640455393182;2398.4603464220586;2399.664047033417;20645.4838629034;21084.156633734787;21148.788512114836;21194.894025529928;21195.47011324729;2368.834181607288;2372;2438.926832195037;2455.4107014316614;2464.9260522184363;151143;158007;168853;173526.13236933862;174164.12917935455;15540.222988850512;16520.4217852377;16905.956927753123;16973.66052678964;17003.23485443158;27012.86493567559;27159.728402716115;27178;27182.320441989108;27392.17823465299;11475.770484590428;11637.534498620129;11650.592229271935;11795.469203885847;11871.940640296916;10679.89320106789;10728.249022568345;10738.463076846127;10738.73153171177;10764.515596798163;10104.646337378157;10221.43782091992;10342.844857327145;10381.532831022621;10467.528961196764;2996.6104406427025;3008.247938015496;3025.8638361273797;3067.4171907337536;3113.9532907006414;1037.5486663301338;1046.9162467002623;1051.353417648141;1064.084886997182;1066.6000249906285;20762;21293;21553.78446215549;21735.56528869414;21834.89082554577;1085.625459216569;1122.5958654884234;1132.1395739238237;1154.3131836557236;1157.3576664950865;11627.244229125248;11831.230969986924;11888.405579720978;12041.939790301167;12075.3358565278;634235;663856;675794;685014;685420;137043.31478342545;141478;141660.29169854085;141746;143579.2821035909;1160.187868492042;1217.719924417389;1240.4913985265998;1262.4634530324574;1325.3307079924577;21611.02750376268;22063;22237.66643500381;22301.665475018213;22380.104795807987;64013.67993160005;64095.359046410806;64285;65980.34019659742;66313;76595.23404765881;77003;77527.61236193783;77543.61228193823;82000;15925.761113583074;16096;16142.67714645724;16304.429344973343;16346.836531634532;24342.878285608458;24650.630240546765;24686.13598524043;24745.62881556742;24753.133640322503;19768.90115549413;20164.967006599032;20309.390718278475;20503.692444613043;20539.178432863115;16949.661006780043;17813.287468501116;17837.73243401324;18221.45335639933;18399.264029439208;19878.60242795165;20336.69494957547;20544.79455205429;20618.484537886674;20735.170593176103;15748.448804291795;15782.289796959394;15805.446809361618;15925;16082.59793505125;19820.306289279804;20031.39905802828;20062;20069.29757458482;20272.898635506728 04:38:53 INFO - PID 5283 | |3;mootools.html;1407.4933024111317;1459.6277949122973;1467.5303902751118;1477.276134694;1498.970020599588;17042.82957170428;17796.555086122855;17836.108194590284;17870.731939020927;17871.910640446797;17267.39564115256;17452.912735436305;17457.912710436463;17546.210420531075;17593.12034398278;3100.534919762031;3164.129864287328;3166.1926208816776;3175.158582975513;3200.4079245339685;3154.463741164008;3184.0607020928765;3185.347003864214;3192.425363434581;3202.759793015533;3172.317951640397;3284.3759685659766;3285.227971426713;3285.5071739239065;3286.9342613147724;3167.8099314041115;3219.678032196785;3225.532297816815;3225.6774322567558;3233.030090972699;3138.0585824252635;3145.2294187923876;3168.2237851726245;3169.4453470642547;3170.6036745406823;17069.231884565223;17404.30382784687;17410.21654025572;17417.39039133624;17460.30158793647;9171.082891710843;9430.952845235799;9443.338966272364;9460.385074970105;9534.904650953471;6249.375062493714;6328.778492752732;6434.324395938453;6469.288378278386;6504.577202481823;2126.4258650164525;2132.2004248406847;2134.509062915538;2174.3911704722705;2209.4255493571786;31108.533371999438;31372.686273137206;31450.685493145233;31457.84271078653;31501.8424907874;7808.68765249395;7933.880991785128;7965.362770978308;7966.163552826985;8182.509049457051;20506.179752810018;20522.179112835318;20562.074706638236;20590.382288531368;20608.69086963697;9053.59258833354;9340.486273255035;9342;9383.296252780932;9407.858882116774;8395.664173432995;8420.073791882887;8424.957875210584;8484.575771211415;8583.527905965231;6252.343503932113;6269.244611508785;6306.527010474233;6315.494760419156;6377.71300291488;1711.922963466647;1739.878208525391;1860.4604664647102;1864.4593068010124;1865.123392005755;1001.6744558018673;1013.7313611892707;1037.0666400239693;1038.3925403638805;1052.5263631365763;8977.775555611162;9049.366544341832;9055.547222638841;9105.317101217302;9126.45241285525;1090.7927493776315;1095.3865835132192;1106.9557217711363;1112.165875593305;1113.3153110836777;5368.973155134199;5377.166539186433;5391.919121213185;5398.190271459234;5430.809921652803;25462.745372546407;25956;26326.473470530484;26511.204663859728;26514.337141571614;25808;26162;26164.476710466064;26253;26295.868520657274;12651.493940242472;12962.351882405843;13048.47806087765;13136.34318284082;13140.34298285082;9850.852237216592;9995.750106247402;10174.949125254327;10225.284230103822;10314.329568578018;21978.230761923256;21984.45038874041;22157.44606384789;22443.10227590878;22518.887405562866;23052.769472305732;23108.306750797503;23168.6524702133;24101.276961691176;24130.276091717278;12973.935130324287;13031.609051728463;13045;13173;13174.868251317748;16080.517584472485;16138.273777679799;16389;16406.343746250495;16407.17964101814;12875.163114397534;13192.340382981005;13229;13312.134711243738;13373.53192638253;12513.061520386189;12522.499100035897;12693;12714.87285127137;12904.677383065124;11472.770544589228;11618.825717614412;11644.708882278012;11751.47118379692;11843.111766617365;8375.497470151811;8389.538575378168;8516.531590762568;8603.741887743377;8610.354223433393;8802.91197088021;8813.030566637537;8917.955410222907;9016.81966360656;9125.771855703395 04:38:53 INFO - PID 5283 | |4;prototype.html;552.1386636846518;591.6095377051146;594.2275042444826;600.8227572866004;607.8328459673589;6402.647854368008;6465.967670161648;6496.252930912952;6533.542652014361;6556.73773049078;6328.892443822324;6373.713182906768;6375.808725738224;6400.423961843433;6458.903116453245;5250.7112108834;5283.894322113555;5300.814471493499;5301.231321458386;5312.203169524563;5029.798808047673;5130.153524668425;5237.711925844077;5300.469953004707;5303.681779093247;5109.795608175668;5117.48825117489;5118.923216151742;5122.846314610568;5125.205593133071;5097.8215762448135;5104.05574968632;5116.795328186868;5147.639665223417;5150.227465880111;4680.882977925545;4681.976590117061;4697.154512187805;4702.741349225791;4704.1767690654;6241.75560618779;6264.9686751566405;6334.5249106317215;6393.93606063938;6414.903776443357;6020.789272375446;6039.067498400514;6065.393460653943;6095.878082438371;6101.2983506896835;6771.322867713189;6787.929681447156;6854.451643868529;6895.241523432418;6920.550164239308;5232.136697444917;5237.73811309433;5270.841874743764;5273.920891186635;5280.577553795687;6999.755008574726;7059.5411298264935;7066.915259998313;7171.103612048494;7190.663034513804;5334.51989320963;5345.33183352081;5346.636607665098;5347.51872331492;5399.867052514313;5336.17289320156;5457.590680698963;5467.644603100865;5468.152436372368;5488.862778430492;5980.85047873798;6009.489193418608;6053.364396738279;6053.424924632153;6078.726457309432;6945.131858517685;6954.687039083254;6955.513114081966;6961;6985.79042628722;1871.8783279086815;1886.8584856135844;1892.4133518609276;1896.3078476356031;1896.6206758648325;1272.9045321600918;1344.6369480240476;1344.926029068391;1354.8848347890344;1360.2586590308306;6488.351164883474;6499.54503184782;6504.739810407531;6511.6651086527145;6516.218053833571;6853.246142924274;6874;6925.653717314114;6937.583744975318;6941.548799328129;6419.614823110628;6470.191226096738;6486.837829054311;6499.642519661369;6522.804315870531;3638.1450359165574;3672.8347224374966;3675.3384390809374;3684.9631503685155;3711.5917249102577;7154.6048520538;7176.677049532784;7297;7336.193018767931;7393.8909163625885;7124.358807707331;7160.749373771997;7233.529820561646;7269.454790890704;7278.818029549304;7116.466265030143;7181.533200341961;7218.314260145278;7257.673404696801;7299.708011679473;6742.561733487308;6825.77136115504;6830.214525329452;6847.417969472651;6862.828429289308;6746.347144949519;6845.589264644137;6863.6568171590225;6873.690683919335;6882.621455819978;7267.563946163247;7278.563286202845;7312.1591017033725;7373.33639972405;7394.186639469546;5391.191321301836;5414.377346605191;5428.538574221236;5436.836894893159;5440.401555828935;6728.461723062045;6898.172219333712;7029.332213439715;7039.225685174729;7080.645967701697;6685.2646208916;6714.932850671431;6748.662566871735;6795.791367805384;6844;6655.866882662416;6682.431993280626;6737.528373014038;6747.662616869039;6750.797476075725;6539.673016349258;6542.8364290893105;6627.701753421011;6708.322919270183;6719.731210751515;6764.594124352555;6845.14435695538;6852.828679283058;6878.621675807678;6896.482763792836;6566.179227596551;6623.549286763928;6639.136912201383;6654.334566543307;6680.63256520896 04:38:53 INFO - PID 5283 | |5;yui.html;990.4750482244403;1014.568808256491;1021.9591216351346;1036.036486067957;1041.890601486844;18214.63570728588;18340.81659183408;18524.62950740986;18572.721409178874;18758.81241187588;18959.90520047401;19082.61834763304;19343.806561934412;19346.419607411764;19713.40859774209;1076.3434305073918;1078.320657985468;1079.4063265204145;1080.8000519903842;1080.9783804323908;1054.0829478353844;1076.4294923690456;1079.3739631013993;1079.9352038877653;1080.0117892128692;1155.5897656331965;1157.2362240920993;1158.687154468293;1159.176984341119;1159.6984783956148;1129.9378534180616;1145.2155273637543;1147.432021149528;1148.4946623485723;1154.4343271796802;849.2653854415947;851.6125163050859;851.7529916324258;852.497026754218;857.1342943626919;20012.49968750793;20119.0946407412;20137.09383077765;20217.8989105055;21833.344999650035;21651.78348216529;21875;21890.343289701334;22056.88971555148;22097.779022209892;19381.80618193814;19383.127759250725;19404.611907761908;19433.416997490098;19620.90189549043;4063.4311196432523;4154.1068670235745;4191.224623444642;4216.3464662977285;4219.472565929259;155524.22237888738;161653.19173404176;166974.99999999878;167972;168994;18767.624647506975;19403.61192776165;19464.124114414884;19508.414747557596;19515.707264391047;34885.65114348875;35476.46785298223;35554.8222258887;35571;35632.821835891176;10318.948405257926;10531.262811603268;10710.410927398912;10727.141828653688;10752.569897204181;4911.852644420673;4992.975035124874;4993.875153121201;5009.599232061426;5024.422191447957;6541.6075035498025;6544.738210471528;6569.638669873108;6653.301403352578;6658.43403310724;1255.2970336611527;1273.2169715624825;1275.222114510148;1283.1210620724646;1304.7520971015476;737.6127533045087;754.2156157596148;766.2911806578892;780.7657702689171;795.08168065884;13486.730265394834;13612.115212511155;14032.649183770487;14938.925305373403;14978.850211497964;783.07988113967;785.6896525872248;786.5831109511968;792.3621484704753;793.5437123653807;6059.545534084961;6120.44915957566;6137.539684523678;6197.101420294032;6296.118543403927;151536;152045;152180;152512.2374388143;152584;114068;119894.40052799854;131878.34060829633;139429;144016.27991859973;122338.77661223452;125020.37489812492;127282.36358818332;128030;132067;13809.723805524034;14020.579382618538;15015.774763378777;15207;15330.310136044129;58837.70581147067;58896;59180;59803.70098149481;59905.70047149737;73458.63270683613;73923;75038;75169.62415187889;77176;21221.893890531068;21466.17537509329;21767;21944.45138871541;22044.669329959743;22564;22699.659505107105;22789.430264243525;22889.77110228943;22895.08419663195;22171.113155474246;22391.104355826235;22411.663825042313;22437.551248975255;22593;18091.547711306797;18273.08634568293;18283.360082397052;18449.354272600394;18453.81546184575;22235.888820555792;22252.221172258895;22315;22378.552428951654;22516.98673559661;12905.225686458842;13142.211467311992;13322.134061285986;13364.264965426995;13453.327333633475;15865.286062127463;16022.198890055684;16034.438794642132;16037.27832247575;16238.837611623732 04:38:53 INFO - PID 5283 | __end_tp_report 04:38:53 INFO - PID 5283 | __start_cc_report 04:38:53 INFO - PID 5283 | _x_x_mozilla_cycle_collect,271 04:38:53 INFO - PID 5283 | __end_cc_report 04:38:53 INFO - PID 5283 | __startTimestamp1506080333236__endTimestamp 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | ------- Summary: start ------- 04:38:53 INFO - PID 5283 | Number of tests: 6 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#0] dojo.html Cycles:165 Average:6632.86 Median:6890.66 stddev:780.09 (11.3%) stddev-sans-first:754.35 04:38:53 INFO - PID 5283 | Values: 3986.3 4008.5 4034.7 4040.6 4050.9 6554.7 6576.5 6596.4 6649.8 6681.3 6596.9 6598.2 6633.4 6691.8 6701.3 5908.6 5925.3 5968.3 5968.7 5986.9 5852.6 5927.6 5981.5 6044.5 6062.3 5974.1 5982.8 6001.2 6019.4 6052.7 5899.6 5994.3 6010.7 6060.1 6068.6 5788.7 5847.0 5856.1 5880.3 5936.2 6490.6 6497.5 6514.9 6521.2 6530.8 7135.3 7144.1 7233.0 7235.9 7249.1 7186.6 7188.9 7273.5 7276.1 7330.8 6606.3 6645.6 6658.3 6720.3 6771.4 7326.9 7334.4 7344.2 7349.4 7407.5 7057.4 7097.6 7131.1 7160.8 7177.2 6845.3 7021.8 7232.3 7314.3 7352.0 7121.4 7181.4 7188.2 7210.4 7213.3 7130.1 7145.6 7152.1 7195.2 7205.6 5278.2 5287.2 5355.7 5370.9 5374.3 4756.1 4787.5 4840.8 4848.6 4960.5 6790.1 6845.6 6846.8 6847.7 6855.8 7169.6 7208.1 7213.7 7217.1 7280.0 6724.9 6777.0 6804.1 6813.5 6870.3 6028.8 6058.6 6096.4 6107.3 6109.8 7484.5 7486.7 7544.1 7556.1 7606.7 6976.8 7073.0 7089.5 7108.6 7220.7 7463.5 7519.8 7526.8 7538.8 7582.4 6989.4 7069.5 7151.6 7180.0 7188.2 7020.2 7134.1 7136.8 7212.7 7292.9 6890.7 6898.9 6907.2 6921.8 6931.8 6867.6 6911.1 6991.0 6992.1 7006.8 6831.4 6857.8 6915.2 6944.2 6960.0 6978.4 6980.2 7057.1 7093.3 7098.7 6758.9 6796.7 6841.7 6891.8 6914.2 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#1] ext.html Cycles:180 Average:45177.78 Median:20724.79 stddev:70887.89 (342.0%) stddev-sans-first:71008.99 04:38:53 INFO - PID 5283 | Values: 955.8 968.4 990.8 995.6 1023.7 43871.1 44143.3 44462.6 44505.6 44578.3 44530.3 44717.1 45103.3 45134.3 45194.0 7983.0 8114.5 8162.6 8168.3 8171.0 7839.5 7912.3 7927.0 7934.1 7945.6 8760.9 8927.0 8968.7 9001.9 9007.2 8838.5 8911.1 8911.7 8914.6 8915.4 8831.9 8883.6 8923.1 8924.9 8930.6 40674.4 40747.2 41261.8 41266.6 41281.0 3706.5 3735.3 3737.5 3741.9 3750.0 33900.8 33945.8 33985.2 34121.8 34183.0 5622.6 5674.4 5685.6 5692.9 5699.3 237571.0 238799.0 239033.0 239203.8 240623.0 52488.5 52506.2 52971.7 53239.5 53569.5 55877.4 55978.7 56002.7 56081.0 56339.4 18244.6 18549.6 18596.9 18625.5 18625.6 15511.0 15511.7 15562.2 15563.7 15571.2 15014.0 15516.0 15518.8 15618.8 15695.3 5976.8 6010.3 6086.9 6225.8 6247.8 1093.5 1093.6 1102.5 1113.5 1114.2 25952.9 26120.9 26190.2 26332.6 26473.7 1201.5 1210.0 1233.1 1233.6 1244.2 13647.6 13705.2 13749.9 13875.0 14154.3 277679.0 307289.0 309529.0 309964.0 322738.0 56228.7 56450.2 56990.1 57042.4 57271.7 1530.2 1537.1 1558.5 1566.1 1573.1 31268.0 31575.8 31656.1 31669.7 32257.8 42319.4 42528.1 42681.6 42701.6 42735.4 267641.0 267864.0 268633.0 268724.0 269270.0 37699.6 38381.0 38629.6 39104.6 39176.6 46363.3 48055.5 48247.3 48512.0 48767.8 35467.3 35510.3 35607.1 35702.3 35849.0 33242.7 33489.0 33853.7 33939.0 34319.8 40284.4 41088.6 41343.6 41514.0 41583.4 33237.0 33398.3 33806.3 34308.7 34519.3 24869.7 25087.5 25210.0 25537.4 26025.9 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#2] jquery.html Cycles:180 Average:42533.65 Median:21948.95 stddev:111889.33 (509.8%) stddev-sans-first:112158.99 04:38:53 INFO - PID 5283 | Values: 639.2 641.2 642.2 647.6 663.6 23999.5 24892.0 24971.5 24972.4 25011.6 23268.1 23371.2 23632.8 23676.0 23756.2 6359.6 6628.8 6641.1 6686.2 6794.2 6627.3 6695.6 6718.2 6718.4 6728.6 6479.5 6654.2 6659.2 6668.4 6693.8 6703.1 6744.1 6744.9 6745.4 6747.7 6287.5 6313.1 6330.0 6344.4 6347.0 30484.0 31376.8 31964.5 31968.7 31980.0 2351.4 2390.3 2397.0 2398.5 2399.7 20645.5 21084.2 21148.8 21194.9 21195.5 2368.8 2372.0 2438.9 2455.4 2464.9 151143.0 158007.0 168853.0 173526.1 174164.1 15540.2 16520.4 16906.0 16973.7 17003.2 27012.9 27159.7 27178.0 27182.3 27392.2 11475.8 11637.5 11650.6 11795.5 11871.9 10679.9 10728.2 10738.5 10738.7 10764.5 10104.6 10221.4 10342.8 10381.5 10467.5 2996.6 3008.2 3025.9 3067.4 3114.0 1037.5 1046.9 1051.4 1064.1 1066.6 20762.0 21293.0 21553.8 21735.6 21834.9 1085.6 1122.6 1132.1 1154.3 1157.4 11627.2 11831.2 11888.4 12041.9 12075.3 634235.0 663856.0 675794.0 685014.0 685420.0 137043.3 141478.0 141660.3 141746.0 143579.3 1160.2 1217.7 1240.5 1262.5 1325.3 21611.0 22063.0 22237.7 22301.7 22380.1 64013.7 64095.4 64285.0 65980.3 66313.0 76595.2 77003.0 77527.6 77543.6 82000.0 15925.8 16096.0 16142.7 16304.4 16346.8 24342.9 24650.6 24686.1 24745.6 24753.1 19768.9 20165.0 20309.4 20503.7 20539.2 16949.7 17813.3 17837.7 18221.5 18399.3 19878.6 20336.7 20544.8 20618.5 20735.2 15748.4 15782.3 15805.4 15925.0 16082.6 19820.3 20031.4 20062.0 20069.3 20272.9 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#3] mootools.html Cycles:180 Average:10992.48 Median:26059.00 stddev:7990.95 (30.7%) stddev-sans-first:7980.91 04:38:53 INFO - PID 5283 | Values: 1407.5 1459.6 1467.5 1477.3 1499.0 17042.8 17796.6 17836.1 17870.7 17871.9 17267.4 17452.9 17457.9 17546.2 17593.1 3100.5 3164.1 3166.2 3175.2 3200.4 3154.5 3184.1 3185.3 3192.4 3202.8 3172.3 3284.4 3285.2 3285.5 3286.9 3167.8 3219.7 3225.5 3225.7 3233.0 3138.1 3145.2 3168.2 3169.4 3170.6 17069.2 17404.3 17410.2 17417.4 17460.3 9171.1 9431.0 9443.3 9460.4 9534.9 6249.4 6328.8 6434.3 6469.3 6504.6 2126.4 2132.2 2134.5 2174.4 2209.4 31108.5 31372.7 31450.7 31457.8 31501.8 7808.7 7933.9 7965.4 7966.2 8182.5 20506.2 20522.2 20562.1 20590.4 20608.7 9053.6 9340.5 9342.0 9383.3 9407.9 8395.7 8420.1 8425.0 8484.6 8583.5 6252.3 6269.2 6306.5 6315.5 6377.7 1711.9 1739.9 1860.5 1864.5 1865.1 1001.7 1013.7 1037.1 1038.4 1052.5 8977.8 9049.4 9055.5 9105.3 9126.5 1090.8 1095.4 1107.0 1112.2 1113.3 5369.0 5377.2 5391.9 5398.2 5430.8 25462.7 25956.0 26326.5 26511.2 26514.3 25808.0 26162.0 26164.5 26253.0 26295.9 12651.5 12962.4 13048.5 13136.3 13140.3 9850.9 9995.8 10174.9 10225.3 10314.3 21978.2 21984.5 22157.4 22443.1 22518.9 23052.8 23108.3 23168.7 24101.3 24130.3 12973.9 13031.6 13045.0 13173.0 13174.9 16080.5 16138.3 16389.0 16406.3 16407.2 12875.2 13192.3 13229.0 13312.1 13373.5 12513.1 12522.5 12693.0 12714.9 12904.7 11472.8 11618.8 11644.7 11751.5 11843.1 8375.5 8389.5 8516.5 8603.7 8610.4 8802.9 8813.0 8918.0 9016.8 9125.8 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#4] prototype.html Cycles:180 Average:5825.64 Median:6492.30 stddev:1622.20 (25.0%) stddev-sans-first:1577.72 04:38:53 INFO - PID 5283 | Values: 552.1 591.6 594.2 600.8 607.8 6402.6 6466.0 6496.3 6533.5 6556.7 6328.9 6373.7 6375.8 6400.4 6458.9 5250.7 5283.9 5300.8 5301.2 5312.2 5029.8 5130.2 5237.7 5300.5 5303.7 5109.8 5117.5 5118.9 5122.8 5125.2 5097.8 5104.1 5116.8 5147.6 5150.2 4680.9 4682.0 4697.2 4702.7 4704.2 6241.8 6265.0 6334.5 6393.9 6414.9 6020.8 6039.1 6065.4 6095.9 6101.3 6771.3 6787.9 6854.5 6895.2 6920.6 5232.1 5237.7 5270.8 5273.9 5280.6 6999.8 7059.5 7066.9 7171.1 7190.7 5334.5 5345.3 5346.6 5347.5 5399.9 5336.2 5457.6 5467.6 5468.2 5488.9 5980.9 6009.5 6053.4 6053.4 6078.7 6945.1 6954.7 6955.5 6961.0 6985.8 1871.9 1886.9 1892.4 1896.3 1896.6 1272.9 1344.6 1344.9 1354.9 1360.3 6488.4 6499.5 6504.7 6511.7 6516.2 6853.2 6874.0 6925.7 6937.6 6941.5 6419.6 6470.2 6486.8 6499.6 6522.8 3638.1 3672.8 3675.3 3685.0 3711.6 7154.6 7176.7 7297.0 7336.2 7393.9 7124.4 7160.7 7233.5 7269.5 7278.8 7116.5 7181.5 7218.3 7257.7 7299.7 6742.6 6825.8 6830.2 6847.4 6862.8 6746.3 6845.6 6863.7 6873.7 6882.6 7267.6 7278.6 7312.2 7373.3 7394.2 5391.2 5414.4 5428.5 5436.8 5440.4 6728.5 6898.2 7029.3 7039.2 7080.6 6685.3 6714.9 6748.7 6795.8 6844.0 6655.9 6682.4 6737.5 6747.7 6750.8 6539.7 6542.8 6627.7 6708.3 6719.7 6764.6 6845.1 6852.8 6878.6 6896.5 6566.2 6623.5 6639.1 6654.3 6680.6 04:38:53 INFO - PID 5283 | 04:38:53 INFO - PID 5283 | [#5] yui.html Cycles:180 Average:29699.49 Median:19393.37 stddev:43485.02 (224.2%) stddev-sans-first:43553.58 04:38:53 INFO - PID 5283 | Values: 990.5 1014.6 1022.0 1036.0 1041.9 18214.6 18340.8 18524.6 18572.7 18758.8 18959.9 19082.6 19343.8 19346.4 19713.4 1076.3 1078.3 1079.4 1080.8 1081.0 1054.1 1076.4 1079.4 1079.9 1080.0 1155.6 1157.2 1158.7 1159.2 1159.7 1129.9 1145.2 1147.4 1148.5 1154.4 849.3 851.6 851.8 852.5 857.1 20012.5 20119.1 20137.1 20217.9 21833.3 21651.8 21875.0 21890.3 22056.9 22097.8 19381.8 19383.1 19404.6 19433.4 19620.9 4063.4 4154.1 4191.2 4216.3 4219.5 155524.2 161653.2 166975.0 167972.0 168994.0 18767.6 19403.6 19464.1 19508.4 19515.7 34885.7 35476.5 35554.8 35571.0 35632.8 10318.9 10531.3 10710.4 10727.1 10752.6 4911.9 4993.0 4993.9 5009.6 5024.4 6541.6 6544.7 6569.6 6653.3 6658.4 1255.3 1273.2 1275.2 1283.1 1304.8 737.6 754.2 766.3 780.8 795.1 13486.7 13612.1 14032.6 14938.9 14978.9 783.1 785.7 786.6 792.4 793.5 6059.5 6120.4 6137.5 6197.1 6296.1 151536.0 152045.0 152180.0 152512.2 152584.0 114068.0 119894.4 131878.3 139429.0 144016.3 122338.8 125020.4 127282.4 128030.0 132067.0 13809.7 14020.6 15015.8 15207.0 15330.3 58837.7 58896.0 59180.0 59803.7 59905.7 73458.6 73923.0 75038.0 75169.6 77176.0 21221.9 21466.2 21767.0 21944.5 22044.7 22564.0 22699.7 22789.4 22889.8 22895.1 22171.1 22391.1 22411.7 22437.6 22593.0 18091.5 18273.1 18283.4 18449.4 18453.8 22235.9 22252.2 22315.0 22378.6 22517.0 12905.2 13142.2 13322.1 13364.3 13453.3 15865.3 16022.2 16034.4 16037.3 16238.8 04:38:53 INFO - PID 5283 | -------- Summary: end -------- 04:38:53 INFO - PID 5283 | 04:38:53 INFO - TEST-INFO | 5283: exit 0 04:38:53 INFO - TEST-OK | dromaeo_css | took 1107841ms 04:38:53 INFO - TEST-START | kraken 04:38:53 INFO - Initialising browser for kraken test... 04:38:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52980/getInfo.html -profile /tmp/tmpCPDdMv/profile 04:38:53 INFO - TEST-INFO | started process 5644 (/builds/slave/test/build/application/firefox/firefox http://localhost:52980/getInfo.html) 04:38:59 INFO - TEST-INFO | 5644: exit 0 04:38:59 INFO - Browser initialized. 04:38:59 INFO - Running cycle 1/1 for kraken test... 04:38:59 INFO - Using env: {'DISPLAY': ':0', 04:38:59 INFO - 'HOME': '/home/cltbld', 04:38:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:38:59 INFO - 'LANG': 'en_US.UTF-8', 04:38:59 INFO - 'LANGUAGE': 'en_US:en', 04:38:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:38:59 INFO - 'LOGNAME': 'cltbld', 04:38:59 INFO - 'MAIL': '/var/mail/cltbld', 04:38:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:38:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:38:59 INFO - 'MOZ_NO_REMOTE': '1', 04:38:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:38:59 INFO - 'NO_EM_RESTART': '1', 04:38:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:59 INFO - 'PWD': '/builds/slave/test', 04:38:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:59 INFO - 'RUST_BACKTRACE': 'full', 04:38:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:38:59 INFO - 'SHELL': '/bin/bash', 04:38:59 INFO - 'SHLVL': '1', 04:38:59 INFO - 'TERM': 'linux', 04:38:59 INFO - 'TMOUT': '86400', 04:38:59 INFO - 'USER': 'cltbld', 04:38:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456', 04:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:59 INFO - '_': '/tools/buildbot/bin/python'} 04:38:59 INFO - TEST-INFO | started process 5833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPDdMv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:10 INFO - PID 5833 | RSS: Main: 144011264 04:39:10 INFO - PID 5833 | 04:39:13 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52980/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:14 INFO - PID 5833 | RSS: Main: 150016000 04:39:14 INFO - PID 5833 | 04:39:16 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52980/tests/kraken/driver.html?testName=audio-dft) 04:39:17 INFO - PID 5833 | RSS: Main: 150142976 04:39:17 INFO - PID 5833 | 04:39:20 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52980/tests/kraken/driver.html?testName=audio-fft) 04:39:20 INFO - PID 5833 | RSS: Main: 151695360 04:39:20 INFO - PID 5833 | 04:39:22 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52980/tests/kraken/driver.html?testName=audio-oscillator) 04:39:23 INFO - PID 5833 | RSS: Main: 151597056 04:39:23 INFO - PID 5833 | 04:39:25 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52980/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:26 INFO - PID 5833 | RSS: Main: 151568384 04:39:26 INFO - PID 5833 | 04:39:29 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52980/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:29 INFO - PID 5833 | RSS: Main: 151224320 04:39:29 INFO - PID 5833 | 04:39:33 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52980/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:33 INFO - PID 5833 | RSS: Main: 153788416 04:39:33 INFO - PID 5833 | 04:39:36 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52980/tests/kraken/driver.html?testName=json-parse-financial) 04:39:37 INFO - PID 5833 | RSS: Main: 154599424 04:39:37 INFO - PID 5833 | 04:39:38 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52980/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:39 INFO - PID 5833 | RSS: Main: 154673152 04:39:39 INFO - PID 5833 | 04:39:40 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:41 INFO - PID 5833 | RSS: Main: 154955776 04:39:41 INFO - PID 5833 | 04:39:43 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:44 INFO - PID 5833 | RSS: Main: 152305664 04:39:44 INFO - PID 5833 | 04:39:46 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:47 INFO - PID 5833 | RSS: Main: 151928832 04:39:47 INFO - PID 5833 | 04:39:49 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:50 INFO - PID 5833 | RSS: Main: 152084480 04:39:50 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | Cycle 1(1): loaded http://localhost:52980/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52980/tests/kraken/driver.html?testName=ai-astar) 04:39:52 INFO - PID 5833 | RSS: Main: 153526272 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | __start_tp_report 04:39:52 INFO - PID 5833 | _x_x_mozilla_page_load 04:39:52 INFO - PID 5833 | _x_x_mozilla_page_load_details 04:39:52 INFO - PID 5833 | |i|pagename|runs| 04:39:52 INFO - PID 5833 | |0;ai-astar;105;105;105;105;105;95;104;106;104;103 04:39:52 INFO - PID 5833 | |1;audio-beat-detection;122;111;110;110;113;114;113;118;113;139 04:39:52 INFO - PID 5833 | |2;audio-dft;163;161;162;163;160;163;161;161;162;161 04:39:52 INFO - PID 5833 | |3;audio-fft;75;74;72;73;72;73;72;73;73;73 04:39:52 INFO - PID 5833 | |4;audio-oscillator;77;76;77;80;78;77;77;76;77;77 04:39:52 INFO - PID 5833 | |5;imaging-gaussian-blur;110;113;114;110;114;112;114;117;113;110 04:39:52 INFO - PID 5833 | |6;imaging-darkroom;151;149;149;148;148;148;147;147;150;148 04:39:52 INFO - PID 5833 | |7;imaging-desaturate;94;93;94;94;93;94;94;95;94;94 04:39:52 INFO - PID 5833 | |8;json-parse-financial;44;44;48;44;44;44;44;44;43;58 04:39:52 INFO - PID 5833 | |9;json-stringify-tinderbox;38;38;38;38;38;37;38;38;37;37 04:39:52 INFO - PID 5833 | |10;stanford-crypto-aes;69;68;68;73;68;74;71;73;67;69 04:39:52 INFO - PID 5833 | |11;stanford-crypto-ccm;107;102;99;99;105;105;106;102;105;108 04:39:52 INFO - PID 5833 | |12;stanford-crypto-pbkdf2;151;158;161;152;147;146;155;152;156;150 04:39:52 INFO - PID 5833 | |13;stanford-crypto-sha256-iterative;59;58;59;57;59;57;59;60;61;57 04:39:52 INFO - PID 5833 | __end_tp_report 04:39:52 INFO - PID 5833 | __start_cc_report 04:39:52 INFO - PID 5833 | _x_x_mozilla_cycle_collect,711 04:39:52 INFO - PID 5833 | __end_cc_report 04:39:52 INFO - PID 5833 | __startTimestamp1506080392401__endTimestamp 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | ------- Summary: start ------- 04:39:52 INFO - PID 5833 | Number of tests: 14 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#0] ai-astar Cycles:10 Average:103.70 Median:105.00 stddev:3.16 (3.0%) stddev-sans-first:3.32 04:39:52 INFO - PID 5833 | Values: 105.0 105.0 105.0 105.0 105.0 95.0 104.0 106.0 104.0 103.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:113.50 stddev:8.79 (7.7%) stddev-sans-first:9.08 04:39:52 INFO - PID 5833 | Values: 122.0 111.0 110.0 110.0 113.0 114.0 113.0 118.0 113.0 139.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 04:39:52 INFO - PID 5833 | Values: 163.0 161.0 162.0 163.0 160.0 163.0 161.0 161.0 162.0 161.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#3] audio-fft Cycles:10 Average:73.00 Median:73.00 stddev:0.94 (1.3%) stddev-sans-first:0.67 04:39:52 INFO - PID 5833 | Values: 75.0 74.0 72.0 73.0 72.0 73.0 72.0 73.0 73.0 73.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 04:39:52 INFO - PID 5833 | Values: 77.0 76.0 77.0 80.0 78.0 77.0 77.0 76.0 77.0 77.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#5] imaging-gaussian-blur Cycles:10 Average:112.70 Median:113.50 stddev:2.26 (2.0%) stddev-sans-first:2.18 04:39:52 INFO - PID 5833 | Values: 110.0 113.0 114.0 110.0 114.0 112.0 114.0 117.0 113.0 110.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.27 (0.9%) stddev-sans-first:0.97 04:39:52 INFO - PID 5833 | Values: 151.0 149.0 149.0 148.0 148.0 148.0 147.0 147.0 150.0 148.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:39:52 INFO - PID 5833 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 94.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:44.00 stddev:4.52 (10.3%) stddev-sans-first:4.76 04:39:52 INFO - PID 5833 | Values: 44.0 44.0 48.0 44.0 44.0 44.0 44.0 44.0 43.0 58.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 04:39:52 INFO - PID 5833 | Values: 38.0 38.0 38.0 38.0 38.0 37.0 38.0 38.0 37.0 37.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#10] stanford-crypto-aes Cycles:10 Average:70.00 Median:70.00 stddev:2.54 (3.6%) stddev-sans-first:2.67 04:39:52 INFO - PID 5833 | Values: 69.0 68.0 68.0 73.0 68.0 74.0 71.0 73.0 67.0 69.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#11] stanford-crypto-ccm Cycles:10 Average:103.80 Median:106.50 stddev:3.16 (3.0%) stddev-sans-first:3.13 04:39:52 INFO - PID 5833 | Values: 107.0 102.0 99.0 99.0 105.0 105.0 106.0 102.0 105.0 108.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.50 stddev:4.73 (3.1%) stddev-sans-first:4.97 04:39:52 INFO - PID 5833 | Values: 151.0 158.0 161.0 152.0 147.0 146.0 155.0 152.0 156.0 150.0 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:59.00 stddev:1.35 (2.3%) stddev-sans-first:1.42 04:39:52 INFO - PID 5833 | Values: 59.0 58.0 59.0 57.0 59.0 57.0 59.0 60.0 61.0 57.0 04:39:52 INFO - PID 5833 | -------- Summary: end -------- 04:39:52 INFO - PID 5833 | 04:39:52 INFO - PID 5833 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:39:52 INFO - TEST-INFO | 5833: exit 0 04:39:53 INFO - TEST-OK | kraken | took 59135ms 04:39:53 INFO - SUITE-END | took 1166s 04:39:53 INFO - Completed test suite (00:19:27) 04:39:53 INFO - javascript benchmark 04:39:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9507.94690278626, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3986.342253528168, 4008.498937632796, 4034.6973976951735, 4040.5757395473474, 4050.9189816203675, 6554.672266386686, 6576.473882089422, 6596.373344532274, 6649.8005059848165, 6681.265060843303, 6596.934030659692, 6598.208215014193, 6633.369829866155, 6691.765788197414, 6701.329867013296, 5908.586398952075, 5925.2889653241455, 5968.253968253968, 5968.7015649217365, 5986.940130598693, 5852.619579727326, 5927.614705044159, 5981.49157321626, 6044.455998960093, 6062.333143354227, 5974.133750606159, 5982.760689572412, 6001.159837622715, 6019.367966363535, 6052.667103309316, 5899.5870289079785, 5994.25071866019, 6010.669413182273, 6060.060690592965, 6068.6358818471035, 5788.739506722208, 5847.0352391855295, 5856.121581762727, 5880.323762767251, 5936.198613187207, 6490.643014634194, 6497.480201583862, 6514.869702605969, 6521.15225020749, 6530.771423000219, 7135.322144396326, 7144.071270734823, 7233.0, 7235.927640723578, 7249.057622509093, 7186.568805871664, 7188.928110718878, 7273.490855640107, 7276.090488688914, 7330.780076597657, 6606.306337834554, 6645.634490103091, 6658.300878407795, 6720.32796720324, 6771.356721111487, 7326.890096648554, 7334.376577990931, 7344.155422126417, 7349.448791340671, 7407.48137644546, 7057.435405167575, 7097.645117744092, 7131.144262688511, 7160.820979475555, 7177.210506844243, 6845.315468453215, 7021.824454388681, 7232.276772322725, 7314.268573142643, 7352.04423424962, 7121.359077683033, 7181.35367816899, 7188.17336006366, 7210.423166146696, 7213.278672132849, 7130.108736407949, 7145.642717864086, 7152.141742990874, 7195.208527062019, 7205.603691797001, 5278.234655974862, 5287.206918962186, 5355.705436201047, 5370.946290537045, 5374.328208973879, 4756.096341695067, 4787.521247875185, 4840.782164802592, 4848.612111031109, 4960.528749768766, 6790.11728475305, 6845.589264644137, 6846.7945961621235, 6847.691853866588, 6855.794326170223, 7169.641517924188, 7208.135023797178, 7213.675384607705, 7217.097862767154, 7280.017197678351, 6724.865502689919, 6777.01733248686, 6804.08144900442, 6813.454923606099, 6870.31296870309, 6028.819135425944, 6058.606190597597, 6096.420840020191, 6107.29766076898, 6109.7861574844665, 7484.513506622052, 7486.737964171228, 7544.0569928758905, 7556.055493063367, 7606.733764318223, 6976.755813546704, 7073.045138906182, 7089.503734738519, 7108.573485590881, 7220.675069621774, 7463.514871533333, 7519.849603008019, 7526.849463010819, 7538.849223015619, 7582.431317651309, 6989.37095661393, 7069.469789765685, 7151.570905745672, 7179.964100179465, 7188.209296977433, 7020.227774944854, 7134.143902731706, 7136.821579460555, 7212.74755383559, 7292.854142917005, 6890.655467226718, 6898.8620227596175, 6907.171139463297, 6921.757738479129, 6931.757388491378, 6867.622280774605, 6911.101556797584, 6990.965045174741, 6992.0910281663055, 7006.824829379307, 6831.351021652935, 6857.828554286183, 6915.204751453647, 6944.201416837129, 6959.96520017417, 6978.441724661913, 6980.162380514371, 7057.117860267466, 7093.290670933072, 7098.680559374738, 6758.932410676027, 6796.66016699173, 6841.657917104224, 6891.793246202421, 6914.239433662193], "value": 6579.970009689382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [955.7610597350663, 968.3802366485451, 990.7523119220195, 995.6266400099962, 1023.6570748799152, 43871.12257754847, 44143.33784993228, 44462.555374446245, 44505.55494445059, 44578.33132503015, 44530.33204501927, 44717.10565788682, 45103.32345014819, 45134.322985155246, 45194.0, 7983.0, 8114.472559283628, 8162.591870406485, 8168.346532277418, 8171.0, 7839.451238413313, 7912.327452166573, 7927.04875414951, 7934.127246002935, 7945.562994035326, 8760.8685869712, 8927.0, 8968.730938071836, 9001.864972025392, 9007.189352958232, 8838.513881736502, 8911.10888911107, 8911.688090916787, 8914.554272286392, 8915.42049766763, 8831.911680883173, 8883.600237989305, 8923.10768923109, 8924.910750892537, 8930.598123084477, 40674.38988415176, 40747.18505629901, 41261.79369103135, 41266.587334126576, 41281.0, 3706.4625629283605, 3735.34631439497, 3737.4580685800406, 3741.906452338686, 3749.9625003749884, 33900.83049584761, 33945.830270848484, 33985.15037124067, 34121.829390853134, 34183.0, 5622.634528755618, 5674.404187560329, 5685.573581981368, 5692.857678558028, 5699.287589051369, 237571.0, 238799.0, 239033.0, 239203.8039809807, 240623.0, 52488.47511524836, 52506.21240681393, 52971.73514132405, 53239.46760532423, 53569.46430535645, 55877.44122558722, 55978.720106400026, 56002.71998639981, 56081.0, 56339.43660563342, 18244.63510729778, 18549.629007419775, 18596.907015464836, 18625.534361640795, 18625.627487450176, 15511.0, 15511.689766204612, 15562.221888905737, 15563.688726225411, 15571.221438928009, 15014.0, 15516.0, 15518.767218491732, 15618.843811561967, 15695.2735199128, 5976.790812321635, 6010.308814486302, 6086.878262434727, 6225.750969961151, 6247.781327653511, 1093.5352475198008, 1093.5844379135876, 1102.5148934468807, 1113.5434471866495, 1114.1810769084716, 25952.87023564908, 26120.8693956529, 26190.21429357122, 26332.60501092485, 26473.73526264751, 1201.4773573495556, 1209.9576514821938, 1233.0998371188903, 1233.5682511121215, 1244.2472304255975, 13647.590572282847, 13705.246211458267, 13749.862501375059, 13875.028747987544, 14154.292285385896, 277679.0, 307289.0, 309529.0, 309964.0, 322738.0, 56228.71885640546, 56450.15324770132, 56990.14514782282, 57042.42957570371, 57271.713641431525, 1530.2042937672347, 1537.085434166669, 1558.4934896158568, 1566.1229711361673, 1573.0797483472068, 31268.0, 31575.84212078925, 31656.05031849048, 31669.683303166672, 32257.838710806296, 42319.36520952127, 42528.14943701171, 42681.57318426776, 42701.57298426976, 42735.3589696161, 267641.0, 267864.0, 268633.0, 268724.0, 269270.0, 37699.62300376961, 38381.0, 38629.613703863724, 39104.608953910094, 39176.60823391729, 46363.304550431094, 48055.519444805104, 48247.27629085637, 48512.0, 48767.75616121897, 35467.289022029465, 35510.289794203454, 35607.10982225465, 35702.28595428129, 35849.0, 33242.66757332492, 33489.0, 33853.66146338505, 33939.0, 34319.828400857834, 40284.3957340646, 41088.58911410848, 41343.58656413398, 41514.0, 41583.37624935689, 33237.0, 33398.33203335871, 33806.32387352288, 34308.65691343055, 34519.30961380809, 24869.741581285012, 25087.498250035263, 25210.0, 25537.361565961, 26025.869870650524], "value": 19306.071707457562, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.1514244917382, 641.16533251977, 642.195567093821, 647.5681696096353, 663.6283681138563, 23999.520009599797, 24892.0, 24971.500569988635, 24972.375690607743, 25011.624825627583, 23268.06927722889, 23371.1820086297, 23632.763672363315, 23676.0, 23756.168534101267, 6359.55483116182, 6628.834279143011, 6641.070250164981, 6686.1642294713165, 6794.218664853555, 6627.337266273383, 6695.564788288746, 6718.160229971254, 6718.361755633207, 6728.596284222962, 6479.481641468671, 6654.168228971379, 6659.2008958925, 6668.433183179435, 6693.765718199864, 6703.061571380011, 6744.055832183498, 6744.898826517606, 6745.392914637681, 6747.662616869186, 6287.528435367366, 6313.147725057104, 6330.01884707871, 6344.429001389897, 6347.0, 30484.0, 31376.843115784504, 31964.520532192037, 31968.680313197037, 31980.0, 2351.400392899817, 2390.2829151254555, 2396.9640455393182, 2398.4603464220586, 2399.664047033417, 20645.4838629034, 21084.156633734787, 21148.788512114836, 21194.894025529928, 21195.47011324729, 2368.834181607288, 2372.0, 2438.926832195037, 2455.4107014316614, 2464.9260522184363, 151143.0, 158007.0, 168853.0, 173526.13236933862, 174164.12917935455, 15540.222988850512, 16520.4217852377, 16905.956927753123, 16973.66052678964, 17003.23485443158, 27012.86493567559, 27159.728402716115, 27178.0, 27182.320441989108, 27392.17823465299, 11475.770484590428, 11637.534498620129, 11650.592229271935, 11795.469203885847, 11871.940640296916, 10679.89320106789, 10728.249022568345, 10738.463076846127, 10738.73153171177, 10764.515596798163, 10104.646337378157, 10221.43782091992, 10342.844857327145, 10381.532831022621, 10467.528961196764, 2996.6104406427025, 3008.247938015496, 3025.8638361273797, 3067.4171907337536, 3113.9532907006414, 1037.5486663301338, 1046.9162467002623, 1051.353417648141, 1064.084886997182, 1066.6000249906285, 20762.0, 21293.0, 21553.78446215549, 21735.56528869414, 21834.89082554577, 1085.625459216569, 1122.5958654884234, 1132.1395739238237, 1154.3131836557236, 1157.3576664950865, 11627.244229125248, 11831.230969986924, 11888.405579720978, 12041.939790301167, 12075.3358565278, 634235.0, 663856.0, 675794.0, 685014.0, 685420.0, 137043.31478342545, 141478.0, 141660.29169854085, 141746.0, 143579.2821035909, 1160.187868492042, 1217.719924417389, 1240.4913985265998, 1262.4634530324574, 1325.3307079924577, 21611.02750376268, 22063.0, 22237.66643500381, 22301.665475018213, 22380.104795807987, 64013.67993160005, 64095.359046410806, 64285.0, 65980.34019659742, 66313.0, 76595.23404765881, 77003.0, 77527.61236193783, 77543.61228193823, 82000.0, 15925.761113583074, 16096.0, 16142.67714645724, 16304.429344973343, 16346.836531634532, 24342.878285608458, 24650.630240546765, 24686.13598524043, 24745.62881556742, 24753.133640322503, 19768.90115549413, 20164.967006599032, 20309.390718278475, 20503.692444613043, 20539.178432863115, 16949.661006780043, 17813.287468501116, 17837.73243401324, 18221.45335639933, 18399.264029439208, 19878.60242795165, 20336.69494957547, 20544.79455205429, 20618.484537886674, 20735.170593176103, 15748.448804291795, 15782.289796959394, 15805.446809361618, 15925.0, 16082.59793505125, 19820.306289279804, 20031.39905802828, 20062.0, 20069.29757458482, 20272.898635506728], "value": 13164.868453792822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.4933024111317, 1459.6277949122973, 1467.5303902751118, 1477.276134694, 1498.970020599588, 17042.82957170428, 17796.555086122855, 17836.108194590284, 17870.731939020927, 17871.910640446797, 17267.39564115256, 17452.912735436305, 17457.912710436463, 17546.210420531075, 17593.12034398278, 3100.534919762031, 3164.129864287328, 3166.1926208816776, 3175.158582975513, 3200.4079245339685, 3154.463741164008, 3184.0607020928765, 3185.347003864214, 3192.425363434581, 3202.759793015533, 3172.317951640397, 3284.3759685659766, 3285.227971426713, 3285.5071739239065, 3286.9342613147724, 3167.8099314041115, 3219.678032196785, 3225.532297816815, 3225.6774322567558, 3233.030090972699, 3138.0585824252635, 3145.2294187923876, 3168.2237851726245, 3169.4453470642547, 3170.6036745406823, 17069.231884565223, 17404.30382784687, 17410.21654025572, 17417.39039133624, 17460.30158793647, 9171.082891710843, 9430.952845235799, 9443.338966272364, 9460.385074970105, 9534.904650953471, 6249.375062493714, 6328.778492752732, 6434.324395938453, 6469.288378278386, 6504.577202481823, 2126.4258650164525, 2132.2004248406847, 2134.509062915538, 2174.3911704722705, 2209.4255493571786, 31108.533371999438, 31372.686273137206, 31450.685493145233, 31457.84271078653, 31501.8424907874, 7808.68765249395, 7933.880991785128, 7965.362770978308, 7966.163552826985, 8182.509049457051, 20506.179752810018, 20522.179112835318, 20562.074706638236, 20590.382288531368, 20608.69086963697, 9053.59258833354, 9340.486273255035, 9342.0, 9383.296252780932, 9407.858882116774, 8395.664173432995, 8420.073791882887, 8424.957875210584, 8484.575771211415, 8583.527905965231, 6252.343503932113, 6269.244611508785, 6306.527010474233, 6315.494760419156, 6377.71300291488, 1711.922963466647, 1739.878208525391, 1860.4604664647102, 1864.4593068010124, 1865.123392005755, 1001.6744558018673, 1013.7313611892707, 1037.0666400239693, 1038.3925403638805, 1052.5263631365763, 8977.775555611162, 9049.366544341832, 9055.547222638841, 9105.317101217302, 9126.45241285525, 1090.7927493776315, 1095.3865835132192, 1106.9557217711363, 1112.165875593305, 1113.3153110836777, 5368.973155134199, 5377.166539186433, 5391.919121213185, 5398.190271459234, 5430.809921652803, 25462.745372546407, 25956.0, 26326.473470530484, 26511.204663859728, 26514.337141571614, 25808.0, 26162.0, 26164.476710466064, 26253.0, 26295.868520657274, 12651.493940242472, 12962.351882405843, 13048.47806087765, 13136.34318284082, 13140.34298285082, 9850.852237216592, 9995.750106247402, 10174.949125254327, 10225.284230103822, 10314.329568578018, 21978.230761923256, 21984.45038874041, 22157.44606384789, 22443.10227590878, 22518.887405562866, 23052.769472305732, 23108.306750797503, 23168.6524702133, 24101.276961691176, 24130.276091717278, 12973.935130324287, 13031.609051728463, 13045.0, 13173.0, 13174.868251317748, 16080.517584472485, 16138.273777679799, 16389.0, 16406.343746250495, 16407.17964101814, 12875.163114397534, 13192.340382981005, 13229.0, 13312.134711243738, 13373.53192638253, 12513.061520386189, 12522.499100035897, 12693.0, 12714.87285127137, 12904.677383065124, 11472.770544589228, 11618.825717614412, 11644.708882278012, 11751.47118379692, 11843.111766617365, 8375.497470151811, 8389.538575378168, 8516.531590762568, 8603.741887743377, 8610.354223433393, 8802.91197088021, 8813.030566637537, 8917.955410222907, 9016.81966360656, 9125.771855703395], "value": 7797.265750780531, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.1386636846518, 591.6095377051146, 594.2275042444826, 600.8227572866004, 607.8328459673589, 6402.647854368008, 6465.967670161648, 6496.252930912952, 6533.542652014361, 6556.73773049078, 6328.892443822324, 6373.713182906768, 6375.808725738224, 6400.423961843433, 6458.903116453245, 5250.7112108834, 5283.894322113555, 5300.814471493499, 5301.231321458386, 5312.203169524563, 5029.798808047673, 5130.153524668425, 5237.711925844077, 5300.469953004707, 5303.681779093247, 5109.795608175668, 5117.48825117489, 5118.923216151742, 5122.846314610568, 5125.205593133071, 5097.8215762448135, 5104.05574968632, 5116.795328186868, 5147.639665223417, 5150.227465880111, 4680.882977925545, 4681.976590117061, 4697.154512187805, 4702.741349225791, 4704.1767690654, 6241.75560618779, 6264.9686751566405, 6334.5249106317215, 6393.93606063938, 6414.903776443357, 6020.789272375446, 6039.067498400514, 6065.393460653943, 6095.878082438371, 6101.2983506896835, 6771.322867713189, 6787.929681447156, 6854.451643868529, 6895.241523432418, 6920.550164239308, 5232.136697444917, 5237.73811309433, 5270.841874743764, 5273.920891186635, 5280.577553795687, 6999.755008574726, 7059.5411298264935, 7066.915259998313, 7171.103612048494, 7190.663034513804, 5334.51989320963, 5345.33183352081, 5346.636607665098, 5347.51872331492, 5399.867052514313, 5336.17289320156, 5457.590680698963, 5467.644603100865, 5468.152436372368, 5488.862778430492, 5980.85047873798, 6009.489193418608, 6053.364396738279, 6053.424924632153, 6078.726457309432, 6945.131858517685, 6954.687039083254, 6955.513114081966, 6961.0, 6985.79042628722, 1871.8783279086815, 1886.8584856135844, 1892.4133518609276, 1896.3078476356031, 1896.6206758648325, 1272.9045321600918, 1344.6369480240476, 1344.926029068391, 1354.8848347890344, 1360.2586590308306, 6488.351164883474, 6499.54503184782, 6504.739810407531, 6511.6651086527145, 6516.218053833571, 6853.246142924274, 6874.0, 6925.653717314114, 6937.583744975318, 6941.548799328129, 6419.614823110628, 6470.191226096738, 6486.837829054311, 6499.642519661369, 6522.804315870531, 3638.1450359165574, 3672.8347224374966, 3675.3384390809374, 3684.9631503685155, 3711.5917249102577, 7154.6048520538, 7176.677049532784, 7297.0, 7336.193018767931, 7393.8909163625885, 7124.358807707331, 7160.749373771997, 7233.529820561646, 7269.454790890704, 7278.818029549304, 7116.466265030143, 7181.533200341961, 7218.314260145278, 7257.673404696801, 7299.708011679473, 6742.561733487308, 6825.77136115504, 6830.214525329452, 6847.417969472651, 6862.828429289308, 6746.347144949519, 6845.589264644137, 6863.6568171590225, 6873.690683919335, 6882.621455819978, 7267.563946163247, 7278.563286202845, 7312.1591017033725, 7373.33639972405, 7394.186639469546, 5391.191321301836, 5414.377346605191, 5428.538574221236, 5436.836894893159, 5440.401555828935, 6728.461723062045, 6898.172219333712, 7029.332213439715, 7039.225685174729, 7080.645967701697, 6685.2646208916, 6714.932850671431, 6748.662566871735, 6795.791367805384, 6844.0, 6655.866882662416, 6682.431993280626, 6737.528373014038, 6747.662616869039, 6750.797476075725, 6539.673016349258, 6542.8364290893105, 6627.701753421011, 6708.322919270183, 6719.731210751515, 6764.594124352555, 6845.14435695538, 6852.828679283058, 6878.621675807678, 6896.482763792836, 6566.179227596551, 6623.549286763928, 6639.136912201383, 6654.334566543307, 6680.63256520896], "value": 5361.097767388263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [990.4750482244403, 1014.568808256491, 1021.9591216351346, 1036.036486067957, 1041.890601486844, 18214.63570728588, 18340.81659183408, 18524.62950740986, 18572.721409178874, 18758.81241187588, 18959.90520047401, 19082.61834763304, 19343.806561934412, 19346.419607411764, 19713.40859774209, 1076.3434305073918, 1078.320657985468, 1079.4063265204145, 1080.8000519903842, 1080.9783804323908, 1054.0829478353844, 1076.4294923690456, 1079.3739631013993, 1079.9352038877653, 1080.0117892128692, 1155.5897656331965, 1157.2362240920993, 1158.687154468293, 1159.176984341119, 1159.6984783956148, 1129.9378534180616, 1145.2155273637543, 1147.432021149528, 1148.4946623485723, 1154.4343271796802, 849.2653854415947, 851.6125163050859, 851.7529916324258, 852.497026754218, 857.1342943626919, 20012.49968750793, 20119.0946407412, 20137.09383077765, 20217.8989105055, 21833.344999650035, 21651.78348216529, 21875.0, 21890.343289701334, 22056.88971555148, 22097.779022209892, 19381.80618193814, 19383.127759250725, 19404.611907761908, 19433.416997490098, 19620.90189549043, 4063.4311196432523, 4154.1068670235745, 4191.224623444642, 4216.3464662977285, 4219.472565929259, 155524.22237888738, 161653.19173404176, 166974.99999999878, 167972.0, 168994.0, 18767.624647506975, 19403.61192776165, 19464.124114414884, 19508.414747557596, 19515.707264391047, 34885.65114348875, 35476.46785298223, 35554.8222258887, 35571.0, 35632.821835891176, 10318.948405257926, 10531.262811603268, 10710.410927398912, 10727.141828653688, 10752.569897204181, 4911.852644420673, 4992.975035124874, 4993.875153121201, 5009.599232061426, 5024.422191447957, 6541.6075035498025, 6544.738210471528, 6569.638669873108, 6653.301403352578, 6658.43403310724, 1255.2970336611527, 1273.2169715624825, 1275.222114510148, 1283.1210620724646, 1304.7520971015476, 737.6127533045087, 754.2156157596148, 766.2911806578892, 780.7657702689171, 795.08168065884, 13486.730265394834, 13612.115212511155, 14032.649183770487, 14938.925305373403, 14978.850211497964, 783.07988113967, 785.6896525872248, 786.5831109511968, 792.3621484704753, 793.5437123653807, 6059.545534084961, 6120.44915957566, 6137.539684523678, 6197.101420294032, 6296.118543403927, 151536.0, 152045.0, 152180.0, 152512.2374388143, 152584.0, 114068.0, 119894.40052799854, 131878.34060829633, 139429.0, 144016.27991859973, 122338.77661223452, 125020.37489812492, 127282.36358818332, 128030.0, 132067.0, 13809.723805524034, 14020.579382618538, 15015.774763378777, 15207.0, 15330.310136044129, 58837.70581147067, 58896.0, 59180.0, 59803.70098149481, 59905.70047149737, 73458.63270683613, 73923.0, 75038.0, 75169.62415187889, 77176.0, 21221.893890531068, 21466.17537509329, 21767.0, 21944.45138871541, 22044.669329959743, 22564.0, 22699.659505107105, 22789.430264243525, 22889.77110228943, 22895.08419663195, 22171.113155474246, 22391.104355826235, 22411.663825042313, 22437.551248975255, 22593.0, 18091.547711306797, 18273.08634568293, 18283.360082397052, 18449.354272600394, 18453.81546184575, 22235.888820555792, 22252.221172258895, 22315.0, 22378.552428951654, 22516.98673559661, 12905.225686458842, 13142.211467311992, 13322.134061285986, 13364.264965426995, 13453.327333633475, 15865.286062127463, 16022.198890055684, 16034.438794642132, 16037.27832247575, 16238.837611623732], "value": 10567.319684929573, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1355.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 105.0, 105.0, 95.0, 104.0, 106.0, 104.0, 103.0], "value": 103.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 111.0, 110.0, 110.0, 113.0, 114.0, 113.0, 118.0, 113.0, 139.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 160.0, 163.0, 161.0, 161.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 73.0, 72.0, 73.0, 72.0, 73.0, 73.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 80.0, 78.0, 77.0, 77.0, 76.0, 77.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 110.0, 114.0, 112.0, 114.0, 117.0, 113.0, 110.0], "value": 112.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 150.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 44.0, 48.0, 44.0, 44.0, 44.0, 44.0, 44.0, 43.0, 58.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 37.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 73.0, 68.0, 74.0, 71.0, 73.0, 67.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 102.0, 99.0, 99.0, 105.0, 105.0, 106.0, 102.0, 105.0, 108.0], "value": 103.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 158.0, 161.0, 152.0, 147.0, 146.0, 155.0, 152.0, 156.0, 150.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 57.0, 59.0, 57.0, 59.0, 60.0, 61.0, 57.0], "value": 58.6, "unit": "score"}]}]} 04:39:53 INFO - Return code: 0 04:39:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:39:53 INFO - # TBPL SUCCESS # 04:39:53 INFO - Running post-action listener: _package_coverage_data 04:39:53 INFO - Running post-action listener: _resource_record_post_action 04:39:53 INFO - [mozharness: 2017-09-22 11:39:53.224357Z] Finished run-tests step (success) 04:39:53 INFO - Running post-run listener: _resource_record_post_run 04:39:53 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 338841600; Read time: 488; Write time: 359464 04:39:53 INFO - TinderboxPrint: CPU usage
13.0% 04:39:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 488 04:39:53 INFO - TinderboxPrint: I/O write bytes / time
338,841,600 / 359,464 04:39:53 INFO - TinderboxPrint: CPU idle
8,194.8 (86.9%) 04:39:53 INFO - TinderboxPrint: CPU user
1,178.5 (12.5%) 04:39:53 INFO - TinderboxPrint: Swap in / out
0 / 0 04:39:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 58343424; Read time: 120; Write time: 67112 04:39:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:39:53 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271302656; Read time: 368; Write time: 290112 04:39:53 INFO - Running post-run listener: _upload_blobber_files 04:39:53 INFO - Blob upload gear active. 04:39:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:39:53 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'] 04:39:53 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 04:39:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:39:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:39:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:55 INFO - (blobuploader) - INFO - Done attempting. 04:39:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:39:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:39:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:56 INFO - (blobuploader) - INFO - Done attempting. 04:39:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:39:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:39:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:57 INFO - (blobuploader) - INFO - Done attempting. 04:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:01 INFO - (blobuploader) - INFO - Done attempting. 04:40:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:01 INFO - Return code: 0 04:40:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e9719d514eaf77d92c98db3afceb976d27957f8ca6ffde6957c76576d254f5ff3c848589176aee00ee59c646ff5c86304a2ec9d9c32057a8333411e0a617f09", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0cc6f355087d3c53dd315e0b526d9fe79789ddb22c2efe1172214e965f106afac5b179be4db2715d396e57739a7004e36e317fc1a5498b593077db821e5d6147", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b920c2e011156239b664b8c43fa34cc21928a7f6e31d8eb93495260528051ad09f4e211f2b0e42e6419e7cf2932d4758402488bf38f546f9606d72a25b6d4997", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/327936d2a67f7275dd4ff60346fa33da96e1637311015a164bd26de42e21d3a35dac14db767c6ded2e5858ccf3925c72f1beb4b3a4138e6a95ab045b694f7bd6"} 04:40:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:01 INFO - Contents: 04:40:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e9719d514eaf77d92c98db3afceb976d27957f8ca6ffde6957c76576d254f5ff3c848589176aee00ee59c646ff5c86304a2ec9d9c32057a8333411e0a617f09", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0cc6f355087d3c53dd315e0b526d9fe79789ddb22c2efe1172214e965f106afac5b179be4db2715d396e57739a7004e36e317fc1a5498b593077db821e5d6147", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b920c2e011156239b664b8c43fa34cc21928a7f6e31d8eb93495260528051ad09f4e211f2b0e42e6419e7cf2932d4758402488bf38f546f9606d72a25b6d4997", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/327936d2a67f7275dd4ff60346fa33da96e1637311015a164bd26de42e21d3a35dac14db767c6ded2e5858ccf3925c72f1beb4b3a4138e6a95ab045b694f7bd6"} 04:40:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:01 INFO - Copying logs to upload dir... 04:40:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.823158 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-22 04:40:01.625947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 04:40:01.633241) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e9719d514eaf77d92c98db3afceb976d27957f8ca6ffde6957c76576d254f5ff3c848589176aee00ee59c646ff5c86304a2ec9d9c32057a8333411e0a617f09", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0cc6f355087d3c53dd315e0b526d9fe79789ddb22c2efe1172214e965f106afac5b179be4db2715d396e57739a7004e36e317fc1a5498b593077db821e5d6147", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b920c2e011156239b664b8c43fa34cc21928a7f6e31d8eb93495260528051ad09f4e211f2b0e42e6419e7cf2932d4758402488bf38f546f9606d72a25b6d4997", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/327936d2a67f7275dd4ff60346fa33da96e1637311015a164bd26de42e21d3a35dac14db767c6ded2e5858ccf3925c72f1beb4b3a4138e6a95ab045b694f7bd6"} build_url:https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/F_pZonTiTMOWCnfnEqvf0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e9719d514eaf77d92c98db3afceb976d27957f8ca6ffde6957c76576d254f5ff3c848589176aee00ee59c646ff5c86304a2ec9d9c32057a8333411e0a617f09", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0cc6f355087d3c53dd315e0b526d9fe79789ddb22c2efe1172214e965f106afac5b179be4db2715d396e57739a7004e36e317fc1a5498b593077db821e5d6147", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b920c2e011156239b664b8c43fa34cc21928a7f6e31d8eb93495260528051ad09f4e211f2b0e42e6419e7cf2932d4758402488bf38f546f9606d72a25b6d4997", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/327936d2a67f7275dd4ff60346fa33da96e1637311015a164bd26de42e21d3a35dac14db767c6ded2e5858ccf3925c72f1beb4b3a4138e6a95ab045b694f7bd6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 04:40:01.664178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:40:01.664514) ========= 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=ba164b0a7b0ec7655860e956000001c1-1506078944.255519-1157404456 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 04:40:01.743713) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 04:40:01.747039) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 04:40:01.747355) ========= ========= Total master_lag: 0.21 =========