builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1504432163.6 results: success (0) revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.600339) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.600897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.601182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.620246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.620543) ========= 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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-03 02:49:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-09-03 02:49:23 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.202733 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.853037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.856397) ========= 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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015371 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.909270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:23.909615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-03 02:49:24,053 truncating revision to first 12 chars 2017-09-03 02:49:24,053 Setting DEBUG logging. 2017-09-03 02:49:24,053 attempt 1/10 2017-09-03 02:49:24,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37824bf5c5b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-03 02:49:24,352 unpacking tar archive at: mozilla-central-37824bf5c5b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:24.624099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:24.627446) ========= script_repo_revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:24.627825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:24.628093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:49:24.641474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-03 02:49:24.641763) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:49:25 INFO - MultiFileLogger online at 20170903 02:49:25 in /builds/slave/test 02:49:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:49:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:49:25 INFO - {'append_to_log': False, 02:49:25 INFO - 'base_work_dir': '/builds/slave/test', 02:49:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:49:25 INFO - 'branch': 'Firefox-Non-PGO', 02:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 02:49:25 INFO - 'code_coverage': False, 02:49:25 INFO - 'config_files': ('talos/linux_config.py',), 02:49:25 INFO - 'default_actions': ('clobber', 02:49:25 INFO - 'read-buildbot-config', 02:49:25 INFO - 'download-and-extract', 02:49:25 INFO - 'populate-webroot', 02:49:25 INFO - 'create-virtualenv', 02:49:25 INFO - 'install', 02:49:25 INFO - 'setup-mitmproxy', 02:49:25 INFO - 'run-tests'), 02:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:49:25 INFO - 'disable_ccov_upload': False, 02:49:25 INFO - 'disable_stylo': False, 02:49:25 INFO - 'download_minidump_stackwalk': True, 02:49:25 INFO - 'download_symbols': 'ondemand', 02:49:25 INFO - 'enable_stylo': False, 02:49:25 INFO - 'enable_webrender': False, 02:49:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:49:25 INFO - 'gecko_profile': False, 02:49:25 INFO - 'gecko_profile_interval': 0, 02:49:25 INFO - 'installer_path': 'installer.exe', 02:49:25 INFO - 'log_level': 'info', 02:49:25 INFO - 'log_name': 'talos', 02:49:25 INFO - 'log_to_console': True, 02:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:49:25 INFO - 'opt_config_files': (), 02:49:25 INFO - 'pip_index': False, 02:49:25 INFO - 'suite': 'dromaeojs-e10s', 02:49:25 INFO - 'system_bits': '32', 02:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:49:25 INFO - 'title': 'talos-linux64-ix-032', 02:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:49:25 INFO - 'use_talos_json': True, 02:49:25 INFO - 'verify': 'False', 02:49:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:49:25 INFO - 'work_dir': 'build'} 02:49:25 INFO - [mozharness: 2017-09-03 09:49:25.085969Z] Running clobber step. 02:49:25 INFO - Running pre-action listener: _resource_record_pre_action 02:49:25 INFO - Running main action method: clobber 02:49:25 INFO - rmtree: /builds/slave/test/build 02:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:49:26 INFO - Running post-action listener: _resource_record_post_action 02:49:26 INFO - [mozharness: 2017-09-03 09:49:26.069874Z] Finished clobber step (success) 02:49:26 INFO - [mozharness: 2017-09-03 09:49:26.069971Z] Running read-buildbot-config step. 02:49:26 INFO - Running pre-action listener: _resource_record_pre_action 02:49:26 INFO - Running main action method: read_buildbot_config 02:49:26 INFO - Using buildbot properties: 02:49:26 INFO - { 02:49:26 INFO - "project": "", 02:49:26 INFO - "product": "firefox", 02:49:26 INFO - "who": "archaeopteryx@coole-files.de", 02:49:26 INFO - "installer_path": "public/build/target.tar.bz2", 02:49:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:49:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:49:26 INFO - "stage_platform": "linux64", 02:49:26 INFO - "basedir": "/builds/slave/test", 02:49:26 INFO - "buildnumber": 807, 02:49:26 INFO - "platform": "ubuntu64_hw", 02:49:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:49:26 INFO - "slavebuilddir": "test", 02:49:26 INFO - "taskId": "I8Biw42ETiezROP1ssWfLQ", 02:49:26 INFO - "branch": "mozilla-central", 02:49:26 INFO - "script_repo_revision": "production", 02:49:26 INFO - "revision": "37824bf5c5b08afa7e689fceb935b8f457ebd9eb", 02:49:26 INFO - "slavename": "talos-linux64-ix-032", 02:49:26 INFO - "repo_path": "mozilla-central" 02:49:26 INFO - } 02:49:26 INFO - Finding installer, test and symbols from parent task. 02:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8Biw42ETiezROP1ssWfLQ'}, attempt #1 02:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I8Biw42ETiezROP1ssWfLQ'}, attempt #1 02:49:26 INFO - Task dependencies: K9R3fxHzShCqGda311qAQg 02:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg'}, attempt #1 02:49:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:49:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:49:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip 02:49:27 INFO - Running post-action listener: _resource_record_post_action 02:49:27 INFO - [mozharness: 2017-09-03 09:49:27.444295Z] Finished read-buildbot-config step (success) 02:49:27 INFO - [mozharness: 2017-09-03 09:49:27.444510Z] Running download-and-extract step. 02:49:27 INFO - Running pre-action listener: _resource_record_pre_action 02:49:27 INFO - Running main action method: download_and_extract 02:49:27 INFO - mkdir: /builds/slave/test/build/tests 02:49:27 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')]} 02:49:27 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:49:27 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:49:27 INFO - Downloaded 989 bytes. 02:49:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:49:27 INFO - Using the following test package requirements: 02:49:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:49:27 INFO - u'common': [u'target.common.tests.zip'], 02:49:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:49:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:49:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:49:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:49:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:49:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:49:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:49:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:49:27 INFO - u'target.web-platform.tests.tar.gz'], 02:49:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:49:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:49:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:49:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:49:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:49:29 INFO - Content-Length response header: 55022284 02:49:29 INFO - Bytes received: 55022284 02:49:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:49:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:49:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:49:40 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:49:41 INFO - Content-Length response header: 55022284 02:49:41 INFO - Bytes received: 55022284 02:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip 02:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip into memory 02:49:54 INFO - Content-Length response header: 14496650 02:49:54 INFO - Bytes received: 14496650 02:49: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')]} 02:49:54 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:49:54 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:49:56 INFO - Downloaded 62653558 bytes. 02:49:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:49:56 INFO - mkdir: /builds/slave/test/properties 02:49:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:49:56 INFO - Writing to file /builds/slave/test/properties/build_url 02:49:56 INFO - Contents: 02:49:56 INFO - build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:49:56 INFO - Running post-action listener: _resource_record_post_action 02:49:56 INFO - Running post-action listener: find_tests_for_verification 02:49:56 INFO - Running post-action listener: set_extra_try_arguments 02:49:56 INFO - [mozharness: 2017-09-03 09:49:56.961135Z] Finished download-and-extract step (success) 02:49:56 INFO - [mozharness: 2017-09-03 09:49:56.961230Z] Running populate-webroot step. 02:49:56 INFO - Running pre-action listener: _resource_record_pre_action 02:49:56 INFO - Running main action method: populate_webroot 02:49:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:49:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:49:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:49:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:49:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'tests': ['damp', 'tps']}, 02:49:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['damp', 'tps']}, 02:49:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:49:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:49:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:49:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:49:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:49:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:49:56 INFO - 'ts_paint', 02:49:56 INFO - 'tpaint', 02:49:56 INFO - 'sessionrestore', 02:49:56 INFO - 'sessionrestore_many_windows', 02:49:56 INFO - 'sessionrestore_no_auto_restore', 02:49:56 INFO - 'tabpaint']}, 02:49:56 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['a11yr', 02:49:56 INFO - 'ts_paint', 02:49:56 INFO - 'tpaint', 02:49:56 INFO - 'sessionrestore', 02:49:56 INFO - 'sessionrestore_many_windows', 02:49:56 INFO - 'sessionrestore_no_auto_restore', 02:49:56 INFO - 'tabpaint']}, 02:49:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:49:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:49:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['bloom_basic_singleton']}, 02:49:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['bloom_basic']}, 02:49:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:49:56 INFO - 'tsvgr_opacity', 02:49:56 INFO - 'tart', 02:49:56 INFO - 'tscrollx', 02:49:56 INFO - 'tsvg_static']}, 02:49:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['tsvgx', 02:49:56 INFO - 'tsvgr_opacity', 02:49:56 INFO - 'tart', 02:49:56 INFO - 'tscrollx', 02:49:56 INFO - 'tsvg_static']}, 02:49:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:49:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo'], 02:49:56 INFO - 'tests': ['tp5o']}, 02:49:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:49:56 INFO - 'talos_options': ['--mitmproxy', 02:49:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:49:56 INFO - '--firstNonBlankPaint'], 02:49:56 INFO - 'tests': ['tp6_google', 02:49:56 INFO - 'tp6_youtube', 02:49:56 INFO - 'tp6_amazon', 02:49:56 INFO - 'tp6_facebook']}, 02:49:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo', 02:49:56 INFO - '--mitmproxy', 02:49:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:49:56 INFO - '--firstNonBlankPaint'], 02:49:56 INFO - 'tests': ['tp6_google', 02:49:56 INFO - 'tp6_youtube', 02:49:56 INFO - 'tp6_amazon', 02:49:56 INFO - 'tp6_facebook']}, 02:49:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo', 02:49:56 INFO - '--stylo-threads=1', 02:49:56 INFO - '--mitmproxy', 02:49:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:49:56 INFO - '--firstNonBlankPaint'], 02:49:56 INFO - 'tests': ['tp6_google', 02:49:56 INFO - 'tp6_youtube', 02:49:56 INFO - 'tp6_amazon', 02:49:56 INFO - 'tp6_facebook']}, 02:49:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--xperf_path', 02:49:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:56 INFO - 'tests': ['tp5n']}, 02:49:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:49:56 INFO - 'talos_options': ['--enable-stylo', 02:49:56 INFO - '--xperf_path', 02:49:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:56 INFO - 'tests': ['tp5n']}}} 02:49:56 INFO - Running post-action listener: _resource_record_post_action 02:49:56 INFO - [mozharness: 2017-09-03 09:49:56.977617Z] Finished populate-webroot step (success) 02:49:56 INFO - [mozharness: 2017-09-03 09:49:56.977721Z] Running create-virtualenv step. 02:49:56 INFO - Running pre-action listener: _resource_record_pre_action 02:49:56 INFO - Running main action method: create_virtualenv 02:49:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:49:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:49:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:49:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:49:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:49:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:49:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:49:58 INFO - Installing pip...............done. 02:49:58 INFO - Return code: 0 02:49:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:49:59 INFO - Reading from file tmpfile_stdout 02:49:59 INFO - Output received: 02:49:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:49:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:49:59 INFO - Using env: {'DISPLAY': ':0', 02:49:59 INFO - 'HOME': '/home/cltbld', 02:49:59 INFO - 'LANG': 'en_US.UTF-8', 02:49:59 INFO - 'LANGUAGE': 'en_US:en', 02:49:59 INFO - 'LOGNAME': 'cltbld', 02:49:59 INFO - 'MAIL': '/var/mail/cltbld', 02:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:59 INFO - 'MOZ_NO_REMOTE': '1', 02:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:59 INFO - 'NO_EM_RESTART': '1', 02:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:59 INFO - 'PWD': '/builds/slave/test', 02:49:59 INFO - 'SHELL': '/bin/bash', 02:49:59 INFO - 'SHLVL': '1', 02:49:59 INFO - 'TERM': 'linux', 02:49:59 INFO - 'TMOUT': '86400', 02:49:59 INFO - 'USER': 'cltbld', 02:49:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:59 INFO - '_': '/tools/buildbot/bin/python'} 02:50:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:50:00 INFO - Downloading/unpacking pip>=1.5 02:50:00 INFO - Running setup.py egg_info for package pip 02:50:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:50:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:50:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:50:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:50:00 INFO - Installing collected packages: pip 02:50:00 INFO - Found existing installation: pip 1.1 02:50:00 INFO - Uninstalling pip: 02:50:00 INFO - Successfully uninstalled pip 02:50:00 INFO - Running setup.py install for pip 02:50:00 INFO - warning: no files found matching 'pip/cacert.pem' 02:50:00 INFO - warning: no files found matching '*.html' under directory 'docs' 02:50:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:50:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:50:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:50:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:50:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:50:00 INFO - Successfully installed pip 02:50:00 INFO - Cleaning up... 02:50:00 INFO - Return code: 0 02:50:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50: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')]} 02:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50: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', '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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:50: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 psutil>=3.1.1 02:50:00 INFO - Using env: {'DISPLAY': ':0', 02:50:00 INFO - 'HOME': '/home/cltbld', 02:50:00 INFO - 'LANG': 'en_US.UTF-8', 02:50:00 INFO - 'LANGUAGE': 'en_US:en', 02:50:00 INFO - 'LOGNAME': 'cltbld', 02:50:00 INFO - 'MAIL': '/var/mail/cltbld', 02:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:00 INFO - 'MOZ_NO_REMOTE': '1', 02:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:00 INFO - 'NO_EM_RESTART': '1', 02:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:00 INFO - 'PWD': '/builds/slave/test', 02:50:00 INFO - 'SHELL': '/bin/bash', 02:50:00 INFO - 'SHLVL': '1', 02:50:00 INFO - 'TERM': 'linux', 02:50:00 INFO - 'TMOUT': '86400', 02:50:00 INFO - 'USER': 'cltbld', 02:50:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:00 INFO - '_': '/tools/buildbot/bin/python'} 02:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:00 INFO - Downloading/unpacking psutil>=3.1.1 02:50: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 02:50: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 02:50: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 02:50: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 02:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:50:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:01 INFO - Installing collected packages: psutil 02:50:01 INFO - Running setup.py install for psutil 02:50:01 INFO - building 'psutil._psutil_linux' extension 02:50:01 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 02:50:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:50:02 INFO - building 'psutil._psutil_posix' extension 02:50:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:50:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:50:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:50:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:50:02 INFO - Successfully installed psutil 02:50:02 INFO - Cleaning up... 02:50:03 INFO - Return code: 0 02:50:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:50:03 INFO - Using env: {'DISPLAY': ':0', 02:50:03 INFO - 'HOME': '/home/cltbld', 02:50:03 INFO - 'LANG': 'en_US.UTF-8', 02:50:03 INFO - 'LANGUAGE': 'en_US:en', 02:50:03 INFO - 'LOGNAME': 'cltbld', 02:50:03 INFO - 'MAIL': '/var/mail/cltbld', 02:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:03 INFO - 'MOZ_NO_REMOTE': '1', 02:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:03 INFO - 'NO_EM_RESTART': '1', 02:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:03 INFO - 'PWD': '/builds/slave/test', 02:50:03 INFO - 'SHELL': '/bin/bash', 02:50:03 INFO - 'SHLVL': '1', 02:50:03 INFO - 'TERM': 'linux', 02:50:03 INFO - 'TMOUT': '86400', 02:50:03 INFO - 'USER': 'cltbld', 02:50:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:03 INFO - '_': '/tools/buildbot/bin/python'} 02:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:50: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 02:50: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 02:50: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 02:50: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 02:50:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:50:03 INFO - Installing collected packages: mozsystemmonitor 02:50:03 INFO - Running setup.py install for mozsystemmonitor 02:50:03 INFO - Successfully installed mozsystemmonitor 02:50:03 INFO - Cleaning up... 02:50:03 INFO - Return code: 0 02:50:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:50:03 INFO - Using env: {'DISPLAY': ':0', 02:50:03 INFO - 'HOME': '/home/cltbld', 02:50:03 INFO - 'LANG': 'en_US.UTF-8', 02:50:03 INFO - 'LANGUAGE': 'en_US:en', 02:50:03 INFO - 'LOGNAME': 'cltbld', 02:50:03 INFO - 'MAIL': '/var/mail/cltbld', 02:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:03 INFO - 'MOZ_NO_REMOTE': '1', 02:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:03 INFO - 'NO_EM_RESTART': '1', 02:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:03 INFO - 'PWD': '/builds/slave/test', 02:50:03 INFO - 'SHELL': '/bin/bash', 02:50:03 INFO - 'SHLVL': '1', 02:50:03 INFO - 'TERM': 'linux', 02:50:03 INFO - 'TMOUT': '86400', 02:50:03 INFO - 'USER': 'cltbld', 02:50:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:03 INFO - '_': '/tools/buildbot/bin/python'} 02:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:50:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:50:04 INFO - warning: no files found matching '*.txt' 02:50:04 INFO - no previously-included directories found matching 'build' 02:50:04 INFO - no previously-included directories found matching 'dist' 02:50:04 INFO - no previously-included directories found matching '.git*' 02:50:04 INFO - Installing collected packages: jsonschema, functools32 02:50:04 INFO - Running setup.py install for functools32 02:50:05 INFO - warning: no files found matching '*.txt' 02:50:05 INFO - no previously-included directories found matching 'build' 02:50:05 INFO - no previously-included directories found matching 'dist' 02:50:05 INFO - no previously-included directories found matching '.git*' 02:50:05 INFO - Successfully installed jsonschema functools32 02:50:05 INFO - Cleaning up... 02:50:05 INFO - Return code: 0 02:50:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:05 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:05 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 02:50:05 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 02:50:05 INFO - Using env: {'DISPLAY': ':0', 02:50:05 INFO - 'HOME': '/home/cltbld', 02:50:05 INFO - 'LANG': 'en_US.UTF-8', 02:50:05 INFO - 'LANGUAGE': 'en_US:en', 02:50:05 INFO - 'LOGNAME': 'cltbld', 02:50:05 INFO - 'MAIL': '/var/mail/cltbld', 02:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:05 INFO - 'MOZ_NO_REMOTE': '1', 02:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:05 INFO - 'NO_EM_RESTART': '1', 02:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:05 INFO - 'PWD': '/builds/slave/test', 02:50:05 INFO - 'SHELL': '/bin/bash', 02:50:05 INFO - 'SHLVL': '1', 02:50:05 INFO - 'TERM': 'linux', 02:50:05 INFO - 'TMOUT': '86400', 02:50:05 INFO - 'USER': 'cltbld', 02:50:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:05 INFO - '_': '/tools/buildbot/bin/python'} 02:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:50:05 INFO - Cleaning up... 02:50:05 INFO - Return code: 0 02:50:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:05 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:05 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 02:50:05 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 02:50:05 INFO - Using env: {'DISPLAY': ':0', 02:50:05 INFO - 'HOME': '/home/cltbld', 02:50:05 INFO - 'LANG': 'en_US.UTF-8', 02:50:05 INFO - 'LANGUAGE': 'en_US:en', 02:50:05 INFO - 'LOGNAME': 'cltbld', 02:50:05 INFO - 'MAIL': '/var/mail/cltbld', 02:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:05 INFO - 'MOZ_NO_REMOTE': '1', 02:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:05 INFO - 'NO_EM_RESTART': '1', 02:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:05 INFO - 'PWD': '/builds/slave/test', 02:50:05 INFO - 'SHELL': '/bin/bash', 02:50:05 INFO - 'SHLVL': '1', 02:50:05 INFO - 'TERM': 'linux', 02:50:05 INFO - 'TMOUT': '86400', 02:50:05 INFO - 'USER': 'cltbld', 02:50:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:05 INFO - '_': '/tools/buildbot/bin/python'} 02:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:50:05 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 02:50:05 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 02:50:05 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 02:50:05 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 02:50:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:50:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:50:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:50:06 INFO - Downloading docopt-0.6.1.tar.gz 02:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:50:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:50:06 INFO - Running setup.py install for blobuploader 02:50:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:50:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:50:06 INFO - Running setup.py install for requests 02:50:07 INFO - Running setup.py install for docopt 02:50:07 INFO - Successfully installed blobuploader requests docopt 02:50:07 INFO - Cleaning up... 02:50:07 INFO - Return code: 0 02:50:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50: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')]} 02:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:07 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:07 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 02:50:07 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 02:50:07 INFO - Using env: {'DISPLAY': ':0', 02:50:07 INFO - 'HOME': '/home/cltbld', 02:50:07 INFO - 'LANG': 'en_US.UTF-8', 02:50:07 INFO - 'LANGUAGE': 'en_US:en', 02:50:07 INFO - 'LOGNAME': 'cltbld', 02:50:07 INFO - 'MAIL': '/var/mail/cltbld', 02:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:07 INFO - 'MOZ_NO_REMOTE': '1', 02:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:07 INFO - 'NO_EM_RESTART': '1', 02:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:07 INFO - 'PWD': '/builds/slave/test', 02:50:07 INFO - 'SHELL': '/bin/bash', 02:50:07 INFO - 'SHLVL': '1', 02:50:07 INFO - 'TERM': 'linux', 02:50:07 INFO - 'TMOUT': '86400', 02:50:07 INFO - 'USER': 'cltbld', 02:50:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:07 INFO - '_': '/tools/buildbot/bin/python'} 02:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:07 INFO - Running setup.py (path:/tmp/pip-rWJ_bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:07 INFO - Running setup.py (path:/tmp/pip-_AXIQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:07 INFO - Running setup.py (path:/tmp/pip-drIZiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:07 INFO - Running setup.py (path:/tmp/pip-uZSWYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:07 INFO - Running setup.py (path:/tmp/pip-k2Bmw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:07 INFO - Running setup.py (path:/tmp/pip-FlrLuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:07 INFO - Running setup.py (path:/tmp/pip-4clVOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:07 INFO - Running setup.py (path:/tmp/pip-e3aONx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:08 INFO - Running setup.py (path:/tmp/pip-T0yi8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:08 INFO - Running setup.py (path:/tmp/pip-qrO3zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:08 INFO - Running setup.py (path:/tmp/pip-tlkygj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:08 INFO - Running setup.py (path:/tmp/pip-lXD1qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:08 INFO - Running setup.py (path:/tmp/pip-Zkvu7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:08 INFO - Running setup.py (path:/tmp/pip-dMMxKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:08 INFO - Running setup.py (path:/tmp/pip-RrTWTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:08 INFO - Running setup.py (path:/tmp/pip-Jbz7lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:08 INFO - Running setup.py (path:/tmp/pip-NQV83X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:50:08 INFO - Running setup.py install for manifestparser 02:50:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:50:08 INFO - Running setup.py install for mozcrash 02:50:08 INFO - Running setup.py install for mozdebug 02:50:08 INFO - Running setup.py install for mozdevice 02:50:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozfile 02:50:09 INFO - Running setup.py install for mozhttpd 02:50:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozinfo 02:50:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozInstall 02:50:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozleak 02:50:09 INFO - Running setup.py install for mozlog 02:50:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for moznetwork 02:50:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozprocess 02:50:09 INFO - Running setup.py install for mozprofile 02:50:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:50:09 INFO - Running setup.py install for mozrunner 02:50:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:50:10 INFO - Running setup.py install for mozscreenshot 02:50:10 INFO - Running setup.py install for moztest 02:50:10 INFO - Running setup.py install for mozversion 02:50:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:50:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:50:10 INFO - Cleaning up... 02:50:10 INFO - Return code: 0 02:50:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50: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')]} 02:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:10 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:10 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 02:50:10 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 02:50:10 INFO - Using env: {'DISPLAY': ':0', 02:50:10 INFO - 'HOME': '/home/cltbld', 02:50:10 INFO - 'LANG': 'en_US.UTF-8', 02:50:10 INFO - 'LANGUAGE': 'en_US:en', 02:50:10 INFO - 'LOGNAME': 'cltbld', 02:50:10 INFO - 'MAIL': '/var/mail/cltbld', 02:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:10 INFO - 'MOZ_NO_REMOTE': '1', 02:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:10 INFO - 'NO_EM_RESTART': '1', 02:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:10 INFO - 'PWD': '/builds/slave/test', 02:50:10 INFO - 'SHELL': '/bin/bash', 02:50:10 INFO - 'SHLVL': '1', 02:50:10 INFO - 'TERM': 'linux', 02:50:10 INFO - 'TMOUT': '86400', 02:50:10 INFO - 'USER': 'cltbld', 02:50:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:10 INFO - '_': '/tools/buildbot/bin/python'} 02:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:50:10 INFO - Running setup.py (path:/tmp/pip-fbRnsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:50:10 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)) 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:50:10 INFO - Running setup.py (path:/tmp/pip-u_dMsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:50:10 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)) 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:50:10 INFO - Running setup.py (path:/tmp/pip-W68Fpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:50:10 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)) 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:50:10 INFO - Running setup.py (path:/tmp/pip-ABQ0cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:50:10 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)) 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:50:10 INFO - Running setup.py (path:/tmp/pip-yyilgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:50:10 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)) 02:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:50:10 INFO - Running setup.py (path:/tmp/pip-PHqce4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:50:11 INFO - Running setup.py (path:/tmp/pip-y5D7xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:50:11 INFO - Running setup.py (path:/tmp/pip-9Wa2vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:50:11 INFO - Running setup.py (path:/tmp/pip-i5iTVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:50:11 INFO - Running setup.py (path:/tmp/pip-qyZAQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:50:11 INFO - Running setup.py (path:/tmp/pip-zd_uQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:50:11 INFO - Running setup.py (path:/tmp/pip-P_EtuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:50:11 INFO - Running setup.py (path:/tmp/pip-HOWSfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:50:11 INFO - Running setup.py (path:/tmp/pip-c9TVL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:11 INFO - Running setup.py (path:/tmp/pip-odXVwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:50:11 INFO - Running setup.py (path:/tmp/pip-i96J4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:50:11 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)) 02:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:50:11 INFO - Running setup.py (path:/tmp/pip-iQhx9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 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)) 02:50:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:50: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 02:50: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 02:50: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 02:50: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 02:50:12 INFO - Downloading blessings-1.6.tar.gz 02:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:50:13 INFO - Installing collected packages: blessings 02:50:13 INFO - Running setup.py install for blessings 02:50:13 INFO - Successfully installed blessings 02:50:13 INFO - Cleaning up... 02:50:13 INFO - Return code: 0 02:50:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:50:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:13 INFO - Reading from file tmpfile_stdout 02:50:13 INFO - Current package versions: 02:50:13 INFO - argparse == 1.2.1 02:50:13 INFO - blessings == 1.6 02:50:13 INFO - blobuploader == 1.2.4 02:50:13 INFO - docopt == 0.6.1 02:50:13 INFO - functools32 == 3.2.3-2 02:50:13 INFO - jsonschema == 2.5.1 02:50:13 INFO - manifestparser == 1.1 02:50:13 INFO - mozInstall == 1.13 02:50:13 INFO - mozcrash == 1.0 02:50:13 INFO - mozdebug == 0.1 02:50:13 INFO - mozdevice == 0.51 02:50:13 INFO - mozfile == 1.2 02:50:13 INFO - mozhttpd == 0.7 02:50:13 INFO - mozinfo == 0.10 02:50:13 INFO - mozleak == 0.1 02:50:13 INFO - mozlog == 3.5 02:50:13 INFO - moznetwork == 0.27 02:50:13 INFO - mozprocess == 0.25 02:50:13 INFO - mozprofile == 0.28 02:50:13 INFO - mozrunner == 6.13 02:50:13 INFO - mozscreenshot == 0.1 02:50:13 INFO - mozsystemmonitor == 0.3 02:50:13 INFO - moztest == 0.8 02:50:13 INFO - mozversion == 1.4 02:50:13 INFO - psutil == 3.1.1 02:50:13 INFO - requests == 1.2.3 02:50:13 INFO - wsgiref == 0.1.2 02:50:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:50: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')]} 02:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50: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')]} 02:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:13 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:13 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 02:50:13 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 02:50:13 INFO - Using env: {'DISPLAY': ':0', 02:50:13 INFO - 'HOME': '/home/cltbld', 02:50:13 INFO - 'LANG': 'en_US.UTF-8', 02:50:13 INFO - 'LANGUAGE': 'en_US:en', 02:50:13 INFO - 'LOGNAME': 'cltbld', 02:50:13 INFO - 'MAIL': '/var/mail/cltbld', 02:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:13 INFO - 'MOZ_NO_REMOTE': '1', 02:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:13 INFO - 'NO_EM_RESTART': '1', 02:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:13 INFO - 'PWD': '/builds/slave/test', 02:50:13 INFO - 'SHELL': '/bin/bash', 02:50:13 INFO - 'SHLVL': '1', 02:50:13 INFO - 'TERM': 'linux', 02:50:13 INFO - 'TMOUT': '86400', 02:50:13 INFO - 'USER': 'cltbld', 02:50:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:13 INFO - '_': '/tools/buildbot/bin/python'} 02:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 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)) 02:50:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:50:13 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 02:50:13 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 02:50:13 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 02:50:13 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 02:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:50:14 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)) 02:50:14 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)) 02:50:14 INFO - Installing collected packages: simplejson 02:50:14 INFO - Running setup.py install for simplejson 02:50:14 INFO - building 'simplejson._speedups' extension 02:50:14 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 02:50:15 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 02:50:15 INFO - Successfully installed simplejson 02:50:15 INFO - Cleaning up... 02:50:15 INFO - Return code: 0 02:50:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:50:15 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')]} 02:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:50:15 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')]} 02:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:50:15 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 0x1bf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f62a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, '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': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', '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 02:50:15 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 02:50:15 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 02:50:15 INFO - Using env: {'DISPLAY': ':0', 02:50:15 INFO - 'HOME': '/home/cltbld', 02:50:15 INFO - 'LANG': 'en_US.UTF-8', 02:50:15 INFO - 'LANGUAGE': 'en_US:en', 02:50:15 INFO - 'LOGNAME': 'cltbld', 02:50:15 INFO - 'MAIL': '/var/mail/cltbld', 02:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:15 INFO - 'MOZ_NO_REMOTE': '1', 02:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:15 INFO - 'NO_EM_RESTART': '1', 02:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:15 INFO - 'PWD': '/builds/slave/test', 02:50:15 INFO - 'SHELL': '/bin/bash', 02:50:15 INFO - 'SHLVL': '1', 02:50:15 INFO - 'TERM': 'linux', 02:50:15 INFO - 'TMOUT': '86400', 02:50:15 INFO - 'USER': 'cltbld', 02:50:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:15 INFO - '_': '/tools/buildbot/bin/python'} 02:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:50:16 INFO - Cleaning up... 02:50:16 INFO - Return code: 0 02:50:16 INFO - Running post-action listener: _resource_record_post_action 02:50:16 INFO - Running post-action listener: _start_resource_monitoring 02:50:16 INFO - Starting resource monitoring. 02:50:16 INFO - [mozharness: 2017-09-03 09:50:16.102211Z] Finished create-virtualenv step (success) 02:50:16 INFO - [mozharness: 2017-09-03 09:50:16.103226Z] Running install step. 02:50:16 INFO - Running pre-action listener: _resource_record_pre_action 02:50:16 INFO - Running main action method: install 02:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:50:16 INFO - Reading from file tmpfile_stdout 02:50:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:50:16 INFO - Reading from file tmpfile_stdout 02:50:16 INFO - Output received: 02:50:16 INFO - Usage: mozinstall [options] installer 02:50:16 INFO - Options: 02:50:16 INFO - -h, --help show this help message and exit 02:50:16 INFO - -d DEST, --destination=DEST 02:50:16 INFO - Directory to install application into. [default: 02:50:16 INFO - "/builds/slave/test"] 02:50:16 INFO - --app=APP Application being installed. [default: firefox] 02:50:16 INFO - mkdir: /builds/slave/test/build/application 02:50:16 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'] 02:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:50:32 INFO - Reading from file tmpfile_stdout 02:50:32 INFO - Output received: 02:50:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:50:32 INFO - Running post-action listener: _resource_record_post_action 02:50:32 INFO - [mozharness: 2017-09-03 09:50:32.947495Z] Finished install step (success) 02:50:32 INFO - [mozharness: 2017-09-03 09:50:32.947744Z] Running setup-mitmproxy step. 02:50:32 INFO - Running pre-action listener: _resource_record_pre_action 02:50:32 INFO - Running main action method: setup_mitmproxy 02:50:32 INFO - Skipping: mitmproxy is not required 02:50:32 INFO - Running post-action listener: _resource_record_post_action 02:50:32 INFO - [mozharness: 2017-09-03 09:50:32.948857Z] Finished setup-mitmproxy step (success) 02:50:32 INFO - [mozharness: 2017-09-03 09:50:32.949076Z] Running run-tests step. 02:50:32 INFO - Running pre-action listener: _resource_record_pre_action 02:50:32 INFO - Running pre-action listener: _set_gcov_prefix 02:50:32 INFO - Running main action method: run_tests 02:50:32 WARNING - Try message not found. 02:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:50:32 INFO - Python 2.7.3 02:50:32 INFO - Return code: 0 02:50:32 INFO - grabbing minidump binary from tooltool 02:50:32 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')]} 02:50:32 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 0x1f66090>, '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 0x1f66d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f60f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:50:32 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 02:50:32 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 02:50:32 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 02:50:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:50:33 INFO - Return code: 0 02:50:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:50:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:50:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:50:33 INFO - ENV: RUST_BACKTRACE is now full 02:50:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:50:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 02:50:33 INFO - Using env: {'DISPLAY': ':0', 02:50:33 INFO - 'HOME': '/home/cltbld', 02:50:33 INFO - 'LANG': 'en_US.UTF-8', 02:50:33 INFO - 'LANGUAGE': 'en_US:en', 02:50:33 INFO - 'LOGNAME': 'cltbld', 02:50:33 INFO - 'MAIL': '/var/mail/cltbld', 02:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:33 INFO - 'MOZ_NO_REMOTE': '1', 02:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:33 INFO - 'NO_EM_RESTART': '1', 02:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:33 INFO - 'PWD': '/builds/slave/test', 02:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:33 INFO - 'RUST_BACKTRACE': 'full', 02:50:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:50:33 INFO - 'SHELL': '/bin/bash', 02:50:33 INFO - 'SHLVL': '1', 02:50:33 INFO - 'TERM': 'linux', 02:50:33 INFO - 'TMOUT': '86400', 02:50:33 INFO - 'USER': 'cltbld', 02:50:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:33 INFO - '_': '/tools/buildbot/bin/python'} 02:50:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:50:33 INFO - mozversion application_buildid: 20170903085438 02:50:33 INFO - mozversion application_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:50:33 INFO - mozversion application_display_name: Nightly 02:50:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:33 INFO - mozversion application_name: Firefox 02:50:33 INFO - mozversion application_remotingname: firefox 02:50:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:50:33 INFO - mozversion application_vendor: Mozilla 02:50:33 INFO - mozversion application_version: 57.0a1 02:50:33 INFO - mozversion platform_buildid: 20170903085438 02:50:33 INFO - mozversion platform_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:50:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:50:33 INFO - mozversion platform_version: 57.0a1 02:50:33 INFO - using testdate: 1504432233 02:50:33 INFO - actual date: 1504432233 02:50:33 INFO - starting webserver on 'localhost:41437' 02:50:33 INFO - SUITE-START | Running 2 tests 02:50:33 INFO - TEST-START | dromaeo_css 02:50:33 INFO - Initialising browser for dromaeo_css test... 02:50:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41437/getInfo.html -profile /tmp/tmpm95rlj/profile 02:50:33 INFO - TEST-INFO | started process 3537 (/builds/slave/test/build/application/firefox/firefox http://localhost:41437/getInfo.html) 02:50:41 INFO - TEST-INFO | 3537: exit 0 02:50:41 INFO - Browser initialized. 02:50:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:50:41 INFO - Using env: {'DISPLAY': ':0', 02:50:41 INFO - 'HOME': '/home/cltbld', 02:50:41 INFO - 'JSGC_DISABLE_POISONING': '1', 02:50:41 INFO - 'LANG': 'en_US.UTF-8', 02:50:41 INFO - 'LANGUAGE': 'en_US:en', 02:50:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:50:41 INFO - 'LOGNAME': 'cltbld', 02:50:41 INFO - 'MAIL': '/var/mail/cltbld', 02:50:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:50:41 INFO - 'MOZ_CRASHREPORTER': '1', 02:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:50:41 INFO - 'MOZ_NO_REMOTE': '1', 02:50:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:41 INFO - 'NO_EM_RESTART': '1', 02:50:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:41 INFO - 'PWD': '/builds/slave/test', 02:50:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:41 INFO - 'RUST_BACKTRACE': 'full', 02:50:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:50:41 INFO - 'SHELL': '/bin/bash', 02:50:41 INFO - 'SHLVL': '1', 02:50:41 INFO - 'TERM': 'linux', 02:50:41 INFO - 'TMOUT': '86400', 02:50:41 INFO - 'USER': 'cltbld', 02:50:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 02:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:41 INFO - '_': '/tools/buildbot/bin/python'} 02:50:41 INFO - TEST-INFO | started process 3722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm95rlj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:42 INFO - PID 3722 | 02:50:42 INFO - PID 3722 | (/builds/slave/test/build/application/firefox/firefox:3774): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:50:42 INFO - PID 3722 | 02:50:52 INFO - PID 3722 | RSS: Main: 170090496 02:50:52 INFO - PID 3722 | 02:53:51 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41437/tests/dromaeo/cssquery-ext.html) 02:53:53 INFO - PID 3722 | RSS: Main: 171454464 02:53:53 INFO - PID 3722 | 02:56:54 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-ext.html (next: http://localhost:41437/tests/dromaeo/cssquery-jquery.html) 02:56:55 INFO - PID 3722 | RSS: Main: 168329216 02:56:55 INFO - PID 3722 | 02:59:56 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41437/tests/dromaeo/cssquery-mootools.html) 02:59:57 INFO - PID 3722 | RSS: Main: 170528768 02:59:57 INFO - PID 3722 | 03:02:59 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41437/tests/dromaeo/cssquery-prototype.html) 03:02:59 INFO - PID 3722 | RSS: Main: 169025536 03:02:59 INFO - PID 3722 | 03:06:03 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41437/tests/dromaeo/cssquery-yui.html) 03:06:04 INFO - PID 3722 | RSS: Main: 170143744 03:06:04 INFO - PID 3722 | 03:09:05 INFO - PID 3722 | Cycle 1(1): loaded http://localhost:41437/tests/dromaeo/cssquery-yui.html (next: http://localhost:41437/tests/dromaeo/cssquery-dojo.html) 03:09:06 INFO - PID 3722 | RSS: Main: 172818432 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | __start_tp_report 03:09:06 INFO - PID 3722 | _x_x_mozilla_page_load 03:09:06 INFO - PID 3722 | _x_x_mozilla_page_load_details 03:09:06 INFO - PID 3722 | |i|pagename|runs| 03:09:06 INFO - PID 3722 | |0;dojo.html;3353.664633536648;3358.3786999405106;3364.5121457388677;3399.966000339996;3416.794992300462;6444.291127975931;6508.381703738143;6519.739210431577;6520.869582608345;6547.705353259103;6414.102025716404;6498.837529061764;6507.154069970898;6507.6420796856155;6521.152250207467;5873.089671100986;5875.294964604253;5896.086106653475;5931.466168044875;6060.2424696912885;6032.366601506845;6041.093835924603;6055.27336719592;6067.120267561201;6079.057746049347;1062.5758982784487;5964.2842858857;6043.576949613529;6051.546134039942;6057.666828324441;5503.394626591072;5896.056630939029;5912;5980.342162362137;6046.697665116727;5916.763329466816;5927.792527261525;6017.909731354033;6021.3677563856045;6034.63792172471;6490;6504.968521945331;6517.902231466532;6575.3095924927675;6602.603843769341;6958.512904096715;6967.825804354881;7051.858962820715;7063.293670632947;7064.752733654349;7026.859462810715;7027;7041.753538626123;7122.715091396338;7134.92865071353;6361.650109243989;6444.452221561126;6445.033245013192;6445.677716114175;6448.097266382711;7118;7138.64306784669;7152.356287934111;7153.535020223773;7161.355478007004;6739.393454589012;6772.72909083641;6800.6939687714175;6839.726410943506;6873.931260687429;6950.374466297956;6967.338102880219;7030.086088808423;7033.120859892513;7069.575825450489;6914.274001229899;6922.203946546211;7006;7042.92957070433;7047.154341478953;6697.430718388991;6975.372216500539;6984.301569843076;7047.68285427157;7073.893891591631;5326.813561525328;5399.568034557226;5420.810271640474;5420.91868621971;5434.239206511092;4669.466388652321;4814.975925120352;4827.662063655581;4840.975795121002;4891.608671306287;6136.447719705248;6141.6007959482495;6207.875842483216;6213.285472170668;6225.035119556476;6852.828679282959;6908.689108990107;6950.687219075154;7037.929620703728;7139.785806425815;6061.666608336495;6068.089786532056;6075.179850720185;6157.753689852356;6162.506999440034;6003.8198854034445;6006;6045.576809623372;6051.4553690168095;6104.969475152596;6799.694013769392;6887.931120688829;6890.483213758988;6898.2756810535175;6900.2064762551945;7031.437485001085;7032.789016329519;7043.049188359506;7145.4640901931525;7159.355657990805;6589.703463344257;6717.630530320879;6721.865562688817;6797.218319893078;6884.552504087218;6904.930950690429;6906.723731050702;6920.446364290744;6921.2386637470845;6976.5814051157095;6967.198772141066;7044.542104763174;7052.0479735235085;7062.823429414306;7066.964665176847;6689.331066893272;6710.6309152997055;6720.798376048726;6805.251422343637;6810.62541560219;6547.050677651619;6551.967240163769;6640.501962352746;6764.2559318475915;6823.420009299067;6610.900836487553;6636.369544893228;6637.767678131242;6718.529702920944;6723.7646682365885;6777.966110169417;6861.4853885957755;6902.8619427610165;6903.102596662402;6904.13698287714;6432.9678351607945;6518.511111666549;6549.214094308523;6560.573562718408;6640.800775976729 03:09:06 INFO - PID 3722 | |1;ext.html;794.3922898982275;845.8139209373937;871.5816408124097;874.2481465939292;1106.4578356605266;29273;29751.256218594546;39412.408813867776;40119.79940100303;40243.39634905479;40624.59375406245;40949.18101637973;40989.795051024776;41020;41078.17843643133;7508.249175082503;7654.234576542357;7740.4968677036095;7742.419318551103;7805.882911756328;7542.2457754224415;7633.427492938052;7650.464467487278;7665.770026899202;7678.5392876427595;7626.694932202733;7679.308862202401;7704.9614751926165;7709.6916123354995;7714.344280736144;7659.119201291839;7664.770056898274;7668;7687.423443241779;7690.230976902293;7607.277308655669;7655.502392344535;7659.310662040388;7659.578723170223;7667.156612772591;35897.64102358995;36140.45789313162;36144.457833132525;36187.81906090453;36217.81891090554;3544.7341449391397;3593.317269718771;3595.0293420776243;3596.946045809315;3598.4242521196743;30233.848830755924;30252.394952100836;30352.84823575868;30362.54456183159;30404.239894002607;4963.1810751226;5120;5142.717150556718;5168.0697474454955;5178.482151784829;184050;186271;187587;188054;188179;46194;46219;46258.074838503715;46258.30612540815;46328.5367146331;46856.53143468522;47206.5279347209;47519;47772;47926;14027.929860350632;14351.138931664134;15871.444499442465;16080.195990200444;16088.11515366666;13176.868231317756;13463.192208467523;13474.86525134736;13486.527971520949;13517.121387110003;13996.72006559863;14013.5095271665;14112.364943577564;14129.222892740998;14291.428342866377;5669.943300567024;5686.3744988051285;5704.201411802351;5707;5757.107648314518;1004.9045340692622;1019.6227395863579;1019.8113349030453;1026.897310268982;1027.8612387327764;22568.322950311518;23163.420914477272;23279.650805237936;23328.65007024896;23532.764672353398;1110.3005106782837;1116.5757012335262;1123.556195302867;1126.9178795992952;1133.9376334301528;12309.692257693629;12364.44360003802;12387.009039276836;12387.938060309642;12395;222878;223963;224012;224995;225274;49249.26126108111;49577;49829.50170498249;49915;50167.498325016284;1447.073872721459;1452.8183977002875;1467.669774300795;1486.0934829753842;1491;22111;22345.664815028114;22350.888245558668;22724.318270451913;23176.536469270857;36382.27235455223;36484.63515364812;36507.452388213664;36551.634483655886;36562.8171859139;196042;196185;197191;197355;198107;31881.36237275288;31997;32000.67999319977;32217.51673724849;32246.516302255015;39273.214535708554;39410.605893940694;39558.2088358237;39614.60385396109;39717.40423893586;29630.259243519085;29989.85005075048;30085.54871676883;30233.848830755705;30483.2379190522;30372.39255214839;30483.08550743481;30553.54169687412;31045.68954310518;31180;33378.16554586155;33587.66412335845;33617;33642.831785840914;33709;28989.565156522247;29308.706912930596;29539.85230073836;29556.261093472836;29761.702382975895;22537;22683.432914177276;24220.39449013789;24395.26814195506;25049 03:09:06 INFO - PID 3722 | |2;jquery.html;565.9037963546197;566.317587307295;584.4681339980617;586.5249148189964;589.8761260135371;21421.678674819872;21924.342269731933;22306.219282325103;22333.330000100003;22358.10567577295;25427.872860635718;25856.870715646397;25890.223293301184;25958.48083038338;26005.08982185624;6516.934830651692;6631.668416579152;6657;6659.63372014539;6660.167479065117;5906.970465147669;6207.565470417073;6505.381988711065;6538.378854008862;6589.901151482732;6449.193850768654;6462.063000864871;6463.612183269019;6476.643784591845;6481.2222533295835;6456.838579035538;6467.870642587169;6474.805755827333;6475.967620161892;6476.319986401407;5994.190784244159;6005.669688167149;6010.729517171738;6020.036794112964;6029.246344206974;28784.856075719486;29377.559336609967;29880.25299367533;30257.848710756527;30502.694973050206;1996.331229038274;2019.5254115282896;2026.9290574829959;2028.1988614497338;2028.9898550507153;19352.80647193524;19848.40454786359;19876.30432934855;19918.402447926586;19971;2347.823913206499;2370.8103351731993;2404.759524047599;2409.9879500602383;2461.8153638477006;130200.34899825534;133917.3304133473;134018;134239;134471;14412.567622971328;15167.772483412758;15254.466093686668;15322.923385383001;15696;22796.886015569817;22902.541949160925;23047.769522304898;23100;23146.305610831703;10091.192704583616;10195.745106372251;10300.175985921109;10326.328788628714;10447.634332798316;9432.481213533185;9474.194693451134;9530.666426675032;9532.380395274286;9688;8714.782130446663;9078.319126065571;9116.225120864668;9496.382735122334;9544.570494327772;2692.7845772338164;2702.513547561458;2715.5247831629385;2764.378014946621;2786.1920043187656;938.8967213606497;975.1711045611173;976.1751320134475;978.3151793744265;978.9021097890154;19716;24403.389915251904;25450.618240726402;25601.61597576038;25622.871885640827;979.9559019844124;1036.9481525923673;1038.5118994072773;1057.894210578936;1058.216919479595;10704;10954.726131846768;10987.560497580167;11163.162762792823;11210.55157793679;471915;486251;491311;494267;494741;120877;123031.384843077;126502;126646;127381.72618273698;1224.6203676860202;1225.522046401904;1249.6376050945123;1260.9873901261053;1264.7470505898857;17464.73802892932;17778.733318999966;17827.910860445616;18163.636727265115;18228.81771182324;57137.42862571321;57859.71070144622;59355;59501.70249148727;64507.354926450134;71521;73097.6345118271;73563;74009.6299518499;74500;12143.14997950135;12593.244405335709;14334.068285561405;14959.700805984037;14999.400023998918;22411.77588224097;23579;23611;24027.51944961056;24058;18423.631527369645;18647.81352186515;18688.626227475645;18961.241550337832;18995.335163269217;16463.506094817174;17168.39910603123;17241.741373879653;17697.38059167923;17826.91086544559;18763.718544221574;18942.337018204296;19314.71027934554;19603.215871364984;19608.019599019706;14647;14652.853471465149;14749.262536872899;14766.926165369105;14776.852231477978;18431.447056588324;18432.63134737271;18730.25078996825;19040.904795475933;19094.904525477283 03:09:06 INFO - PID 3722 | |3;mootools.html;1338.7322535492901;1404.1294397473562;1420.3098313007517;1425.7790042543409;1429.6783223774653;15018.174000429972;15231.46689865855;15588.766168507482;15595.1422671753;15602.921985390072;15807.367705291774;16085;16093.275802588882;16094.919525402356;16100.275487603056;2806.1581525542356;2856.771458283343;2857.3285277959662;2857.3570946536965;2858.8141770784937;2732.5764506501423;2767.6678798544203;2773.6948935617065;2777.1946135620647;2801.0476438011074;2715.2804506805714;2765.6404667393313;2779.8888044478194;2783.958240626392;2790.107165706964;2612.9869350653316;2683.168217852472;2684.396010897552;2685.060228919882;2687.811853170279;2748.6151938728594;2755.5453350197195;2757.26932362924;2764.2398340456334;2782.2070709847594;14965.476208332764;15264.16047117408;15389.307481163263;15389.307481163263;15409;7996.4002699797165;8255.917440825575;8264.132266112092;8265;8296.8340633187;4987.625928055374;5197.558207552363;5337.759800808934;5360.705161216131;5388.245645609618;1921.951951201217;1949.756280464942;1957.8335841453493;1997.131247907165;2021.1410150686047;26859.194224173305;27068.323291917663;27175;27250;28154.577681334795;6762.425193858577;6787.592744435349;6806.829829254309;6926.826829329307;7021.929780702229;17549.21028553718;17650.382236621914;17686.380976665754;17688.204030818644;17714.291428342978;7929.643166057541;8144.429889907649;8152.307053900485;8153.266206041366;8155.79610509742;7503.2496750324535;7514.173440921494;7586.127595326608;7617.352525035323;7618;5055.974720126449;5227.3465816772905;5247.422783493813;5258.053550360895;5271.973640131775;1464.5972357601745;1485.9405623775144;1493.16382825618;1496.5435542159746;1500.7898894154828;874.9300055995506;896.7264984179757;904.0688091266006;910.3672947301562;914.1133100892124;7666.8849967250535;7709.306162445407;7740.109887362913;7765.107012693613;7826.882596761053;685.9657017149123;710.4565007769061;714.8034290570031;735.3859527294662;743.8214828441135;4807.840754592944;5257.395399529027;5335.33308336458;5525.475079867406;5540.833774986757;21691.783082168975;22175.66736498954;22686;22690.546189076125;22770.43073923132;20848.270310539363;22037;22087.66868496974;22116.22593209262;22395.88802056012;10052.547635356426;10237.181025517792;10457.320274182153;11485.885141148648;11904.821427678591;8278.503289802631;8650.1349865013;8733.91266087331;9071.365004449624;9154.221891139061;18320.26718931281;18878.15048322856;19188.232470701016;19378.515537111685;19609.509762256057;19457;19615.11731972036;19695.60608787845;19783.40649780509;19912.203511859363;11583.536658533565;11643.359615221245;11744.29534227949;11914;11958.222715523463;13869.167849929037;14011.649708757363;14045.719085618435;14052.648683782987;14105.929470352583;11169.609063682732;11286.66140015801;11341.773164536828;11427;11675.591354302558;11216;11222.88777112251;11376.886231137914;11477.426128693698;11679.708007299885;10221.795564088528;10375.584976601154;10382.792344153226;10401.895981040092;10402.791944160923;7214.855702886018;7227.674754636159;7315.195328513965;7328.706851725871;7332.340089391981;7431.071116110486;7451.552906825608;7529.134149572869;7532.209118042527;7659.502132361378 03:09:06 INFO - PID 3722 | |4;prototype.html;495.9864889786173;525.2357819372813;528.1259515501846;539.9298091248139;542.3248056170067;6410.583312084711;6443.420092191702;6531.738730450782;6533;6544.869102617945;6301.779437719681;6413.390727880856;6449.258335291443;6449.451796597295;6502.252240992288;5304.8859739454765;5313.495217954288;5314.282571852789;5334.786608535654;5359.38367087786;4903.200019984522;5145.485451454862;5272.23552584875;5307.946920530784;5346.304980352568;5080.339555857733;5095.668781529189;5101.6683915545555;5104.132297509414;5115.769790359443;5095.668781529226;5103.519979206045;5103.56619687327;5107.157319042353;5117.923231151499;4443.488998765151;4537.591616754508;4563;4576.290674945389;4583.358329833826;6144.38556144382;6258.655773932432;6269.498440124779;6282.308946015934;6293.87412251757;5809.128630705386;5844.649321040752;5852.619579727304;5862.50168735658;5898.292204935392;6732.93267067328;6741.314671332167;6767.984802279649;6776.322367763233;6784.76253331131;4985.426675932278;4997.325361076245;5008.924866127011;5021.623378246646;5036.722980236085;6788.72845086196;6876.69054892526;6907.620080895498;6945.687444065029;7070.29297070294;4993.875153121128;5121;5131.2559678846355;5134;5152.613553983466;5189.532942035235;5210.426853046162;5224.503672151215;5227.163653815372;5229.47705229474;5774.162746401748;5828.446297601806;5838.182654428383;5848.590598658053;5856.531477481792;6793.388595026372;6799.252082270947;6801.863962720718;6815.273890443862;6816.386525212754;1794.7436794244081;1816.445983974874;1834.477174005402;1838.3933302010305;1841.162271166616;1206.3824019209212;1236.3200239868036;1242.931638759877;1243.0118056145386;1262.6906407929932;5960.165576819249;5978.372270911578;5983.521318294526;6010;6019.428154325332;6903.8921841504225;6904.4453552185005;6946.37482626566;7013.193482749549;7029.191642961125;5937.346891841894;5975.790847320323;5982.252218472691;5985.281766188085;6016.969915150396;3569.5359603251413;3672.485851980725;3685.7972811495088;3694.1503454205144;3724.6647801697977;6651.068850360954;6662.700178491979;6693.464522838161;6706.497012724065;6772.255051944282;7055.506114571931;7074.575525468488;7080.256573059754;7100.609466479394;7137.2149063602965;6653.334666533308;6657.46740260778;6755.121834161626;6763.628000460022;6767.932320676829;7008.579485230903;7017.228104908354;7026.508144429841;7027.939883284027;7032;6948.895766563607;6950.826229344105;6963.408110310477;6981.616011119234;6983.196932352845;6791.3548212919695;6791.607720417402;6800.823736404303;6812.14848143982;6819.863602728017;5122.231665250242;5158;5170.689758614495;5172.922406163986;5175.585953123666;6649.434798042221;6778;6867.622280774605;6885.449164066762;6907;6727.831804204739;6745.392914637706;6757.425618822455;6757.628330441873;6778.593284402951;6655.134832471941;6665.533412661067;6689.76585819494;6724.193096828412;6730.966345168243;6631;6694.83262918431;6696.966515167393;6714.6642667865435;6744.325567443413;6814.4548436124;6821.386075253251;6848.760293389708;6849.315068493111;6850.828729281808;6585.275619681735;6589.736410543716;6609.1408116944485;6619.569727967667;6619.768308109193 03:09:06 INFO - PID 3722 | |5;yui.html;853.4409961475236;865.7402779166252;875.9430637008594;881.8721285413615;895.4850960697601;18896.149673264703;19541.902290488546;19656.508587285323;19671.409857704257;19819.207231710734;16507;18799.90600047001;18862.43412697621;18877.056147192656;18877.339293124744;945.5272363818091;951.7763325618508;955.7849483866144;957.9137877591015;957.9377340472847;945.0927109974399;960.0255740423476;961.0917682789767;970.4662435660358;972.377678285894;1029.8609687692178;1033.576233744165;1033.679559336608;1034.105498743589;1034.5396298647106;988.6440881282805;1020.2348238820884;1028.1877316919663;1028.511457057899;1032.2619327181064;726.1649103530982;726.3970904149543;726.8582626387856;729.4383324839897;729.5987207036162;19556.608867822564;19893.701594476093;19961.600767984703;19977.300794472125;19992.700109498368;20846.791532084637;21008.159673613038;21818.454538636663;21835.563288734294;21851.562968740534;16604.83395166045;16957.3217071317;16999.57501062471;17003.57491062721;17006.914965425218;3708.2027364116843;3731.7760934343755;3882.6893848492336;3886.0867696091395;3891.280113179071;122297;123267.383663082;124079;125990;128076;15893.443729469413;16312.18439078065;16403.261853216634;16577.668446631;16579.253933573018;29424.26439338991;30201.697983020327;30343.848280758455;30346.54480182799;30357.54463683002;8931.285497160212;9014.86477702835;9339.859902101474;9341.299402544837;9344.15902568772;4349.739015659071;4460.241758900995;4467.374567560544;4468.061707041557;4485.372047913294;5230.058589453859;5337.519623233928;5353.544948679406;5358.19627055937;5388.784448622089;1017.7506510904876;1046.9738256543646;1048.6853943816977;1061.124572227915;1062.5802807890839;631.3812463785424;639.7057353617388;645.9644719540377;648.6659370424235;658.2857599504496;11644.41777911101;11875.871792179729;12075.75848483043;12221.450034748279;12348.876511234772;639.577878600131;661.0711949710665;661.2593894837812;663.2770280394393;671.5198632977445;5710.172025056344;5869.647821130746;5885.941140588539;5899.203607512931;5924.903892779849;111656.44171779089;112384.43807780909;115466.4226678878;116663;117210;93538;94776;95323.52338238264;98255.50872245592;98923.01076989282;83758.58120709358;84963.57518212493;85964;87452.56273718718;88259;12291.69270768238;12413.503459861504;12513.499460021498;12522.311272880079;12530.686732831387;40287.79856100701;40904.590954090076;40914.795426022676;42189.57810421979;42590.14819703527;53653.731731342654;53736;54933.450665492834;55015;55740;17638.73541896847;17745.645087098444;17781.288748450435;17849.73225401646;17942.730859036863;18934.43196704101;18985.810141898957;19153;19265.325713599956;19268.32560860363;16822.327106915585;16923.91538042302;17025.40411085606;17037.829621703626;17132.828671713123;17143.31426742966;17364.913175434547;17466.214020369367;17529.912350438168;17588.38440654571;16242.106684132486;16480.752788708418;16484.752728708838;16658.83341166621;16870.325186992384;12438.440270188044;12573.1198816082;12831.615051548468;13007.47970081224;13054.918768065158;13144.0799144059;13490.662733431744;13497.595072147851;13701.520446784314;14119.223442710749 03:09:06 INFO - PID 3722 | __end_tp_report 03:09:06 INFO - PID 3722 | __start_cc_report 03:09:06 INFO - PID 3722 | _x_x_mozilla_cycle_collect,360 03:09:06 INFO - PID 3722 | __end_cc_report 03:09:06 INFO - PID 3722 | __startTimestamp1504433346044__endTimestamp 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | ------- Summary: start ------- 03:09:06 INFO - PID 3722 | Number of tests: 6 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#0] dojo.html Cycles:165 Average:6390.32 Median:6610.90 stddev:866.32 (13.1%) stddev-sans-first:835.58 03:09:06 INFO - PID 3722 | Values: 3353.7 3358.4 3364.5 3400.0 3416.8 6444.3 6508.4 6519.7 6520.9 6547.7 6414.1 6498.8 6507.2 6507.6 6521.2 5873.1 5875.3 5896.1 5931.5 6060.2 6032.4 6041.1 6055.3 6067.1 6079.1 1062.6 5964.3 6043.6 6051.5 6057.7 5503.4 5896.1 5912.0 5980.3 6046.7 5916.8 5927.8 6017.9 6021.4 6034.6 6490.0 6505.0 6517.9 6575.3 6602.6 6958.5 6967.8 7051.9 7063.3 7064.8 7026.9 7027.0 7041.8 7122.7 7134.9 6361.7 6444.5 6445.0 6445.7 6448.1 7118.0 7138.6 7152.4 7153.5 7161.4 6739.4 6772.7 6800.7 6839.7 6873.9 6950.4 6967.3 7030.1 7033.1 7069.6 6914.3 6922.2 7006.0 7042.9 7047.2 6697.4 6975.4 6984.3 7047.7 7073.9 5326.8 5399.6 5420.8 5420.9 5434.2 4669.5 4815.0 4827.7 4841.0 4891.6 6136.4 6141.6 6207.9 6213.3 6225.0 6852.8 6908.7 6950.7 7037.9 7139.8 6061.7 6068.1 6075.2 6157.8 6162.5 6003.8 6006.0 6045.6 6051.5 6105.0 6799.7 6887.9 6890.5 6898.3 6900.2 7031.4 7032.8 7043.0 7145.5 7159.4 6589.7 6717.6 6721.9 6797.2 6884.6 6904.9 6906.7 6920.4 6921.2 6976.6 6967.2 7044.5 7052.0 7062.8 7067.0 6689.3 6710.6 6720.8 6805.3 6810.6 6547.1 6552.0 6640.5 6764.3 6823.4 6610.9 6636.4 6637.8 6718.5 6723.8 6778.0 6861.5 6902.9 6903.1 6904.1 6433.0 6518.5 6549.2 6560.6 6640.8 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#1] ext.html Cycles:180 Average:36345.93 Median:32109.10 stddev:52590.22 (163.8%) stddev-sans-first:52670.00 03:09:06 INFO - PID 3722 | Values: 794.4 845.8 871.6 874.2 1106.5 29273.0 29751.3 39412.4 40119.8 40243.4 40624.6 40949.2 40989.8 41020.0 41078.2 7508.2 7654.2 7740.5 7742.4 7805.9 7542.2 7633.4 7650.5 7665.8 7678.5 7626.7 7679.3 7705.0 7709.7 7714.3 7659.1 7664.8 7668.0 7687.4 7690.2 7607.3 7655.5 7659.3 7659.6 7667.2 35897.6 36140.5 36144.5 36187.8 36217.8 3544.7 3593.3 3595.0 3596.9 3598.4 30233.8 30252.4 30352.8 30362.5 30404.2 4963.2 5120.0 5142.7 5168.1 5178.5 184050.0 186271.0 187587.0 188054.0 188179.0 46194.0 46219.0 46258.1 46258.3 46328.5 46856.5 47206.5 47519.0 47772.0 47926.0 14027.9 14351.1 15871.4 16080.2 16088.1 13176.9 13463.2 13474.9 13486.5 13517.1 13996.7 14013.5 14112.4 14129.2 14291.4 5669.9 5686.4 5704.2 5707.0 5757.1 1004.9 1019.6 1019.8 1026.9 1027.9 22568.3 23163.4 23279.7 23328.7 23532.8 1110.3 1116.6 1123.6 1126.9 1133.9 12309.7 12364.4 12387.0 12387.9 12395.0 222878.0 223963.0 224012.0 224995.0 225274.0 49249.3 49577.0 49829.5 49915.0 50167.5 1447.1 1452.8 1467.7 1486.1 1491.0 22111.0 22345.7 22350.9 22724.3 23176.5 36382.3 36484.6 36507.5 36551.6 36562.8 196042.0 196185.0 197191.0 197355.0 198107.0 31881.4 31997.0 32000.7 32217.5 32246.5 39273.2 39410.6 39558.2 39614.6 39717.4 29630.3 29989.9 30085.5 30233.8 30483.2 30372.4 30483.1 30553.5 31045.7 31180.0 33378.2 33587.7 33617.0 33642.8 33709.0 28989.6 29308.7 29539.9 29556.3 29761.7 22537.0 22683.4 24220.4 24395.3 25049.0 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#2] jquery.html Cycles:180 Average:35155.93 Median:12747.06 stddev:82358.58 (646.1%) stddev-sans-first:82548.67 03:09:06 INFO - PID 3722 | Values: 565.9 566.3 584.5 586.5 589.9 21421.7 21924.3 22306.2 22333.3 22358.1 25427.9 25856.9 25890.2 25958.5 26005.1 6516.9 6631.7 6657.0 6659.6 6660.2 5907.0 6207.6 6505.4 6538.4 6589.9 6449.2 6462.1 6463.6 6476.6 6481.2 6456.8 6467.9 6474.8 6476.0 6476.3 5994.2 6005.7 6010.7 6020.0 6029.2 28784.9 29377.6 29880.3 30257.8 30502.7 1996.3 2019.5 2026.9 2028.2 2029.0 19352.8 19848.4 19876.3 19918.4 19971.0 2347.8 2370.8 2404.8 2410.0 2461.8 130200.3 133917.3 134018.0 134239.0 134471.0 14412.6 15167.8 15254.5 15322.9 15696.0 22796.9 22902.5 23047.8 23100.0 23146.3 10091.2 10195.7 10300.2 10326.3 10447.6 9432.5 9474.2 9530.7 9532.4 9688.0 8714.8 9078.3 9116.2 9496.4 9544.6 2692.8 2702.5 2715.5 2764.4 2786.2 938.9 975.2 976.2 978.3 978.9 19716.0 24403.4 25450.6 25601.6 25622.9 980.0 1036.9 1038.5 1057.9 1058.2 10704.0 10954.7 10987.6 11163.2 11210.6 471915.0 486251.0 491311.0 494267.0 494741.0 120877.0 123031.4 126502.0 126646.0 127381.7 1224.6 1225.5 1249.6 1261.0 1264.7 17464.7 17778.7 17827.9 18163.6 18228.8 57137.4 57859.7 59355.0 59501.7 64507.4 71521.0 73097.6 73563.0 74009.6 74500.0 12143.1 12593.2 14334.1 14959.7 14999.4 22411.8 23579.0 23611.0 24027.5 24058.0 18423.6 18647.8 18688.6 18961.2 18995.3 16463.5 17168.4 17241.7 17697.4 17826.9 18763.7 18942.3 19314.7 19603.2 19608.0 14647.0 14652.9 14749.3 14766.9 14776.9 18431.4 18432.6 18730.3 19040.9 19094.9 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#3] mootools.html Cycles:180 Average:9517.51 Median:14878.07 stddev:6875.91 (46.2%) stddev-sans-first:6867.74 03:09:06 INFO - PID 3722 | Values: 1338.7 1404.1 1420.3 1425.8 1429.7 15018.2 15231.5 15588.8 15595.1 15602.9 15807.4 16085.0 16093.3 16094.9 16100.3 2806.2 2856.8 2857.3 2857.4 2858.8 2732.6 2767.7 2773.7 2777.2 2801.0 2715.3 2765.6 2779.9 2784.0 2790.1 2613.0 2683.2 2684.4 2685.1 2687.8 2748.6 2755.5 2757.3 2764.2 2782.2 14965.5 15264.2 15389.3 15389.3 15409.0 7996.4 8255.9 8264.1 8265.0 8296.8 4987.6 5197.6 5337.8 5360.7 5388.2 1922.0 1949.8 1957.8 1997.1 2021.1 26859.2 27068.3 27175.0 27250.0 28154.6 6762.4 6787.6 6806.8 6926.8 7021.9 17549.2 17650.4 17686.4 17688.2 17714.3 7929.6 8144.4 8152.3 8153.3 8155.8 7503.2 7514.2 7586.1 7617.4 7618.0 5056.0 5227.3 5247.4 5258.1 5272.0 1464.6 1485.9 1493.2 1496.5 1500.8 874.9 896.7 904.1 910.4 914.1 7666.9 7709.3 7740.1 7765.1 7826.9 686.0 710.5 714.8 735.4 743.8 4807.8 5257.4 5335.3 5525.5 5540.8 21691.8 22175.7 22686.0 22690.5 22770.4 20848.3 22037.0 22087.7 22116.2 22395.9 10052.5 10237.2 10457.3 11485.9 11904.8 8278.5 8650.1 8733.9 9071.4 9154.2 18320.3 18878.2 19188.2 19378.5 19609.5 19457.0 19615.1 19695.6 19783.4 19912.2 11583.5 11643.4 11744.3 11914.0 11958.2 13869.2 14011.6 14045.7 14052.6 14105.9 11169.6 11286.7 11341.8 11427.0 11675.6 11216.0 11222.9 11376.9 11477.4 11679.7 10221.8 10375.6 10382.8 10401.9 10402.8 7214.9 7227.7 7315.2 7328.7 7332.3 7431.1 7451.6 7529.1 7532.2 7659.5 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#4] prototype.html Cycles:180 Average:5693.85 Median:6356.18 stddev:1600.90 (25.2%) stddev-sans-first:1557.13 03:09:06 INFO - PID 3722 | Values: 496.0 525.2 528.1 539.9 542.3 6410.6 6443.4 6531.7 6533.0 6544.9 6301.8 6413.4 6449.3 6449.5 6502.3 5304.9 5313.5 5314.3 5334.8 5359.4 4903.2 5145.5 5272.2 5307.9 5346.3 5080.3 5095.7 5101.7 5104.1 5115.8 5095.7 5103.5 5103.6 5107.2 5117.9 4443.5 4537.6 4563.0 4576.3 4583.4 6144.4 6258.7 6269.5 6282.3 6293.9 5809.1 5844.6 5852.6 5862.5 5898.3 6732.9 6741.3 6768.0 6776.3 6784.8 4985.4 4997.3 5008.9 5021.6 5036.7 6788.7 6876.7 6907.6 6945.7 7070.3 4993.9 5121.0 5131.3 5134.0 5152.6 5189.5 5210.4 5224.5 5227.2 5229.5 5774.2 5828.4 5838.2 5848.6 5856.5 6793.4 6799.3 6801.9 6815.3 6816.4 1794.7 1816.4 1834.5 1838.4 1841.2 1206.4 1236.3 1242.9 1243.0 1262.7 5960.2 5978.4 5983.5 6010.0 6019.4 6903.9 6904.4 6946.4 7013.2 7029.2 5937.3 5975.8 5982.3 5985.3 6017.0 3569.5 3672.5 3685.8 3694.2 3724.7 6651.1 6662.7 6693.5 6706.5 6772.3 7055.5 7074.6 7080.3 7100.6 7137.2 6653.3 6657.5 6755.1 6763.6 6767.9 7008.6 7017.2 7026.5 7027.9 7032.0 6948.9 6950.8 6963.4 6981.6 6983.2 6791.4 6791.6 6800.8 6812.1 6819.9 5122.2 5158.0 5170.7 5172.9 5175.6 6649.4 6778.0 6867.6 6885.4 6907.0 6727.8 6745.4 6757.4 6757.6 6778.6 6655.1 6665.5 6689.8 6724.2 6731.0 6631.0 6694.8 6697.0 6714.7 6744.3 6814.5 6821.4 6848.8 6849.3 6850.8 6585.3 6589.7 6609.1 6619.6 6619.8 03:09:06 INFO - PID 3722 | 03:09:06 INFO - PID 3722 | [#5] yui.html Cycles:180 Average:23211.31 Median:19927.65 stddev:31758.77 (159.4%) stddev-sans-first:31803.49 03:09:06 INFO - PID 3722 | Values: 853.4 865.7 875.9 881.9 895.5 18896.1 19541.9 19656.5 19671.4 19819.2 16507.0 18799.9 18862.4 18877.1 18877.3 945.5 951.8 955.8 957.9 957.9 945.1 960.0 961.1 970.5 972.4 1029.9 1033.6 1033.7 1034.1 1034.5 988.6 1020.2 1028.2 1028.5 1032.3 726.2 726.4 726.9 729.4 729.6 19556.6 19893.7 19961.6 19977.3 19992.7 20846.8 21008.2 21818.5 21835.6 21851.6 16604.8 16957.3 16999.6 17003.6 17006.9 3708.2 3731.8 3882.7 3886.1 3891.3 122297.0 123267.4 124079.0 125990.0 128076.0 15893.4 16312.2 16403.3 16577.7 16579.3 29424.3 30201.7 30343.8 30346.5 30357.5 8931.3 9014.9 9339.9 9341.3 9344.2 4349.7 4460.2 4467.4 4468.1 4485.4 5230.1 5337.5 5353.5 5358.2 5388.8 1017.8 1047.0 1048.7 1061.1 1062.6 631.4 639.7 646.0 648.7 658.3 11644.4 11875.9 12075.8 12221.5 12348.9 639.6 661.1 661.3 663.3 671.5 5710.2 5869.6 5885.9 5899.2 5924.9 111656.4 112384.4 115466.4 116663.0 117210.0 93538.0 94776.0 95323.5 98255.5 98923.0 83758.6 84963.6 85964.0 87452.6 88259.0 12291.7 12413.5 12513.5 12522.3 12530.7 40287.8 40904.6 40914.8 42189.6 42590.1 53653.7 53736.0 54933.5 55015.0 55740.0 17638.7 17745.6 17781.3 17849.7 17942.7 18934.4 18985.8 19153.0 19265.3 19268.3 16822.3 16923.9 17025.4 17037.8 17132.8 17143.3 17364.9 17466.2 17529.9 17588.4 16242.1 16480.8 16484.8 16658.8 16870.3 12438.4 12573.1 12831.6 13007.5 13054.9 13144.1 13490.7 13497.6 13701.5 14119.2 03:09:06 INFO - PID 3722 | -------- Summary: end -------- 03:09:06 INFO - PID 3722 | 03:09:06 INFO - TEST-INFO | 3722: exit 0 03:09:06 INFO - TEST-OK | dromaeo_css | took 1113364ms 03:09:06 INFO - TEST-START | kraken 03:09:06 INFO - Initialising browser for kraken test... 03:09:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41437/getInfo.html -profile /tmp/tmpDy9PWJ/profile 03:09:06 INFO - TEST-INFO | started process 4206 (/builds/slave/test/build/application/firefox/firefox http://localhost:41437/getInfo.html) 03:09:12 INFO - TEST-INFO | 4206: exit 0 03:09:12 INFO - Browser initialized. 03:09:12 INFO - Running cycle 1/1 for kraken test... 03:09:12 INFO - Using env: {'DISPLAY': ':0', 03:09:12 INFO - 'HOME': '/home/cltbld', 03:09:12 INFO - 'JSGC_DISABLE_POISONING': '1', 03:09:12 INFO - 'LANG': 'en_US.UTF-8', 03:09:12 INFO - 'LANGUAGE': 'en_US:en', 03:09:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:09:12 INFO - 'LOGNAME': 'cltbld', 03:09:12 INFO - 'MAIL': '/var/mail/cltbld', 03:09:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:12 INFO - 'MOZ_CRASHREPORTER': '1', 03:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:09:12 INFO - 'MOZ_NO_REMOTE': '1', 03:09:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:12 INFO - 'NO_EM_RESTART': '1', 03:09:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:12 INFO - 'PWD': '/builds/slave/test', 03:09:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:12 INFO - 'RUST_BACKTRACE': 'full', 03:09:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:09:12 INFO - 'SHELL': '/bin/bash', 03:09:12 INFO - 'SHLVL': '1', 03:09:12 INFO - 'TERM': 'linux', 03:09:12 INFO - 'TMOUT': '86400', 03:09:12 INFO - 'USER': 'cltbld', 03:09:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1504432162.40195-613819599', 03:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:12 INFO - '_': '/tools/buildbot/bin/python'} 03:09:12 INFO - TEST-INFO | started process 4393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDy9PWJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:13 INFO - PID 4393 | 03:09:13 INFO - PID 4393 | (/builds/slave/test/build/application/firefox/firefox:4445): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:09:13 INFO - PID 4393 | 03:09:23 INFO - PID 4393 | RSS: Main: 169840640 03:09:23 INFO - PID 4393 | 03:09:26 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41437/tests/kraken/driver.html?testName=audio-beat-detection) 03:09:27 INFO - PID 4393 | RSS: Main: 175591424 03:09:27 INFO - PID 4393 | 03:09:29 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41437/tests/kraken/driver.html?testName=audio-dft) 03:09:30 INFO - PID 4393 | RSS: Main: 176168960 03:09:30 INFO - PID 4393 | 03:09:33 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41437/tests/kraken/driver.html?testName=audio-fft) 03:09:34 INFO - PID 4393 | RSS: Main: 169459712 03:09:34 INFO - PID 4393 | 03:09:36 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41437/tests/kraken/driver.html?testName=audio-oscillator) 03:09:36 INFO - PID 4393 | RSS: Main: 170561536 03:09:36 INFO - PID 4393 | 03:09:39 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41437/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:09:39 INFO - PID 4393 | RSS: Main: 170586112 03:09:39 INFO - PID 4393 | 03:09:42 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41437/tests/kraken/driver.html?testName=imaging-darkroom) 03:09:43 INFO - PID 4393 | RSS: Main: 173113344 03:09:43 INFO - PID 4393 | 03:09:46 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41437/tests/kraken/driver.html?testName=imaging-desaturate) 03:09:47 INFO - PID 4393 | RSS: Main: 173772800 03:09:47 INFO - PID 4393 | 03:09:50 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41437/tests/kraken/driver.html?testName=json-parse-financial) 03:09:51 INFO - PID 4393 | RSS: Main: 174014464 03:09:51 INFO - PID 4393 | 03:09:52 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41437/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:09:53 INFO - PID 4393 | RSS: Main: 173920256 03:09:53 INFO - PID 4393 | 03:09:54 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:09:55 INFO - PID 4393 | RSS: Main: 173756416 03:09:55 INFO - PID 4393 | 03:09:57 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:58 INFO - PID 4393 | RSS: Main: 170991616 03:09:58 INFO - PID 4393 | 03:10:00 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:10:01 INFO - PID 4393 | RSS: Main: 170991616 03:10:01 INFO - PID 4393 | 03:10:04 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:10:05 INFO - PID 4393 | RSS: Main: 170942464 03:10:05 INFO - PID 4393 | 03:10:06 INFO - PID 4393 | Cycle 1(1): loaded http://localhost:41437/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41437/tests/kraken/driver.html?testName=ai-astar) 03:10:07 INFO - PID 4393 | RSS: Main: 172580864 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | __start_tp_report 03:10:07 INFO - PID 4393 | _x_x_mozilla_page_load 03:10:07 INFO - PID 4393 | _x_x_mozilla_page_load_details 03:10:07 INFO - PID 4393 | |i|pagename|runs| 03:10:07 INFO - PID 4393 | |0;ai-astar;99;107;101;108;107;109;108;102;109;108 03:10:07 INFO - PID 4393 | |1;audio-beat-detection;146;118;147;179;117;143;150;116;173;120 03:10:07 INFO - PID 4393 | |2;audio-dft;164;162;162;162;163;162;163;175;164;163 03:10:07 INFO - PID 4393 | |3;audio-fft;75;78;74;189;76;73;73;88;92;73 03:10:07 INFO - PID 4393 | |4;audio-oscillator;79;79;134;79;80;80;131;79;80;125 03:10:07 INFO - PID 4393 | |5;imaging-gaussian-blur;114;114;117;117;116;117;116;115;113;114 03:10:07 INFO - PID 4393 | |6;imaging-darkroom;147;147;147;148;147;148;147;147;148;147 03:10:07 INFO - PID 4393 | |7;imaging-desaturate;93;94;94;94;94;102;98;94;98;98 03:10:07 INFO - PID 4393 | |8;json-parse-financial;52;53;53;53;52;52;51;52;59;52 03:10:07 INFO - PID 4393 | |9;json-stringify-tinderbox;38;38;38;38;38;37;37;38;38;38 03:10:07 INFO - PID 4393 | |10;stanford-crypto-aes;74;77;75;73;74;75;76;75;74;74 03:10:07 INFO - PID 4393 | |11;stanford-crypto-ccm;118;123;118;117;115;116;122;117;125;160 03:10:07 INFO - PID 4393 | |12;stanford-crypto-pbkdf2;181;167;176;169;169;183;170;174;171;184 03:10:07 INFO - PID 4393 | |13;stanford-crypto-sha256-iterative;64;63;65;64;64;62;63;65;64;64 03:10:07 INFO - PID 4393 | __end_tp_report 03:10:07 INFO - PID 4393 | __start_cc_report 03:10:07 INFO - PID 4393 | _x_x_mozilla_cycle_collect,938 03:10:07 INFO - PID 4393 | __end_cc_report 03:10:07 INFO - PID 4393 | __startTimestamp1504433407085__endTimestamp 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | ------- Summary: start ------- 03:10:07 INFO - PID 4393 | Number of tests: 14 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#0] ai-astar Cycles:10 Average:105.80 Median:108.00 stddev:3.68 (3.4%) stddev-sans-first:2.96 03:10:07 INFO - PID 4393 | Values: 99.0 107.0 101.0 108.0 107.0 109.0 108.0 102.0 109.0 108.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:146.50 stddev:23.06 (15.7%) stddev-sans-first:24.38 03:10:07 INFO - PID 4393 | Values: 146.0 118.0 147.0 179.0 117.0 143.0 150.0 116.0 173.0 120.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.94 (2.4%) stddev-sans-first:4.18 03:10:07 INFO - PID 4393 | Values: 164.0 162.0 162.0 162.0 163.0 162.0 163.0 175.0 164.0 163.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#3] audio-fft Cycles:10 Average:89.10 Median:75.50 stddev:35.73 (47.3%) stddev-sans-first:37.53 03:10:07 INFO - PID 4393 | Values: 75.0 78.0 74.0 189.0 76.0 73.0 73.0 88.0 92.0 73.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:24.53 (31.0%) stddev-sans-first:25.36 03:10:07 INFO - PID 4393 | Values: 79.0 79.0 134.0 79.0 80.0 80.0 131.0 79.0 80.0 125.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:116.00 stddev:1.49 (1.3%) stddev-sans-first:1.51 03:10:07 INFO - PID 4393 | Values: 114.0 114.0 117.0 117.0 116.0 117.0 116.0 115.0 113.0 114.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:10:07 INFO - PID 4393 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.00 stddev:2.92 (3.1%) stddev-sans-first:2.91 03:10:07 INFO - PID 4393 | Values: 93.0 94.0 94.0 94.0 94.0 102.0 98.0 94.0 98.0 98.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:2.23 (4.3%) stddev-sans-first:2.35 03:10:07 INFO - PID 4393 | Values: 52.0 53.0 53.0 53.0 52.0 52.0 51.0 52.0 59.0 52.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 03:10:07 INFO - PID 4393 | Values: 38.0 38.0 38.0 38.0 38.0 37.0 37.0 38.0 38.0 38.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:1.16 (1.5%) stddev-sans-first:1.20 03:10:07 INFO - PID 4393 | Values: 74.0 77.0 75.0 73.0 74.0 75.0 76.0 75.0 74.0 74.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:120.00 stddev:13.37 (11.1%) stddev-sans-first:14.05 03:10:07 INFO - PID 4393 | Values: 118.0 123.0 118.0 117.0 115.0 116.0 122.0 117.0 125.0 160.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.00 stddev:6.29 (3.6%) stddev-sans-first:6.20 03:10:07 INFO - PID 4393 | Values: 181.0 167.0 176.0 169.0 169.0 183.0 170.0 174.0 171.0 184.0 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 03:10:07 INFO - PID 4393 | Values: 64.0 63.0 65.0 64.0 64.0 62.0 63.0 65.0 64.0 64.0 03:10:07 INFO - PID 4393 | -------- Summary: end -------- 03:10:07 INFO - PID 4393 | 03:10:07 INFO - PID 4393 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:10:07 INFO - TEST-INFO | 4393: exit 0 03:10:07 INFO - TEST-OK | kraken | took 61054ms 03:10:07 INFO - SUITE-END | took 1174s 03:10:08 INFO - Completed test suite (00:19:34) 03:10:08 INFO - javascript benchmark 03:10:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8600.80607222412, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.664633536648, 3358.3786999405106, 3364.5121457388677, 3399.966000339996, 3416.794992300462, 6444.291127975931, 6508.381703738143, 6519.739210431577, 6520.869582608345, 6547.705353259103, 6414.102025716404, 6498.837529061764, 6507.154069970898, 6507.6420796856155, 6521.152250207467, 5873.089671100986, 5875.294964604253, 5896.086106653475, 5931.466168044875, 6060.2424696912885, 6032.366601506845, 6041.093835924603, 6055.27336719592, 6067.120267561201, 6079.057746049347, 1062.5758982784487, 5964.2842858857, 6043.576949613529, 6051.546134039942, 6057.666828324441, 5503.394626591072, 5896.056630939029, 5912.0, 5980.342162362137, 6046.697665116727, 5916.763329466816, 5927.792527261525, 6017.909731354033, 6021.3677563856045, 6034.63792172471, 6490.0, 6504.968521945331, 6517.902231466532, 6575.3095924927675, 6602.603843769341, 6958.512904096715, 6967.825804354881, 7051.858962820715, 7063.293670632947, 7064.752733654349, 7026.859462810715, 7027.0, 7041.753538626123, 7122.715091396338, 7134.92865071353, 6361.650109243989, 6444.452221561126, 6445.033245013192, 6445.677716114175, 6448.097266382711, 7118.0, 7138.64306784669, 7152.356287934111, 7153.535020223773, 7161.355478007004, 6739.393454589012, 6772.72909083641, 6800.6939687714175, 6839.726410943506, 6873.931260687429, 6950.374466297956, 6967.338102880219, 7030.086088808423, 7033.120859892513, 7069.575825450489, 6914.274001229899, 6922.203946546211, 7006.0, 7042.92957070433, 7047.154341478953, 6697.430718388991, 6975.372216500539, 6984.301569843076, 7047.68285427157, 7073.893891591631, 5326.813561525328, 5399.568034557226, 5420.810271640474, 5420.91868621971, 5434.239206511092, 4669.466388652321, 4814.975925120352, 4827.662063655581, 4840.975795121002, 4891.608671306287, 6136.447719705248, 6141.6007959482495, 6207.875842483216, 6213.285472170668, 6225.035119556476, 6852.828679282959, 6908.689108990107, 6950.687219075154, 7037.929620703728, 7139.785806425815, 6061.666608336495, 6068.089786532056, 6075.179850720185, 6157.753689852356, 6162.506999440034, 6003.8198854034445, 6006.0, 6045.576809623372, 6051.4553690168095, 6104.969475152596, 6799.694013769392, 6887.931120688829, 6890.483213758988, 6898.2756810535175, 6900.2064762551945, 7031.437485001085, 7032.789016329519, 7043.049188359506, 7145.4640901931525, 7159.355657990805, 6589.703463344257, 6717.630530320879, 6721.865562688817, 6797.218319893078, 6884.552504087218, 6904.930950690429, 6906.723731050702, 6920.446364290744, 6921.2386637470845, 6976.5814051157095, 6967.198772141066, 7044.542104763174, 7052.0479735235085, 7062.823429414306, 7066.964665176847, 6689.331066893272, 6710.6309152997055, 6720.798376048726, 6805.251422343637, 6810.62541560219, 6547.050677651619, 6551.967240163769, 6640.501962352746, 6764.2559318475915, 6823.420009299067, 6610.900836487553, 6636.369544893228, 6637.767678131242, 6718.529702920944, 6723.7646682365885, 6777.966110169417, 6861.4853885957755, 6902.8619427610165, 6903.102596662402, 6904.13698287714, 6432.9678351607945, 6518.511111666549, 6549.214094308523, 6560.573562718408, 6640.800775976729], "value": 6329.686774371707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.3922898982275, 845.8139209373937, 871.5816408124097, 874.2481465939292, 1106.4578356605266, 29273.0, 29751.256218594546, 39412.408813867776, 40119.79940100303, 40243.39634905479, 40624.59375406245, 40949.18101637973, 40989.795051024776, 41020.0, 41078.17843643133, 7508.249175082503, 7654.234576542357, 7740.4968677036095, 7742.419318551103, 7805.882911756328, 7542.2457754224415, 7633.427492938052, 7650.464467487278, 7665.770026899202, 7678.5392876427595, 7626.694932202733, 7679.308862202401, 7704.9614751926165, 7709.6916123354995, 7714.344280736144, 7659.119201291839, 7664.770056898274, 7668.0, 7687.423443241779, 7690.230976902293, 7607.277308655669, 7655.502392344535, 7659.310662040388, 7659.578723170223, 7667.156612772591, 35897.64102358995, 36140.45789313162, 36144.457833132525, 36187.81906090453, 36217.81891090554, 3544.7341449391397, 3593.317269718771, 3595.0293420776243, 3596.946045809315, 3598.4242521196743, 30233.848830755924, 30252.394952100836, 30352.84823575868, 30362.54456183159, 30404.239894002607, 4963.1810751226, 5120.0, 5142.717150556718, 5168.0697474454955, 5178.482151784829, 184050.0, 186271.0, 187587.0, 188054.0, 188179.0, 46194.0, 46219.0, 46258.074838503715, 46258.30612540815, 46328.5367146331, 46856.53143468522, 47206.5279347209, 47519.0, 47772.0, 47926.0, 14027.929860350632, 14351.138931664134, 15871.444499442465, 16080.195990200444, 16088.11515366666, 13176.868231317756, 13463.192208467523, 13474.86525134736, 13486.527971520949, 13517.121387110003, 13996.72006559863, 14013.5095271665, 14112.364943577564, 14129.222892740998, 14291.428342866377, 5669.943300567024, 5686.3744988051285, 5704.201411802351, 5707.0, 5757.107648314518, 1004.9045340692622, 1019.6227395863579, 1019.8113349030453, 1026.897310268982, 1027.8612387327764, 22568.322950311518, 23163.420914477272, 23279.650805237936, 23328.65007024896, 23532.764672353398, 1110.3005106782837, 1116.5757012335262, 1123.556195302867, 1126.9178795992952, 1133.9376334301528, 12309.692257693629, 12364.44360003802, 12387.009039276836, 12387.938060309642, 12395.0, 222878.0, 223963.0, 224012.0, 224995.0, 225274.0, 49249.26126108111, 49577.0, 49829.50170498249, 49915.0, 50167.498325016284, 1447.073872721459, 1452.8183977002875, 1467.669774300795, 1486.0934829753842, 1491.0, 22111.0, 22345.664815028114, 22350.888245558668, 22724.318270451913, 23176.536469270857, 36382.27235455223, 36484.63515364812, 36507.452388213664, 36551.634483655886, 36562.8171859139, 196042.0, 196185.0, 197191.0, 197355.0, 198107.0, 31881.36237275288, 31997.0, 32000.67999319977, 32217.51673724849, 32246.516302255015, 39273.214535708554, 39410.605893940694, 39558.2088358237, 39614.60385396109, 39717.40423893586, 29630.259243519085, 29989.85005075048, 30085.54871676883, 30233.848830755705, 30483.2379190522, 30372.39255214839, 30483.08550743481, 30553.54169687412, 31045.68954310518, 31180.0, 33378.16554586155, 33587.66412335845, 33617.0, 33642.831785840914, 33709.0, 28989.565156522247, 29308.706912930596, 29539.85230073836, 29556.261093472836, 29761.702382975895, 22537.0, 22683.432914177276, 24220.39449013789, 24395.26814195506, 25049.0], "value": 16742.0795940552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.9037963546197, 566.317587307295, 584.4681339980617, 586.5249148189964, 589.8761260135371, 21421.678674819872, 21924.342269731933, 22306.219282325103, 22333.330000100003, 22358.10567577295, 25427.872860635718, 25856.870715646397, 25890.223293301184, 25958.48083038338, 26005.08982185624, 6516.934830651692, 6631.668416579152, 6657.0, 6659.63372014539, 6660.167479065117, 5906.970465147669, 6207.565470417073, 6505.381988711065, 6538.378854008862, 6589.901151482732, 6449.193850768654, 6462.063000864871, 6463.612183269019, 6476.643784591845, 6481.2222533295835, 6456.838579035538, 6467.870642587169, 6474.805755827333, 6475.967620161892, 6476.319986401407, 5994.190784244159, 6005.669688167149, 6010.729517171738, 6020.036794112964, 6029.246344206974, 28784.856075719486, 29377.559336609967, 29880.25299367533, 30257.848710756527, 30502.694973050206, 1996.331229038274, 2019.5254115282896, 2026.9290574829959, 2028.1988614497338, 2028.9898550507153, 19352.80647193524, 19848.40454786359, 19876.30432934855, 19918.402447926586, 19971.0, 2347.823913206499, 2370.8103351731993, 2404.759524047599, 2409.9879500602383, 2461.8153638477006, 130200.34899825534, 133917.3304133473, 134018.0, 134239.0, 134471.0, 14412.567622971328, 15167.772483412758, 15254.466093686668, 15322.923385383001, 15696.0, 22796.886015569817, 22902.541949160925, 23047.769522304898, 23100.0, 23146.305610831703, 10091.192704583616, 10195.745106372251, 10300.175985921109, 10326.328788628714, 10447.634332798316, 9432.481213533185, 9474.194693451134, 9530.666426675032, 9532.380395274286, 9688.0, 8714.782130446663, 9078.319126065571, 9116.225120864668, 9496.382735122334, 9544.570494327772, 2692.7845772338164, 2702.513547561458, 2715.5247831629385, 2764.378014946621, 2786.1920043187656, 938.8967213606497, 975.1711045611173, 976.1751320134475, 978.3151793744265, 978.9021097890154, 19716.0, 24403.389915251904, 25450.618240726402, 25601.61597576038, 25622.871885640827, 979.9559019844124, 1036.9481525923673, 1038.5118994072773, 1057.894210578936, 1058.216919479595, 10704.0, 10954.726131846768, 10987.560497580167, 11163.162762792823, 11210.55157793679, 471915.0, 486251.0, 491311.0, 494267.0, 494741.0, 120877.0, 123031.384843077, 126502.0, 126646.0, 127381.72618273698, 1224.6203676860202, 1225.522046401904, 1249.6376050945123, 1260.9873901261053, 1264.7470505898857, 17464.73802892932, 17778.733318999966, 17827.910860445616, 18163.636727265115, 18228.81771182324, 57137.42862571321, 57859.71070144622, 59355.0, 59501.70249148727, 64507.354926450134, 71521.0, 73097.6345118271, 73563.0, 74009.6299518499, 74500.0, 12143.14997950135, 12593.244405335709, 14334.068285561405, 14959.700805984037, 14999.400023998918, 22411.77588224097, 23579.0, 23611.0, 24027.51944961056, 24058.0, 18423.631527369645, 18647.81352186515, 18688.626227475645, 18961.241550337832, 18995.335163269217, 16463.506094817174, 17168.39910603123, 17241.741373879653, 17697.38059167923, 17826.91086544559, 18763.718544221574, 18942.337018204296, 19314.71027934554, 19603.215871364984, 19608.019599019706, 14647.0, 14652.853471465149, 14749.262536872899, 14766.926165369105, 14776.852231477978, 18431.447056588324, 18432.63134737271, 18730.25078996825, 19040.904795475933, 19094.904525477283], "value": 12119.700588000273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.7322535492901, 1404.1294397473562, 1420.3098313007517, 1425.7790042543409, 1429.6783223774653, 15018.174000429972, 15231.46689865855, 15588.766168507482, 15595.1422671753, 15602.921985390072, 15807.367705291774, 16085.0, 16093.275802588882, 16094.919525402356, 16100.275487603056, 2806.1581525542356, 2856.771458283343, 2857.3285277959662, 2857.3570946536965, 2858.8141770784937, 2732.5764506501423, 2767.6678798544203, 2773.6948935617065, 2777.1946135620647, 2801.0476438011074, 2715.2804506805714, 2765.6404667393313, 2779.8888044478194, 2783.958240626392, 2790.107165706964, 2612.9869350653316, 2683.168217852472, 2684.396010897552, 2685.060228919882, 2687.811853170279, 2748.6151938728594, 2755.5453350197195, 2757.26932362924, 2764.2398340456334, 2782.2070709847594, 14965.476208332764, 15264.16047117408, 15389.307481163263, 15389.307481163263, 15409.0, 7996.4002699797165, 8255.917440825575, 8264.132266112092, 8265.0, 8296.8340633187, 4987.625928055374, 5197.558207552363, 5337.759800808934, 5360.705161216131, 5388.245645609618, 1921.951951201217, 1949.756280464942, 1957.8335841453493, 1997.131247907165, 2021.1410150686047, 26859.194224173305, 27068.323291917663, 27175.0, 27250.0, 28154.577681334795, 6762.425193858577, 6787.592744435349, 6806.829829254309, 6926.826829329307, 7021.929780702229, 17549.21028553718, 17650.382236621914, 17686.380976665754, 17688.204030818644, 17714.291428342978, 7929.643166057541, 8144.429889907649, 8152.307053900485, 8153.266206041366, 8155.79610509742, 7503.2496750324535, 7514.173440921494, 7586.127595326608, 7617.352525035323, 7618.0, 5055.974720126449, 5227.3465816772905, 5247.422783493813, 5258.053550360895, 5271.973640131775, 1464.5972357601745, 1485.9405623775144, 1493.16382825618, 1496.5435542159746, 1500.7898894154828, 874.9300055995506, 896.7264984179757, 904.0688091266006, 910.3672947301562, 914.1133100892124, 7666.8849967250535, 7709.306162445407, 7740.109887362913, 7765.107012693613, 7826.882596761053, 685.9657017149123, 710.4565007769061, 714.8034290570031, 735.3859527294662, 743.8214828441135, 4807.840754592944, 5257.395399529027, 5335.33308336458, 5525.475079867406, 5540.833774986757, 21691.783082168975, 22175.66736498954, 22686.0, 22690.546189076125, 22770.43073923132, 20848.270310539363, 22037.0, 22087.66868496974, 22116.22593209262, 22395.88802056012, 10052.547635356426, 10237.181025517792, 10457.320274182153, 11485.885141148648, 11904.821427678591, 8278.503289802631, 8650.1349865013, 8733.91266087331, 9071.365004449624, 9154.221891139061, 18320.26718931281, 18878.15048322856, 19188.232470701016, 19378.515537111685, 19609.509762256057, 19457.0, 19615.11731972036, 19695.60608787845, 19783.40649780509, 19912.203511859363, 11583.536658533565, 11643.359615221245, 11744.29534227949, 11914.0, 11958.222715523463, 13869.167849929037, 14011.649708757363, 14045.719085618435, 14052.648683782987, 14105.929470352583, 11169.609063682732, 11286.66140015801, 11341.773164536828, 11427.0, 11675.591354302558, 11216.0, 11222.88777112251, 11376.886231137914, 11477.426128693698, 11679.708007299885, 10221.795564088528, 10375.584976601154, 10382.792344153226, 10401.895981040092, 10402.791944160923, 7214.855702886018, 7227.674754636159, 7315.195328513965, 7328.706851725871, 7332.340089391981, 7431.071116110486, 7451.552906825608, 7529.134149572869, 7532.209118042527, 7659.502132361378], "value": 6730.457483305564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9864889786173, 525.2357819372813, 528.1259515501846, 539.9298091248139, 542.3248056170067, 6410.583312084711, 6443.420092191702, 6531.738730450782, 6533.0, 6544.869102617945, 6301.779437719681, 6413.390727880856, 6449.258335291443, 6449.451796597295, 6502.252240992288, 5304.8859739454765, 5313.495217954288, 5314.282571852789, 5334.786608535654, 5359.38367087786, 4903.200019984522, 5145.485451454862, 5272.23552584875, 5307.946920530784, 5346.304980352568, 5080.339555857733, 5095.668781529189, 5101.6683915545555, 5104.132297509414, 5115.769790359443, 5095.668781529226, 5103.519979206045, 5103.56619687327, 5107.157319042353, 5117.923231151499, 4443.488998765151, 4537.591616754508, 4563.0, 4576.290674945389, 4583.358329833826, 6144.38556144382, 6258.655773932432, 6269.498440124779, 6282.308946015934, 6293.87412251757, 5809.128630705386, 5844.649321040752, 5852.619579727304, 5862.50168735658, 5898.292204935392, 6732.93267067328, 6741.314671332167, 6767.984802279649, 6776.322367763233, 6784.76253331131, 4985.426675932278, 4997.325361076245, 5008.924866127011, 5021.623378246646, 5036.722980236085, 6788.72845086196, 6876.69054892526, 6907.620080895498, 6945.687444065029, 7070.29297070294, 4993.875153121128, 5121.0, 5131.2559678846355, 5134.0, 5152.613553983466, 5189.532942035235, 5210.426853046162, 5224.503672151215, 5227.163653815372, 5229.47705229474, 5774.162746401748, 5828.446297601806, 5838.182654428383, 5848.590598658053, 5856.531477481792, 6793.388595026372, 6799.252082270947, 6801.863962720718, 6815.273890443862, 6816.386525212754, 1794.7436794244081, 1816.445983974874, 1834.477174005402, 1838.3933302010305, 1841.162271166616, 1206.3824019209212, 1236.3200239868036, 1242.931638759877, 1243.0118056145386, 1262.6906407929932, 5960.165576819249, 5978.372270911578, 5983.521318294526, 6010.0, 6019.428154325332, 6903.8921841504225, 6904.4453552185005, 6946.37482626566, 7013.193482749549, 7029.191642961125, 5937.346891841894, 5975.790847320323, 5982.252218472691, 5985.281766188085, 6016.969915150396, 3569.5359603251413, 3672.485851980725, 3685.7972811495088, 3694.1503454205144, 3724.6647801697977, 6651.068850360954, 6662.700178491979, 6693.464522838161, 6706.497012724065, 6772.255051944282, 7055.506114571931, 7074.575525468488, 7080.256573059754, 7100.609466479394, 7137.2149063602965, 6653.334666533308, 6657.46740260778, 6755.121834161626, 6763.628000460022, 6767.932320676829, 7008.579485230903, 7017.228104908354, 7026.508144429841, 7027.939883284027, 7032.0, 6948.895766563607, 6950.826229344105, 6963.408110310477, 6981.616011119234, 6983.196932352845, 6791.3548212919695, 6791.607720417402, 6800.823736404303, 6812.14848143982, 6819.863602728017, 5122.231665250242, 5158.0, 5170.689758614495, 5172.922406163986, 5175.585953123666, 6649.434798042221, 6778.0, 6867.622280774605, 6885.449164066762, 6907.0, 6727.831804204739, 6745.392914637706, 6757.425618822455, 6757.628330441873, 6778.593284402951, 6655.134832471941, 6665.533412661067, 6689.76585819494, 6724.193096828412, 6730.966345168243, 6631.0, 6694.83262918431, 6696.966515167393, 6714.6642667865435, 6744.325567443413, 6814.4548436124, 6821.386075253251, 6848.760293389708, 6849.315068493111, 6850.828729281808, 6585.275619681735, 6589.736410543716, 6609.1408116944485, 6619.569727967667, 6619.768308109193], "value": 5220.366924350865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.4409961475236, 865.7402779166252, 875.9430637008594, 881.8721285413615, 895.4850960697601, 18896.149673264703, 19541.902290488546, 19656.508587285323, 19671.409857704257, 19819.207231710734, 16507.0, 18799.90600047001, 18862.43412697621, 18877.056147192656, 18877.339293124744, 945.5272363818091, 951.7763325618508, 955.7849483866144, 957.9137877591015, 957.9377340472847, 945.0927109974399, 960.0255740423476, 961.0917682789767, 970.4662435660358, 972.377678285894, 1029.8609687692178, 1033.576233744165, 1033.679559336608, 1034.105498743589, 1034.5396298647106, 988.6440881282805, 1020.2348238820884, 1028.1877316919663, 1028.511457057899, 1032.2619327181064, 726.1649103530982, 726.3970904149543, 726.8582626387856, 729.4383324839897, 729.5987207036162, 19556.608867822564, 19893.701594476093, 19961.600767984703, 19977.300794472125, 19992.700109498368, 20846.791532084637, 21008.159673613038, 21818.454538636663, 21835.563288734294, 21851.562968740534, 16604.83395166045, 16957.3217071317, 16999.57501062471, 17003.57491062721, 17006.914965425218, 3708.2027364116843, 3731.7760934343755, 3882.6893848492336, 3886.0867696091395, 3891.280113179071, 122297.0, 123267.383663082, 124079.0, 125990.0, 128076.0, 15893.443729469413, 16312.18439078065, 16403.261853216634, 16577.668446631, 16579.253933573018, 29424.26439338991, 30201.697983020327, 30343.848280758455, 30346.54480182799, 30357.54463683002, 8931.285497160212, 9014.86477702835, 9339.859902101474, 9341.299402544837, 9344.15902568772, 4349.739015659071, 4460.241758900995, 4467.374567560544, 4468.061707041557, 4485.372047913294, 5230.058589453859, 5337.519623233928, 5353.544948679406, 5358.19627055937, 5388.784448622089, 1017.7506510904876, 1046.9738256543646, 1048.6853943816977, 1061.124572227915, 1062.5802807890839, 631.3812463785424, 639.7057353617388, 645.9644719540377, 648.6659370424235, 658.2857599504496, 11644.41777911101, 11875.871792179729, 12075.75848483043, 12221.450034748279, 12348.876511234772, 639.577878600131, 661.0711949710665, 661.2593894837812, 663.2770280394393, 671.5198632977445, 5710.172025056344, 5869.647821130746, 5885.941140588539, 5899.203607512931, 5924.903892779849, 111656.44171779089, 112384.43807780909, 115466.4226678878, 116663.0, 117210.0, 93538.0, 94776.0, 95323.52338238264, 98255.50872245592, 98923.01076989282, 83758.58120709358, 84963.57518212493, 85964.0, 87452.56273718718, 88259.0, 12291.69270768238, 12413.503459861504, 12513.499460021498, 12522.311272880079, 12530.686732831387, 40287.79856100701, 40904.590954090076, 40914.795426022676, 42189.57810421979, 42590.14819703527, 53653.731731342654, 53736.0, 54933.450665492834, 55015.0, 55740.0, 17638.73541896847, 17745.645087098444, 17781.288748450435, 17849.73225401646, 17942.730859036863, 18934.43196704101, 18985.810141898957, 19153.0, 19265.325713599956, 19268.32560860363, 16822.327106915585, 16923.91538042302, 17025.40411085606, 17037.829621703626, 17132.828671713123, 17143.31426742966, 17364.913175434547, 17466.214020369367, 17529.912350438168, 17588.38440654571, 16242.106684132486, 16480.752788708418, 16484.752728708838, 16658.83341166621, 16870.325186992384, 12438.440270188044, 12573.1198816082, 12831.615051548468, 13007.47970081224, 13054.918768065158, 13144.0799144059, 13490.662733431744, 13497.595072147851, 13701.520446784314, 14119.223442710749], "value": 8969.78959838841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 108.0, 107.0, 109.0, 108.0, 102.0, 109.0, 108.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 147.0, 179.0, 117.0, 143.0, 150.0, 116.0, 173.0, 120.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 175.0, 164.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 189.0, 76.0, 73.0, 73.0, 88.0, 92.0, 73.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 134.0, 79.0, 80.0, 80.0, 131.0, 79.0, 80.0, 125.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 117.0, 116.0, 117.0, 116.0, 115.0, 113.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 102.0, 98.0, 94.0, 98.0, 98.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 51.0, 52.0, 59.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 37.0, 38.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 73.0, 74.0, 75.0, 76.0, 75.0, 74.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 123.0, 118.0, 117.0, 115.0, 116.0, 122.0, 117.0, 125.0, 160.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 167.0, 176.0, 169.0, 169.0, 183.0, 170.0, 174.0, 171.0, 184.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 64.0, 62.0, 63.0, 65.0, 64.0, 64.0], "value": 63.8, "unit": "score"}]}]} 03:10:08 INFO - Return code: 0 03:10:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:10:08 INFO - # TBPL SUCCESS # 03:10:08 INFO - Running post-action listener: _package_coverage_data 03:10:08 INFO - Running post-action listener: _resource_record_post_action 03:10:08 INFO - [mozharness: 2017-09-03 10:10:08.389436Z] Finished run-tests step (success) 03:10:08 INFO - Running post-run listener: _resource_record_post_run 03:10:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 18575360; Write bytes: 402071552; Read time: 6068; Write time: 335064 03:10:08 INFO - TinderboxPrint: CPU usage
13.1% 03:10:08 INFO - TinderboxPrint: I/O read bytes / time
18,575,360 / 6,068 03:10:08 INFO - TinderboxPrint: I/O write bytes / time
402,071,552 / 335,064 03:10:08 INFO - TinderboxPrint: CPU idle
8,255.2 (86.9%) 03:10:08 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 03:10:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:10:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105803776; Read time: 84; Write time: 83340 03:10:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:10:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 16826368; Write bytes: 285437952; Read time: 5932; Write time: 247572 03:10:09 INFO - Running post-run listener: _upload_blobber_files 03:10:09 INFO - Blob upload gear active. 03:10:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:10:09 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 03:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:10:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:10 INFO - (blobuploader) - INFO - Done attempting. 03:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:10:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:17 INFO - (blobuploader) - INFO - Done attempting. 03:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:17 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 03:10:17 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 03:10:17 INFO - (blobuploader) - INFO - Done attempting. 03:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:10:18 INFO - (blobuploader) - INFO - Done attempting. 03:10:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:10:18 INFO - Return code: 0 03:10:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:10:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:10:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7e5a0bde50550a93b21b1ce46f4f069c1a8af837c286faa0291237873e8ac4e4dc4676020af6e175f99815536bd7e493fdc8ae07a9e2a1abd2b9b454ce9d156", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f996c25bd054f7a0fa557257cfe84a4a4e594580aca7b4d12be4e8d39278b27efe2f1327e63bf6790791ca2073e20b1dadc38407fae590df237b6835c5e8667", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975134cc939314f4c0475645dfd4fd5987ca49ba52df5985fd5e4fb422448f59559130fe8349a7fdff2043fdc77b2c1340741d6e39e21d825e8beebdf695ebbc"} 03:10:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:10:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:10:18 INFO - Contents: 03:10:18 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7e5a0bde50550a93b21b1ce46f4f069c1a8af837c286faa0291237873e8ac4e4dc4676020af6e175f99815536bd7e493fdc8ae07a9e2a1abd2b9b454ce9d156", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f996c25bd054f7a0fa557257cfe84a4a4e594580aca7b4d12be4e8d39278b27efe2f1327e63bf6790791ca2073e20b1dadc38407fae590df237b6835c5e8667", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975134cc939314f4c0475645dfd4fd5987ca49ba52df5985fd5e4fb422448f59559130fe8349a7fdff2043fdc77b2c1340741d6e39e21d825e8beebdf695ebbc"} 03:10:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:10:18 INFO - Copying logs to upload dir... 03:10:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:10:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.062410 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-03 03:10:18.770951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:10:18.778844) ========= 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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7e5a0bde50550a93b21b1ce46f4f069c1a8af837c286faa0291237873e8ac4e4dc4676020af6e175f99815536bd7e493fdc8ae07a9e2a1abd2b9b454ce9d156", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f996c25bd054f7a0fa557257cfe84a4a4e594580aca7b4d12be4e8d39278b27efe2f1327e63bf6790791ca2073e20b1dadc38407fae590df237b6835c5e8667", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975134cc939314f4c0475645dfd4fd5987ca49ba52df5985fd5e4fb422448f59559130fe8349a7fdff2043fdc77b2c1340741d6e39e21d825e8beebdf695ebbc"} build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7e5a0bde50550a93b21b1ce46f4f069c1a8af837c286faa0291237873e8ac4e4dc4676020af6e175f99815536bd7e493fdc8ae07a9e2a1abd2b9b454ce9d156", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f996c25bd054f7a0fa557257cfe84a4a4e594580aca7b4d12be4e8d39278b27efe2f1327e63bf6790791ca2073e20b1dadc38407fae590df237b6835c5e8667", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/975134cc939314f4c0475645dfd4fd5987ca49ba52df5985fd5e4fb422448f59559130fe8349a7fdff2043fdc77b2c1340741d6e39e21d825e8beebdf695ebbc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:10:18.813968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:10:18.814321) ========= 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=745a4373a2a16df560f216e000000264-1504432162.40195-613819599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004375 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:10:18.897405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:10:18.897733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:10:18.898065) ========= ========= Total master_lag: 0.25 =========