builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1506302555.16 results: success (0) revision: 40f2d25d78c0ce6e23c932c27aae833916a2041b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.162300) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.162760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.163036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.180535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.180828) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 18:22:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-09-24 18:22:35 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.280404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.280732) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.334501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:35.337850) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 40f2d25d78c0ce6e23c932c27aae833916a2041b --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 40f2d25d78c0ce6e23c932c27aae833916a2041b --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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 18:22:35,512 truncating revision to first 12 chars 2017-09-24 18:22:35,512 Setting DEBUG logging. 2017-09-24 18:22:35,512 attempt 1/10 2017-09-24 18:22:35,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/40f2d25d78c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 18:22:35,984 unpacking tar archive at: mozilla-beta-40f2d25d78c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:36.151977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:36.152326) ========= script_repo_revision: 40f2d25d78c0ce6e23c932c27aae833916a2041b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:36.152726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:36.153020) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 18:22:36.168973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-24 18:22:36.169375) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:36 INFO - MultiFileLogger online at 20170924 18:22:36 in /builds/slave/test 18:22:36 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 18:22:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:36 INFO - {'append_to_log': False, 18:22:36 INFO - 'base_work_dir': '/builds/slave/test', 18:22:36 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 18:22:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:36 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 18:22:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:36 INFO - 'code_coverage': False, 18:22:36 INFO - 'config_files': ('talos/linux_config.py',), 18:22:36 INFO - 'default_actions': ('clobber', 18:22:36 INFO - 'read-buildbot-config', 18:22:36 INFO - 'download-and-extract', 18:22:36 INFO - 'populate-webroot', 18:22:36 INFO - 'create-virtualenv', 18:22:36 INFO - 'install', 18:22:36 INFO - 'setup-mitmproxy', 18:22:36 INFO - 'run-tests'), 18:22:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:36 INFO - 'disable_ccov_upload': False, 18:22:36 INFO - 'disable_stylo': False, 18:22:36 INFO - 'download_minidump_stackwalk': True, 18:22:36 INFO - 'download_symbols': 'ondemand', 18:22:36 INFO - 'enable_stylo': False, 18:22:36 INFO - 'enable_webrender': False, 18:22:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:22:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:36 INFO - 'gecko_profile': False, 18:22:36 INFO - 'gecko_profile_interval': 0, 18:22:36 INFO - 'installer_path': 'installer.exe', 18:22:36 INFO - 'log_level': 'info', 18:22:36 INFO - 'log_name': 'talos', 18:22:36 INFO - 'log_to_console': True, 18:22:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:36 INFO - 'opt_config_files': (), 18:22:36 INFO - 'pip_index': False, 18:22:36 INFO - 'suite': 'dromaeojs-e10s', 18:22:36 INFO - 'system_bits': '32', 18:22:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:36 INFO - 'title': 'talos-linux64-ix-051', 18:22:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:36 INFO - 'use_talos_json': True, 18:22:36 INFO - 'verify': 'False', 18:22:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:36 INFO - 'work_dir': 'build'} 18:22:36 INFO - [mozharness: 2017-09-25 01:22:36.495311Z] Running clobber step. 18:22:36 INFO - Running pre-action listener: _resource_record_pre_action 18:22:36 INFO - Running main action method: clobber 18:22:36 INFO - rmtree: /builds/slave/test/build 18:22:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:38 INFO - Running post-action listener: _resource_record_post_action 18:22:38 INFO - [mozharness: 2017-09-25 01:22:38.100693Z] Finished clobber step (success) 18:22:38 INFO - [mozharness: 2017-09-25 01:22:38.100792Z] Running read-buildbot-config step. 18:22:38 INFO - Running pre-action listener: _resource_record_pre_action 18:22:38 INFO - Running main action method: read_buildbot_config 18:22:38 INFO - Using buildbot properties: 18:22:38 INFO - { 18:22:38 INFO - "project": "", 18:22:38 INFO - "product": "firefox", 18:22:38 INFO - "who": "ryanvm@gmail.com", 18:22:38 INFO - "installer_path": "public/build/target.tar.bz2", 18:22:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 18:22:38 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 18:22:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 18:22:38 INFO - "stage_platform": "linux64", 18:22:38 INFO - "basedir": "/builds/slave/test", 18:22:38 INFO - "buildnumber": 118, 18:22:38 INFO - "platform": "ubuntu64_hw", 18:22:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:22:38 INFO - "slavebuilddir": "test", 18:22:38 INFO - "taskId": "S0ONzIVIRQyIIdTCmw42Ng", 18:22:38 INFO - "branch": "mozilla-beta", 18:22:38 INFO - "script_repo_revision": "production", 18:22:38 INFO - "revision": "40f2d25d78c0ce6e23c932c27aae833916a2041b", 18:22:38 INFO - "slavename": "talos-linux64-ix-051", 18:22:38 INFO - "repo_path": "releases/mozilla-beta" 18:22:38 INFO - } 18:22:38 INFO - Finding installer, test and symbols from parent task. 18:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0ONzIVIRQyIIdTCmw42Ng'}, attempt #1 18:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S0ONzIVIRQyIIdTCmw42Ng'}, attempt #1 18:22:38 INFO - Task dependencies: dTMAbwsERsGY9UqfKjOsbg 18:22:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg'}, attempt #1 18:22:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 18:22:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.test_packages.json 18:22:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.crashreporter-symbols.zip 18:22:39 INFO - Running post-action listener: _resource_record_post_action 18:22:39 INFO - [mozharness: 2017-09-25 01:22:39.434298Z] Finished read-buildbot-config step (success) 18:22:39 INFO - [mozharness: 2017-09-25 01:22:39.434515Z] Running download-and-extract step. 18:22:39 INFO - Running pre-action listener: _resource_record_pre_action 18:22:39 INFO - Running main action method: download_and_extract 18:22:39 INFO - mkdir: /builds/slave/test/build/tests 18:22:39 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')]} 18:22:39 INFO - trying https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.test_packages.json 18:22:39 INFO - Downloading https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:22:39 INFO - Downloaded 989 bytes. 18:22:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:22:39 INFO - Using the following test package requirements: 18:22:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:22:39 INFO - u'common': [u'target.common.tests.zip'], 18:22:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:22:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:22:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:22:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:22:39 INFO - u'mozbase': [u'target.common.tests.zip'], 18:22:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:22:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:22:39 INFO - u'web-platform': [u'target.common.tests.zip', 18:22:39 INFO - u'target.web-platform.tests.tar.gz'], 18:22:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:22:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 18:22:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.common.tests.zip 18:22:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:22:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.common.tests.zip into memory 18:22:41 INFO - Content-Length response header: 55179620 18:22:41 INFO - Bytes received: 55179620 18:22:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.talos.tests.zip 18:22:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:22:51 INFO - Fetch https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.talos.tests.zip into memory 18:22:52 INFO - Content-Length response header: 14509184 18:22:52 INFO - Bytes received: 14509184 18:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:52 INFO - trying https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 18:22:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:22:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:22:53 INFO - Downloaded 53574512 bytes. 18:22:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 18:22:53 INFO - mkdir: /builds/slave/test/properties 18:22:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:53 INFO - Contents: 18:22:53 INFO - build_url:https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 18:22:53 INFO - Running post-action listener: _resource_record_post_action 18:22:53 INFO - Running post-action listener: find_tests_for_verification 18:22:53 INFO - Running post-action listener: set_extra_try_arguments 18:22:53 INFO - [mozharness: 2017-09-25 01:22:53.959395Z] Finished download-and-extract step (success) 18:22:53 INFO - [mozharness: 2017-09-25 01:22:53.959492Z] Running populate-webroot step. 18:22:53 INFO - Running pre-action listener: _resource_record_pre_action 18:22:53 INFO - Running main action method: populate_webroot 18:22:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:22:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['tresize', 18:22:53 INFO - 'tcanvasmark']}, 18:22:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:22:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['dromaeo_css', 18:22:53 INFO - 'kraken']}, 18:22:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'tests': ['damp', 'tps']}, 18:22:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['damp', 'tps']}, 18:22:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['dromaeo_dom']}, 18:22:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:22:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['basic_compositor_video', 18:22:53 INFO - 'glvideo']}, 18:22:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:22:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['ts_paint_webext', 18:22:53 INFO - 'tp5o_webext']}, 18:22:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:22:53 INFO - 'ts_paint', 18:22:53 INFO - 'tpaint', 18:22:53 INFO - 'sessionrestore', 18:22:53 INFO - 'sessionrestore_many_windows', 18:22:53 INFO - 'sessionrestore_no_auto_restore', 18:22:53 INFO - 'tabpaint']}, 18:22:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['a11yr', 18:22:53 INFO - 'ts_paint', 18:22:53 INFO - 'tpaint', 18:22:53 INFO - 'sessionrestore', 18:22:53 INFO - 'sessionrestore_many_windows', 18:22:53 INFO - 'sessionrestore_no_auto_restore', 18:22:53 INFO - 'tabpaint']}, 18:22:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:22:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 18:22:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['perf_reftest_singletons']}, 18:22:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['bloom_basic']}, 18:22:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:22:53 INFO - 'tsvgr_opacity', 18:22:53 INFO - 'tart', 18:22:53 INFO - 'tscrollx', 18:22:53 INFO - 'tsvg_static']}, 18:22:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['tsvgx', 18:22:53 INFO - 'tsvgr_opacity', 18:22:53 INFO - 'tart', 18:22:53 INFO - 'tscrollx', 18:22:53 INFO - 'tsvg_static']}, 18:22:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:22:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo'], 18:22:53 INFO - 'tests': ['tp5o']}, 18:22:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:22:53 INFO - 'talos_options': ['--mitmproxy', 18:22:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:22:53 INFO - '--firstNonBlankPaint'], 18:22:53 INFO - 'tests': ['tp6_google', 18:22:53 INFO - 'tp6_youtube', 18:22:53 INFO - 'tp6_amazon', 18:22:53 INFO - 'tp6_facebook']}, 18:22:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo', 18:22:53 INFO - '--mitmproxy', 18:22:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:22:53 INFO - '--firstNonBlankPaint'], 18:22:53 INFO - 'tests': ['tp6_google', 18:22:53 INFO - 'tp6_youtube', 18:22:53 INFO - 'tp6_amazon', 18:22:53 INFO - 'tp6_facebook']}, 18:22:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:22:53 INFO - 'talos_options': ['--stylo-threads=1', 18:22:53 INFO - '--mitmproxy', 18:22:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:22:53 INFO - '--firstNonBlankPaint'], 18:22:53 INFO - 'tests': ['tp6_google', 18:22:53 INFO - 'tp6_youtube', 18:22:53 INFO - 'tp6_amazon', 18:22:53 INFO - 'tp6_facebook']}, 18:22:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--xperf_path', 18:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:53 INFO - 'tests': ['tp5n']}, 18:22:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:22:53 INFO - 'talos_options': ['--disable-stylo', 18:22:53 INFO - '--xperf_path', 18:22:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:53 INFO - 'tests': ['tp5n']}}} 18:22:53 INFO - Running post-action listener: _resource_record_post_action 18:22:53 INFO - [mozharness: 2017-09-25 01:22:53.974510Z] Finished populate-webroot step (success) 18:22:53 INFO - [mozharness: 2017-09-25 01:22:53.974600Z] Running create-virtualenv step. 18:22:53 INFO - Running pre-action listener: _resource_record_pre_action 18:22:53 INFO - Running main action method: create_virtualenv 18:22:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:22:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:22:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:22:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:54 INFO - Installing pip...............done. 18:22:54 INFO - Return code: 0 18:22:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:22:54 INFO - Reading from file tmpfile_stdout 18:22:54 INFO - Output received: 18:22:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:22:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:22:54 INFO - Using env: {'DISPLAY': ':0', 18:22:54 INFO - 'HOME': '/home/cltbld', 18:22:54 INFO - 'LANG': 'en_US.UTF-8', 18:22:54 INFO - 'LANGUAGE': 'en_US:en', 18:22:54 INFO - 'LOGNAME': 'cltbld', 18:22:54 INFO - 'MAIL': '/var/mail/cltbld', 18:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:54 INFO - 'MOZ_NO_REMOTE': '1', 18:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:54 INFO - 'NO_EM_RESTART': '1', 18:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:54 INFO - 'PWD': '/builds/slave/test', 18:22:54 INFO - 'SHELL': '/bin/bash', 18:22:54 INFO - 'SHLVL': '1', 18:22:54 INFO - 'TERM': 'linux', 18:22:54 INFO - 'TMOUT': '86400', 18:22:54 INFO - 'USER': 'cltbld', 18:22:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:54 INFO - '_': '/tools/buildbot/bin/python'} 18:22:56 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:22:56 INFO - Downloading/unpacking pip>=1.5 18:22:56 INFO - Running setup.py egg_info for package pip 18:22:56 INFO - warning: no files found matching 'pip/cacert.pem' 18:22:56 INFO - warning: no files found matching '*.html' under directory 'docs' 18:22:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:22:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:22:56 INFO - Installing collected packages: pip 18:22:56 INFO - Found existing installation: pip 1.1 18:22:56 INFO - Uninstalling pip: 18:22:56 INFO - Successfully uninstalled pip 18:22:56 INFO - Running setup.py install for pip 18:22:56 INFO - warning: no files found matching 'pip/cacert.pem' 18:22:56 INFO - warning: no files found matching '*.html' under directory 'docs' 18:22:56 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:22:56 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:22:56 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:22:56 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:22:56 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:22:56 INFO - Successfully installed pip 18:22:56 INFO - Cleaning up... 18:22:56 INFO - Return code: 0 18:22:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:22:56 INFO - Using env: {'DISPLAY': ':0', 18:22:56 INFO - 'HOME': '/home/cltbld', 18:22:56 INFO - 'LANG': 'en_US.UTF-8', 18:22:56 INFO - 'LANGUAGE': 'en_US:en', 18:22:56 INFO - 'LOGNAME': 'cltbld', 18:22:56 INFO - 'MAIL': '/var/mail/cltbld', 18:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:56 INFO - 'MOZ_NO_REMOTE': '1', 18:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:56 INFO - 'NO_EM_RESTART': '1', 18:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:56 INFO - 'PWD': '/builds/slave/test', 18:22:56 INFO - 'SHELL': '/bin/bash', 18:22:56 INFO - 'SHLVL': '1', 18:22:56 INFO - 'TERM': 'linux', 18:22:56 INFO - 'TMOUT': '86400', 18:22:56 INFO - 'USER': 'cltbld', 18:22:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:56 INFO - '_': '/tools/buildbot/bin/python'} 18:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:56 INFO - Downloading/unpacking psutil>=3.1.1 18:22: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 18:22: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 18:22: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 18:22: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 18:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:57 INFO - Installing collected packages: psutil 18:22:57 INFO - Running setup.py install for psutil 18:22:57 INFO - building 'psutil._psutil_linux' extension 18:22:57 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 18:22:57 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 18:22:57 INFO - building 'psutil._psutil_posix' extension 18:22:57 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 18:22:58 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 18:22:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:58 INFO - Successfully installed psutil 18:22:58 INFO - Cleaning up... 18:22:58 INFO - Return code: 0 18:22:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22: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')]} 18:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:22:58 INFO - Using env: {'DISPLAY': ':0', 18:22:58 INFO - 'HOME': '/home/cltbld', 18:22:58 INFO - 'LANG': 'en_US.UTF-8', 18:22:58 INFO - 'LANGUAGE': 'en_US:en', 18:22:58 INFO - 'LOGNAME': 'cltbld', 18:22:58 INFO - 'MAIL': '/var/mail/cltbld', 18:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:58 INFO - 'MOZ_NO_REMOTE': '1', 18:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:58 INFO - 'NO_EM_RESTART': '1', 18:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:58 INFO - 'PWD': '/builds/slave/test', 18:22:58 INFO - 'SHELL': '/bin/bash', 18:22:58 INFO - 'SHLVL': '1', 18:22:58 INFO - 'TERM': 'linux', 18:22:58 INFO - 'TMOUT': '86400', 18:22:58 INFO - 'USER': 'cltbld', 18:22:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:58 INFO - '_': '/tools/buildbot/bin/python'} 18:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:22: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 18:22: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 18:22: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 18:22: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 18:22:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:22:59 INFO - Installing collected packages: mozsystemmonitor 18:22:59 INFO - Running setup.py install for mozsystemmonitor 18:22:59 INFO - Successfully installed mozsystemmonitor 18:22:59 INFO - Cleaning up... 18:23:00 INFO - Return code: 0 18:23:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:23:00 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')]} 18:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:00 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')]} 18:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:00 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:00 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 18:23:00 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 18:23:00 INFO - Using env: {'DISPLAY': ':0', 18:23:00 INFO - 'HOME': '/home/cltbld', 18:23:00 INFO - 'LANG': 'en_US.UTF-8', 18:23:00 INFO - 'LANGUAGE': 'en_US:en', 18:23:00 INFO - 'LOGNAME': 'cltbld', 18:23:00 INFO - 'MAIL': '/var/mail/cltbld', 18:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:00 INFO - 'MOZ_NO_REMOTE': '1', 18:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:00 INFO - 'NO_EM_RESTART': '1', 18:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:00 INFO - 'PWD': '/builds/slave/test', 18:23:00 INFO - 'SHELL': '/bin/bash', 18:23:00 INFO - 'SHLVL': '1', 18:23:00 INFO - 'TERM': 'linux', 18:23:00 INFO - 'TMOUT': '86400', 18:23:00 INFO - 'USER': 'cltbld', 18:23:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:00 INFO - '_': '/tools/buildbot/bin/python'} 18:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:00 INFO - Downloading/unpacking jsonschema==2.5.1 18:23: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 18:23: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 18:23: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 18:23: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 18:23:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:23: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 18:23: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 18:23: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 18:23: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 18:23:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:01 INFO - warning: no files found matching '*.txt' 18:23:01 INFO - no previously-included directories found matching 'build' 18:23:01 INFO - no previously-included directories found matching 'dist' 18:23:01 INFO - no previously-included directories found matching '.git*' 18:23:01 INFO - Installing collected packages: jsonschema, functools32 18:23:01 INFO - Running setup.py install for functools32 18:23:01 INFO - warning: no files found matching '*.txt' 18:23:01 INFO - no previously-included directories found matching 'build' 18:23:01 INFO - no previously-included directories found matching 'dist' 18:23:01 INFO - no previously-included directories found matching '.git*' 18:23:01 INFO - Successfully installed jsonschema functools32 18:23:01 INFO - Cleaning up... 18:23:01 INFO - Return code: 0 18:23:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23: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')]} 18:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:02 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:02 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 18:23:02 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 18:23:02 INFO - Using env: {'DISPLAY': ':0', 18:23:02 INFO - 'HOME': '/home/cltbld', 18:23:02 INFO - 'LANG': 'en_US.UTF-8', 18:23:02 INFO - 'LANGUAGE': 'en_US:en', 18:23:02 INFO - 'LOGNAME': 'cltbld', 18:23:02 INFO - 'MAIL': '/var/mail/cltbld', 18:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:02 INFO - 'MOZ_NO_REMOTE': '1', 18:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:02 INFO - 'NO_EM_RESTART': '1', 18:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:02 INFO - 'PWD': '/builds/slave/test', 18:23:02 INFO - 'SHELL': '/bin/bash', 18:23:02 INFO - 'SHLVL': '1', 18:23:02 INFO - 'TERM': 'linux', 18:23:02 INFO - 'TMOUT': '86400', 18:23:02 INFO - 'USER': 'cltbld', 18:23:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:02 INFO - '_': '/tools/buildbot/bin/python'} 18:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:23:02 INFO - Cleaning up... 18:23:02 INFO - Return code: 0 18:23:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:02 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:02 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 18:23:02 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 18:23:02 INFO - Using env: {'DISPLAY': ':0', 18:23:02 INFO - 'HOME': '/home/cltbld', 18:23:02 INFO - 'LANG': 'en_US.UTF-8', 18:23:02 INFO - 'LANGUAGE': 'en_US:en', 18:23:02 INFO - 'LOGNAME': 'cltbld', 18:23:02 INFO - 'MAIL': '/var/mail/cltbld', 18:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:02 INFO - 'MOZ_NO_REMOTE': '1', 18:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:02 INFO - 'NO_EM_RESTART': '1', 18:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:02 INFO - 'PWD': '/builds/slave/test', 18:23:02 INFO - 'SHELL': '/bin/bash', 18:23:02 INFO - 'SHLVL': '1', 18:23:02 INFO - 'TERM': 'linux', 18:23:02 INFO - 'TMOUT': '86400', 18:23:02 INFO - 'USER': 'cltbld', 18:23:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:02 INFO - '_': '/tools/buildbot/bin/python'} 18:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:02 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:03 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:04 INFO - Downloading docopt-0.6.1.tar.gz 18:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:04 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:04 INFO - Running setup.py install for blobuploader 18:23:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:04 INFO - Running setup.py install for requests 18:23:04 INFO - Running setup.py install for docopt 18:23:04 INFO - Successfully installed blobuploader requests docopt 18:23:04 INFO - Cleaning up... 18:23:04 INFO - Return code: 0 18:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:04 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:04 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 18:23:04 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 18:23:04 INFO - Using env: {'DISPLAY': ':0', 18:23:04 INFO - 'HOME': '/home/cltbld', 18:23:04 INFO - 'LANG': 'en_US.UTF-8', 18:23:04 INFO - 'LANGUAGE': 'en_US:en', 18:23:04 INFO - 'LOGNAME': 'cltbld', 18:23:04 INFO - 'MAIL': '/var/mail/cltbld', 18:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:04 INFO - 'MOZ_NO_REMOTE': '1', 18:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:04 INFO - 'NO_EM_RESTART': '1', 18:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:04 INFO - 'PWD': '/builds/slave/test', 18:23:04 INFO - 'SHELL': '/bin/bash', 18:23:04 INFO - 'SHLVL': '1', 18:23:04 INFO - 'TERM': 'linux', 18:23:04 INFO - 'TMOUT': '86400', 18:23:04 INFO - 'USER': 'cltbld', 18:23:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:04 INFO - '_': '/tools/buildbot/bin/python'} 18:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:04 INFO - Running setup.py (path:/tmp/pip-v3HEdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:05 INFO - Running setup.py (path:/tmp/pip-ntkPOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:05 INFO - Running setup.py (path:/tmp/pip-lQp_5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:05 INFO - Running setup.py (path:/tmp/pip-ECyxZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:05 INFO - Running setup.py (path:/tmp/pip-f0yfHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:05 INFO - Running setup.py (path:/tmp/pip-F9sOuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:05 INFO - Running setup.py (path:/tmp/pip-2SThrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:05 INFO - Running setup.py (path:/tmp/pip-V1o4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:05 INFO - Running setup.py (path:/tmp/pip-SQeram-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:05 INFO - Running setup.py (path:/tmp/pip-EPXxup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:05 INFO - Running setup.py (path:/tmp/pip-JNlEqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:05 INFO - Running setup.py (path:/tmp/pip-3OmpNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:05 INFO - Running setup.py (path:/tmp/pip-gK597a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:05 INFO - Running setup.py (path:/tmp/pip-Gb78Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:05 INFO - Running setup.py (path:/tmp/pip-JovctI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:06 INFO - Running setup.py (path:/tmp/pip-5pJmQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:06 INFO - Running setup.py (path:/tmp/pip-U5hILL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:06 INFO - Running setup.py install for manifestparser 18:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozcrash 18:23:06 INFO - Running setup.py install for mozdebug 18:23:06 INFO - Running setup.py install for mozdevice 18:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozfile 18:23:06 INFO - Running setup.py install for mozhttpd 18:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozinfo 18:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozInstall 18:23:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:06 INFO - Running setup.py install for mozleak 18:23:07 INFO - Running setup.py install for mozlog 18:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for moznetwork 18:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozprocess 18:23:07 INFO - Running setup.py install for mozprofile 18:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozrunner 18:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Running setup.py install for mozscreenshot 18:23:07 INFO - Running setup.py install for moztest 18:23:07 INFO - Running setup.py install for mozversion 18:23:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:07 INFO - Cleaning up... 18:23:07 INFO - Return code: 0 18:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:07 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:07 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 18:23:07 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 18:23:07 INFO - Using env: {'DISPLAY': ':0', 18:23:07 INFO - 'HOME': '/home/cltbld', 18:23:07 INFO - 'LANG': 'en_US.UTF-8', 18:23:07 INFO - 'LANGUAGE': 'en_US:en', 18:23:07 INFO - 'LOGNAME': 'cltbld', 18:23:07 INFO - 'MAIL': '/var/mail/cltbld', 18:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:07 INFO - 'MOZ_NO_REMOTE': '1', 18:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:07 INFO - 'NO_EM_RESTART': '1', 18:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:07 INFO - 'PWD': '/builds/slave/test', 18:23:07 INFO - 'SHELL': '/bin/bash', 18:23:07 INFO - 'SHLVL': '1', 18:23:07 INFO - 'TERM': 'linux', 18:23:07 INFO - 'TMOUT': '86400', 18:23:07 INFO - 'USER': 'cltbld', 18:23:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:07 INFO - '_': '/tools/buildbot/bin/python'} 18:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:08 INFO - Running setup.py (path:/tmp/pip-YEwQnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:08 INFO - Running setup.py (path:/tmp/pip-k7mqqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:08 INFO - Running setup.py (path:/tmp/pip-AJu_Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:08 INFO - Running setup.py (path:/tmp/pip-LxdSjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:08 INFO - Running setup.py (path:/tmp/pip-nMqnuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:08 INFO - Running setup.py (path:/tmp/pip-mNBW2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:08 INFO - Running setup.py (path:/tmp/pip-wCV6rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:08 INFO - Running setup.py (path:/tmp/pip-SQ715Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:08 INFO - Running setup.py (path:/tmp/pip-TCsOTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:08 INFO - Running setup.py (path:/tmp/pip-NtecPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:08 INFO - Running setup.py (path:/tmp/pip-CvMLJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:08 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)) 18:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:08 INFO - Running setup.py (path:/tmp/pip-fxi_BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:09 INFO - Running setup.py (path:/tmp/pip-6oy6jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:09 INFO - Running setup.py (path:/tmp/pip-VMjPG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:09 INFO - Running setup.py (path:/tmp/pip-Nq0A4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:09 INFO - Running setup.py (path:/tmp/pip-zW76Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:09 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)) 18:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:09 INFO - Running setup.py (path:/tmp/pip-60FgiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 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)) 18:23:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:10 INFO - Downloading blessings-1.6.tar.gz 18:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:10 INFO - Installing collected packages: blessings 18:23:10 INFO - Running setup.py install for blessings 18:23:10 INFO - Successfully installed blessings 18:23:10 INFO - Cleaning up... 18:23:10 INFO - Return code: 0 18:23:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:10 INFO - Reading from file tmpfile_stdout 18:23:10 INFO - Current package versions: 18:23:10 INFO - argparse == 1.2.1 18:23:10 INFO - blessings == 1.6 18:23:10 INFO - blobuploader == 1.2.4 18:23:10 INFO - docopt == 0.6.1 18:23:10 INFO - functools32 == 3.2.3-2 18:23:10 INFO - jsonschema == 2.5.1 18:23:10 INFO - manifestparser == 1.1 18:23:10 INFO - mozInstall == 1.13 18:23:10 INFO - mozcrash == 1.0 18:23:10 INFO - mozdebug == 0.1 18:23:10 INFO - mozdevice == 0.51 18:23:10 INFO - mozfile == 1.2 18:23:10 INFO - mozhttpd == 0.7 18:23:10 INFO - mozinfo == 0.10 18:23:10 INFO - mozleak == 0.1 18:23:10 INFO - mozlog == 3.5 18:23:10 INFO - moznetwork == 0.27 18:23:10 INFO - mozprocess == 0.25 18:23:10 INFO - mozprofile == 0.28 18:23:10 INFO - mozrunner == 6.13 18:23:10 INFO - mozscreenshot == 0.1 18:23:10 INFO - mozsystemmonitor == 0.3 18:23:10 INFO - moztest == 0.8 18:23:10 INFO - mozversion == 1.4 18:23:10 INFO - psutil == 3.1.1 18:23:10 INFO - requests == 1.2.3 18:23:10 INFO - wsgiref == 0.1.2 18:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23: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')]} 18:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23: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')]} 18:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:10 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:10 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 18:23:10 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 18:23:10 INFO - Using env: {'DISPLAY': ':0', 18:23:10 INFO - 'HOME': '/home/cltbld', 18:23:10 INFO - 'LANG': 'en_US.UTF-8', 18:23:10 INFO - 'LANGUAGE': 'en_US:en', 18:23:10 INFO - 'LOGNAME': 'cltbld', 18:23:10 INFO - 'MAIL': '/var/mail/cltbld', 18:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:10 INFO - 'MOZ_NO_REMOTE': '1', 18:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:10 INFO - 'NO_EM_RESTART': '1', 18:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:10 INFO - 'PWD': '/builds/slave/test', 18:23:10 INFO - 'SHELL': '/bin/bash', 18:23:10 INFO - 'SHLVL': '1', 18:23:10 INFO - 'TERM': 'linux', 18:23:10 INFO - 'TMOUT': '86400', 18:23:10 INFO - 'USER': 'cltbld', 18:23:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:10 INFO - '_': '/tools/buildbot/bin/python'} 18:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 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)) 18:23:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:23:11 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 18:23:11 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 18:23:11 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 18:23:11 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 18:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:23:12 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)) 18:23:12 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)) 18:23:12 INFO - Installing collected packages: simplejson 18:23:12 INFO - Running setup.py install for simplejson 18:23:12 INFO - building 'simplejson._speedups' extension 18:23:12 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 18:23:13 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 18:23:13 INFO - Successfully installed simplejson 18:23:13 INFO - Cleaning up... 18:23:13 INFO - Return code: 0 18:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:13 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 0x220c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', '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 18:23:13 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 18:23:13 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 18:23:13 INFO - Using env: {'DISPLAY': ':0', 18:23:13 INFO - 'HOME': '/home/cltbld', 18:23:13 INFO - 'LANG': 'en_US.UTF-8', 18:23:13 INFO - 'LANGUAGE': 'en_US:en', 18:23:13 INFO - 'LOGNAME': 'cltbld', 18:23:13 INFO - 'MAIL': '/var/mail/cltbld', 18:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:13 INFO - 'MOZ_NO_REMOTE': '1', 18:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:13 INFO - 'NO_EM_RESTART': '1', 18:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:13 INFO - 'PWD': '/builds/slave/test', 18:23:13 INFO - 'SHELL': '/bin/bash', 18:23:13 INFO - 'SHLVL': '1', 18:23:13 INFO - 'TERM': 'linux', 18:23:13 INFO - 'TMOUT': '86400', 18:23:13 INFO - 'USER': 'cltbld', 18:23:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:13 INFO - '_': '/tools/buildbot/bin/python'} 18:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:23:13 INFO - Cleaning up... 18:23:13 INFO - Return code: 0 18:23:13 INFO - Running post-action listener: _resource_record_post_action 18:23:13 INFO - Running post-action listener: _start_resource_monitoring 18:23:13 INFO - Starting resource monitoring. 18:23:13 INFO - [mozharness: 2017-09-25 01:23:13.646502Z] Finished create-virtualenv step (success) 18:23:13 INFO - [mozharness: 2017-09-25 01:23:13.647016Z] Running install step. 18:23:13 INFO - Running pre-action listener: _resource_record_pre_action 18:23:13 INFO - Running main action method: install 18:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:13 INFO - Reading from file tmpfile_stdout 18:23:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:13 INFO - Reading from file tmpfile_stdout 18:23:13 INFO - Output received: 18:23:13 INFO - Usage: mozinstall [options] installer 18:23:13 INFO - Options: 18:23:13 INFO - -h, --help show this help message and exit 18:23:13 INFO - -d DEST, --destination=DEST 18:23:13 INFO - Directory to install application into. [default: 18:23:13 INFO - "/builds/slave/test"] 18:23:13 INFO - --app=APP Application being installed. [default: firefox] 18:23:13 INFO - mkdir: /builds/slave/test/build/application 18:23:13 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'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:23:28 INFO - Reading from file tmpfile_stdout 18:23:28 INFO - Output received: 18:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:28 INFO - Running post-action listener: _resource_record_post_action 18:23:28 INFO - [mozharness: 2017-09-25 01:23:28.608042Z] Finished install step (success) 18:23:28 INFO - [mozharness: 2017-09-25 01:23:28.608292Z] Running setup-mitmproxy step. 18:23:28 INFO - Running pre-action listener: _resource_record_pre_action 18:23:28 INFO - Running main action method: setup_mitmproxy 18:23:28 INFO - Skipping: mitmproxy is not required 18:23:28 INFO - Running post-action listener: _resource_record_post_action 18:23:28 INFO - [mozharness: 2017-09-25 01:23:28.609462Z] Finished setup-mitmproxy step (success) 18:23:28 INFO - [mozharness: 2017-09-25 01:23:28.609686Z] Running run-tests step. 18:23:28 INFO - Running pre-action listener: _resource_record_pre_action 18:23:28 INFO - Running pre-action listener: _set_gcov_prefix 18:23:28 INFO - Running main action method: run_tests 18:23:28 WARNING - Try message not found. 18:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:28 INFO - Python 2.7.3 18:23:28 INFO - Return code: 0 18:23:28 INFO - grabbing minidump binary from tooltool 18:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:23:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257b090>, '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 0x257bd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2575f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:23:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:23:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:28 INFO - Return code: 0 18:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:28 INFO - ENV: RUST_BACKTRACE is now full 18:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:28 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/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 18:23:28 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/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 18:23:28 INFO - Using env: {'DISPLAY': ':0', 18:23:28 INFO - 'HOME': '/home/cltbld', 18:23:28 INFO - 'LANG': 'en_US.UTF-8', 18:23:28 INFO - 'LANGUAGE': 'en_US:en', 18:23:28 INFO - 'LOGNAME': 'cltbld', 18:23:28 INFO - 'MAIL': '/var/mail/cltbld', 18:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:28 INFO - 'MOZ_NO_REMOTE': '1', 18:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:28 INFO - 'NO_EM_RESTART': '1', 18:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:28 INFO - 'PWD': '/builds/slave/test', 18:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:28 INFO - 'RUST_BACKTRACE': 'full', 18:23:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:23:28 INFO - 'SHELL': '/bin/bash', 18:23:28 INFO - 'SHLVL': '1', 18:23:28 INFO - 'TERM': 'linux', 18:23:28 INFO - 'TMOUT': '86400', 18:23:28 INFO - 'USER': 'cltbld', 18:23:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:28 INFO - '_': '/tools/buildbot/bin/python'} 18:23:28 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/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 18:23:28 INFO - mozversion application_buildid: 20170925000404 18:23:28 INFO - mozversion application_changeset: 40f2d25d78c0ce6e23c932c27aae833916a2041b 18:23:28 INFO - mozversion application_display_name: Firefox 18:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:28 INFO - mozversion application_name: Firefox 18:23:28 INFO - mozversion application_remotingname: firefox 18:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:23:28 INFO - mozversion application_vendor: Mozilla 18:23:28 INFO - mozversion application_version: 57.0 18:23:28 INFO - mozversion platform_buildid: 20170925000404 18:23:28 INFO - mozversion platform_changeset: 40f2d25d78c0ce6e23c932c27aae833916a2041b 18:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:23:28 INFO - mozversion platform_version: 57.0 18:23:28 INFO - using testdate: 1506302608 18:23:28 INFO - actual date: 1506302608 18:23:28 INFO - starting webserver on 'localhost:53065' 18:23:28 INFO - SUITE-START | Running 2 tests 18:23:28 INFO - TEST-START | dromaeo_css 18:23:28 INFO - Initialising browser for dromaeo_css test... 18:23:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53065/getInfo.html -profile /tmp/tmpPo5Ug6/profile 18:23:28 INFO - TEST-INFO | started process 24869 (/builds/slave/test/build/application/firefox/firefox http://localhost:53065/getInfo.html) 18:23:34 INFO - TEST-INFO | 24869: exit 0 18:23:34 INFO - Browser initialized. 18:23:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:34 INFO - Using env: {'DISPLAY': ':0', 18:23:34 INFO - 'HOME': '/home/cltbld', 18:23:34 INFO - 'JSGC_DISABLE_POISONING': '1', 18:23:34 INFO - 'LANG': 'en_US.UTF-8', 18:23:34 INFO - 'LANGUAGE': 'en_US:en', 18:23:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:23:34 INFO - 'LOGNAME': 'cltbld', 18:23:34 INFO - 'MAIL': '/var/mail/cltbld', 18:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:34 INFO - 'MOZ_CRASHREPORTER': '1', 18:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:23:34 INFO - 'MOZ_NO_REMOTE': '1', 18:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:34 INFO - 'NO_EM_RESTART': '1', 18:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:34 INFO - 'PWD': '/builds/slave/test', 18:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:34 INFO - 'RUST_BACKTRACE': 'full', 18:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:23:34 INFO - 'SHELL': '/bin/bash', 18:23:34 INFO - 'SHLVL': '1', 18:23:34 INFO - 'TERM': 'linux', 18:23:34 INFO - 'TMOUT': '86400', 18:23:34 INFO - 'USER': 'cltbld', 18:23:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:34 INFO - '_': '/tools/buildbot/bin/python'} 18:23:34 INFO - TEST-INFO | started process 25061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPo5Ug6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:45 INFO - PID 25061 | RSS: Main: 141283328 18:23:45 INFO - PID 25061 | 18:26:43 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53065/tests/dromaeo/cssquery-ext.html) 18:26:44 INFO - PID 25061 | RSS: Main: 145141760 18:26:44 INFO - PID 25061 | 18:29:45 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-ext.html (next: http://localhost:53065/tests/dromaeo/cssquery-jquery.html) 18:29:46 INFO - PID 25061 | RSS: Main: 143376384 18:29:46 INFO - PID 25061 | 18:32:48 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53065/tests/dromaeo/cssquery-mootools.html) 18:32:48 INFO - PID 25061 | RSS: Main: 144371712 18:32:48 INFO - PID 25061 | 18:35:50 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53065/tests/dromaeo/cssquery-prototype.html) 18:35:50 INFO - PID 25061 | RSS: Main: 144277504 18:35:50 INFO - PID 25061 | 18:38:53 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53065/tests/dromaeo/cssquery-yui.html) 18:38:54 INFO - PID 25061 | RSS: Main: 145498112 18:38:54 INFO - PID 25061 | 18:41:55 INFO - PID 25061 | Cycle 1(1): loaded http://localhost:53065/tests/dromaeo/cssquery-yui.html (next: http://localhost:53065/tests/dromaeo/cssquery-dojo.html) 18:41:55 INFO - PID 25061 | RSS: Main: 146546688 18:41:55 INFO - PID 25061 | 18:41:55 INFO - PID 25061 | __start_tp_report 18:41:55 INFO - PID 25061 | _x_x_mozilla_page_load 18:41:55 INFO - PID 25061 | _x_x_mozilla_page_load_details 18:41:55 INFO - PID 25061 | |i|pagename|runs| 18:41:55 INFO - PID 25061 | |0;dojo.html;4021.41689455029;4025.396190571414;4029.8992525186886;4037.6164264394884;4043.615856493634;6604.60372377657;6652.334766523345;6710.664466776666;6759.2226893907155;6769.898451523225;6654.201495820508;6668.6332251726135;6673.299303573116;6745;6762.966185169067;5975.701214939236;6019.097135429677;6042.274927008754;6053.303870054934;6076.240469941257;5906.675132867691;5997.820065398023;6038.124471951586;6064.272287325505;6115.113308570255;6039.094135879609;6101.237345331833;6106.419890110433;6114.541409394291;6126.111713801519;6053.969730151321;6100.931823954501;6135.754569817202;6168.198134242542;6184.690765461709;5983.341832398432;6052.939470605325;6100;6143.385661433821;6182.783602573933;6510.08858759774;6566.376194261537;6598.670066496656;6606.405423511907;6680.565763225423;7181.317774811385;7219.602921839297;7232.674529646179;7237.710491580383;7291.5989620570845;7257.782266532013;7277.935547598469;7339.155997060353;7370.226126256773;7374.225706300815;6635.93364066358;6663.4669226461765;6696.1629796275465;6754.696038678222;6756.628385438799;7435.739749108755;7488.700451981968;7538.246175382418;7538.434617403716;7543.849123017619;7140.964295178491;7166.319199676127;7233.963830180815;7245.7826265212125;7251;7190.101237345332;7219.278072192738;7256.201817800038;7275.818104547428;7277.345038946521;7157.105361829771;7192.460565457612;7224.169220539705;7244.384227340735;7249.093863267091;7182.138143422718;7211.747588834365;7254.056972593635;7298.8175295616975;7301.561906285639;5361.222622719762;5406.459354064562;5445.50990410865;5452.781888724407;5462.098753705594;4848.515148485123;4898.53463920927;4904.117258893433;4925.458199598042;4944.90110197794;6712.53012289135;6721.529492935545;6723.428508576728;6725.798226053226;6728.192616886005;7139.178994415709;7162.140543134858;7228.674709638079;7325.047743793273;7370.6314684266645;6706.932930670729;6707.262201157869;6761.763338283235;6798.320167983162;6800.761973330909;6069.514438844882;6133.785317513954;6170.475509581646;6217.098520714561;6288;7531.171571127172;7566.24337566239;7574.128975167816;7631.198724133886;7633.5419874807685;7217.953396757546;7220.133583969957;7224.755280144053;7328.267173282629;7348.008018917378;7377.0409846719585;7404.481686281909;7490.625468726651;7493.925060749323;7634.50375725576;7105.32499412555;7163.785086447415;7200.71197152129;7219.60292183935;7231.457640677076;7176.354128128493;7229.421646268391;7229.566226026455;7234.240404757425;7317.304856038668;6948.687309071205;6953.061336719478;7035.964820175866;7059.399951004222;7064.646767661699;6956.40870526011;7025.648717564203;7034.437245020284;7042.014118023379;7046.788596342118;6813.216480104851;6912.032315475938;6925.376716095576;6925.757598484029;7011.053507776385;6949;7032.2264550898335;7036.718531258693;7061.6822243000215;7080.114985626797;6831.11195544576;6875.518713689994;6875.896861547181;6882.8623427532175;6894 18:41:56 INFO - PID 25061 | |1;ext.html;884.8850448434974;953.1802649721238;954.7422196007078;1003.4781913405025;1005.3716427232979;45806.312905306404;46774.29838552416;46831;46836.765816170875;47117.76441117794;43173.35239971395;43503.56496435035;43511.564884351144;43517;43565.78217108918;7931.484453510532;8055;8061.072976607677;8066.314363279128;8095.797605059891;7970.920290797076;8010.39922005849;8066.798330041737;8075.596220188967;8079.474834135792;8705.129487051308;8888.377813553054;8914.242289405409;8927.151920567569;8927.419717718327;8846.5576721164;8889.599968001456;8918.866217006751;8925.866112008325;8939.28485721144;8824.29405647553;8841.778955526099;8879.112088791133;8896.199342059246;8898.644054237822;41893.1621367574;41899.58100418987;41915.1616967662;42060.579394205975;42245.1550968982;3867.8839634811;3877.0501227199234;3885.4948856648457;3896.7661940283674;3930.0960779020984;34149.658503414896;34161;34322.48516272258;34359.14102147441;34426.311473770635;5458.9454105458835;5462.890742185174;5467.043267428184;5482.424345443751;5526.806561770319;222667;226745;227694;230032;243825.78087109627;53564;54153.45846541484;54204;54511.182332265045;54522.727386362814;56037;56104;56578.43421565814;56742.14886776701;56812.715936420056;16788.496345109666;17061.7440738389;17075.829241707674;17081.06054167008;17151;13915.095518791246;13995.790063149061;14023;14027.438902443992;14041.78937315941;15441.382344706086;15545.145017024171;15552.300146493435;15619.531414057596;15713.371465141496;5970.701464926737;6065.2418447694035;6120.693965301717;6221.4089661482085;6407.967960160169;1106.330669944688;1112.821948488238;1117.4915413486844;1117.742919128605;1123.8482804821408;25979.74020259811;26014.479710406064;26015;26145.607815882777;26456;1219.1709637446622;1226.650404634675;1234.1299383934304;1244.0731654917145;1251.7621651886113;13888.097273677178;13900.860991389956;13936.303184840717;14009.85990140106;14275.428982840778;286297;286782;291135;291271;291889;58272.12591811126;58917.70541147267;58924.41075589275;59015.40984590185;59092.704536477046;1520.7338715724704;1550.78934779142;1580.9051456912623;1581.8892677512695;1592.2357268510948;25720.228393148234;26082.73917260803;26099.869500652374;26177.345566360993;26244;40786;40852.18295634011;40855;40899;40909.79545102255;229421;229711;229999;230563;231776;36323.273534528635;38885.80557097196;39987.80006099951;40057;40235.3964690524;52196.73901630467;52563.73718131538;52686;53539.19691204713;53733.19400209078;38351.61648383592;38788;38918;39234;39264.41103383509;37635.62364376321;37806.8109659461;37843.243135137694;37934.24131517409;38119.42820857634;43732;44404;44839.775801120784;44897.55102448934;44925.32612010757;36420;36523;36708.44937325889;36817;37090;27145.321366965985;27186.32034199161;27406.5889011669;27419.451610968066;27757.861210693816 18:41:56 INFO - PID 25061 | |2;jquery.html;635.5962396264326;642.1188946172458;649.0271989741817;650.9023646453032;650.9920703625472;24401;24788.008479660813;25022.74977250227;25072;25142.245732628005;26525.469490610223;26612;26662.33344166392;26772.19683409496;26778.59832102515;4540.614047805941;6566.310537393565;6651;6655.301193374698;6709.832254193635;6604.537682362236;6693.297203793604;6714.328567143295;6719.160104986877;6727.495437842157;6517.087607734921;6652.467802575807;6678.532502724787;6678.899816502756;6747.257801641816;6676;6682.064510968468;6763.120794296735;6836.658167091626;6843.828904277408;6240.719167637467;6295.905561416583;6308.3060863305;6319.210098737658;6346.143270658448;29176.562351564742;29906.401871962655;30311.696883031327;30454.695453045406;30468.238294042825;2274.4200228941513;2316.7104111986;2322.5238826040622;2323.9186628467924;2333.5332933413215;20924.267650632155;21549.461263468384;21598.89200553987;21694.457638559004;21743.891280543656;2588.1717850287914;2618.882150303241;2646.801489888266;2650.3771613670774;2672.9599056014176;152263.238683807;157502;166044;168850;169674;16066.518004459886;16536.338546458006;16658.83341166597;16935.407260745815;17013.48959531216;26082.478350433266;26144.73855261461;26150;26243.343916402242;26289.474210516066;10668.679939601825;10891.618793342195;10969.451527423756;10980.670579882617;11150.721231969266;9941.900580994097;9991.150752186146;10093.495325233709;10138.949305253574;10147.289689721796;9948.950255248677;9992.850107248398;10037.749056273506;10327.277090603586;10397.532111055021;2933.8826446941885;2985.7163569460868;3078.5382192671277;3132.8590213439993;3143.2456210509313;1033.3696445168441;1047.607147319755;1047.711879233217;1063.5267306048734;1067.2209287220373;21050.47373815667;21171.68242476364;21335.78664213369;21349.57300853974;21764.782352176277;1138.2203190814319;1139.1740987783955;1145.1811954452605;1148.024179447463;1162.1458228202264;11285.322880627189;11657.125715571367;11733.296002239893;11755.353455559854;11803.88196118045;618511;624146;625504;626118;639973;124510;126068.36965815112;130822;131509;132740.33629831788;1271.5295340723992;1293.2434525802512;1361.8025386319127;1362;1368.9178649280875;22680.432989174744;22874;22878.42803929915;22914.885425572764;22942.42643933915;64095.359046408936;66952;67434.98847517389;68006.31993680199;68646.31353686599;81453.59273203596;82186.58906705429;82604;82675;83576.58211708903;15580.532584022498;15890;16227.594310141869;16262.674746504767;16289.266982985557;23978.40053998664;24214.51570968606;24247.515049698555;24336.269911902673;24349.75650243546;18943.715844262624;18974.525636859187;19050.52373690669;19127.808721912603;19133.80866191376;18025.188866501303;18308.359207427675;18319.725204122216;18441.077946102374;18473;19255.13351899196;20156.092975816417;20263.29078482246;20307.898460507604;20331.881746504085;15662.765058523903;15939.123348215959;16000.119993400474;16015.759763603322;16017.839821601634;19787.604247914674;20101;20109;20195.899020504803;20235.59528809386 18:41:56 INFO - PID 25061 | |3;mootools.html;1478.6007777899965;1511.4936496273747;1518.6734852006816;1529.3347393883655;1539.161157169343;17230.138493075345;17908.10459477026;17930.551736206602;17934;17949.10254487277;17545.298188072462;17678.911605441954;17696.292148314085;17720.46838594841;17747.82252177478;3071.355015446759;3106.5495503152088;3151.975607927421;3153;3162.0513845846267;3036.423079614877;3066.723994840475;3073.231692076981;3074.631044274679;3074.7540196784316;3038.7417069549115;3116.688331166888;3117.953230701541;3125.296808218144;3129.843507824611;3139.3250451153112;3148.4018036573093;3186.6335371432233;3188.85650145744;3190.170555655523;2982;2986.641603007653;3017.3663530658587;3047.040182342555;3057.1287183152695;17325.393611223546;17400.30398784047;17449.82550174495;17465;17493;8989.685361012333;9306.53467326631;9315.627374904996;9329.11373419524;9334.673286434941;5934.37689042653;5935.73289201987;5947.345791962881;6136.938630613681;6155.199824022893;2153.7738537453497;2200.273909609825;2202.757696653367;2254.1997590855176;2257.2325409360733;32350;32570.999999999764;32578.511322330185;32580.837095814608;32582.837085814655;7695.384369250447;7854.175311592315;7893.526388416713;8007.719729809429;8054.71124620058;20984.685229721566;21072.578548428944;21087.78912210858;21101.261455848973;21136;8863.955680221557;9010.05394433575;9035.548222588975;9042.367034307666;9114.453132812052;8166.836663266701;8194.959025204837;8225.629846656915;8232.670693172206;8250.54621995796;5893.057110862242;5975.940240597625;5986.670733109634;6016;6255.937440625627;1652.182169825944;1696.0502118813504;1696.202784691193;1739.4086010756403;1760.9295628174987;989.1394486796534;1034.6016783538241;1035.6530562261726;1043.9478026098664;1052.8578641883248;9587.472689002172;9656.613735450645;9660;9734.707958761248;9846.704598861903;765.7740966414921;773.8723110686786;778.8091917480253;786.3276898251912;840.6931470013401;5818.418158184148;5873.970630146908;5898.528117750569;5921.644701317935;5940.673262970492;25439.74560254374;25973.870130649226;26511.46977060448;26552.867235664085;26625.866870665523;25680;25966.480670386485;26380.20859374222;26381.34046648811;26644.60033099505;12475.937620312023;12705;12729.045321600917;12971.481140754264;13221.801672974912;9204.217641500547;9308.813823723623;9383.530823458936;9474.621015159591;9497.287703422133;22343.32970010902;22403.21588744386;22622.773772262066;22826.543469130193;23644.172453964027;22851.31446056621;23010.539789204457;23228.419289517897;23284.76715232826;23548.529029419657;13066.869331306565;13117.803232951705;13126.343682816012;13199.538016169388;13216.867831321564;16182.67634647324;16409.42567010149;16413.67172656564;16447.177641118134;16451.58871028234;13086.803697944348;13131.080824342205;13318.200907945555;13331;13352.198868067948;12697.4286157125;12834.501176131145;13111.67220819449;13212;13447.663808404868;10820.350778953289;10885.619003335161;11039.724006899893;11045.779084418105;11055.447227638746;7879.921200788148;8122.309603683753;8170.632321545426;8171.346292296721;8206.83586328282;7772.611369431619;7876.09424916119;7884.369250460064;7943.4439589230515;7985.161558036322 18:41:56 INFO - PID 25061 | |4;prototype.html;555.5971920357739;564.1227890630071;566.2723400430447;584.2754983820064;600.618607184438;6279.905801412982;6347.587406818559;6383.202099737533;6443.838904027401;6462.321456247085;6224.19085518883;6231.937680623192;6275.152854364659;6318.747250110002;6336.144620476234;5175.870603234912;5190.974045129769;5241.606879484035;5241.842744717665;5243.318368612094;4923.433805112422;5102.234664800291;5103.540681338679;5131.461196574362;5133.177721908724;5096.490350964892;5107.3360463139925;5112.539871411572;5120.820771273006;5121.974390128044;4995.700257984533;5005.374328208974;5009.649324547283;5022.899542009158;5080.568151707109;4623.283391074388;4635.6523260755575;4658.138244424792;4678.274867395559;4685;6243.344448832898;6249.812505624838;6290.119383286344;6293.30773614902;6325.810225693236;5942.70286485674;5958.5828991970575;5976.551758618121;5977.402259774031;6013.909791353133;6756.628385438799;6767.120274364351;6778.356056174655;6798.252192258848;6807.115075040263;4991.276264941564;5209.557187639055;5210.993767399541;5217.34783152106;5221.791128354899;6811.9659401702675;6856.965715171442;6910.965445172742;6988.266232045613;6991.580505169706;5330.626856120034;5341.439148889388;5341.893162136736;5344.545713614309;5365.892682146336;5385.7576409061685;5435.239066530688;5446.7276636168035;5454.581808729758;5456.826782241757;5979.402059793986;5982.726563905688;5992.370801065826;6028.788992385334;6043.697815109227;6697.598144111369;6741.685371352539;6810.659467026728;6815.352541508549;6836.521443499007;1808.6292310076403;1840.2822899069106;1841.6408800283816;1843.271907596492;1844.2530775036132;1274.15905502368;1301.9218846869219;1325.2247435250295;1340.2226708509236;1344.8587898270737;6093.725782339805;6209.720562574695;6224.782132625427;6268.247810262797;6305.936940630627;6662.700178491979;6774.390304872585;6818.556793808387;6857.622830744257;6859.828504287433;6293.527985401113;6305.464035557029;6308;6358.968205158944;6393.200849893763;3602.7658202217294;3604.4052731299566;3624.1845584743223;3647.708183345326;3650.2699460108083;7053.717851285994;7070.646467676595;7128.215896251409;7161.2122666507685;7182.389496892718;6957.304269573104;6974.407175390047;6994.2306346302885;7003.159620845531;7054.365107140382;6944.340287672663;7014.789556313421;7044.737933550128;7069.257727938492;7077.5399599025895;6581.380240867599;6608.372204640552;6724.4620430364475;6728.654269146093;6820.62486563224;6599.439047681001;6628.933710663025;6668.698993998002;6697.229818570927;6698;7005.824854378681;7010.75462358815;7074.151101867808;7101.183363913216;7116;5327.547158491417;5334.425525325966;5351.866203344947;5405.324334458192;5406.107992181246;6595.769148079794;6669.6665166740495;6806.8638627228165;6821;6828.248892621708;6483.7730679425995;6612.5040621952585;6633.1376920999965;6653.600783952978;6682.63245521501;6470.838229044311;6543.509236807354;6553.311902250386;6618;6670.83322916931;6451.387118223761;6545.312742162005;6621.656063687999;6644.235912870082;6644.700988455627;6591.571547849375;6682.766103186365;6720.1599800025;6723.394894459522;6753.425958793558;6453.709583068679;6467.15926929515;6516.152900122954;6545.5090868184125;6562.604649303065 18:41:56 INFO - PID 25061 | |5;yui.html;944.3861490031475;966.077396086737;980.3725615606013;982.3369225772602;989.8267803134452;20704;21424;21519.139234430604;21628.56742865142;21637.675434868488;19270.71093933592;20166.899165504154;21043.47391315218;21217.681734773993;21349.679754803692;1084.4523515624599;1113.3709454158416;1114.420501339303;1114.504045699664;1116.2744216259416;1060.6234786650743;1090.4711215060688;1097.040089921319;1099.780043991205;1101.509828126484;1174.583023026826;1176.7881781279366;1176.823476478531;1178.4755783676267;1178.8231765235241;1159.0611604600258;1159.6810877008807;1164.2956011612937;1165.7143999720038;1170.7073231692077;856.3491746272878;859.1537335724369;861.0399404663817;861.2421069458899;863.6200071968377;19479.12343944526;19985.800141998538;20076;20124.698129528068;22630.43423914399;23122.3063308101;23286;23464.91008866187;23716;23798.167064152844;18472.445826625222;18701.719474207897;18834.058297085092;18845.90577047106;18847;3940.9014774630864;3965.5836137205756;3977.880663580097;3984.4222587724907;4003.3594624859884;162302;166639;168116;169591;170200;18589.7211541827;19099.61800764005;19132.713009304593;19135.80864191368;19158.425247242605;28603.57094643582;29287.12138635844;29636.259093522833;29851.253718657208;30294.697053029628;9723.708288751348;9737.610495580097;9750.463724495221;9854.901450985542;9932.900670993342;4855.6115510759055;4888.828890988798;4917.483664215278;4930.827421040246;4952.133376659071;5910.881782364415;5922.200502932135;5929;5998.1002849572915;5999.790007349722;1193.4271549656214;1205.584073494643;1209.9818502722467;1221.5724496426358;1224.1125184241355;716.3051839715572;760.3233122520961;766.5094339622646;778.0546635837485;785.4776573578506;12411.255324680547;13214.735705286033;13291.534796282083;13522.18866867991;13844.30778461073;748.2714928515147;752.913414957276;755.2560727683227;761.6991288441035;766.2950085920854;6285.622862628257;6322.620642761449;6358.459530939922;6367.840803979938;6373.235211774524;137491.31254343665;138475.30762346124;141704.29147854194;143348;144450;120520.39739801244;124132;125021.37489312496;126279.3686031564;128666.35666821606;108134;108188;108627;112779.43610281896;114497;13328.800067998794;14226.288685565472;14432.278386080863;14579.708405831612;14653.92673036628;52900.47099528956;54223.18665219946;54449.727751362574;54945;55268.170977434565;69568.6521567389;70014;70070;70692;72013.6399318;18604.25582976666;18787.812121879153;18933.148008339933;19245.518862028563;19246.615067698847;22264.332070037926;22277;22327.330180094625;22363.217287394862;22518;18877.71683424722;19053.809461905203;19198.520036999187;19411.51471213231;19492.317768878587;20671.17315307431;21067.57864842664;21080.894595526923;21140.577188456453;21238.36284911455;17568.297268109134;17703.911480443032;18031.5492112693;18153.636927261647;18352.449426517225;13783.862161378258;13862.584122476343;13899.930500347433;14020.369083391475;14053.367598458299;15263.08421494714;15603.609909752347;15633.374665013727;15645.295961681979;15712.685746285239 18:41:56 INFO - PID 25061 | __end_tp_report 18:41:56 INFO - PID 25061 | __start_cc_report 18:41:56 INFO - PID 25061 | _x_x_mozilla_cycle_collect,256 18:41:56 INFO - PID 25061 | __end_cc_report 18:41:56 INFO - PID 25061 | __startTimestamp1506303715989__endTimestamp 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | ------- Summary: start ------- 18:41:56 INFO - PID 25061 | Number of tests: 6 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#0] dojo.html Cycles:165 Average:6694.59 Median:6925.38 stddev:774.45 (11.2%) stddev-sans-first:747.89 18:41:56 INFO - PID 25061 | Values: 4021.4 4025.4 4029.9 4037.6 4043.6 6604.6 6652.3 6710.7 6759.2 6769.9 6654.2 6668.6 6673.3 6745.0 6763.0 5975.7 6019.1 6042.3 6053.3 6076.2 5906.7 5997.8 6038.1 6064.3 6115.1 6039.1 6101.2 6106.4 6114.5 6126.1 6054.0 6100.9 6135.8 6168.2 6184.7 5983.3 6052.9 6100.0 6143.4 6182.8 6510.1 6566.4 6598.7 6606.4 6680.6 7181.3 7219.6 7232.7 7237.7 7291.6 7257.8 7277.9 7339.2 7370.2 7374.2 6635.9 6663.5 6696.2 6754.7 6756.6 7435.7 7488.7 7538.2 7538.4 7543.8 7141.0 7166.3 7234.0 7245.8 7251.0 7190.1 7219.3 7256.2 7275.8 7277.3 7157.1 7192.5 7224.2 7244.4 7249.1 7182.1 7211.7 7254.1 7298.8 7301.6 5361.2 5406.5 5445.5 5452.8 5462.1 4848.5 4898.5 4904.1 4925.5 4944.9 6712.5 6721.5 6723.4 6725.8 6728.2 7139.2 7162.1 7228.7 7325.0 7370.6 6706.9 6707.3 6761.8 6798.3 6800.8 6069.5 6133.8 6170.5 6217.1 6288.0 7531.2 7566.2 7574.1 7631.2 7633.5 7218.0 7220.1 7224.8 7328.3 7348.0 7377.0 7404.5 7490.6 7493.9 7634.5 7105.3 7163.8 7200.7 7219.6 7231.5 7176.4 7229.4 7229.6 7234.2 7317.3 6948.7 6953.1 7036.0 7059.4 7064.6 6956.4 7025.6 7034.4 7042.0 7046.8 6813.2 6912.0 6925.4 6925.8 7011.1 6949.0 7032.2 7036.7 7061.7 7080.1 6831.1 6875.5 6875.9 6882.9 6894.0 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#1] ext.html Cycles:180 Average:43892.47 Median:21565.38 stddev:65351.03 (303.0%) stddev-sans-first:65454.57 18:41:56 INFO - PID 25061 | Values: 884.9 953.2 954.7 1003.5 1005.4 45806.3 46774.3 46831.0 46836.8 47117.8 43173.4 43503.6 43511.6 43517.0 43565.8 7931.5 8055.0 8061.1 8066.3 8095.8 7970.9 8010.4 8066.8 8075.6 8079.5 8705.1 8888.4 8914.2 8927.2 8927.4 8846.6 8889.6 8918.9 8925.9 8939.3 8824.3 8841.8 8879.1 8896.2 8898.6 41893.2 41899.6 41915.2 42060.6 42245.2 3867.9 3877.1 3885.5 3896.8 3930.1 34149.7 34161.0 34322.5 34359.1 34426.3 5458.9 5462.9 5467.0 5482.4 5526.8 222667.0 226745.0 227694.0 230032.0 243825.8 53564.0 54153.5 54204.0 54511.2 54522.7 56037.0 56104.0 56578.4 56742.1 56812.7 16788.5 17061.7 17075.8 17081.1 17151.0 13915.1 13995.8 14023.0 14027.4 14041.8 15441.4 15545.1 15552.3 15619.5 15713.4 5970.7 6065.2 6120.7 6221.4 6408.0 1106.3 1112.8 1117.5 1117.7 1123.8 25979.7 26014.5 26015.0 26145.6 26456.0 1219.2 1226.7 1234.1 1244.1 1251.8 13888.1 13900.9 13936.3 14009.9 14275.4 286297.0 286782.0 291135.0 291271.0 291889.0 58272.1 58917.7 58924.4 59015.4 59092.7 1520.7 1550.8 1580.9 1581.9 1592.2 25720.2 26082.7 26099.9 26177.3 26244.0 40786.0 40852.2 40855.0 40899.0 40909.8 229421.0 229711.0 229999.0 230563.0 231776.0 36323.3 38885.8 39987.8 40057.0 40235.4 52196.7 52563.7 52686.0 53539.2 53733.2 38351.6 38788.0 38918.0 39234.0 39264.4 37635.6 37806.8 37843.2 37934.2 38119.4 43732.0 44404.0 44839.8 44897.6 44925.3 36420.0 36523.0 36708.4 36817.0 37090.0 27145.3 27186.3 27406.6 27419.5 27757.9 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#2] jquery.html Cycles:180 Average:41106.05 Median:22928.66 stddev:104995.44 (457.9%) stddev-sans-first:105246.01 18:41:56 INFO - PID 25061 | Values: 635.6 642.1 649.0 650.9 651.0 24401.0 24788.0 25022.7 25072.0 25142.2 26525.5 26612.0 26662.3 26772.2 26778.6 4540.6 6566.3 6651.0 6655.3 6709.8 6604.5 6693.3 6714.3 6719.2 6727.5 6517.1 6652.5 6678.5 6678.9 6747.3 6676.0 6682.1 6763.1 6836.7 6843.8 6240.7 6295.9 6308.3 6319.2 6346.1 29176.6 29906.4 30311.7 30454.7 30468.2 2274.4 2316.7 2322.5 2323.9 2333.5 20924.3 21549.5 21598.9 21694.5 21743.9 2588.2 2618.9 2646.8 2650.4 2673.0 152263.2 157502.0 166044.0 168850.0 169674.0 16066.5 16536.3 16658.8 16935.4 17013.5 26082.5 26144.7 26150.0 26243.3 26289.5 10668.7 10891.6 10969.5 10980.7 11150.7 9941.9 9991.2 10093.5 10138.9 10147.3 9949.0 9992.9 10037.7 10327.3 10397.5 2933.9 2985.7 3078.5 3132.9 3143.2 1033.4 1047.6 1047.7 1063.5 1067.2 21050.5 21171.7 21335.8 21349.6 21764.8 1138.2 1139.2 1145.2 1148.0 1162.1 11285.3 11657.1 11733.3 11755.4 11803.9 618511.0 624146.0 625504.0 626118.0 639973.0 124510.0 126068.4 130822.0 131509.0 132740.3 1271.5 1293.2 1361.8 1362.0 1368.9 22680.4 22874.0 22878.4 22914.9 22942.4 64095.4 66952.0 67435.0 68006.3 68646.3 81453.6 82186.6 82604.0 82675.0 83576.6 15580.5 15890.0 16227.6 16262.7 16289.3 23978.4 24214.5 24247.5 24336.3 24349.8 18943.7 18974.5 19050.5 19127.8 19133.8 18025.2 18308.4 18319.7 18441.1 18473.0 19255.1 20156.1 20263.3 20307.9 20331.9 15662.8 15939.1 16000.1 16015.8 16017.8 19787.6 20101.0 20109.0 20195.9 20235.6 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#3] mootools.html Cycles:180 Average:10962.53 Median:3002.00 stddev:8163.78 (271.9%) stddev-sans-first:8155.58 18:41:56 INFO - PID 25061 | Values: 1478.6 1511.5 1518.7 1529.3 1539.2 17230.1 17908.1 17930.6 17934.0 17949.1 17545.3 17678.9 17696.3 17720.5 17747.8 3071.4 3106.5 3152.0 3153.0 3162.1 3036.4 3066.7 3073.2 3074.6 3074.8 3038.7 3116.7 3118.0 3125.3 3129.8 3139.3 3148.4 3186.6 3188.9 3190.2 2982.0 2986.6 3017.4 3047.0 3057.1 17325.4 17400.3 17449.8 17465.0 17493.0 8989.7 9306.5 9315.6 9329.1 9334.7 5934.4 5935.7 5947.3 6136.9 6155.2 2153.8 2200.3 2202.8 2254.2 2257.2 32350.0 32571.0 32578.5 32580.8 32582.8 7695.4 7854.2 7893.5 8007.7 8054.7 20984.7 21072.6 21087.8 21101.3 21136.0 8864.0 9010.1 9035.5 9042.4 9114.5 8166.8 8195.0 8225.6 8232.7 8250.5 5893.1 5975.9 5986.7 6016.0 6255.9 1652.2 1696.1 1696.2 1739.4 1760.9 989.1 1034.6 1035.7 1043.9 1052.9 9587.5 9656.6 9660.0 9734.7 9846.7 765.8 773.9 778.8 786.3 840.7 5818.4 5874.0 5898.5 5921.6 5940.7 25439.7 25973.9 26511.5 26552.9 26625.9 25680.0 25966.5 26380.2 26381.3 26644.6 12475.9 12705.0 12729.0 12971.5 13221.8 9204.2 9308.8 9383.5 9474.6 9497.3 22343.3 22403.2 22622.8 22826.5 23644.2 22851.3 23010.5 23228.4 23284.8 23548.5 13066.9 13117.8 13126.3 13199.5 13216.9 16182.7 16409.4 16413.7 16447.2 16451.6 13086.8 13131.1 13318.2 13331.0 13352.2 12697.4 12834.5 13111.7 13212.0 13447.7 10820.4 10885.6 11039.7 11045.8 11055.4 7879.9 8122.3 8170.6 8171.3 8206.8 7772.6 7876.1 7884.4 7943.4 7985.2 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#4] prototype.html Cycles:180 Average:5715.85 Median:6313.37 stddev:1578.57 (25.0%) stddev-sans-first:1534.75 18:41:56 INFO - PID 25061 | Values: 555.6 564.1 566.3 584.3 600.6 6279.9 6347.6 6383.2 6443.8 6462.3 6224.2 6231.9 6275.2 6318.7 6336.1 5175.9 5191.0 5241.6 5241.8 5243.3 4923.4 5102.2 5103.5 5131.5 5133.2 5096.5 5107.3 5112.5 5120.8 5122.0 4995.7 5005.4 5009.6 5022.9 5080.6 4623.3 4635.7 4658.1 4678.3 4685.0 6243.3 6249.8 6290.1 6293.3 6325.8 5942.7 5958.6 5976.6 5977.4 6013.9 6756.6 6767.1 6778.4 6798.3 6807.1 4991.3 5209.6 5211.0 5217.3 5221.8 6812.0 6857.0 6911.0 6988.3 6991.6 5330.6 5341.4 5341.9 5344.5 5365.9 5385.8 5435.2 5446.7 5454.6 5456.8 5979.4 5982.7 5992.4 6028.8 6043.7 6697.6 6741.7 6810.7 6815.4 6836.5 1808.6 1840.3 1841.6 1843.3 1844.3 1274.2 1301.9 1325.2 1340.2 1344.9 6093.7 6209.7 6224.8 6268.2 6305.9 6662.7 6774.4 6818.6 6857.6 6859.8 6293.5 6305.5 6308.0 6359.0 6393.2 3602.8 3604.4 3624.2 3647.7 3650.3 7053.7 7070.6 7128.2 7161.2 7182.4 6957.3 6974.4 6994.2 7003.2 7054.4 6944.3 7014.8 7044.7 7069.3 7077.5 6581.4 6608.4 6724.5 6728.7 6820.6 6599.4 6628.9 6668.7 6697.2 6698.0 7005.8 7010.8 7074.2 7101.2 7116.0 5327.5 5334.4 5351.9 5405.3 5406.1 6595.8 6669.7 6806.9 6821.0 6828.2 6483.8 6612.5 6633.1 6653.6 6682.6 6470.8 6543.5 6553.3 6618.0 6670.8 6451.4 6545.3 6621.7 6644.2 6644.7 6591.6 6682.8 6720.2 6723.4 6753.4 6453.7 6467.2 6516.2 6545.5 6562.6 18:41:56 INFO - PID 25061 | 18:41:56 INFO - PID 25061 | [#5] yui.html Cycles:180 Average:28291.26 Median:19485.72 stddev:41390.45 (212.4%) stddev-sans-first:41455.63 18:41:56 INFO - PID 25061 | Values: 944.4 966.1 980.4 982.3 989.8 20704.0 21424.0 21519.1 21628.6 21637.7 19270.7 20166.9 21043.5 21217.7 21349.7 1084.5 1113.4 1114.4 1114.5 1116.3 1060.6 1090.5 1097.0 1099.8 1101.5 1174.6 1176.8 1176.8 1178.5 1178.8 1159.1 1159.7 1164.3 1165.7 1170.7 856.3 859.2 861.0 861.2 863.6 19479.1 19985.8 20076.0 20124.7 22630.4 23122.3 23286.0 23464.9 23716.0 23798.2 18472.4 18701.7 18834.1 18845.9 18847.0 3940.9 3965.6 3977.9 3984.4 4003.4 162302.0 166639.0 168116.0 169591.0 170200.0 18589.7 19099.6 19132.7 19135.8 19158.4 28603.6 29287.1 29636.3 29851.3 30294.7 9723.7 9737.6 9750.5 9854.9 9932.9 4855.6 4888.8 4917.5 4930.8 4952.1 5910.9 5922.2 5929.0 5998.1 5999.8 1193.4 1205.6 1210.0 1221.6 1224.1 716.3 760.3 766.5 778.1 785.5 12411.3 13214.7 13291.5 13522.2 13844.3 748.3 752.9 755.3 761.7 766.3 6285.6 6322.6 6358.5 6367.8 6373.2 137491.3 138475.3 141704.3 143348.0 144450.0 120520.4 124132.0 125021.4 126279.4 128666.4 108134.0 108188.0 108627.0 112779.4 114497.0 13328.8 14226.3 14432.3 14579.7 14653.9 52900.5 54223.2 54449.7 54945.0 55268.2 69568.7 70014.0 70070.0 70692.0 72013.6 18604.3 18787.8 18933.1 19245.5 19246.6 22264.3 22277.0 22327.3 22363.2 22518.0 18877.7 19053.8 19198.5 19411.5 19492.3 20671.2 21067.6 21080.9 21140.6 21238.4 17568.3 17703.9 18031.5 18153.6 18352.4 13783.9 13862.6 13899.9 14020.4 14053.4 15263.1 15603.6 15633.4 15645.3 15712.7 18:41:56 INFO - PID 25061 | -------- Summary: end -------- 18:41:56 INFO - PID 25061 | 18:41:56 INFO - TEST-INFO | 25061: exit 0 18:41:56 INFO - TEST-OK | dromaeo_css | took 1107652ms 18:41:56 INFO - TEST-START | kraken 18:41:56 INFO - Initialising browser for kraken test... 18:41:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53065/getInfo.html -profile /tmp/tmpNxoSsP/profile 18:41:56 INFO - TEST-INFO | started process 25428 (/builds/slave/test/build/application/firefox/firefox http://localhost:53065/getInfo.html) 18:42:01 INFO - TEST-INFO | 25428: exit 0 18:42:02 INFO - Browser initialized. 18:42:02 INFO - Running cycle 1/1 for kraken test... 18:42:02 INFO - Using env: {'DISPLAY': ':0', 18:42:02 INFO - 'HOME': '/home/cltbld', 18:42:02 INFO - 'JSGC_DISABLE_POISONING': '1', 18:42:02 INFO - 'LANG': 'en_US.UTF-8', 18:42:02 INFO - 'LANGUAGE': 'en_US:en', 18:42:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:42:02 INFO - 'LOGNAME': 'cltbld', 18:42:02 INFO - 'MAIL': '/var/mail/cltbld', 18:42:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:42:02 INFO - 'MOZ_CRASHREPORTER': '1', 18:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:42:02 INFO - 'MOZ_NO_REMOTE': '1', 18:42:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:02 INFO - 'NO_EM_RESTART': '1', 18:42:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:02 INFO - 'PWD': '/builds/slave/test', 18:42:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:02 INFO - 'RUST_BACKTRACE': 'full', 18:42:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:42:02 INFO - 'SHELL': '/bin/bash', 18:42:02 INFO - 'SHLVL': '1', 18:42:02 INFO - 'TERM': 'linux', 18:42:02 INFO - 'TMOUT': '86400', 18:42:02 INFO - 'USER': 'cltbld', 18:42:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340', 18:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:02 INFO - '_': '/tools/buildbot/bin/python'} 18:42:02 INFO - TEST-INFO | started process 25622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNxoSsP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:13 INFO - PID 25622 | RSS: Main: 141299712 18:42:13 INFO - PID 25622 | 18:42:15 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53065/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:16 INFO - PID 25622 | RSS: Main: 147595264 18:42:16 INFO - PID 25622 | 18:42:19 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53065/tests/kraken/driver.html?testName=audio-dft) 18:42:19 INFO - PID 25622 | RSS: Main: 147607552 18:42:19 INFO - PID 25622 | 18:42:22 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53065/tests/kraken/driver.html?testName=audio-fft) 18:42:23 INFO - PID 25622 | RSS: Main: 149274624 18:42:23 INFO - PID 25622 | 18:42:25 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53065/tests/kraken/driver.html?testName=audio-oscillator) 18:42:25 INFO - PID 25622 | RSS: Main: 149331968 18:42:25 INFO - PID 25622 | 18:42:27 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:28 INFO - PID 25622 | RSS: Main: 148807680 18:42:28 INFO - PID 25622 | 18:42:31 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53065/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:32 INFO - PID 25622 | RSS: Main: 149311488 18:42:32 INFO - PID 25622 | 18:42:35 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53065/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:36 INFO - PID 25622 | RSS: Main: 151552000 18:42:36 INFO - PID 25622 | 18:42:38 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53065/tests/kraken/driver.html?testName=json-parse-financial) 18:42:39 INFO - PID 25622 | RSS: Main: 152465408 18:42:39 INFO - PID 25622 | 18:42:41 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:41 INFO - PID 25622 | RSS: Main: 152158208 18:42:41 INFO - PID 25622 | 18:42:43 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:43 INFO - PID 25622 | RSS: Main: 152657920 18:42:43 INFO - PID 25622 | 18:42:45 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:46 INFO - PID 25622 | RSS: Main: 149897216 18:42:46 INFO - PID 25622 | 18:42:48 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:49 INFO - PID 25622 | RSS: Main: 149471232 18:42:49 INFO - PID 25622 | 18:42:52 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:52 INFO - PID 25622 | RSS: Main: 149860352 18:42:52 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | Cycle 1(1): loaded http://localhost:53065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53065/tests/kraken/driver.html?testName=ai-astar) 18:42:54 INFO - PID 25622 | RSS: Main: 151203840 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | __start_tp_report 18:42:54 INFO - PID 25622 | _x_x_mozilla_page_load 18:42:54 INFO - PID 25622 | _x_x_mozilla_page_load_details 18:42:54 INFO - PID 25622 | |i|pagename|runs| 18:42:54 INFO - PID 25622 | |0;ai-astar;104;105;104;106;106;107;108;105;106;106 18:42:54 INFO - PID 25622 | |1;audio-beat-detection;112;113;113;110;109;111;140;116;114;112 18:42:54 INFO - PID 25622 | |2;audio-dft;164;163;162;164;163;161;162;160;162;162 18:42:54 INFO - PID 25622 | |3;audio-fft;74;75;73;74;76;75;73;72;80;78 18:42:54 INFO - PID 25622 | |4;audio-oscillator;79;79;78;77;77;79;82;82;78;78 18:42:54 INFO - PID 25622 | |5;imaging-gaussian-blur;117;113;114;114;113;113;115;114;110;114 18:42:54 INFO - PID 25622 | |6;imaging-darkroom;149;149;149;151;150;150;149;149;149;149 18:42:54 INFO - PID 25622 | |7;imaging-desaturate;94;95;94;94;95;93;96;94;95;95 18:42:54 INFO - PID 25622 | |8;json-parse-financial;43;44;44;43;44;45;46;44;45;43 18:42:54 INFO - PID 25622 | |9;json-stringify-tinderbox;41;38;37;38;38;38;38;37;38;40 18:42:54 INFO - PID 25622 | |10;stanford-crypto-aes;68;69;70;69;69;73;70;71;70;69 18:42:54 INFO - PID 25622 | |11;stanford-crypto-ccm;103;103;103;104;104;102;103;108;107;102 18:42:54 INFO - PID 25622 | |12;stanford-crypto-pbkdf2;154;169;154;155;151;155;149;149;151;152 18:42:54 INFO - PID 25622 | |13;stanford-crypto-sha256-iterative;59;58;63;59;60;56;58;66;62;59 18:42:54 INFO - PID 25622 | __end_tp_report 18:42:54 INFO - PID 25622 | __start_cc_report 18:42:54 INFO - PID 25622 | _x_x_mozilla_cycle_collect,689 18:42:54 INFO - PID 25622 | __end_cc_report 18:42:54 INFO - PID 25622 | __startTimestamp1506303774722__endTimestamp 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | ------- Summary: start ------- 18:42:54 INFO - PID 25622 | Number of tests: 14 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#0] ai-astar Cycles:10 Average:105.70 Median:106.00 stddev:1.25 (1.2%) stddev-sans-first:1.17 18:42:54 INFO - PID 25622 | Values: 104.0 105.0 104.0 106.0 106.0 107.0 108.0 105.0 106.0 106.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:113.00 stddev:9.01 (8.0%) stddev-sans-first:9.49 18:42:54 INFO - PID 25622 | Values: 112.0 113.0 113.0 110.0 109.0 111.0 140.0 116.0 114.0 112.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 18:42:54 INFO - PID 25622 | Values: 164.0 163.0 162.0 164.0 163.0 161.0 162.0 160.0 162.0 162.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#3] audio-fft Cycles:10 Average:75.00 Median:75.00 stddev:2.45 (3.3%) stddev-sans-first:2.57 18:42:54 INFO - PID 25622 | Values: 74.0 75.0 73.0 74.0 76.0 75.0 73.0 72.0 80.0 78.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:1.79 (2.3%) stddev-sans-first:1.90 18:42:54 INFO - PID 25622 | Values: 79.0 79.0 78.0 77.0 77.0 79.0 82.0 82.0 78.0 78.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.77 (1.5%) stddev-sans-first:1.41 18:42:54 INFO - PID 25622 | Values: 117.0 113.0 114.0 114.0 113.0 113.0 115.0 114.0 110.0 114.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 18:42:54 INFO - PID 25622 | Values: 149.0 149.0 149.0 151.0 150.0 150.0 149.0 149.0 149.0 149.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 18:42:54 INFO - PID 25622 | Values: 94.0 95.0 94.0 94.0 95.0 93.0 96.0 94.0 95.0 95.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.00 stddev:0.99 (2.3%) stddev-sans-first:0.97 18:42:54 INFO - PID 25622 | Values: 43.0 44.0 44.0 43.0 44.0 45.0 46.0 44.0 45.0 43.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:1.25 (3.3%) stddev-sans-first:0.87 18:42:54 INFO - PID 25622 | Values: 41.0 38.0 37.0 38.0 38.0 38.0 38.0 37.0 38.0 40.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#10] stanford-crypto-aes Cycles:10 Average:69.80 Median:70.00 stddev:1.40 (2.0%) stddev-sans-first:1.32 18:42:54 INFO - PID 25622 | Values: 68.0 69.0 70.0 69.0 69.0 73.0 70.0 71.0 70.0 69.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#11] stanford-crypto-ccm Cycles:10 Average:103.90 Median:103.50 stddev:2.02 (2.0%) stddev-sans-first:2.12 18:42:54 INFO - PID 25622 | Values: 103.0 103.0 103.0 104.0 104.0 102.0 103.0 108.0 107.0 102.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:5.76 (3.7%) stddev-sans-first:6.11 18:42:54 INFO - PID 25622 | Values: 154.0 169.0 154.0 155.0 151.0 155.0 149.0 149.0 151.0 152.0 18:42:54 INFO - PID 25622 | 18:42:54 INFO - PID 25622 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:59.50 stddev:2.91 (4.9%) stddev-sans-first:3.06 18:42:54 INFO - PID 25622 | Values: 59.0 58.0 63.0 59.0 60.0 56.0 58.0 66.0 62.0 59.0 18:42:54 INFO - PID 25622 | -------- Summary: end -------- 18:42:54 INFO - PID 25622 | 18:42:55 INFO - PID 25622 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:42:55 INFO - TEST-INFO | 25622: exit 0 18:42:55 INFO - TEST-OK | kraken | took 58718ms 18:42:55 INFO - SUITE-END | took 1166s 18:42:55 INFO - Completed test suite (00:19:26) 18:42:55 INFO - javascript benchmark 18:42:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9410.088320075218, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4021.41689455029, 4025.396190571414, 4029.8992525186886, 4037.6164264394884, 4043.615856493634, 6604.60372377657, 6652.334766523345, 6710.664466776666, 6759.2226893907155, 6769.898451523225, 6654.201495820508, 6668.6332251726135, 6673.299303573116, 6745.0, 6762.966185169067, 5975.701214939236, 6019.097135429677, 6042.274927008754, 6053.303870054934, 6076.240469941257, 5906.675132867691, 5997.820065398023, 6038.124471951586, 6064.272287325505, 6115.113308570255, 6039.094135879609, 6101.237345331833, 6106.419890110433, 6114.541409394291, 6126.111713801519, 6053.969730151321, 6100.931823954501, 6135.754569817202, 6168.198134242542, 6184.690765461709, 5983.341832398432, 6052.939470605325, 6100.0, 6143.385661433821, 6182.783602573933, 6510.08858759774, 6566.376194261537, 6598.670066496656, 6606.405423511907, 6680.565763225423, 7181.317774811385, 7219.602921839297, 7232.674529646179, 7237.710491580383, 7291.5989620570845, 7257.782266532013, 7277.935547598469, 7339.155997060353, 7370.226126256773, 7374.225706300815, 6635.93364066358, 6663.4669226461765, 6696.1629796275465, 6754.696038678222, 6756.628385438799, 7435.739749108755, 7488.700451981968, 7538.246175382418, 7538.434617403716, 7543.849123017619, 7140.964295178491, 7166.319199676127, 7233.963830180815, 7245.7826265212125, 7251.0, 7190.101237345332, 7219.278072192738, 7256.201817800038, 7275.818104547428, 7277.345038946521, 7157.105361829771, 7192.460565457612, 7224.169220539705, 7244.384227340735, 7249.093863267091, 7182.138143422718, 7211.747588834365, 7254.056972593635, 7298.8175295616975, 7301.561906285639, 5361.222622719762, 5406.459354064562, 5445.50990410865, 5452.781888724407, 5462.098753705594, 4848.515148485123, 4898.53463920927, 4904.117258893433, 4925.458199598042, 4944.90110197794, 6712.53012289135, 6721.529492935545, 6723.428508576728, 6725.798226053226, 6728.192616886005, 7139.178994415709, 7162.140543134858, 7228.674709638079, 7325.047743793273, 7370.6314684266645, 6706.932930670729, 6707.262201157869, 6761.763338283235, 6798.320167983162, 6800.761973330909, 6069.514438844882, 6133.785317513954, 6170.475509581646, 6217.098520714561, 6288.0, 7531.171571127172, 7566.24337566239, 7574.128975167816, 7631.198724133886, 7633.5419874807685, 7217.953396757546, 7220.133583969957, 7224.755280144053, 7328.267173282629, 7348.008018917378, 7377.0409846719585, 7404.481686281909, 7490.625468726651, 7493.925060749323, 7634.50375725576, 7105.32499412555, 7163.785086447415, 7200.71197152129, 7219.60292183935, 7231.457640677076, 7176.354128128493, 7229.421646268391, 7229.566226026455, 7234.240404757425, 7317.304856038668, 6948.687309071205, 6953.061336719478, 7035.964820175866, 7059.399951004222, 7064.646767661699, 6956.40870526011, 7025.648717564203, 7034.437245020284, 7042.014118023379, 7046.788596342118, 6813.216480104851, 6912.032315475938, 6925.376716095576, 6925.757598484029, 7011.053507776385, 6949.0, 7032.2264550898335, 7036.718531258693, 7061.6822243000215, 7080.114985626797, 6831.11195544576, 6875.518713689994, 6875.896861547181, 6882.8623427532175, 6894.0], "value": 6642.578174714282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [884.8850448434974, 953.1802649721238, 954.7422196007078, 1003.4781913405025, 1005.3716427232979, 45806.312905306404, 46774.29838552416, 46831.0, 46836.765816170875, 47117.76441117794, 43173.35239971395, 43503.56496435035, 43511.564884351144, 43517.0, 43565.78217108918, 7931.484453510532, 8055.0, 8061.072976607677, 8066.314363279128, 8095.797605059891, 7970.920290797076, 8010.39922005849, 8066.798330041737, 8075.596220188967, 8079.474834135792, 8705.129487051308, 8888.377813553054, 8914.242289405409, 8927.151920567569, 8927.419717718327, 8846.5576721164, 8889.599968001456, 8918.866217006751, 8925.866112008325, 8939.28485721144, 8824.29405647553, 8841.778955526099, 8879.112088791133, 8896.199342059246, 8898.644054237822, 41893.1621367574, 41899.58100418987, 41915.1616967662, 42060.579394205975, 42245.1550968982, 3867.8839634811, 3877.0501227199234, 3885.4948856648457, 3896.7661940283674, 3930.0960779020984, 34149.658503414896, 34161.0, 34322.48516272258, 34359.14102147441, 34426.311473770635, 5458.9454105458835, 5462.890742185174, 5467.043267428184, 5482.424345443751, 5526.806561770319, 222667.0, 226745.0, 227694.0, 230032.0, 243825.78087109627, 53564.0, 54153.45846541484, 54204.0, 54511.182332265045, 54522.727386362814, 56037.0, 56104.0, 56578.43421565814, 56742.14886776701, 56812.715936420056, 16788.496345109666, 17061.7440738389, 17075.829241707674, 17081.06054167008, 17151.0, 13915.095518791246, 13995.790063149061, 14023.0, 14027.438902443992, 14041.78937315941, 15441.382344706086, 15545.145017024171, 15552.300146493435, 15619.531414057596, 15713.371465141496, 5970.701464926737, 6065.2418447694035, 6120.693965301717, 6221.4089661482085, 6407.967960160169, 1106.330669944688, 1112.821948488238, 1117.4915413486844, 1117.742919128605, 1123.8482804821408, 25979.74020259811, 26014.479710406064, 26015.0, 26145.607815882777, 26456.0, 1219.1709637446622, 1226.650404634675, 1234.1299383934304, 1244.0731654917145, 1251.7621651886113, 13888.097273677178, 13900.860991389956, 13936.303184840717, 14009.85990140106, 14275.428982840778, 286297.0, 286782.0, 291135.0, 291271.0, 291889.0, 58272.12591811126, 58917.70541147267, 58924.41075589275, 59015.40984590185, 59092.704536477046, 1520.7338715724704, 1550.78934779142, 1580.9051456912623, 1581.8892677512695, 1592.2357268510948, 25720.228393148234, 26082.73917260803, 26099.869500652374, 26177.345566360993, 26244.0, 40786.0, 40852.18295634011, 40855.0, 40899.0, 40909.79545102255, 229421.0, 229711.0, 229999.0, 230563.0, 231776.0, 36323.273534528635, 38885.80557097196, 39987.80006099951, 40057.0, 40235.3964690524, 52196.73901630467, 52563.73718131538, 52686.0, 53539.19691204713, 53733.19400209078, 38351.61648383592, 38788.0, 38918.0, 39234.0, 39264.41103383509, 37635.62364376321, 37806.8109659461, 37843.243135137694, 37934.24131517409, 38119.42820857634, 43732.0, 44404.0, 44839.775801120784, 44897.55102448934, 44925.32612010757, 36420.0, 36523.0, 36708.44937325889, 36817.0, 37090.0, 27145.321366965985, 27186.32034199161, 27406.5889011669, 27419.451610968066, 27757.861210693816], "value": 19318.21686926335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.5962396264326, 642.1188946172458, 649.0271989741817, 650.9023646453032, 650.9920703625472, 24401.0, 24788.008479660813, 25022.74977250227, 25072.0, 25142.245732628005, 26525.469490610223, 26612.0, 26662.33344166392, 26772.19683409496, 26778.59832102515, 4540.614047805941, 6566.310537393565, 6651.0, 6655.301193374698, 6709.832254193635, 6604.537682362236, 6693.297203793604, 6714.328567143295, 6719.160104986877, 6727.495437842157, 6517.087607734921, 6652.467802575807, 6678.532502724787, 6678.899816502756, 6747.257801641816, 6676.0, 6682.064510968468, 6763.120794296735, 6836.658167091626, 6843.828904277408, 6240.719167637467, 6295.905561416583, 6308.3060863305, 6319.210098737658, 6346.143270658448, 29176.562351564742, 29906.401871962655, 30311.696883031327, 30454.695453045406, 30468.238294042825, 2274.4200228941513, 2316.7104111986, 2322.5238826040622, 2323.9186628467924, 2333.5332933413215, 20924.267650632155, 21549.461263468384, 21598.89200553987, 21694.457638559004, 21743.891280543656, 2588.1717850287914, 2618.882150303241, 2646.801489888266, 2650.3771613670774, 2672.9599056014176, 152263.238683807, 157502.0, 166044.0, 168850.0, 169674.0, 16066.518004459886, 16536.338546458006, 16658.83341166597, 16935.407260745815, 17013.48959531216, 26082.478350433266, 26144.73855261461, 26150.0, 26243.343916402242, 26289.474210516066, 10668.679939601825, 10891.618793342195, 10969.451527423756, 10980.670579882617, 11150.721231969266, 9941.900580994097, 9991.150752186146, 10093.495325233709, 10138.949305253574, 10147.289689721796, 9948.950255248677, 9992.850107248398, 10037.749056273506, 10327.277090603586, 10397.532111055021, 2933.8826446941885, 2985.7163569460868, 3078.5382192671277, 3132.8590213439993, 3143.2456210509313, 1033.3696445168441, 1047.607147319755, 1047.711879233217, 1063.5267306048734, 1067.2209287220373, 21050.47373815667, 21171.68242476364, 21335.78664213369, 21349.57300853974, 21764.782352176277, 1138.2203190814319, 1139.1740987783955, 1145.1811954452605, 1148.024179447463, 1162.1458228202264, 11285.322880627189, 11657.125715571367, 11733.296002239893, 11755.353455559854, 11803.88196118045, 618511.0, 624146.0, 625504.0, 626118.0, 639973.0, 124510.0, 126068.36965815112, 130822.0, 131509.0, 132740.33629831788, 1271.5295340723992, 1293.2434525802512, 1361.8025386319127, 1362.0, 1368.9178649280875, 22680.432989174744, 22874.0, 22878.42803929915, 22914.885425572764, 22942.42643933915, 64095.359046408936, 66952.0, 67434.98847517389, 68006.31993680199, 68646.31353686599, 81453.59273203596, 82186.58906705429, 82604.0, 82675.0, 83576.58211708903, 15580.532584022498, 15890.0, 16227.594310141869, 16262.674746504767, 16289.266982985557, 23978.40053998664, 24214.51570968606, 24247.515049698555, 24336.269911902673, 24349.75650243546, 18943.715844262624, 18974.525636859187, 19050.52373690669, 19127.808721912603, 19133.80866191376, 18025.188866501303, 18308.359207427675, 18319.725204122216, 18441.077946102374, 18473.0, 19255.13351899196, 20156.092975816417, 20263.29078482246, 20307.898460507604, 20331.881746504085, 15662.765058523903, 15939.123348215959, 16000.119993400474, 16015.759763603322, 16017.839821601634, 19787.604247914674, 20101.0, 20109.0, 20195.899020504803, 20235.59528809386], "value": 13112.05621593889, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.6007777899965, 1511.4936496273747, 1518.6734852006816, 1529.3347393883655, 1539.161157169343, 17230.138493075345, 17908.10459477026, 17930.551736206602, 17934.0, 17949.10254487277, 17545.298188072462, 17678.911605441954, 17696.292148314085, 17720.46838594841, 17747.82252177478, 3071.355015446759, 3106.5495503152088, 3151.975607927421, 3153.0, 3162.0513845846267, 3036.423079614877, 3066.723994840475, 3073.231692076981, 3074.631044274679, 3074.7540196784316, 3038.7417069549115, 3116.688331166888, 3117.953230701541, 3125.296808218144, 3129.843507824611, 3139.3250451153112, 3148.4018036573093, 3186.6335371432233, 3188.85650145744, 3190.170555655523, 2982.0, 2986.641603007653, 3017.3663530658587, 3047.040182342555, 3057.1287183152695, 17325.393611223546, 17400.30398784047, 17449.82550174495, 17465.0, 17493.0, 8989.685361012333, 9306.53467326631, 9315.627374904996, 9329.11373419524, 9334.673286434941, 5934.37689042653, 5935.73289201987, 5947.345791962881, 6136.938630613681, 6155.199824022893, 2153.7738537453497, 2200.273909609825, 2202.757696653367, 2254.1997590855176, 2257.2325409360733, 32350.0, 32570.999999999764, 32578.511322330185, 32580.837095814608, 32582.837085814655, 7695.384369250447, 7854.175311592315, 7893.526388416713, 8007.719729809429, 8054.71124620058, 20984.685229721566, 21072.578548428944, 21087.78912210858, 21101.261455848973, 21136.0, 8863.955680221557, 9010.05394433575, 9035.548222588975, 9042.367034307666, 9114.453132812052, 8166.836663266701, 8194.959025204837, 8225.629846656915, 8232.670693172206, 8250.54621995796, 5893.057110862242, 5975.940240597625, 5986.670733109634, 6016.0, 6255.937440625627, 1652.182169825944, 1696.0502118813504, 1696.202784691193, 1739.4086010756403, 1760.9295628174987, 989.1394486796534, 1034.6016783538241, 1035.6530562261726, 1043.9478026098664, 1052.8578641883248, 9587.472689002172, 9656.613735450645, 9660.0, 9734.707958761248, 9846.704598861903, 765.7740966414921, 773.8723110686786, 778.8091917480253, 786.3276898251912, 840.6931470013401, 5818.418158184148, 5873.970630146908, 5898.528117750569, 5921.644701317935, 5940.673262970492, 25439.74560254374, 25973.870130649226, 26511.46977060448, 26552.867235664085, 26625.866870665523, 25680.0, 25966.480670386485, 26380.20859374222, 26381.34046648811, 26644.60033099505, 12475.937620312023, 12705.0, 12729.045321600917, 12971.481140754264, 13221.801672974912, 9204.217641500547, 9308.813823723623, 9383.530823458936, 9474.621015159591, 9497.287703422133, 22343.32970010902, 22403.21588744386, 22622.773772262066, 22826.543469130193, 23644.172453964027, 22851.31446056621, 23010.539789204457, 23228.419289517897, 23284.76715232826, 23548.529029419657, 13066.869331306565, 13117.803232951705, 13126.343682816012, 13199.538016169388, 13216.867831321564, 16182.67634647324, 16409.42567010149, 16413.67172656564, 16447.177641118134, 16451.58871028234, 13086.803697944348, 13131.080824342205, 13318.200907945555, 13331.0, 13352.198868067948, 12697.4286157125, 12834.501176131145, 13111.67220819449, 13212.0, 13447.663808404868, 10820.350778953289, 10885.619003335161, 11039.724006899893, 11045.779084418105, 11055.447227638746, 7879.921200788148, 8122.309603683753, 8170.632321545426, 8171.346292296721, 8206.83586328282, 7772.611369431619, 7876.09424916119, 7884.369250460064, 7943.4439589230515, 7985.161558036322], "value": 7647.695761650695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5971920357739, 564.1227890630071, 566.2723400430447, 584.2754983820064, 600.618607184438, 6279.905801412982, 6347.587406818559, 6383.202099737533, 6443.838904027401, 6462.321456247085, 6224.19085518883, 6231.937680623192, 6275.152854364659, 6318.747250110002, 6336.144620476234, 5175.870603234912, 5190.974045129769, 5241.606879484035, 5241.842744717665, 5243.318368612094, 4923.433805112422, 5102.234664800291, 5103.540681338679, 5131.461196574362, 5133.177721908724, 5096.490350964892, 5107.3360463139925, 5112.539871411572, 5120.820771273006, 5121.974390128044, 4995.700257984533, 5005.374328208974, 5009.649324547283, 5022.899542009158, 5080.568151707109, 4623.283391074388, 4635.6523260755575, 4658.138244424792, 4678.274867395559, 4685.0, 6243.344448832898, 6249.812505624838, 6290.119383286344, 6293.30773614902, 6325.810225693236, 5942.70286485674, 5958.5828991970575, 5976.551758618121, 5977.402259774031, 6013.909791353133, 6756.628385438799, 6767.120274364351, 6778.356056174655, 6798.252192258848, 6807.115075040263, 4991.276264941564, 5209.557187639055, 5210.993767399541, 5217.34783152106, 5221.791128354899, 6811.9659401702675, 6856.965715171442, 6910.965445172742, 6988.266232045613, 6991.580505169706, 5330.626856120034, 5341.439148889388, 5341.893162136736, 5344.545713614309, 5365.892682146336, 5385.7576409061685, 5435.239066530688, 5446.7276636168035, 5454.581808729758, 5456.826782241757, 5979.402059793986, 5982.726563905688, 5992.370801065826, 6028.788992385334, 6043.697815109227, 6697.598144111369, 6741.685371352539, 6810.659467026728, 6815.352541508549, 6836.521443499007, 1808.6292310076403, 1840.2822899069106, 1841.6408800283816, 1843.271907596492, 1844.2530775036132, 1274.15905502368, 1301.9218846869219, 1325.2247435250295, 1340.2226708509236, 1344.8587898270737, 6093.725782339805, 6209.720562574695, 6224.782132625427, 6268.247810262797, 6305.936940630627, 6662.700178491979, 6774.390304872585, 6818.556793808387, 6857.622830744257, 6859.828504287433, 6293.527985401113, 6305.464035557029, 6308.0, 6358.968205158944, 6393.200849893763, 3602.7658202217294, 3604.4052731299566, 3624.1845584743223, 3647.708183345326, 3650.2699460108083, 7053.717851285994, 7070.646467676595, 7128.215896251409, 7161.2122666507685, 7182.389496892718, 6957.304269573104, 6974.407175390047, 6994.2306346302885, 7003.159620845531, 7054.365107140382, 6944.340287672663, 7014.789556313421, 7044.737933550128, 7069.257727938492, 7077.5399599025895, 6581.380240867599, 6608.372204640552, 6724.4620430364475, 6728.654269146093, 6820.62486563224, 6599.439047681001, 6628.933710663025, 6668.698993998002, 6697.229818570927, 6698.0, 7005.824854378681, 7010.75462358815, 7074.151101867808, 7101.183363913216, 7116.0, 5327.547158491417, 5334.425525325966, 5351.866203344947, 5405.324334458192, 5406.107992181246, 6595.769148079794, 6669.6665166740495, 6806.8638627228165, 6821.0, 6828.248892621708, 6483.7730679425995, 6612.5040621952585, 6633.1376920999965, 6653.600783952978, 6682.63245521501, 6470.838229044311, 6543.509236807354, 6553.311902250386, 6618.0, 6670.83322916931, 6451.387118223761, 6545.312742162005, 6621.656063687999, 6644.235912870082, 6644.700988455627, 6591.571547849375, 6682.766103186365, 6720.1599800025, 6723.394894459522, 6753.425958793558, 6453.709583068679, 6467.15926929515, 6516.152900122954, 6545.5090868184125, 6562.604649303065], "value": 5262.131523783605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.3861490031475, 966.077396086737, 980.3725615606013, 982.3369225772602, 989.8267803134452, 20704.0, 21424.0, 21519.139234430604, 21628.56742865142, 21637.675434868488, 19270.71093933592, 20166.899165504154, 21043.47391315218, 21217.681734773993, 21349.679754803692, 1084.4523515624599, 1113.3709454158416, 1114.420501339303, 1114.504045699664, 1116.2744216259416, 1060.6234786650743, 1090.4711215060688, 1097.040089921319, 1099.780043991205, 1101.509828126484, 1174.583023026826, 1176.7881781279366, 1176.823476478531, 1178.4755783676267, 1178.8231765235241, 1159.0611604600258, 1159.6810877008807, 1164.2956011612937, 1165.7143999720038, 1170.7073231692077, 856.3491746272878, 859.1537335724369, 861.0399404663817, 861.2421069458899, 863.6200071968377, 19479.12343944526, 19985.800141998538, 20076.0, 20124.698129528068, 22630.43423914399, 23122.3063308101, 23286.0, 23464.91008866187, 23716.0, 23798.167064152844, 18472.445826625222, 18701.719474207897, 18834.058297085092, 18845.90577047106, 18847.0, 3940.9014774630864, 3965.5836137205756, 3977.880663580097, 3984.4222587724907, 4003.3594624859884, 162302.0, 166639.0, 168116.0, 169591.0, 170200.0, 18589.7211541827, 19099.61800764005, 19132.713009304593, 19135.80864191368, 19158.425247242605, 28603.57094643582, 29287.12138635844, 29636.259093522833, 29851.253718657208, 30294.697053029628, 9723.708288751348, 9737.610495580097, 9750.463724495221, 9854.901450985542, 9932.900670993342, 4855.6115510759055, 4888.828890988798, 4917.483664215278, 4930.827421040246, 4952.133376659071, 5910.881782364415, 5922.200502932135, 5929.0, 5998.1002849572915, 5999.790007349722, 1193.4271549656214, 1205.584073494643, 1209.9818502722467, 1221.5724496426358, 1224.1125184241355, 716.3051839715572, 760.3233122520961, 766.5094339622646, 778.0546635837485, 785.4776573578506, 12411.255324680547, 13214.735705286033, 13291.534796282083, 13522.18866867991, 13844.30778461073, 748.2714928515147, 752.913414957276, 755.2560727683227, 761.6991288441035, 766.2950085920854, 6285.622862628257, 6322.620642761449, 6358.459530939922, 6367.840803979938, 6373.235211774524, 137491.31254343665, 138475.30762346124, 141704.29147854194, 143348.0, 144450.0, 120520.39739801244, 124132.0, 125021.37489312496, 126279.3686031564, 128666.35666821606, 108134.0, 108188.0, 108627.0, 112779.43610281896, 114497.0, 13328.800067998794, 14226.288685565472, 14432.278386080863, 14579.708405831612, 14653.92673036628, 52900.47099528956, 54223.18665219946, 54449.727751362574, 54945.0, 55268.170977434565, 69568.6521567389, 70014.0, 70070.0, 70692.0, 72013.6399318, 18604.25582976666, 18787.812121879153, 18933.148008339933, 19245.518862028563, 19246.615067698847, 22264.332070037926, 22277.0, 22327.330180094625, 22363.217287394862, 22518.0, 18877.71683424722, 19053.809461905203, 19198.520036999187, 19411.51471213231, 19492.317768878587, 20671.17315307431, 21067.57864842664, 21080.894595526923, 21140.577188456453, 21238.36284911455, 17568.297268109134, 17703.911480443032, 18031.5492112693, 18153.636927261647, 18352.449426517225, 13783.862161378258, 13862.584122476343, 13899.930500347433, 14020.369083391475, 14053.367598458299, 15263.08421494714, 15603.609909752347, 15633.374665013727, 15645.295961681979, 15712.685746285239], "value": 10253.441099616866, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1364.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 104.0, 106.0, 106.0, 107.0, 108.0, 105.0, 106.0, 106.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 110.0, 109.0, 111.0, 140.0, 116.0, 114.0, 112.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 164.0, 163.0, 161.0, 162.0, 160.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 74.0, 76.0, 75.0, 73.0, 72.0, 80.0, 78.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 77.0, 77.0, 79.0, 82.0, 82.0, 78.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 110.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 151.0, 150.0, 150.0, 149.0, 149.0, 149.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 93.0, 96.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 44.0, 43.0, 44.0, 45.0, 46.0, 44.0, 45.0, 43.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [41.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 40.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 69.0, 73.0, 70.0, 71.0, 70.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 103.0, 104.0, 104.0, 102.0, 103.0, 108.0, 107.0, 102.0], "value": 103.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 169.0, 154.0, 155.0, 151.0, 155.0, 149.0, 149.0, 151.0, 152.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 63.0, 59.0, 60.0, 56.0, 58.0, 66.0, 62.0, 59.0], "value": 60.0, "unit": "score"}]}]} 18:42:55 INFO - Return code: 0 18:42:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:42:55 INFO - # TBPL SUCCESS # 18:42:55 INFO - Running post-action listener: _package_coverage_data 18:42:55 INFO - Running post-action listener: _resource_record_post_action 18:42:55 INFO - [mozharness: 2017-09-25 01:42:55.503949Z] Finished run-tests step (success) 18:42:55 INFO - Running post-run listener: _resource_record_post_run 18:42:55 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288509952; Read time: 12; Write time: 145708 18:42:55 INFO - TinderboxPrint: CPU usage
13.0% 18:42:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:42:55 INFO - TinderboxPrint: I/O write bytes / time
288,509,952 / 145,708 18:42:55 INFO - TinderboxPrint: CPU idle
8,188.0 (86.9%) 18:42:55 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 18:42:55 INFO - TinderboxPrint: Swap in / out
0 / 0 18:42:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9359360; Read time: 0; Write time: 788 18:42:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:42:55 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279150592; Read time: 12; Write time: 144920 18:42:56 INFO - Running post-run listener: _upload_blobber_files 18:42:56 INFO - Blob upload gear active. 18:42:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:56 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 18:42:56 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'] 18:42:56 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 18:42:56 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:42:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:57 INFO - (blobuploader) - INFO - Done attempting. 18:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:42:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:58 INFO - (blobuploader) - INFO - Done attempting. 18:42:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:42:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:05 INFO - (blobuploader) - INFO - Done attempting. 18:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:06 INFO - (blobuploader) - INFO - Done attempting. 18:43:06 INFO - (blobuploader) - INFO - Iteration through files over. 18:43:06 INFO - Return code: 0 18:43:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:43:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:43:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e20ed5a81cada60b781288cacfbc3ac09c42deace9a1cee48c0f166bd435d0ffc4644f9076614c8e8ea73190373cd27f3b6f5ae9093b2154bd6a11de2f0ac52", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/99b4b7fafd8a89ae6005b13148d298ac8ace9a038a9a3bdda1951db3914bdb63500e13fbacb5087fe552830933de4f01ffb817f697c39ab5ed62b7fae6b87cd0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76cb9f451a07fbfbea1a8744b5be19a74bf5bb75c7200690f1bb6179c1ed2e2e10cd9c0ce4f1d8c50ec85713976c4128f5ee093a011b9906c8e14296d3582765", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ee091b9ecae1ea5dab89fed042596456cf4d39ebecaf456614781e3b230fc8f01d05600b7d76bfb3e5fc89e4a57222fd7d46f762a58421ca573b136c93b814a2"} 18:43:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:43:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:43:06 INFO - Contents: 18:43:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e20ed5a81cada60b781288cacfbc3ac09c42deace9a1cee48c0f166bd435d0ffc4644f9076614c8e8ea73190373cd27f3b6f5ae9093b2154bd6a11de2f0ac52", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/99b4b7fafd8a89ae6005b13148d298ac8ace9a038a9a3bdda1951db3914bdb63500e13fbacb5087fe552830933de4f01ffb817f697c39ab5ed62b7fae6b87cd0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76cb9f451a07fbfbea1a8744b5be19a74bf5bb75c7200690f1bb6179c1ed2e2e10cd9c0ce4f1d8c50ec85713976c4128f5ee093a011b9906c8e14296d3582765", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ee091b9ecae1ea5dab89fed042596456cf4d39ebecaf456614781e3b230fc8f01d05600b7d76bfb3e5fc89e4a57222fd7d46f762a58421ca573b136c93b814a2"} 18:43:06 INFO - Running post-run listener: copy_logs_to_upload_dir 18:43:06 INFO - Copying logs to upload dir... 18:43:06 INFO - mkdir: /builds/slave/test/build/upload/logs 18:43:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.194894 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-24 18:43:06.494041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:43:06.498057) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 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/5e20ed5a81cada60b781288cacfbc3ac09c42deace9a1cee48c0f166bd435d0ffc4644f9076614c8e8ea73190373cd27f3b6f5ae9093b2154bd6a11de2f0ac52", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/99b4b7fafd8a89ae6005b13148d298ac8ace9a038a9a3bdda1951db3914bdb63500e13fbacb5087fe552830933de4f01ffb817f697c39ab5ed62b7fae6b87cd0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76cb9f451a07fbfbea1a8744b5be19a74bf5bb75c7200690f1bb6179c1ed2e2e10cd9c0ce4f1d8c50ec85713976c4128f5ee093a011b9906c8e14296d3582765", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ee091b9ecae1ea5dab89fed042596456cf4d39ebecaf456614781e3b230fc8f01d05600b7d76bfb3e5fc89e4a57222fd7d46f762a58421ca573b136c93b814a2"} build_url:https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/dTMAbwsERsGY9UqfKjOsbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5e20ed5a81cada60b781288cacfbc3ac09c42deace9a1cee48c0f166bd435d0ffc4644f9076614c8e8ea73190373cd27f3b6f5ae9093b2154bd6a11de2f0ac52", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/99b4b7fafd8a89ae6005b13148d298ac8ace9a038a9a3bdda1951db3914bdb63500e13fbacb5087fe552830933de4f01ffb817f697c39ab5ed62b7fae6b87cd0", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/76cb9f451a07fbfbea1a8744b5be19a74bf5bb75c7200690f1bb6179c1ed2e2e10cd9c0ce4f1d8c50ec85713976c4128f5ee093a011b9906c8e14296d3582765", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ee091b9ecae1ea5dab89fed042596456cf4d39ebecaf456614781e3b230fc8f01d05600b7d76bfb3e5fc89e4a57222fd7d46f762a58421ca573b136c93b814a2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 18:43:06.530886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:43:06.531221) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1506302554.38619-1150236340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 18:43:06.583620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:43:06.583932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 18:43:06.584232) ========= ========= Total master_lag: 0.27 =========