builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-032 starttime: 1506424946.55 results: success (0) revision: bc56729898954e32d3a3731d03d178ed78924c33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.548505) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.548923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.549267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.614404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.614915) ========= 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-1506424741.73082-418985993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 04:22:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-09-26 04:22:27 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.728942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.732244) ========= 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-1506424741.73082-418985993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.783209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:26.783518) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc56729898954e32d3a3731d03d178ed78924c33 --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 bc56729898954e32d3a3731d03d178ed78924c33 --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-1506424741.73082-418985993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 04:22:27,257 truncating revision to first 12 chars 2017-09-26 04:22:27,257 Setting DEBUG logging. 2017-09-26 04:22:27,257 attempt 1/10 2017-09-26 04:22:27,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc5672989895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 04:22:27,672 unpacking tar archive at: mozilla-central-bc5672989895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.783775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:27.590078) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:27.590416) ========= script_repo_revision: bc56729898954e32d3a3731d03d178ed78924c33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:27.590806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:27.591078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 04:22:27.608268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 04:22:27.608661) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1506424741.73082-418985993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:28 INFO - MultiFileLogger online at 20170926 04:22:28 in /builds/slave/test 04:22:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:22:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:28 INFO - {'append_to_log': False, 04:22:28 INFO - 'base_work_dir': '/builds/slave/test', 04:22:28 INFO - 'blob_upload_branch': 'Firefox', 04:22:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:28 INFO - 'branch': 'Firefox', 04:22:28 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:28 INFO - 'code_coverage': False, 04:22:28 INFO - 'config_files': ('talos/linux_config.py',), 04:22:28 INFO - 'default_actions': ('clobber', 04:22:28 INFO - 'read-buildbot-config', 04:22:28 INFO - 'download-and-extract', 04:22:28 INFO - 'populate-webroot', 04:22:28 INFO - 'create-virtualenv', 04:22:28 INFO - 'install', 04:22:28 INFO - 'setup-mitmproxy', 04:22:28 INFO - 'run-tests'), 04:22:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:28 INFO - 'disable_ccov_upload': False, 04:22:28 INFO - 'disable_stylo': False, 04:22:28 INFO - 'download_minidump_stackwalk': True, 04:22:28 INFO - 'download_symbols': 'ondemand', 04:22:28 INFO - 'enable_stylo': False, 04:22:28 INFO - 'enable_webrender': False, 04:22:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:22:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:28 INFO - 'gecko_profile': False, 04:22:28 INFO - 'gecko_profile_interval': 0, 04:22:28 INFO - 'installer_path': 'installer.exe', 04:22:28 INFO - 'log_level': 'info', 04:22:28 INFO - 'log_name': 'talos', 04:22:28 INFO - 'log_to_console': True, 04:22:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:28 INFO - 'opt_config_files': (), 04:22:28 INFO - 'pip_index': False, 04:22:28 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:22:28 INFO - 'system_bits': '32', 04:22:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:28 INFO - 'title': 'talos-linux64-ix-032', 04:22:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:28 INFO - 'use_talos_json': True, 04:22:28 INFO - 'verify': 'False', 04:22:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:28 INFO - 'work_dir': 'build'} 04:22:28 INFO - [mozharness: 2017-09-26 11:22:28.233364Z] Running clobber step. 04:22:28 INFO - Running pre-action listener: _resource_record_pre_action 04:22:28 INFO - Running main action method: clobber 04:22:28 INFO - rmtree: /builds/slave/test/build 04:22:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:29 INFO - Running post-action listener: _resource_record_post_action 04:22:29 INFO - [mozharness: 2017-09-26 11:22:29.745308Z] Finished clobber step (success) 04:22:29 INFO - [mozharness: 2017-09-26 11:22:29.745406Z] Running read-buildbot-config step. 04:22:29 INFO - Running pre-action listener: _resource_record_pre_action 04:22:29 INFO - Running main action method: read_buildbot_config 04:22:29 INFO - Using buildbot properties: 04:22:29 INFO - { 04:22:29 INFO - "project": "", 04:22:29 INFO - "product": "firefox", 04:22:29 INFO - "who": "archaeopteryx@coole-files.de", 04:22:29 INFO - "installer_path": "public/build/target.tar.bz2", 04:22:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:22:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:22:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:22:29 INFO - "stage_platform": "linux64-pgo", 04:22:29 INFO - "basedir": "/builds/slave/test", 04:22:29 INFO - "buildnumber": 61, 04:22:29 INFO - "platform": "ubuntu64_hw", 04:22:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:22:29 INFO - "slavebuilddir": "test", 04:22:29 INFO - "taskId": "XBazsULxTbGbaeWQbWlh3w", 04:22:29 INFO - "branch": "mozilla-central", 04:22:29 INFO - "script_repo_revision": "production", 04:22:29 INFO - "revision": "bc56729898954e32d3a3731d03d178ed78924c33", 04:22:29 INFO - "slavename": "talos-linux64-ix-032", 04:22:29 INFO - "repo_path": "mozilla-central" 04:22:29 INFO - } 04:22:29 INFO - Finding installer, test and symbols from parent task. 04:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBazsULxTbGbaeWQbWlh3w'}, attempt #1 04:22:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBazsULxTbGbaeWQbWlh3w'}, attempt #1 04:22:30 INFO - Task dependencies: F9EpRGDWRzSDGYnb2OX3sQ 04:22:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ'}, attempt #1 04:22:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 04:22:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.test_packages.json 04:22:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.crashreporter-symbols.zip 04:22:31 INFO - Running post-action listener: _resource_record_post_action 04:22:31 INFO - [mozharness: 2017-09-26 11:22:31.127339Z] Finished read-buildbot-config step (success) 04:22:31 INFO - [mozharness: 2017-09-26 11:22:31.127557Z] Running download-and-extract step. 04:22:31 INFO - Running pre-action listener: _resource_record_pre_action 04:22:31 INFO - Running main action method: download_and_extract 04:22:31 INFO - mkdir: /builds/slave/test/build/tests 04:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:31 INFO - trying https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.test_packages.json 04:22:31 INFO - Downloading https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:22:31 INFO - Downloaded 989 bytes. 04:22:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:22:31 INFO - Using the following test package requirements: 04:22:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:22:31 INFO - u'common': [u'target.common.tests.zip'], 04:22:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:22:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:22:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:22:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:22:31 INFO - u'mozbase': [u'target.common.tests.zip'], 04:22:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:22:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:22:31 INFO - u'web-platform': [u'target.common.tests.zip', 04:22:31 INFO - u'target.web-platform.tests.tar.gz'], 04:22:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:22:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:22:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.common.tests.zip 04:22:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:22:31 INFO - Fetch https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.common.tests.zip into memory 04:22:33 INFO - Content-Length response header: 55343573 04:22:33 INFO - Bytes received: 55343573 04:22:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.talos.tests.zip 04:22:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:22:43 INFO - Fetch https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.talos.tests.zip into memory 04:22:44 INFO - Content-Length response header: 14513823 04:22:44 INFO - Bytes received: 14513823 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:45 INFO - trying https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 04:22:45 INFO - Downloading https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:22:47 INFO - Downloaded 62312238 bytes. 04:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 04:22:47 INFO - mkdir: /builds/slave/test/properties 04:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:47 INFO - Contents: 04:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 04:22:47 INFO - Running post-action listener: _resource_record_post_action 04:22:47 INFO - Running post-action listener: find_tests_for_verification 04:22:47 INFO - Running post-action listener: set_extra_try_arguments 04:22:47 INFO - [mozharness: 2017-09-26 11:22:47.786130Z] Finished download-and-extract step (success) 04:22:47 INFO - [mozharness: 2017-09-26 11:22:47.786228Z] Running populate-webroot step. 04:22:47 INFO - Running pre-action listener: _resource_record_pre_action 04:22:47 INFO - Running main action method: populate_webroot 04:22:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['tresize', 04:22:47 INFO - 'tcanvasmark']}, 04:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['dromaeo_css', 04:22:47 INFO - 'kraken']}, 04:22:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'tests': ['damp', 'tps']}, 04:22:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['damp', 'tps']}, 04:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['dromaeo_dom']}, 04:22:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:22:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['basic_compositor_video', 04:22:47 INFO - 'glvideo']}, 04:22:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:22:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['ts_paint_webext', 04:22:47 INFO - 'tp5o_webext']}, 04:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:47 INFO - 'ts_paint', 04:22:47 INFO - 'tpaint', 04:22:47 INFO - 'sessionrestore', 04:22:47 INFO - 'sessionrestore_many_windows', 04:22:47 INFO - 'sessionrestore_no_auto_restore', 04:22:47 INFO - 'tabpaint']}, 04:22:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['a11yr', 04:22:47 INFO - 'ts_paint', 04:22:47 INFO - 'tpaint', 04:22:47 INFO - 'sessionrestore', 04:22:47 INFO - 'sessionrestore_many_windows', 04:22:47 INFO - 'sessionrestore_no_auto_restore', 04:22:47 INFO - 'tabpaint']}, 04:22:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:22:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:22:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['perf_reftest_singletons']}, 04:22:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['perf_reftest']}, 04:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:47 INFO - 'tsvgr_opacity', 04:22:47 INFO - 'tart', 04:22:47 INFO - 'tscrollx', 04:22:47 INFO - 'tsvg_static']}, 04:22:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['tsvgx', 04:22:47 INFO - 'tsvgr_opacity', 04:22:47 INFO - 'tart', 04:22:47 INFO - 'tscrollx', 04:22:47 INFO - 'tsvg_static']}, 04:22:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:22:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--disable-stylo'], 04:22:47 INFO - 'tests': ['tp5o']}, 04:22:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:47 INFO - 'talos_options': ['--mitmproxy', 04:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:47 INFO - '--firstNonBlankPaint'], 04:22:47 INFO - 'tests': ['tp6_google', 04:22:47 INFO - 'tp6_youtube', 04:22:47 INFO - 'tp6_amazon', 04:22:47 INFO - 'tp6_facebook']}, 04:22:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:47 INFO - 'talos_options': ['--disable-stylo', 04:22:47 INFO - '--mitmproxy', 04:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:47 INFO - '--firstNonBlankPaint'], 04:22:47 INFO - 'tests': ['tp6_google', 04:22:47 INFO - 'tp6_youtube', 04:22:47 INFO - 'tp6_amazon', 04:22:47 INFO - 'tp6_facebook']}, 04:22:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:22:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:22:47 INFO - 'talos_options': ['--stylo-threads=1', 04:22:47 INFO - '--mitmproxy', 04:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:22:47 INFO - '--firstNonBlankPaint'], 04:22:47 INFO - 'tests': ['tp6_google', 04:22:47 INFO - 'tp6_youtube', 04:22:47 INFO - 'tp6_amazon', 04:22:47 INFO - 'tp6_facebook']}, 04:22:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--xperf_path', 04:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:47 INFO - 'tests': ['tp5n']}, 04:22:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:22:47 INFO - 'talos_options': ['--disable-stylo', 04:22:47 INFO - '--xperf_path', 04:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:47 INFO - 'tests': ['tp5n']}}} 04:22:47 INFO - Running post-action listener: _resource_record_post_action 04:22:47 INFO - [mozharness: 2017-09-26 11:22:47.803744Z] Finished populate-webroot step (success) 04:22:47 INFO - [mozharness: 2017-09-26 11:22:47.803834Z] Running create-virtualenv step. 04:22:47 INFO - Running pre-action listener: _resource_record_pre_action 04:22:47 INFO - Running main action method: create_virtualenv 04:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:22:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:48 INFO - Installing pip...............done. 04:22:48 INFO - Return code: 0 04:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:22:48 INFO - Reading from file tmpfile_stdout 04:22:48 INFO - Output received: 04:22:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:22:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:22:48 INFO - Using env: {'DISPLAY': ':0', 04:22:48 INFO - 'HOME': '/home/cltbld', 04:22:48 INFO - 'LANG': 'en_US.UTF-8', 04:22:48 INFO - 'LANGUAGE': 'en_US:en', 04:22:48 INFO - 'LOGNAME': 'cltbld', 04:22:48 INFO - 'MAIL': '/var/mail/cltbld', 04:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:48 INFO - 'MOZ_NO_REMOTE': '1', 04:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:48 INFO - 'NO_EM_RESTART': '1', 04:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:48 INFO - 'PWD': '/builds/slave/test', 04:22:48 INFO - 'SHELL': '/bin/bash', 04:22:48 INFO - 'SHLVL': '1', 04:22:48 INFO - 'TERM': 'linux', 04:22:48 INFO - 'TMOUT': '86400', 04:22:48 INFO - 'USER': 'cltbld', 04:22:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:48 INFO - '_': '/tools/buildbot/bin/python'} 04:22:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:22:50 INFO - Downloading/unpacking pip>=1.5 04:22:50 INFO - Running setup.py egg_info for package pip 04:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 04:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 04:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:22:50 INFO - Installing collected packages: pip 04:22:50 INFO - Found existing installation: pip 1.1 04:22:50 INFO - Uninstalling pip: 04:22:50 INFO - Successfully uninstalled pip 04:22:50 INFO - Running setup.py install for pip 04:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 04:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 04:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:22:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:22:50 INFO - Successfully installed pip 04:22:50 INFO - Cleaning up... 04:22:50 INFO - Return code: 0 04:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:22:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:22:50 INFO - Using env: {'DISPLAY': ':0', 04:22:50 INFO - 'HOME': '/home/cltbld', 04:22:50 INFO - 'LANG': 'en_US.UTF-8', 04:22:50 INFO - 'LANGUAGE': 'en_US:en', 04:22:50 INFO - 'LOGNAME': 'cltbld', 04:22:50 INFO - 'MAIL': '/var/mail/cltbld', 04:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:50 INFO - 'MOZ_NO_REMOTE': '1', 04:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:50 INFO - 'NO_EM_RESTART': '1', 04:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:50 INFO - 'PWD': '/builds/slave/test', 04:22:50 INFO - 'SHELL': '/bin/bash', 04:22:50 INFO - 'SHLVL': '1', 04:22:50 INFO - 'TERM': 'linux', 04:22:50 INFO - 'TMOUT': '86400', 04:22:50 INFO - 'USER': 'cltbld', 04:22:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:50 INFO - '_': '/tools/buildbot/bin/python'} 04:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:50 INFO - Downloading/unpacking psutil>=3.1.1 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:51 INFO - Installing collected packages: psutil 04:22:51 INFO - Running setup.py install for psutil 04:22:51 INFO - building 'psutil._psutil_linux' extension 04:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:22:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:22:51 INFO - building 'psutil._psutil_posix' extension 04:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:22:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:52 INFO - Successfully installed psutil 04:22:52 INFO - Cleaning up... 04:22:52 INFO - Return code: 0 04:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:52 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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:22:52 INFO - Using env: {'DISPLAY': ':0', 04:22:52 INFO - 'HOME': '/home/cltbld', 04:22:52 INFO - 'LANG': 'en_US.UTF-8', 04:22:52 INFO - 'LANGUAGE': 'en_US:en', 04:22:52 INFO - 'LOGNAME': 'cltbld', 04:22:52 INFO - 'MAIL': '/var/mail/cltbld', 04:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:52 INFO - 'MOZ_NO_REMOTE': '1', 04:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:52 INFO - 'NO_EM_RESTART': '1', 04:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:52 INFO - 'PWD': '/builds/slave/test', 04:22:52 INFO - 'SHELL': '/bin/bash', 04:22:52 INFO - 'SHLVL': '1', 04:22:52 INFO - 'TERM': 'linux', 04:22:52 INFO - 'TMOUT': '86400', 04:22:52 INFO - 'USER': 'cltbld', 04:22:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:52 INFO - '_': '/tools/buildbot/bin/python'} 04:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:54 INFO - Installing collected packages: mozsystemmonitor 04:22:54 INFO - Running setup.py install for mozsystemmonitor 04:22:55 INFO - Successfully installed mozsystemmonitor 04:22:55 INFO - Cleaning up... 04:22:56 INFO - Return code: 0 04:22:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:22:56 INFO - Using env: {'DISPLAY': ':0', 04:22:56 INFO - 'HOME': '/home/cltbld', 04:22:56 INFO - 'LANG': 'en_US.UTF-8', 04:22:56 INFO - 'LANGUAGE': 'en_US:en', 04:22:56 INFO - 'LOGNAME': 'cltbld', 04:22:56 INFO - 'MAIL': '/var/mail/cltbld', 04:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:56 INFO - 'MOZ_NO_REMOTE': '1', 04:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:56 INFO - 'NO_EM_RESTART': '1', 04:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:56 INFO - 'PWD': '/builds/slave/test', 04:22:56 INFO - 'SHELL': '/bin/bash', 04:22:56 INFO - 'SHLVL': '1', 04:22:56 INFO - 'TERM': 'linux', 04:22:56 INFO - 'TMOUT': '86400', 04:22:56 INFO - 'USER': 'cltbld', 04:22:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:56 INFO - '_': '/tools/buildbot/bin/python'} 04:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:56 INFO - Downloading/unpacking jsonschema==2.5.1 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Installing collected packages: jsonschema, functools32 04:22:58 INFO - Running setup.py install for functools32 04:22:58 INFO - warning: no files found matching '*.txt' 04:22:58 INFO - no previously-included directories found matching 'build' 04:22:58 INFO - no previously-included directories found matching 'dist' 04:22:58 INFO - no previously-included directories found matching '.git*' 04:22:58 INFO - Successfully installed jsonschema functools32 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:00 INFO - Downloading docopt-0.6.1.tar.gz 04:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:00 INFO - Running setup.py install for blobuploader 04:23:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:00 INFO - Running setup.py install for requests 04:23:01 INFO - Running setup.py install for docopt 04:23:01 INFO - Successfully installed blobuploader requests docopt 04:23:01 INFO - Cleaning up... 04:23:01 INFO - Return code: 0 04:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:01 INFO - Running setup.py (path:/tmp/pip-ncXL6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:01 INFO - Running setup.py (path:/tmp/pip-fBJTXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:01 INFO - Running setup.py (path:/tmp/pip-g_IGHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:01 INFO - Running setup.py (path:/tmp/pip-Bc7UF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:01 INFO - Running setup.py (path:/tmp/pip-iiKOcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:01 INFO - Running setup.py (path:/tmp/pip-B8AoCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:01 INFO - Running setup.py (path:/tmp/pip-To15q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:01 INFO - Running setup.py (path:/tmp/pip-RMmCC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:01 INFO - Running setup.py (path:/tmp/pip-lPjSMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:02 INFO - Running setup.py (path:/tmp/pip-7LgH2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:02 INFO - Running setup.py (path:/tmp/pip-lx3DKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:02 INFO - Running setup.py (path:/tmp/pip-uYlNJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:02 INFO - Running setup.py (path:/tmp/pip-GZJkNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:02 INFO - Running setup.py (path:/tmp/pip-dQaXAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:02 INFO - Running setup.py (path:/tmp/pip-LSvFXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:02 INFO - Running setup.py (path:/tmp/pip-XBJ13X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:02 INFO - Running setup.py (path:/tmp/pip-VVITdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:02 INFO - Running setup.py install for manifestparser 04:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:02 INFO - Running setup.py install for mozcrash 04:23:02 INFO - Running setup.py install for mozdebug 04:23:02 INFO - Running setup.py install for mozdevice 04:23:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozfile 04:23:03 INFO - Running setup.py install for mozhttpd 04:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozinfo 04:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozInstall 04:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozleak 04:23:03 INFO - Running setup.py install for mozlog 04:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for moznetwork 04:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozprocess 04:23:03 INFO - Running setup.py install for mozprofile 04:23:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:03 INFO - Running setup.py install for mozrunner 04:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Running setup.py install for mozscreenshot 04:23:04 INFO - Running setup.py install for moztest 04:23:04 INFO - Running setup.py install for mozversion 04:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:04 INFO - Cleaning up... 04:23:04 INFO - Return code: 0 04:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:04 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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:04 INFO - Using env: {'DISPLAY': ':0', 04:23:04 INFO - 'HOME': '/home/cltbld', 04:23:04 INFO - 'LANG': 'en_US.UTF-8', 04:23:04 INFO - 'LANGUAGE': 'en_US:en', 04:23:04 INFO - 'LOGNAME': 'cltbld', 04:23:04 INFO - 'MAIL': '/var/mail/cltbld', 04:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:04 INFO - 'MOZ_NO_REMOTE': '1', 04:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:04 INFO - 'NO_EM_RESTART': '1', 04:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:04 INFO - 'PWD': '/builds/slave/test', 04:23:04 INFO - 'SHELL': '/bin/bash', 04:23:04 INFO - 'SHLVL': '1', 04:23:04 INFO - 'TERM': 'linux', 04:23:04 INFO - 'TMOUT': '86400', 04:23:04 INFO - 'USER': 'cltbld', 04:23:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:04 INFO - '_': '/tools/buildbot/bin/python'} 04:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 INFO - Running setup.py (path:/tmp/pip-FQxdRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 INFO - Running setup.py (path:/tmp/pip-w473gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:04 INFO - Running setup.py (path:/tmp/pip-lB8Iza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:04 INFO - Running setup.py (path:/tmp/pip-QjXp32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:04 INFO - Running setup.py (path:/tmp/pip-zZY2Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:04 INFO - Running setup.py (path:/tmp/pip-yJ0Sfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:05 INFO - Running setup.py (path:/tmp/pip-XovIWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:05 INFO - Running setup.py (path:/tmp/pip-wnti1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:05 INFO - Running setup.py (path:/tmp/pip-A56Vdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:05 INFO - Running setup.py (path:/tmp/pip-8Ii7b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:05 INFO - Running setup.py (path:/tmp/pip-ttkMzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:05 INFO - Running setup.py (path:/tmp/pip-DIjtAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:05 INFO - Running setup.py (path:/tmp/pip-Qs62VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:05 INFO - Running setup.py (path:/tmp/pip-Zeplx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 INFO - Running setup.py (path:/tmp/pip-bUEuz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:05 INFO - Running setup.py (path:/tmp/pip-wgRw7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:05 INFO - Running setup.py (path:/tmp/pip-XcqoZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:23:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23: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 04:23: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 04:23: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 04:23: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 04:23:06 INFO - Downloading blessings-1.6.tar.gz 04:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:07 INFO - Installing collected packages: blessings 04:23:07 INFO - Running setup.py install for blessings 04:23:07 INFO - Successfully installed blessings 04:23:07 INFO - Cleaning up... 04:23:07 INFO - Return code: 0 04:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:07 INFO - Reading from file tmpfile_stdout 04:23:07 INFO - Current package versions: 04:23:07 INFO - argparse == 1.2.1 04:23:07 INFO - blessings == 1.6 04:23:07 INFO - blobuploader == 1.2.4 04:23:07 INFO - docopt == 0.6.1 04:23:07 INFO - functools32 == 3.2.3-2 04:23:07 INFO - jsonschema == 2.5.1 04:23:07 INFO - manifestparser == 1.1 04:23:07 INFO - mozInstall == 1.13 04:23:07 INFO - mozcrash == 1.0 04:23:07 INFO - mozdebug == 0.1 04:23:07 INFO - mozdevice == 0.51 04:23:07 INFO - mozfile == 1.2 04:23:07 INFO - mozhttpd == 0.7 04:23:07 INFO - mozinfo == 0.10 04:23:07 INFO - mozleak == 0.1 04:23:07 INFO - mozlog == 3.5 04:23:07 INFO - moznetwork == 0.27 04:23:07 INFO - mozprocess == 0.25 04:23:07 INFO - mozprofile == 0.28 04:23:07 INFO - mozrunner == 6.13 04:23:07 INFO - mozscreenshot == 0.1 04:23:07 INFO - mozsystemmonitor == 0.3 04:23:07 INFO - moztest == 0.8 04:23:07 INFO - mozversion == 1.4 04:23:07 INFO - psutil == 3.1.1 04:23:07 INFO - requests == 1.2.3 04:23:07 INFO - wsgiref == 0.1.2 04:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:23:07 INFO - Using env: {'DISPLAY': ':0', 04:23:07 INFO - 'HOME': '/home/cltbld', 04:23:07 INFO - 'LANG': 'en_US.UTF-8', 04:23:07 INFO - 'LANGUAGE': 'en_US:en', 04:23:07 INFO - 'LOGNAME': 'cltbld', 04:23:07 INFO - 'MAIL': '/var/mail/cltbld', 04:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:07 INFO - 'MOZ_NO_REMOTE': '1', 04:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:07 INFO - 'NO_EM_RESTART': '1', 04:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:07 INFO - 'PWD': '/builds/slave/test', 04:23:07 INFO - 'SHELL': '/bin/bash', 04:23:07 INFO - 'SHLVL': '1', 04:23:07 INFO - 'TERM': 'linux', 04:23:07 INFO - 'TMOUT': '86400', 04:23:07 INFO - 'USER': 'cltbld', 04:23:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:07 INFO - '_': '/tools/buildbot/bin/python'} 04:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:23:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:23:08 INFO - Installing collected packages: simplejson 04:23:08 INFO - Running setup.py install for simplejson 04:23:08 INFO - building 'simplejson._speedups' extension 04:23:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:23:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:23:09 INFO - Successfully installed simplejson 04:23:09 INFO - Cleaning up... 04:23:09 INFO - Return code: 0 04:23:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:09 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 0x1f361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20feb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a1df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, '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-1506424741.73082-418985993', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:23:09 INFO - Using env: {'DISPLAY': ':0', 04:23:09 INFO - 'HOME': '/home/cltbld', 04:23:09 INFO - 'LANG': 'en_US.UTF-8', 04:23:09 INFO - 'LANGUAGE': 'en_US:en', 04:23:09 INFO - 'LOGNAME': 'cltbld', 04:23:09 INFO - 'MAIL': '/var/mail/cltbld', 04:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:09 INFO - 'MOZ_NO_REMOTE': '1', 04:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:09 INFO - 'NO_EM_RESTART': '1', 04:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:09 INFO - 'PWD': '/builds/slave/test', 04:23:09 INFO - 'SHELL': '/bin/bash', 04:23:09 INFO - 'SHLVL': '1', 04:23:09 INFO - 'TERM': 'linux', 04:23:09 INFO - 'TMOUT': '86400', 04:23:09 INFO - 'USER': 'cltbld', 04:23:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:09 INFO - '_': '/tools/buildbot/bin/python'} 04:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:10 INFO - Cleaning up... 04:23:10 INFO - Return code: 0 04:23:10 INFO - Running post-action listener: _resource_record_post_action 04:23:10 INFO - Running post-action listener: _start_resource_monitoring 04:23:10 INFO - Starting resource monitoring. 04:23:10 INFO - [mozharness: 2017-09-26 11:23:10.099368Z] Finished create-virtualenv step (success) 04:23:10 INFO - [mozharness: 2017-09-26 11:23:10.099891Z] Running install step. 04:23:10 INFO - Running pre-action listener: _resource_record_pre_action 04:23:10 INFO - Running main action method: install 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:10 INFO - Reading from file tmpfile_stdout 04:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:10 INFO - Reading from file tmpfile_stdout 04:23:10 INFO - Output received: 04:23:10 INFO - Usage: mozinstall [options] installer 04:23:10 INFO - Options: 04:23:10 INFO - -h, --help show this help message and exit 04:23:10 INFO - -d DEST, --destination=DEST 04:23:10 INFO - Directory to install application into. [default: 04:23:10 INFO - "/builds/slave/test"] 04:23:10 INFO - --app=APP Application being installed. [default: firefox] 04:23:10 INFO - mkdir: /builds/slave/test/build/application 04:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:23:28 INFO - Reading from file tmpfile_stdout 04:23:28 INFO - Output received: 04:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:28 INFO - Running post-action listener: _resource_record_post_action 04:23:28 INFO - [mozharness: 2017-09-26 11:23:28.087455Z] Finished install step (success) 04:23:28 INFO - [mozharness: 2017-09-26 11:23:28.087603Z] Running setup-mitmproxy step. 04:23:28 INFO - Running pre-action listener: _resource_record_pre_action 04:23:28 INFO - Running main action method: setup_mitmproxy 04:23:28 INFO - Skipping: mitmproxy is not required 04:23:28 INFO - Running post-action listener: _resource_record_post_action 04:23:28 INFO - [mozharness: 2017-09-26 11:23:28.088135Z] Finished setup-mitmproxy step (success) 04:23:28 INFO - [mozharness: 2017-09-26 11:23:28.088239Z] Running run-tests step. 04:23:28 INFO - Running pre-action listener: _resource_record_pre_action 04:23:28 INFO - Running pre-action listener: _set_gcov_prefix 04:23:28 INFO - Running main action method: run_tests 04:23:28 WARNING - Try message not found. 04:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:28 INFO - Python 2.7.3 04:23:28 INFO - Return code: 0 04:23:28 INFO - grabbing minidump binary from tooltool 04:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a5440>, '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 0x22a6130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a0320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:23:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:23:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:28 INFO - Return code: 0 04:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:28 INFO - ENV: RUST_BACKTRACE is now full 04:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 04:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/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-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 04:23:28 INFO - Using env: {'DISPLAY': ':0', 04:23:28 INFO - 'HOME': '/home/cltbld', 04:23:28 INFO - 'LANG': 'en_US.UTF-8', 04:23:28 INFO - 'LANGUAGE': 'en_US:en', 04:23:28 INFO - 'LOGNAME': 'cltbld', 04:23:28 INFO - 'MAIL': '/var/mail/cltbld', 04:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:28 INFO - 'MOZ_NO_REMOTE': '1', 04:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:28 INFO - 'NO_EM_RESTART': '1', 04:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:28 INFO - 'PWD': '/builds/slave/test', 04:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:28 INFO - 'RUST_BACKTRACE': 'full', 04:23:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:23:28 INFO - 'SHELL': '/bin/bash', 04:23:28 INFO - 'SHLVL': '1', 04:23:28 INFO - 'TERM': 'linux', 04:23:28 INFO - 'TMOUT': '86400', 04:23:28 INFO - 'USER': 'cltbld', 04:23:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:28 INFO - '_': '/tools/buildbot/bin/python'} 04:23:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/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-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 04:23:28 INFO - mozversion application_buildid: 20170926095452 04:23:28 INFO - mozversion application_changeset: bc56729898954e32d3a3731d03d178ed78924c33 04:23:28 INFO - mozversion application_display_name: Nightly 04:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:28 INFO - mozversion application_name: Firefox 04:23:28 INFO - mozversion application_remotingname: firefox 04:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion application_vendor: Mozilla 04:23:28 INFO - mozversion application_version: 58.0a1 04:23:28 INFO - mozversion platform_buildid: 20170926095452 04:23:28 INFO - mozversion platform_changeset: bc56729898954e32d3a3731d03d178ed78924c33 04:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:28 INFO - mozversion platform_version: 58.0a1 04:23:28 INFO - using testdate: 1506425008 04:23:28 INFO - actual date: 1506425008 04:23:28 INFO - starting webserver on 'localhost:53386' 04:23:28 INFO - SUITE-START | Running 2 tests 04:23:28 INFO - TEST-START | dromaeo_css 04:23:28 INFO - Initialising browser for dromaeo_css test... 04:23:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53386/getInfo.html -profile /tmp/tmpza6fG2/profile 04:23:28 INFO - TEST-INFO | started process 17487 (/builds/slave/test/build/application/firefox/firefox http://localhost:53386/getInfo.html) 04:23:33 INFO - TEST-INFO | 17487: exit 0 04:23:33 INFO - Browser initialized. 04:23:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:33 INFO - Using env: {'DISPLAY': ':0', 04:23:33 INFO - 'HOME': '/home/cltbld', 04:23:33 INFO - 'JSGC_DISABLE_POISONING': '1', 04:23:33 INFO - 'LANG': 'en_US.UTF-8', 04:23:33 INFO - 'LANGUAGE': 'en_US:en', 04:23:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:23:33 INFO - 'LOGNAME': 'cltbld', 04:23:33 INFO - 'MAIL': '/var/mail/cltbld', 04:23:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:33 INFO - 'MOZ_CRASHREPORTER': '1', 04:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:23:33 INFO - 'MOZ_NO_REMOTE': '1', 04:23:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:33 INFO - 'NO_EM_RESTART': '1', 04:23:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:33 INFO - 'PWD': '/builds/slave/test', 04:23:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:33 INFO - 'RUST_BACKTRACE': 'full', 04:23:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:23:33 INFO - 'SHELL': '/bin/bash', 04:23:33 INFO - 'SHLVL': '1', 04:23:33 INFO - 'STYLO_FORCE_DISABLED': '1', 04:23:33 INFO - 'TERM': 'linux', 04:23:33 INFO - 'TMOUT': '86400', 04:23:33 INFO - 'USER': 'cltbld', 04:23:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:33 INFO - '_': '/tools/buildbot/bin/python'} 04:23:33 INFO - TEST-INFO | started process 17727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpza6fG2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:34 INFO - PID 17727 | 04:23:34 INFO - PID 17727 | (/builds/slave/test/build/application/firefox/firefox:17777): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:23:34 INFO - PID 17727 | 04:23:45 INFO - PID 17727 | RSS: Main: 144461824 04:23:45 INFO - PID 17727 | 04:26:41 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53386/tests/dromaeo/cssquery-ext.html) 04:26:42 INFO - PID 17727 | RSS: Main: 146210816 04:26:42 INFO - PID 17727 | 04:29:44 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-ext.html (next: http://localhost:53386/tests/dromaeo/cssquery-jquery.html) 04:29:45 INFO - PID 17727 | RSS: Main: 146010112 04:29:45 INFO - PID 17727 | 04:32:46 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53386/tests/dromaeo/cssquery-mootools.html) 04:32:47 INFO - PID 17727 | RSS: Main: 147996672 04:32:47 INFO - PID 17727 | 04:35:48 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53386/tests/dromaeo/cssquery-prototype.html) 04:35:49 INFO - PID 17727 | RSS: Main: 146538496 04:35:49 INFO - PID 17727 | 04:38:52 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53386/tests/dromaeo/cssquery-yui.html) 04:38:53 INFO - PID 17727 | RSS: Main: 148291584 04:38:53 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | Cycle 1(1): loaded http://localhost:53386/tests/dromaeo/cssquery-yui.html (next: http://localhost:53386/tests/dromaeo/cssquery-dojo.html) 04:41:54 INFO - PID 17727 | RSS: Main: 150532096 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | __start_tp_report 04:41:54 INFO - PID 17727 | _x_x_mozilla_page_load 04:41:54 INFO - PID 17727 | _x_x_mozilla_page_load_details 04:41:54 INFO - PID 17727 | |i|pagename|runs| 04:41:54 INFO - PID 17727 | |0;dojo.html;3863.4977452931116;3877.9612203877955;3898.376259798433;3901.531816182058;3922.921541569167;6161.260648722148;6233.1585235993125;6257.468115210207;6288.151099601552;6344.6510441925675;6206;6266.62400255985;6332.081848132018;6361.141245931798;6371.649559274238;5618.5786066045;5695.515881150087;5728.856778580527;5770.2210201622875;5780.335261444925;198.06597231403074;5422.240886275905;5646.858828529299;5739.081746920494;5755.798547050854;5644.294463192101;5656.830295091154;5746.65520068793;5755.65466072037;5757.884842303151;5670.886582268332;5671.886562268732;5746.540276777848;5752.683602401867;5760.308762948431;5626.803061892814;5628.183913332585;5712.514436272922;5713.771449142029;5716.657000579979;6273.341299163568;6309.810705678791;6340.461060809836;6348.682565871734;6357.364263573651;6750.62871542065;6836.316368363174;6843.520953533254;6845.794626161173;6851.45188384928;6874.140732408449;6979.546329488567;6981.685824137926;6987.196472405688;6989.545679530815;6312.652804095773;6371.808845734636;6379.457746091588;6389.1694079769795;6432.0995060691075;7067.82330441743;7115.466340024519;7144.857102857914;7161.498695091398;7163.3552980232025;6775.457963363017;6780.93219067803;6862.142232220973;6866.896996545056;6868.862622747517;6813.625250611165;6875.862482750317;6895.75864844728;6903.5167538271835;6966.477514186457;6806.897896531556;6814.795556133324;6818.590884546943;6831.726730930806;6836;6693.497987650849;6735.730570777212;6752.662366881636;6830.419414349736;6871.381575658214;4974.577160941288;5003.524665156804;5016.774245158977;5054.7472626368535;5063.012712521097;4557.863264102082;4617.191991401492;4631.235846085426;4637.65217608674;4650.046740418206;6270.623762574261;6307.747690092437;6344.555881088372;6352.7141278642575;6363.7772677956045;6709.932900671029;6718.8320291993095;6725.495587830932;6807.761728339485;6823.965880170567;6259.1550140730415;6361.745530178741;6381.266154392211;6440.935590644127;6444.645544495004;5506.779728810803;5507.834764956978;5574.832755017274;5610.85972850682;5618.016847051749;6980.336867997532;7098.716051357991;7112.964435177894;7218.566885986857;7226.168990566047;6784.966075169593;6808.183018037768;6891.689873955785;6899.862002760017;6932.029515867682;7048.436125109876;7134.928650713427;7139.964300178466;7191.2449192834;7211.098612673416;6663.866722665616;6753;6754.493412994143;6829.453643708591;6848;6802.217744959393;6807.047013418224;6885.414739747178;6888.621125837926;6923.653817309014;6648.468122550088;6679.833004174934;6712.228093769279;6712.228093769279;6737.258901520927;6595.472362211108;6615.338466153346;6622.37087476689;6707.496937729592;6708.19501659804;6455.644939528371;6520.315366886409;6600.53796234259;6613.603183808987;6621.1392518972225;6670.733170673118;6682.899756503753;6714.462842972648;6747.595144291358;6793.66031698423;6304.243490781136;6513.250976137805;6520.673966301571;6537;6547.476201903932 04:41:54 INFO - PID 17727 | |1;ext.html;918.7060140754959;938.5823308627663;940.3558562384767;943.2359788571258;944.0370821761808;40787.79606101969;43546;43736;43921.34117988233;43975.340369894475;42217.57782422175;42470.787646061806;42511;42525.14949701004;42597.14805703892;7388.815279618026;7462.403007759366;7487.850242995137;7528.209537998486;8395.454295470805;8186.672533098669;8235.423520353577;8254.793630159264;8257.545834979073;8264.256216940474;8252.958735206346;8260.710875119372;8314.542700151489;8320.167983201693;8328.33373330132;8297.294729947962;8613.310935125237;8627.094155113717;8634.956825215833;8637.827243455127;8353.958230208871;8372.372072094557;8430.578471076422;8430.74707758762;8436.915630843736;37771.811140944395;37789;38012.23975520474;38113.618863811564;38282.425763613566;3683.557973043252;3685.7419980601367;3698.9075273118387;3719.4048952167523;3720.2373513429684;34301.82849085764;34445;34476.82761586176;34556.48165277523;34567.827160864035;5431.131019036935;5450.645708028966;5457.208704737791;5463.590230732671;5484.424135465759;221684;222725;223482;224199;225253.87373063192;47185.29222061672;53820.73089634527;53828;54040.729796350766;54073;51286.48713512817;57944;58756;58773.11840322398;58801.70599146977;16290.918545407198;16372.67254654924;16375.426860060079;16383.42658006988;16397.344106235854;13296.800547991788;13313.201207927556;13327.067105302729;13338.73322533544;13369.933150334185;15585.142817144939;15658;15671.216439177995;15684.058956462648;15735.606609834846;6053.545984051214;6078.483328917092;6187.381261873777;6187.566870319124;6228.377162283826;1084.6312253833576;1102.3826657072066;1103.1175059952006;1116.4027245423658;1120.3278033180027;25935.74064259371;25995.61006584903;26068;26210;26233;1202;1210.9152359334762;1229.6188181663713;1231.8275441438207;1234.975300493985;13515.864841351657;13690.247036413093;13728.931355343359;13738.931305343409;14033.508827191203;296260;296763;297441;297628;297712;58832.705836470544;59224.7038764812;59288.703556482804;59344.70327648334;59445;1501.3169008101506;1513.9394424222908;1536.784850120984;1559.5711179425748;1566.8824838136957;25215.495690086464;25283.620745689197;25506.107286244893;25515.234542962997;25570.61644075303;40538.59461405348;40593.59406405898;40716.59283407128;40734.38898416467;40814.38778418267;238222;238696;266083;266863;267501;37564.62435375611;37862.43206351852;41666.58333416627;42118;42146.78926605347;53250.73374633102;53409.465905342004;53552.73223633857;53913.73043134759;54084;37689.24621507609;38180;38573.614263857;38677;38940.41589376218;38115.80942095272;38173.236535269694;38219.2356152881;38549;39036;43902.56097439113;44803.551964481245;45063.0987380244;45326.77336613428;45485.772571136935;37035.6296437043;37585.4362184562;37835;37965.81017094897;38266.808665956494;27535.44929101447;27871.303217418914;27885.302867427665;27972;28308 04:41:54 INFO - PID 17727 | |2;jquery.html;599.9700014999252;612.8621060261445;615.1142355008784;618.6473709985308;632.9620222786632;23191.536169276606;23731.406714832116;23946;23970.76029239707;24106.397340066505;24955.75044249557;27073.32316692079;27278.181654550393;27297.181084567495;27338.179854604343;6496.740130394778;6627.204735431755;6631.104800851896;6694.866102677944;6716.261211266757;6455.644939528324;6552.049952756847;6668.266490686021;6698.564593301444;6760.459163266927;6746.763863264762;6755.7973260802255;6759.188897332327;6762.8309292267595;6766.864662706743;6625.0724898514245;6728.764493242737;6730.697118629649;6767.154105736808;6868.278830722752;6349.238091429058;6359.682015899187;6405.935940640627;6411.166548348731;6413.454856337217;29609.40781184364;30201;30275;30315.393692126254;30430.239244019078;2258.853174543666;2270.9545809083725;2275.70415845939;2285.737140228878;2286.1312701173615;21031.5793684127;21268.14927402902;21701.565968680537;21978.780212197835;21989.67015494769;2485.328961180471;2515.3963048868322;2558.9360265993314;2581.019212699181;2583.3412479817716;132370;137018;142379;147938.99999999892;147954;15532.767008494882;16345.673086538203;16408.343666253455;16594.917025415038;16676.16619169037;25730.356741081247;25838.741612583635;25997.350066248495;26024.34939126537;26038.86980565085;10474.371537707762;10538.631147909786;10694.144468442506;10774.676759697222;10927.398993055458;9503.66737164196;9530.857037144448;9643.614255429844;9680.031996800404;9734.951325243328;9594.568244429018;9722;9884.703458896245;9888.258380621483;10054.849177262347;2775.736305051017;2849.244950088228;2913.2716820794803;2933.193371822766;2969.6391368861805;1031.3193292427113;1052.3896140238644;1058.5606973106228;1063.7925604507047;1065.1851333729703;21654.133834646436;21757.67363489549;21774.346769596938;21940.561188776133;22432.439189020406;1098.7912296663608;1123.9943800280946;1124.3647339253296;1130.8473356096986;1137.9544818207344;12114.273143611235;12156.635300940987;12170.087243456775;12213;12229.816552751538;546341;560019;564025;567597;583167;124164;124333;127206.36396817956;127347;129453;1138.9442057087037;1194.1223200947297;1232.2421710648066;1237.307108019512;1298.4092238031674;22636.207732729275;23122.884385577963;23249;23270.301890943298;23302.417439564146;59276;59884.70057649684;60424.093638594575;60513.0923036146;62255;78380.60809696143;78778.60610696909;79172.20827791879;79506;80451.19548804437;15512.534623960848;16002.359905603646;16017.439389621773;16139.031658100552;16140.919295403448;24503.38741531476;24543.631845521973;25087.372815679755;25115;25196.74803251944;20392;20413.67311124772;20670.17319307271;20794.792052079287;20854;17109.23008464647;17973.55066123305;18156.636867262845;18408.35570755017;18665.720014199527;20248.291309804084;20844.166233350497;20909.26817561378;20921.1631534743;21006.159753609685;14999.00019996027;15640.687186256439;15677.608059798597;15683.921580392025;15816.05103693782;20288.695669565263;20535.589288213854;20559;20677.58644827125;20687.79312206919 04:41:54 INFO - PID 17727 | |3;mootools.html;1408.3099281352136;1475.3655927950977;1488.903221290616;1495.2374289112552;1511.2292730707343;16111.59721006974;16873.746893796604;16906.070166140857;16924.153792310364;16979.15104244786;16438.424655137074;16524.09117498537;16590;16594.336226550953;16607.50177494674;2667.479841430917;2699.0283497940727;2699.676038875338;2707.6480057592585;2717.2391730315544;2639.9868000660067;2702.3514356554383;2703.1079743684636;2703.1349968010245;2706.269307287031;2608.6869575650853;2639.8944042238286;2640.9471810563778;2641.379275870169;2646.5103955768245;2536.353229926366;2552.119518766023;2557.105013245377;2557.8337408068414;2560.423904621464;2566.3840678237275;2599.2202339298324;2617.9607305890427;2620.2532278300782;2621.082621082625;16042.5989350266;16048.197590120448;16199;16209.108499032549;16234.512964610962;8138.226868447488;8385.706500272461;8406.411551191419;8421.24208821209;8421.663133474654;5066.898662026776;5386.030514507387;5412.377576578665;5452.809151679672;5514.393416724157;1976.5355141541727;1997.504367357125;1999.380192140441;2075.2010475966863;2148.1429698500956;27025.1892443227;27865.16404507868;29816.254593635116;30796.230094247374;30818.22954426135;7265.564066156047;7407.444441666897;7425.405967522585;7520.511166774142;7527.096748390229;22466.775332246794;22568.887155564447;22621.886890565773;22632.660510092363;22662.546749064928;8685;8782.648694052294;8804.427712198687;8812.9865065517;8816.8677469838;7703.460757746904;7841.607919603997;7855.33229675484;7867.370610351159;7897.24976127267;5694.6583205007;5861.7655293787775;5889.764409423575;5913.408659134138;5942.732577034044;1675.0703359635277;1675.4052311429266;1701.123921180593;1711.8801683882257;1722.6477215385862;962.119660510625;963.7542426681151;974.468914441631;995.721198064543;999.14073896449;8470.110638383005;8470.703525376706;8472.66109355619;8519.446235994641;8569.271611912933;773.9187385324573;790.9762707118796;814.0800894988625;830.588858515039;832.2925513313635;5197.454267301879;5270.7628156733035;5339.626226164131;5373.005993891143;5375.543078838343;24102.638460423106;24126.276211713677;25269.368265793135;25387.492250154894;25450.236492905242;24738.752612473643;24804;24806.37984050413;24992.250232493054;25037.749622503543;11375.601853935239;11674.766504669858;11753.177277590657;11793.11551633648;11807.468663910146;9287.024862389622;9334.20659243972;9377.062293770841;9385.812283754423;9399.10708482693;20448.750637430167;20515.897420512803;20977;21025;21420.78579214188;21634.89182554077;21734.89132554327;21994.34016979493;22135.557288854456;22781.544369112857;13192.604221873358;13459.327033648475;13464.798028029392;13470.663233419244;13471;14980.625484362543;14984.550463486114;15030.398784048515;15034.398624054915;15200.163990980602;11979.940100299442;12071.094667900119;12297.938510307391;12389.132760706663;12519;11868.228565143238;11897.345645989553;11921;12130.696732581757;12313.56902508408;10811.189160813128;10980.231383803057;11017.228793984345;11024.834627480433;11031.558737650405;8246.257836794717;8394.37042221848;8444.451110677786;8462.661493540436;8567.100454452442;8419.831603367777;8446.66213351459;8463.322934165375;8488.618012189343;8511.106333834858 04:41:54 INFO - PID 17727 | |4;prototype.html;551.5642642312571;561.2899681902393;579.4234736437246;585.1281590430259;593.2258402784365;6257.9310758285765;6270.874582508347;6275.843103922399;6276.152719382893;6306.05409188622;6075.878482430348;6158.230221222348;6177.505799536038;6227.657478838662;6258.749650013994;4899.51004899509;4994.350734404522;5136.306598609196;5139.614528910328;5155.587552995761;4964.801407943678;5034.421041580228;5039.697618142924;5060.39275286966;5065.721385323805;4944.579710724593;4966.205407134859;4991.101601711691;5001.774920128603;5010.574101201402;4946.530079642428;4981.302617633534;5005.349304590416;5016.874578135539;5027.321311622921;4547.818087276505;4574.0394517151435;4578.839740609096;4580.381648477446;4580.816767329303;6037.7584896604085;6077.301110372319;6177.011678131522;6202.441780239755;6226.066090086478;5813.970930145322;5833.38749431312;5833.804070165648;5873.706314684291;5904.8780731660845;6486.745735953892;6549.181352330958;6578.473722102221;6629.436497897636;6629.535932484728;4843.443004054544;4997.375328083989;5071.18860982241;5074.213496907985;5090.211017292326;6822.727090916357;6871.732328331688;6965.442764578872;6979.162500499972;6991.196012458581;5210.947890521122;5211.661242019332;5218.869528261824;5230.581553475713;5240.790368385298;5211.348581427322;5299.728065264386;5304.867378315573;5325.840224793263;5329.280547126088;5835.387284335168;5837.532997360201;5887.293524776968;5892.587518873637;5939.22790037301;6659.200895892427;6663.167104111986;6670.599764014175;6722.697478613474;6732.427743641845;1762.3126980477623;1786.937457188992;1791.8835275707038;1802.2790883646385;1809.9276028958957;1234.7283597608512;1292.1730092740654;1305.830242068544;1311.206719934426;1311.6065180445828;6103.816885493442;6148.723307451175;6190.288116866618;6194.4115309045565;6247.2815626202655;6405.263394709668;6574.605523668595;6630;6636.96681516599;6665.366790154928;6042.667653279112;6086.60437071589;6087.452129308295;6162.383761623802;6163.537734669918;3487.953613915815;3499.527563778908;3508.0703613542432;3508.5088087667746;3551.396262635358;6886.622675464927;6931.6880740366805;6959.512834101665;6999.965000174967;7000.404965577881;6849.520533562602;6852.177738671292;6961.547499412522;6991.545549539263;6995.93004069963;7013.368796808311;7019.3682568569075;7028.613426261605;7030.156381234285;7049.8237544060785;6558;6575.2767195607485;6579.901301480386;6627.4698024158915;6638.402543771083;6647.767328143492;6766.357196066366;6777.356151165632;6802.285759995129;6815.69329380189;6923.5499692519825;7043;7052.365287124184;7132.072830531998;7139.32176443237;5138.049460849755;5149.665271757323;5166.793328266827;5190.532852043334;5193.92209116856;6435.903461447989;6542.705578248895;6639.4356479697835;6652.866942661023;6716;6104.908426373519;6496.285408604956;6500.577462464925;6501.349865013461;6532.8366790830605;6393.488520918222;6415.133956915756;6428.035794630843;6442.613443193423;6461.709223085067;6292;6301.590396624205;6314.652694101868;6398.496353356864;6418.775342862978;6458.4790646548545;6508.251551071688;6533.640649764308;6556.3443655634055;6577.473802095725;6316.936830631635;6403.96798016007;6409.679516024087;6410.358964103552;6413.7113829876835 04:41:54 INFO - PID 17727 | |5;yui.html;944.2493217891775;978.8678528398666;992.2805965674887;1005.3113617172238;1016.4663551635393;20032.19871205152;20451.48871278215;20491.282805101826;20539.486512837186;20548.691769623467;19557.902210488963;19782.30761923333;19854.900725496387;20124.899375503137;20331.796682033175;1027.8149933012073;1050.2018465965843;1050.8949105089507;1051.1800795379615;1051.8527406163143;1044.300318786415;1085.8045551800674;1093.147345070846;1093.9507722152523;1097.38546414008;1169.7426566155432;1172.495826794478;1172.8768479309635;1173.337064558526;1173.4191575170303;1086.2016417932814;1151.77540379626;1161.8489596352504;1163.2090178678495;1163.5113252433955;816.2286639126029;823.6911158315631;824.8968878890139;826.9793255168609;828.2876726015621;21322.573548528944;21344.35966920995;21399.8930005349;21514.354569362946;21532.892335538378;22460.32619021432;23877.88061059701;23889.40276493084;23904.641430378557;23945.161919332913;17304.307827686876;17402;17532.737008944878;17612.559686007826;17625.911870440566;3883.0680636647285;3910.7066969977363;3913.9021524462114;3916.432117342998;3917.216556688674;164818;166462;166746;166967;168557;16958.152092395332;17239.913800430917;17408.39070632547;17507.56231094233;17554.21006054705;29252;29724.256893577833;29769.702302977126;29884.701152988626;29980.700192997792;9860.408375497349;9863.654772082942;9872.555734991942;9890.357126786736;9895.406275623485;4646.4191976003;4667.486576476585;4715.316279139505;4759.714417134983;4763.7141771493125;5934.821955341346;6063.818085457443;6074.271087469532;6080;6102.298235702862;1105.8396532502743;1149.402310798397;1165.1377980294521;1171.1801738782885;1180.6162997026001;743.2270438743755;757.394084732212;771.1324759645399;778.5484419036945;782.1748055801185;11817.704557386134;12126.575569855013;12268.81596776049;13128.212307261594;13300.600981970556;690.7651398524525;694.624902552626;696.8014115977023;705.9682314295869;709.5139829217003;5863.208466857005;5919.6744179070565;5922.230110085661;6055.545834062463;6114.11345354921;147240;151616;151697;153082;157770;123400.38299808443;123936;126999;131068;135120;111585.44207278911;114384;115611.42194289144;115657;119881;13195.20828750278;13378.93310533441;13559.93220033933;13568.660783480493;13810.93094534521;54294;54372.184417234566;54732.452675472734;55039.724801375734;56394.87210255854;69665;69767;70749;71302.28697712957;71403;17466.476005719847;18080.367187148386;18149.18328675239;18186.90906545512;18362.81637183611;20405.48986275355;20450.181992720125;20590.382288531368;20741.68887466659;20920.895395522926;18422;19142.138603763142;19255.22979080821;19362.322318718776;19604.313849015216;19341;19416.4175074748;19482.512937176685;19512.21951121939;19751.60496790085;18126.81873181304;18440.35458758937;18493.630127397646;18603.44189674312;18606.81393186051;12922.870771292542;12955.157914735511;13027.544035958696;13161.802572961606;13332;13231.3384330785;13380;13612.65968350799;13615.931920340336;13705.451781928612 04:41:54 INFO - PID 17727 | __end_tp_report 04:41:54 INFO - PID 17727 | __start_cc_report 04:41:54 INFO - PID 17727 | _x_x_mozilla_cycle_collect,261 04:41:54 INFO - PID 17727 | __end_cc_report 04:41:54 INFO - PID 17727 | __startTimestamp1506426114813__endTimestamp 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | ------- Summary: start ------- 04:41:54 INFO - PID 17727 | Number of tests: 6 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#0] dojo.html Cycles:165 Average:6282.83 Median:6595.47 stddev:884.41 (13.4%) stddev-sans-first:866.51 04:41:54 INFO - PID 17727 | Values: 3863.5 3878.0 3898.4 3901.5 3922.9 6161.3 6233.2 6257.5 6288.2 6344.7 6206.0 6266.6 6332.1 6361.1 6371.6 5618.6 5695.5 5728.9 5770.2 5780.3 198.1 5422.2 5646.9 5739.1 5755.8 5644.3 5656.8 5746.7 5755.7 5757.9 5670.9 5671.9 5746.5 5752.7 5760.3 5626.8 5628.2 5712.5 5713.8 5716.7 6273.3 6309.8 6340.5 6348.7 6357.4 6750.6 6836.3 6843.5 6845.8 6851.5 6874.1 6979.5 6981.7 6987.2 6989.5 6312.7 6371.8 6379.5 6389.2 6432.1 7067.8 7115.5 7144.9 7161.5 7163.4 6775.5 6780.9 6862.1 6866.9 6868.9 6813.6 6875.9 6895.8 6903.5 6966.5 6806.9 6814.8 6818.6 6831.7 6836.0 6693.5 6735.7 6752.7 6830.4 6871.4 4974.6 5003.5 5016.8 5054.7 5063.0 4557.9 4617.2 4631.2 4637.7 4650.0 6270.6 6307.7 6344.6 6352.7 6363.8 6709.9 6718.8 6725.5 6807.8 6824.0 6259.2 6361.7 6381.3 6440.9 6444.6 5506.8 5507.8 5574.8 5610.9 5618.0 6980.3 7098.7 7113.0 7218.6 7226.2 6785.0 6808.2 6891.7 6899.9 6932.0 7048.4 7134.9 7140.0 7191.2 7211.1 6663.9 6753.0 6754.5 6829.5 6848.0 6802.2 6807.0 6885.4 6888.6 6923.7 6648.5 6679.8 6712.2 6712.2 6737.3 6595.5 6615.3 6622.4 6707.5 6708.2 6455.6 6520.3 6600.5 6613.6 6621.1 6670.7 6682.9 6714.5 6747.6 6793.7 6304.2 6513.3 6520.7 6537.0 6547.5 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#1] ext.html Cycles:180 Average:44361.50 Median:38274.62 stddev:67822.60 (177.2%) stddev-sans-first:67934.42 04:41:54 INFO - PID 17727 | Values: 918.7 938.6 940.4 943.2 944.0 40787.8 43546.0 43736.0 43921.3 43975.3 42217.6 42470.8 42511.0 42525.1 42597.1 7388.8 7462.4 7487.9 7528.2 8395.5 8186.7 8235.4 8254.8 8257.5 8264.3 8253.0 8260.7 8314.5 8320.2 8328.3 8297.3 8613.3 8627.1 8635.0 8637.8 8354.0 8372.4 8430.6 8430.7 8436.9 37771.8 37789.0 38012.2 38113.6 38282.4 3683.6 3685.7 3698.9 3719.4 3720.2 34301.8 34445.0 34476.8 34556.5 34567.8 5431.1 5450.6 5457.2 5463.6 5484.4 221684.0 222725.0 223482.0 224199.0 225253.9 47185.3 53820.7 53828.0 54040.7 54073.0 51286.5 57944.0 58756.0 58773.1 58801.7 16290.9 16372.7 16375.4 16383.4 16397.3 13296.8 13313.2 13327.1 13338.7 13369.9 15585.1 15658.0 15671.2 15684.1 15735.6 6053.5 6078.5 6187.4 6187.6 6228.4 1084.6 1102.4 1103.1 1116.4 1120.3 25935.7 25995.6 26068.0 26210.0 26233.0 1202.0 1210.9 1229.6 1231.8 1235.0 13515.9 13690.2 13728.9 13738.9 14033.5 296260.0 296763.0 297441.0 297628.0 297712.0 58832.7 59224.7 59288.7 59344.7 59445.0 1501.3 1513.9 1536.8 1559.6 1566.9 25215.5 25283.6 25506.1 25515.2 25570.6 40538.6 40593.6 40716.6 40734.4 40814.4 238222.0 238696.0 266083.0 266863.0 267501.0 37564.6 37862.4 41666.6 42118.0 42146.8 53250.7 53409.5 53552.7 53913.7 54084.0 37689.2 38180.0 38573.6 38677.0 38940.4 38115.8 38173.2 38219.2 38549.0 39036.0 43902.6 44803.6 45063.1 45326.8 45485.8 37035.6 37585.4 37835.0 37965.8 38266.8 27535.4 27871.3 27885.3 27972.0 28308.0 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#2] jquery.html Cycles:180 Average:38478.08 Median:23286.36 stddev:94432.24 (405.5%) stddev-sans-first:94654.32 04:41:54 INFO - PID 17727 | Values: 600.0 612.9 615.1 618.6 633.0 23191.5 23731.4 23946.0 23970.8 24106.4 24955.8 27073.3 27278.2 27297.2 27338.2 6496.7 6627.2 6631.1 6694.9 6716.3 6455.6 6552.0 6668.3 6698.6 6760.5 6746.8 6755.8 6759.2 6762.8 6766.9 6625.1 6728.8 6730.7 6767.2 6868.3 6349.2 6359.7 6405.9 6411.2 6413.5 29609.4 30201.0 30275.0 30315.4 30430.2 2258.9 2271.0 2275.7 2285.7 2286.1 21031.6 21268.1 21701.6 21978.8 21989.7 2485.3 2515.4 2558.9 2581.0 2583.3 132370.0 137018.0 142379.0 147939.0 147954.0 15532.8 16345.7 16408.3 16594.9 16676.2 25730.4 25838.7 25997.4 26024.3 26038.9 10474.4 10538.6 10694.1 10774.7 10927.4 9503.7 9530.9 9643.6 9680.0 9735.0 9594.6 9722.0 9884.7 9888.3 10054.8 2775.7 2849.2 2913.3 2933.2 2969.6 1031.3 1052.4 1058.6 1063.8 1065.2 21654.1 21757.7 21774.3 21940.6 22432.4 1098.8 1124.0 1124.4 1130.8 1138.0 12114.3 12156.6 12170.1 12213.0 12229.8 546341.0 560019.0 564025.0 567597.0 583167.0 124164.0 124333.0 127206.4 127347.0 129453.0 1138.9 1194.1 1232.2 1237.3 1298.4 22636.2 23122.9 23249.0 23270.3 23302.4 59276.0 59884.7 60424.1 60513.1 62255.0 78380.6 78778.6 79172.2 79506.0 80451.2 15512.5 16002.4 16017.4 16139.0 16140.9 24503.4 24543.6 25087.4 25115.0 25196.7 20392.0 20413.7 20670.2 20794.8 20854.0 17109.2 17973.6 18156.6 18408.4 18665.7 20248.3 20844.2 20909.3 20921.2 21006.2 14999.0 15640.7 15677.6 15683.9 15816.1 20288.7 20535.6 20559.0 20677.6 20687.8 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#3] mootools.html Cycles:180 Average:10367.80 Median:2582.80 stddev:7724.58 (299.1%) stddev-sans-first:7716.92 04:41:54 INFO - PID 17727 | Values: 1408.3 1475.4 1488.9 1495.2 1511.2 16111.6 16873.7 16906.1 16924.2 16979.2 16438.4 16524.1 16590.0 16594.3 16607.5 2667.5 2699.0 2699.7 2707.6 2717.2 2640.0 2702.4 2703.1 2703.1 2706.3 2608.7 2639.9 2640.9 2641.4 2646.5 2536.4 2552.1 2557.1 2557.8 2560.4 2566.4 2599.2 2618.0 2620.3 2621.1 16042.6 16048.2 16199.0 16209.1 16234.5 8138.2 8385.7 8406.4 8421.2 8421.7 5066.9 5386.0 5412.4 5452.8 5514.4 1976.5 1997.5 1999.4 2075.2 2148.1 27025.2 27865.2 29816.3 30796.2 30818.2 7265.6 7407.4 7425.4 7520.5 7527.1 22466.8 22568.9 22621.9 22632.7 22662.5 8685.0 8782.6 8804.4 8813.0 8816.9 7703.5 7841.6 7855.3 7867.4 7897.2 5694.7 5861.8 5889.8 5913.4 5942.7 1675.1 1675.4 1701.1 1711.9 1722.6 962.1 963.8 974.5 995.7 999.1 8470.1 8470.7 8472.7 8519.4 8569.3 773.9 791.0 814.1 830.6 832.3 5197.5 5270.8 5339.6 5373.0 5375.5 24102.6 24126.3 25269.4 25387.5 25450.2 24738.8 24804.0 24806.4 24992.3 25037.7 11375.6 11674.8 11753.2 11793.1 11807.5 9287.0 9334.2 9377.1 9385.8 9399.1 20448.8 20515.9 20977.0 21025.0 21420.8 21634.9 21734.9 21994.3 22135.6 22781.5 13192.6 13459.3 13464.8 13470.7 13471.0 14980.6 14984.6 15030.4 15034.4 15200.2 11979.9 12071.1 12297.9 12389.1 12519.0 11868.2 11897.3 11921.0 12130.7 12313.6 10811.2 10980.2 11017.2 11024.8 11031.6 8246.3 8394.4 8444.5 8462.7 8567.1 8419.8 8446.7 8463.3 8488.6 8511.1 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#4] prototype.html Cycles:180 Average:5609.74 Median:6198.43 stddev:1560.63 (25.2%) stddev-sans-first:1518.13 04:41:54 INFO - PID 17727 | Values: 551.6 561.3 579.4 585.1 593.2 6257.9 6270.9 6275.8 6276.2 6306.1 6075.9 6158.2 6177.5 6227.7 6258.7 4899.5 4994.4 5136.3 5139.6 5155.6 4964.8 5034.4 5039.7 5060.4 5065.7 4944.6 4966.2 4991.1 5001.8 5010.6 4946.5 4981.3 5005.3 5016.9 5027.3 4547.8 4574.0 4578.8 4580.4 4580.8 6037.8 6077.3 6177.0 6202.4 6226.1 5814.0 5833.4 5833.8 5873.7 5904.9 6486.7 6549.2 6578.5 6629.4 6629.5 4843.4 4997.4 5071.2 5074.2 5090.2 6822.7 6871.7 6965.4 6979.2 6991.2 5210.9 5211.7 5218.9 5230.6 5240.8 5211.3 5299.7 5304.9 5325.8 5329.3 5835.4 5837.5 5887.3 5892.6 5939.2 6659.2 6663.2 6670.6 6722.7 6732.4 1762.3 1786.9 1791.9 1802.3 1809.9 1234.7 1292.2 1305.8 1311.2 1311.6 6103.8 6148.7 6190.3 6194.4 6247.3 6405.3 6574.6 6630.0 6637.0 6665.4 6042.7 6086.6 6087.5 6162.4 6163.5 3488.0 3499.5 3508.1 3508.5 3551.4 6886.6 6931.7 6959.5 7000.0 7000.4 6849.5 6852.2 6961.5 6991.5 6995.9 7013.4 7019.4 7028.6 7030.2 7049.8 6558.0 6575.3 6579.9 6627.5 6638.4 6647.8 6766.4 6777.4 6802.3 6815.7 6923.5 7043.0 7052.4 7132.1 7139.3 5138.0 5149.7 5166.8 5190.5 5193.9 6435.9 6542.7 6639.4 6652.9 6716.0 6104.9 6496.3 6500.6 6501.3 6532.8 6393.5 6415.1 6428.0 6442.6 6461.7 6292.0 6301.6 6314.7 6398.5 6418.8 6458.5 6508.3 6533.6 6556.3 6577.5 6316.9 6404.0 6409.7 6410.4 6413.7 04:41:54 INFO - PID 17727 | 04:41:54 INFO - PID 17727 | [#5] yui.html Cycles:180 Average:28494.43 Median:19351.66 stddev:42806.20 (221.2%) stddev-sans-first:42876.30 04:41:54 INFO - PID 17727 | Values: 944.2 978.9 992.3 1005.3 1016.5 20032.2 20451.5 20491.3 20539.5 20548.7 19557.9 19782.3 19854.9 20124.9 20331.8 1027.8 1050.2 1050.9 1051.2 1051.9 1044.3 1085.8 1093.1 1094.0 1097.4 1169.7 1172.5 1172.9 1173.3 1173.4 1086.2 1151.8 1161.8 1163.2 1163.5 816.2 823.7 824.9 827.0 828.3 21322.6 21344.4 21399.9 21514.4 21532.9 22460.3 23877.9 23889.4 23904.6 23945.2 17304.3 17402.0 17532.7 17612.6 17625.9 3883.1 3910.7 3913.9 3916.4 3917.2 164818.0 166462.0 166746.0 166967.0 168557.0 16958.2 17239.9 17408.4 17507.6 17554.2 29252.0 29724.3 29769.7 29884.7 29980.7 9860.4 9863.7 9872.6 9890.4 9895.4 4646.4 4667.5 4715.3 4759.7 4763.7 5934.8 6063.8 6074.3 6080.0 6102.3 1105.8 1149.4 1165.1 1171.2 1180.6 743.2 757.4 771.1 778.5 782.2 11817.7 12126.6 12268.8 13128.2 13300.6 690.8 694.6 696.8 706.0 709.5 5863.2 5919.7 5922.2 6055.5 6114.1 147240.0 151616.0 151697.0 153082.0 157770.0 123400.4 123936.0 126999.0 131068.0 135120.0 111585.4 114384.0 115611.4 115657.0 119881.0 13195.2 13378.9 13559.9 13568.7 13810.9 54294.0 54372.2 54732.5 55039.7 56394.9 69665.0 69767.0 70749.0 71302.3 71403.0 17466.5 18080.4 18149.2 18186.9 18362.8 20405.5 20450.2 20590.4 20741.7 20920.9 18422.0 19142.1 19255.2 19362.3 19604.3 19341.0 19416.4 19482.5 19512.2 19751.6 18126.8 18440.4 18493.6 18603.4 18606.8 12922.9 12955.2 13027.5 13161.8 13332.0 13231.3 13380.0 13612.7 13615.9 13705.5 04:41:54 INFO - PID 17727 | -------- Summary: end -------- 04:41:54 INFO - PID 17727 | 04:41:55 INFO - TEST-INFO | 17727: exit 0 04:41:55 INFO - TEST-OK | dromaeo_css | took 1106956ms 04:41:55 INFO - TEST-START | kraken 04:41:55 INFO - Initialising browser for kraken test... 04:41:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53386/getInfo.html -profile /tmp/tmpdCatJ0/profile 04:41:55 INFO - TEST-INFO | started process 18089 (/builds/slave/test/build/application/firefox/firefox http://localhost:53386/getInfo.html) 04:42:00 INFO - TEST-INFO | 18089: exit 0 04:42:00 INFO - Browser initialized. 04:42:00 INFO - Running cycle 1/1 for kraken test... 04:42:00 INFO - Using env: {'DISPLAY': ':0', 04:42:00 INFO - 'HOME': '/home/cltbld', 04:42:00 INFO - 'JSGC_DISABLE_POISONING': '1', 04:42:00 INFO - 'LANG': 'en_US.UTF-8', 04:42:00 INFO - 'LANGUAGE': 'en_US:en', 04:42:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:42:00 INFO - 'LOGNAME': 'cltbld', 04:42:00 INFO - 'MAIL': '/var/mail/cltbld', 04:42:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:00 INFO - 'MOZ_CRASHREPORTER': '1', 04:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:42:00 INFO - 'MOZ_NO_REMOTE': '1', 04:42:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:00 INFO - 'NO_EM_RESTART': '1', 04:42:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:00 INFO - 'PWD': '/builds/slave/test', 04:42:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:00 INFO - 'RUST_BACKTRACE': 'full', 04:42:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:42:00 INFO - 'SHELL': '/bin/bash', 04:42:00 INFO - 'SHLVL': '1', 04:42:00 INFO - 'STYLO_FORCE_DISABLED': '1', 04:42:00 INFO - 'TERM': 'linux', 04:42:00 INFO - 'TMOUT': '86400', 04:42:00 INFO - 'USER': 'cltbld', 04:42:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506424741.73082-418985993', 04:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:00 INFO - '_': '/tools/buildbot/bin/python'} 04:42:00 INFO - TEST-INFO | started process 18325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdCatJ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:01 INFO - PID 18325 | 04:42:01 INFO - PID 18325 | (/builds/slave/test/build/application/firefox/firefox:18375): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:42:01 INFO - PID 18325 | 04:42:11 INFO - PID 18325 | RSS: Main: 144715776 04:42:11 INFO - PID 18325 | 04:42:14 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53386/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:15 INFO - PID 18325 | RSS: Main: 151052288 04:42:15 INFO - PID 18325 | 04:42:17 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53386/tests/kraken/driver.html?testName=audio-dft) 04:42:18 INFO - PID 18325 | RSS: Main: 151560192 04:42:18 INFO - PID 18325 | 04:42:21 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53386/tests/kraken/driver.html?testName=audio-fft) 04:42:21 INFO - PID 18325 | RSS: Main: 148320256 04:42:21 INFO - PID 18325 | 04:42:23 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53386/tests/kraken/driver.html?testName=audio-oscillator) 04:42:24 INFO - PID 18325 | RSS: Main: 149118976 04:42:24 INFO - PID 18325 | 04:42:26 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:26 INFO - PID 18325 | RSS: Main: 148819968 04:42:26 INFO - PID 18325 | 04:42:30 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53386/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:30 INFO - PID 18325 | RSS: Main: 148811776 04:42:30 INFO - PID 18325 | 04:42:34 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53386/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:34 INFO - PID 18325 | RSS: Main: 149942272 04:42:34 INFO - PID 18325 | 04:42:37 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53386/tests/kraken/driver.html?testName=json-parse-financial) 04:42:38 INFO - PID 18325 | RSS: Main: 152023040 04:42:38 INFO - PID 18325 | 04:42:39 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:40 INFO - PID 18325 | RSS: Main: 152059904 04:42:40 INFO - PID 18325 | 04:42:41 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:42 INFO - PID 18325 | RSS: Main: 151711744 04:42:42 INFO - PID 18325 | 04:42:44 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:45 INFO - PID 18325 | RSS: Main: 148742144 04:42:45 INFO - PID 18325 | 04:42:47 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:48 INFO - PID 18325 | RSS: Main: 149131264 04:42:48 INFO - PID 18325 | 04:42:51 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:51 INFO - PID 18325 | RSS: Main: 149348352 04:42:51 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | Cycle 1(1): loaded http://localhost:53386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53386/tests/kraken/driver.html?testName=ai-astar) 04:42:53 INFO - PID 18325 | RSS: Main: 150994944 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | __start_tp_report 04:42:53 INFO - PID 18325 | _x_x_mozilla_page_load 04:42:53 INFO - PID 18325 | _x_x_mozilla_page_load_details 04:42:53 INFO - PID 18325 | |i|pagename|runs| 04:42:53 INFO - PID 18325 | |0;ai-astar;106;105;106;108;105;108;109;106;108;106 04:42:53 INFO - PID 18325 | |1;audio-beat-detection;113;113;120;112;112;114;112;112;114;116 04:42:53 INFO - PID 18325 | |2;audio-dft;163;163;161;162;161;162;164;162;161;163 04:42:53 INFO - PID 18325 | |3;audio-fft;73;75;74;74;74;73;74;75;74;72 04:42:53 INFO - PID 18325 | |4;audio-oscillator;80;78;78;77;79;78;77;78;77;78 04:42:53 INFO - PID 18325 | |5;imaging-gaussian-blur;113;115;113;113;113;115;113;114;114;114 04:42:53 INFO - PID 18325 | |6;imaging-darkroom;150;149;149;150;150;151;152;150;153;151 04:42:53 INFO - PID 18325 | |7;imaging-desaturate;95;95;95;94;95;95;95;96;95;96 04:42:53 INFO - PID 18325 | |8;json-parse-financial;48;44;44;45;43;45;45;44;45;45 04:42:53 INFO - PID 18325 | |9;json-stringify-tinderbox;39;40;40;39;39;40;39;39;38;39 04:42:53 INFO - PID 18325 | |10;stanford-crypto-aes;77;73;72;71;71;74;71;72;71;72 04:42:53 INFO - PID 18325 | |11;stanford-crypto-ccm;120;105;107;113;104;105;109;112;114;106 04:42:53 INFO - PID 18325 | |12;stanford-crypto-pbkdf2;150;156;150;153;159;154;155;153;155;156 04:42:53 INFO - PID 18325 | |13;stanford-crypto-sha256-iterative;61;61;59;60;62;60;61;62;70;62 04:42:53 INFO - PID 18325 | __end_tp_report 04:42:53 INFO - PID 18325 | __start_cc_report 04:42:53 INFO - PID 18325 | _x_x_mozilla_cycle_collect,674 04:42:53 INFO - PID 18325 | __end_cc_report 04:42:53 INFO - PID 18325 | __startTimestamp1506426173627__endTimestamp 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | ------- Summary: start ------- 04:42:53 INFO - PID 18325 | Number of tests: 14 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#0] ai-astar Cycles:10 Average:106.70 Median:107.00 stddev:1.42 (1.3%) stddev-sans-first:1.48 04:42:53 INFO - PID 18325 | Values: 106.0 105.0 106.0 108.0 105.0 108.0 109.0 106.0 108.0 106.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#1] audio-beat-detection Cycles:10 Average:113.80 Median:113.50 stddev:2.53 (2.2%) stddev-sans-first:2.67 04:42:53 INFO - PID 18325 | Values: 113.0 113.0 120.0 112.0 112.0 114.0 112.0 112.0 114.0 116.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 04:42:53 INFO - PID 18325 | Values: 163.0 163.0 161.0 162.0 161.0 162.0 164.0 162.0 161.0 163.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 04:42:53 INFO - PID 18325 | Values: 73.0 75.0 74.0 74.0 74.0 73.0 74.0 75.0 74.0 72.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:0.94 (1.2%) stddev-sans-first:0.67 04:42:53 INFO - PID 18325 | Values: 80.0 78.0 78.0 77.0 79.0 78.0 77.0 78.0 77.0 78.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 04:42:53 INFO - PID 18325 | Values: 113.0 115.0 113.0 113.0 113.0 115.0 113.0 114.0 114.0 114.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 04:42:53 INFO - PID 18325 | Values: 150.0 149.0 149.0 150.0 150.0 151.0 152.0 150.0 153.0 151.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:42:53 INFO - PID 18325 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 96.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:1.32 (2.9%) stddev-sans-first:0.73 04:42:53 INFO - PID 18325 | Values: 48.0 44.0 44.0 45.0 43.0 45.0 45.0 44.0 45.0 45.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#9] json-stringify-tinderbox Cycles:10 Average:39.20 Median:39.00 stddev:0.63 (1.6%) stddev-sans-first:0.67 04:42:53 INFO - PID 18325 | Values: 39.0 40.0 40.0 39.0 39.0 40.0 39.0 39.0 38.0 39.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.00 stddev:1.90 (2.6%) stddev-sans-first:1.05 04:42:53 INFO - PID 18325 | Values: 77.0 73.0 72.0 71.0 71.0 74.0 71.0 72.0 71.0 72.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#11] stanford-crypto-ccm Cycles:10 Average:109.50 Median:110.50 stddev:5.15 (4.7%) stddev-sans-first:3.81 04:42:53 INFO - PID 18325 | Values: 120.0 105.0 107.0 113.0 104.0 105.0 109.0 112.0 114.0 106.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:155.00 stddev:2.77 (1.8%) stddev-sans-first:2.51 04:42:53 INFO - PID 18325 | Values: 150.0 156.0 150.0 153.0 159.0 154.0 155.0 153.0 155.0 156.0 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:61.50 stddev:3.05 (5.0%) stddev-sans-first:3.22 04:42:53 INFO - PID 18325 | Values: 61.0 61.0 59.0 60.0 62.0 60.0 61.0 62.0 70.0 62.0 04:42:53 INFO - PID 18325 | -------- Summary: end -------- 04:42:53 INFO - PID 18325 | 04:42:53 INFO - PID 18325 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:42:54 INFO - TEST-INFO | 18325: exit 0 04:42:54 INFO - TEST-OK | kraken | took 58865ms 04:42:54 INFO - SUITE-END | took 1165s 04:42:54 INFO - Completed test suite (00:19:25) 04:42:54 INFO - javascript benchmark 04:42:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9104.946468086802, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3863.4977452931116, 3877.9612203877955, 3898.376259798433, 3901.531816182058, 3922.921541569167, 6161.260648722148, 6233.1585235993125, 6257.468115210207, 6288.151099601552, 6344.6510441925675, 6206.0, 6266.62400255985, 6332.081848132018, 6361.141245931798, 6371.649559274238, 5618.5786066045, 5695.515881150087, 5728.856778580527, 5770.2210201622875, 5780.335261444925, 198.06597231403074, 5422.240886275905, 5646.858828529299, 5739.081746920494, 5755.798547050854, 5644.294463192101, 5656.830295091154, 5746.65520068793, 5755.65466072037, 5757.884842303151, 5670.886582268332, 5671.886562268732, 5746.540276777848, 5752.683602401867, 5760.308762948431, 5626.803061892814, 5628.183913332585, 5712.514436272922, 5713.771449142029, 5716.657000579979, 6273.341299163568, 6309.810705678791, 6340.461060809836, 6348.682565871734, 6357.364263573651, 6750.62871542065, 6836.316368363174, 6843.520953533254, 6845.794626161173, 6851.45188384928, 6874.140732408449, 6979.546329488567, 6981.685824137926, 6987.196472405688, 6989.545679530815, 6312.652804095773, 6371.808845734636, 6379.457746091588, 6389.1694079769795, 6432.0995060691075, 7067.82330441743, 7115.466340024519, 7144.857102857914, 7161.498695091398, 7163.3552980232025, 6775.457963363017, 6780.93219067803, 6862.142232220973, 6866.896996545056, 6868.862622747517, 6813.625250611165, 6875.862482750317, 6895.75864844728, 6903.5167538271835, 6966.477514186457, 6806.897896531556, 6814.795556133324, 6818.590884546943, 6831.726730930806, 6836.0, 6693.497987650849, 6735.730570777212, 6752.662366881636, 6830.419414349736, 6871.381575658214, 4974.577160941288, 5003.524665156804, 5016.774245158977, 5054.7472626368535, 5063.012712521097, 4557.863264102082, 4617.191991401492, 4631.235846085426, 4637.65217608674, 4650.046740418206, 6270.623762574261, 6307.747690092437, 6344.555881088372, 6352.7141278642575, 6363.7772677956045, 6709.932900671029, 6718.8320291993095, 6725.495587830932, 6807.761728339485, 6823.965880170567, 6259.1550140730415, 6361.745530178741, 6381.266154392211, 6440.935590644127, 6444.645544495004, 5506.779728810803, 5507.834764956978, 5574.832755017274, 5610.85972850682, 5618.016847051749, 6980.336867997532, 7098.716051357991, 7112.964435177894, 7218.566885986857, 7226.168990566047, 6784.966075169593, 6808.183018037768, 6891.689873955785, 6899.862002760017, 6932.029515867682, 7048.436125109876, 7134.928650713427, 7139.964300178466, 7191.2449192834, 7211.098612673416, 6663.866722665616, 6753.0, 6754.493412994143, 6829.453643708591, 6848.0, 6802.217744959393, 6807.047013418224, 6885.414739747178, 6888.621125837926, 6923.653817309014, 6648.468122550088, 6679.833004174934, 6712.228093769279, 6712.228093769279, 6737.258901520927, 6595.472362211108, 6615.338466153346, 6622.37087476689, 6707.496937729592, 6708.19501659804, 6455.644939528371, 6520.315366886409, 6600.53796234259, 6613.603183808987, 6621.1392518972225, 6670.733170673118, 6682.899756503753, 6714.462842972648, 6747.595144291358, 6793.66031698423, 6304.243490781136, 6513.250976137805, 6520.673966301571, 6537.0, 6547.476201903932], "value": 6224.812472811128, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.7060140754959, 938.5823308627663, 940.3558562384767, 943.2359788571258, 944.0370821761808, 40787.79606101969, 43546.0, 43736.0, 43921.34117988233, 43975.340369894475, 42217.57782422175, 42470.787646061806, 42511.0, 42525.14949701004, 42597.14805703892, 7388.815279618026, 7462.403007759366, 7487.850242995137, 7528.209537998486, 8395.454295470805, 8186.672533098669, 8235.423520353577, 8254.793630159264, 8257.545834979073, 8264.256216940474, 8252.958735206346, 8260.710875119372, 8314.542700151489, 8320.167983201693, 8328.33373330132, 8297.294729947962, 8613.310935125237, 8627.094155113717, 8634.956825215833, 8637.827243455127, 8353.958230208871, 8372.372072094557, 8430.578471076422, 8430.74707758762, 8436.915630843736, 37771.811140944395, 37789.0, 38012.23975520474, 38113.618863811564, 38282.425763613566, 3683.557973043252, 3685.7419980601367, 3698.9075273118387, 3719.4048952167523, 3720.2373513429684, 34301.82849085764, 34445.0, 34476.82761586176, 34556.48165277523, 34567.827160864035, 5431.131019036935, 5450.645708028966, 5457.208704737791, 5463.590230732671, 5484.424135465759, 221684.0, 222725.0, 223482.0, 224199.0, 225253.87373063192, 47185.29222061672, 53820.73089634527, 53828.0, 54040.729796350766, 54073.0, 51286.48713512817, 57944.0, 58756.0, 58773.11840322398, 58801.70599146977, 16290.918545407198, 16372.67254654924, 16375.426860060079, 16383.42658006988, 16397.344106235854, 13296.800547991788, 13313.201207927556, 13327.067105302729, 13338.73322533544, 13369.933150334185, 15585.142817144939, 15658.0, 15671.216439177995, 15684.058956462648, 15735.606609834846, 6053.545984051214, 6078.483328917092, 6187.381261873777, 6187.566870319124, 6228.377162283826, 1084.6312253833576, 1102.3826657072066, 1103.1175059952006, 1116.4027245423658, 1120.3278033180027, 25935.74064259371, 25995.61006584903, 26068.0, 26210.0, 26233.0, 1202.0, 1210.9152359334762, 1229.6188181663713, 1231.8275441438207, 1234.975300493985, 13515.864841351657, 13690.247036413093, 13728.931355343359, 13738.931305343409, 14033.508827191203, 296260.0, 296763.0, 297441.0, 297628.0, 297712.0, 58832.705836470544, 59224.7038764812, 59288.703556482804, 59344.70327648334, 59445.0, 1501.3169008101506, 1513.9394424222908, 1536.784850120984, 1559.5711179425748, 1566.8824838136957, 25215.495690086464, 25283.620745689197, 25506.107286244893, 25515.234542962997, 25570.61644075303, 40538.59461405348, 40593.59406405898, 40716.59283407128, 40734.38898416467, 40814.38778418267, 238222.0, 238696.0, 266083.0, 266863.0, 267501.0, 37564.62435375611, 37862.43206351852, 41666.58333416627, 42118.0, 42146.78926605347, 53250.73374633102, 53409.465905342004, 53552.73223633857, 53913.73043134759, 54084.0, 37689.24621507609, 38180.0, 38573.614263857, 38677.0, 38940.41589376218, 38115.80942095272, 38173.236535269694, 38219.2356152881, 38549.0, 39036.0, 43902.56097439113, 44803.551964481245, 45063.0987380244, 45326.77336613428, 45485.772571136935, 37035.6296437043, 37585.4362184562, 37835.0, 37965.81017094897, 38266.808665956494, 27535.44929101447, 27871.303217418914, 27885.302867427665, 27972.0, 28308.0], "value": 19080.571494752698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9700014999252, 612.8621060261445, 615.1142355008784, 618.6473709985308, 632.9620222786632, 23191.536169276606, 23731.406714832116, 23946.0, 23970.76029239707, 24106.397340066505, 24955.75044249557, 27073.32316692079, 27278.181654550393, 27297.181084567495, 27338.179854604343, 6496.740130394778, 6627.204735431755, 6631.104800851896, 6694.866102677944, 6716.261211266757, 6455.644939528324, 6552.049952756847, 6668.266490686021, 6698.564593301444, 6760.459163266927, 6746.763863264762, 6755.7973260802255, 6759.188897332327, 6762.8309292267595, 6766.864662706743, 6625.0724898514245, 6728.764493242737, 6730.697118629649, 6767.154105736808, 6868.278830722752, 6349.238091429058, 6359.682015899187, 6405.935940640627, 6411.166548348731, 6413.454856337217, 29609.40781184364, 30201.0, 30275.0, 30315.393692126254, 30430.239244019078, 2258.853174543666, 2270.9545809083725, 2275.70415845939, 2285.737140228878, 2286.1312701173615, 21031.5793684127, 21268.14927402902, 21701.565968680537, 21978.780212197835, 21989.67015494769, 2485.328961180471, 2515.3963048868322, 2558.9360265993314, 2581.019212699181, 2583.3412479817716, 132370.0, 137018.0, 142379.0, 147938.99999999892, 147954.0, 15532.767008494882, 16345.673086538203, 16408.343666253455, 16594.917025415038, 16676.16619169037, 25730.356741081247, 25838.741612583635, 25997.350066248495, 26024.34939126537, 26038.86980565085, 10474.371537707762, 10538.631147909786, 10694.144468442506, 10774.676759697222, 10927.398993055458, 9503.66737164196, 9530.857037144448, 9643.614255429844, 9680.031996800404, 9734.951325243328, 9594.568244429018, 9722.0, 9884.703458896245, 9888.258380621483, 10054.849177262347, 2775.736305051017, 2849.244950088228, 2913.2716820794803, 2933.193371822766, 2969.6391368861805, 1031.3193292427113, 1052.3896140238644, 1058.5606973106228, 1063.7925604507047, 1065.1851333729703, 21654.133834646436, 21757.67363489549, 21774.346769596938, 21940.561188776133, 22432.439189020406, 1098.7912296663608, 1123.9943800280946, 1124.3647339253296, 1130.8473356096986, 1137.9544818207344, 12114.273143611235, 12156.635300940987, 12170.087243456775, 12213.0, 12229.816552751538, 546341.0, 560019.0, 564025.0, 567597.0, 583167.0, 124164.0, 124333.0, 127206.36396817956, 127347.0, 129453.0, 1138.9442057087037, 1194.1223200947297, 1232.2421710648066, 1237.307108019512, 1298.4092238031674, 22636.207732729275, 23122.884385577963, 23249.0, 23270.301890943298, 23302.417439564146, 59276.0, 59884.70057649684, 60424.093638594575, 60513.0923036146, 62255.0, 78380.60809696143, 78778.60610696909, 79172.20827791879, 79506.0, 80451.19548804437, 15512.534623960848, 16002.359905603646, 16017.439389621773, 16139.031658100552, 16140.919295403448, 24503.38741531476, 24543.631845521973, 25087.372815679755, 25115.0, 25196.74803251944, 20392.0, 20413.67311124772, 20670.17319307271, 20794.792052079287, 20854.0, 17109.23008464647, 17973.55066123305, 18156.636867262845, 18408.35570755017, 18665.720014199527, 20248.291309804084, 20844.166233350497, 20909.26817561378, 20921.1631534743, 21006.159753609685, 14999.00019996027, 15640.687186256439, 15677.608059798597, 15683.921580392025, 15816.05103693782, 20288.695669565263, 20535.589288213854, 20559.0, 20677.58644827125, 20687.79312206919], "value": 12914.338159531184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.3099281352136, 1475.3655927950977, 1488.903221290616, 1495.2374289112552, 1511.2292730707343, 16111.59721006974, 16873.746893796604, 16906.070166140857, 16924.153792310364, 16979.15104244786, 16438.424655137074, 16524.09117498537, 16590.0, 16594.336226550953, 16607.50177494674, 2667.479841430917, 2699.0283497940727, 2699.676038875338, 2707.6480057592585, 2717.2391730315544, 2639.9868000660067, 2702.3514356554383, 2703.1079743684636, 2703.1349968010245, 2706.269307287031, 2608.6869575650853, 2639.8944042238286, 2640.9471810563778, 2641.379275870169, 2646.5103955768245, 2536.353229926366, 2552.119518766023, 2557.105013245377, 2557.8337408068414, 2560.423904621464, 2566.3840678237275, 2599.2202339298324, 2617.9607305890427, 2620.2532278300782, 2621.082621082625, 16042.5989350266, 16048.197590120448, 16199.0, 16209.108499032549, 16234.512964610962, 8138.226868447488, 8385.706500272461, 8406.411551191419, 8421.24208821209, 8421.663133474654, 5066.898662026776, 5386.030514507387, 5412.377576578665, 5452.809151679672, 5514.393416724157, 1976.5355141541727, 1997.504367357125, 1999.380192140441, 2075.2010475966863, 2148.1429698500956, 27025.1892443227, 27865.16404507868, 29816.254593635116, 30796.230094247374, 30818.22954426135, 7265.564066156047, 7407.444441666897, 7425.405967522585, 7520.511166774142, 7527.096748390229, 22466.775332246794, 22568.887155564447, 22621.886890565773, 22632.660510092363, 22662.546749064928, 8685.0, 8782.648694052294, 8804.427712198687, 8812.9865065517, 8816.8677469838, 7703.460757746904, 7841.607919603997, 7855.33229675484, 7867.370610351159, 7897.24976127267, 5694.6583205007, 5861.7655293787775, 5889.764409423575, 5913.408659134138, 5942.732577034044, 1675.0703359635277, 1675.4052311429266, 1701.123921180593, 1711.8801683882257, 1722.6477215385862, 962.119660510625, 963.7542426681151, 974.468914441631, 995.721198064543, 999.14073896449, 8470.110638383005, 8470.703525376706, 8472.66109355619, 8519.446235994641, 8569.271611912933, 773.9187385324573, 790.9762707118796, 814.0800894988625, 830.588858515039, 832.2925513313635, 5197.454267301879, 5270.7628156733035, 5339.626226164131, 5373.005993891143, 5375.543078838343, 24102.638460423106, 24126.276211713677, 25269.368265793135, 25387.492250154894, 25450.236492905242, 24738.752612473643, 24804.0, 24806.37984050413, 24992.250232493054, 25037.749622503543, 11375.601853935239, 11674.766504669858, 11753.177277590657, 11793.11551633648, 11807.468663910146, 9287.024862389622, 9334.20659243972, 9377.062293770841, 9385.812283754423, 9399.10708482693, 20448.750637430167, 20515.897420512803, 20977.0, 21025.0, 21420.78579214188, 21634.89182554077, 21734.89132554327, 21994.34016979493, 22135.557288854456, 22781.544369112857, 13192.604221873358, 13459.327033648475, 13464.798028029392, 13470.663233419244, 13471.0, 14980.625484362543, 14984.550463486114, 15030.398784048515, 15034.398624054915, 15200.163990980602, 11979.940100299442, 12071.094667900119, 12297.938510307391, 12389.132760706663, 12519.0, 11868.228565143238, 11897.345645989553, 11921.0, 12130.696732581757, 12313.56902508408, 10811.189160813128, 10980.231383803057, 11017.228793984345, 11024.834627480433, 11031.558737650405, 8246.257836794717, 8394.37042221848, 8444.451110677786, 8462.661493540436, 8567.100454452442, 8419.831603367777, 8446.66213351459, 8463.322934165375, 8488.618012189343, 8511.106333834858], "value": 7182.837741297019, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5642642312571, 561.2899681902393, 579.4234736437246, 585.1281590430259, 593.2258402784365, 6257.9310758285765, 6270.874582508347, 6275.843103922399, 6276.152719382893, 6306.05409188622, 6075.878482430348, 6158.230221222348, 6177.505799536038, 6227.657478838662, 6258.749650013994, 4899.51004899509, 4994.350734404522, 5136.306598609196, 5139.614528910328, 5155.587552995761, 4964.801407943678, 5034.421041580228, 5039.697618142924, 5060.39275286966, 5065.721385323805, 4944.579710724593, 4966.205407134859, 4991.101601711691, 5001.774920128603, 5010.574101201402, 4946.530079642428, 4981.302617633534, 5005.349304590416, 5016.874578135539, 5027.321311622921, 4547.818087276505, 4574.0394517151435, 4578.839740609096, 4580.381648477446, 4580.816767329303, 6037.7584896604085, 6077.301110372319, 6177.011678131522, 6202.441780239755, 6226.066090086478, 5813.970930145322, 5833.38749431312, 5833.804070165648, 5873.706314684291, 5904.8780731660845, 6486.745735953892, 6549.181352330958, 6578.473722102221, 6629.436497897636, 6629.535932484728, 4843.443004054544, 4997.375328083989, 5071.18860982241, 5074.213496907985, 5090.211017292326, 6822.727090916357, 6871.732328331688, 6965.442764578872, 6979.162500499972, 6991.196012458581, 5210.947890521122, 5211.661242019332, 5218.869528261824, 5230.581553475713, 5240.790368385298, 5211.348581427322, 5299.728065264386, 5304.867378315573, 5325.840224793263, 5329.280547126088, 5835.387284335168, 5837.532997360201, 5887.293524776968, 5892.587518873637, 5939.22790037301, 6659.200895892427, 6663.167104111986, 6670.599764014175, 6722.697478613474, 6732.427743641845, 1762.3126980477623, 1786.937457188992, 1791.8835275707038, 1802.2790883646385, 1809.9276028958957, 1234.7283597608512, 1292.1730092740654, 1305.830242068544, 1311.206719934426, 1311.6065180445828, 6103.816885493442, 6148.723307451175, 6190.288116866618, 6194.4115309045565, 6247.2815626202655, 6405.263394709668, 6574.605523668595, 6630.0, 6636.96681516599, 6665.366790154928, 6042.667653279112, 6086.60437071589, 6087.452129308295, 6162.383761623802, 6163.537734669918, 3487.953613915815, 3499.527563778908, 3508.0703613542432, 3508.5088087667746, 3551.396262635358, 6886.622675464927, 6931.6880740366805, 6959.512834101665, 6999.965000174967, 7000.404965577881, 6849.520533562602, 6852.177738671292, 6961.547499412522, 6991.545549539263, 6995.93004069963, 7013.368796808311, 7019.3682568569075, 7028.613426261605, 7030.156381234285, 7049.8237544060785, 6558.0, 6575.2767195607485, 6579.901301480386, 6627.4698024158915, 6638.402543771083, 6647.767328143492, 6766.357196066366, 6777.356151165632, 6802.285759995129, 6815.69329380189, 6923.5499692519825, 7043.0, 7052.365287124184, 7132.072830531998, 7139.32176443237, 5138.049460849755, 5149.665271757323, 5166.793328266827, 5190.532852043334, 5193.92209116856, 6435.903461447989, 6542.705578248895, 6639.4356479697835, 6652.866942661023, 6716.0, 6104.908426373519, 6496.285408604956, 6500.577462464925, 6501.349865013461, 6532.8366790830605, 6393.488520918222, 6415.133956915756, 6428.035794630843, 6442.613443193423, 6461.709223085067, 6292.0, 6301.590396624205, 6314.652694101868, 6398.496353356864, 6418.775342862978, 6458.4790646548545, 6508.251551071688, 6533.640649764308, 6556.3443655634055, 6577.473802095725, 6316.936830631635, 6403.96798016007, 6409.679516024087, 6410.358964103552, 6413.7113829876835], "value": 5163.444934278442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.2493217891775, 978.8678528398666, 992.2805965674887, 1005.3113617172238, 1016.4663551635393, 20032.19871205152, 20451.48871278215, 20491.282805101826, 20539.486512837186, 20548.691769623467, 19557.902210488963, 19782.30761923333, 19854.900725496387, 20124.899375503137, 20331.796682033175, 1027.8149933012073, 1050.2018465965843, 1050.8949105089507, 1051.1800795379615, 1051.8527406163143, 1044.300318786415, 1085.8045551800674, 1093.147345070846, 1093.9507722152523, 1097.38546414008, 1169.7426566155432, 1172.495826794478, 1172.8768479309635, 1173.337064558526, 1173.4191575170303, 1086.2016417932814, 1151.77540379626, 1161.8489596352504, 1163.2090178678495, 1163.5113252433955, 816.2286639126029, 823.6911158315631, 824.8968878890139, 826.9793255168609, 828.2876726015621, 21322.573548528944, 21344.35966920995, 21399.8930005349, 21514.354569362946, 21532.892335538378, 22460.32619021432, 23877.88061059701, 23889.40276493084, 23904.641430378557, 23945.161919332913, 17304.307827686876, 17402.0, 17532.737008944878, 17612.559686007826, 17625.911870440566, 3883.0680636647285, 3910.7066969977363, 3913.9021524462114, 3916.432117342998, 3917.216556688674, 164818.0, 166462.0, 166746.0, 166967.0, 168557.0, 16958.152092395332, 17239.913800430917, 17408.39070632547, 17507.56231094233, 17554.21006054705, 29252.0, 29724.256893577833, 29769.702302977126, 29884.701152988626, 29980.700192997792, 9860.408375497349, 9863.654772082942, 9872.555734991942, 9890.357126786736, 9895.406275623485, 4646.4191976003, 4667.486576476585, 4715.316279139505, 4759.714417134983, 4763.7141771493125, 5934.821955341346, 6063.818085457443, 6074.271087469532, 6080.0, 6102.298235702862, 1105.8396532502743, 1149.402310798397, 1165.1377980294521, 1171.1801738782885, 1180.6162997026001, 743.2270438743755, 757.394084732212, 771.1324759645399, 778.5484419036945, 782.1748055801185, 11817.704557386134, 12126.575569855013, 12268.81596776049, 13128.212307261594, 13300.600981970556, 690.7651398524525, 694.624902552626, 696.8014115977023, 705.9682314295869, 709.5139829217003, 5863.208466857005, 5919.6744179070565, 5922.230110085661, 6055.545834062463, 6114.11345354921, 147240.0, 151616.0, 151697.0, 153082.0, 157770.0, 123400.38299808443, 123936.0, 126999.0, 131068.0, 135120.0, 111585.44207278911, 114384.0, 115611.42194289144, 115657.0, 119881.0, 13195.20828750278, 13378.93310533441, 13559.93220033933, 13568.660783480493, 13810.93094534521, 54294.0, 54372.184417234566, 54732.452675472734, 55039.724801375734, 56394.87210255854, 69665.0, 69767.0, 70749.0, 71302.28697712957, 71403.0, 17466.476005719847, 18080.367187148386, 18149.18328675239, 18186.90906545512, 18362.81637183611, 20405.48986275355, 20450.181992720125, 20590.382288531368, 20741.68887466659, 20920.895395522926, 18422.0, 19142.138603763142, 19255.22979080821, 19362.322318718776, 19604.313849015216, 19341.0, 19416.4175074748, 19482.512937176685, 19512.21951121939, 19751.60496790085, 18126.81873181304, 18440.35458758937, 18493.630127397646, 18603.44189674312, 18606.81393186051, 12922.870771292542, 12955.157914735511, 13027.544035958696, 13161.802572961606, 13332.0, 13231.3384330785, 13380.0, 13612.65968350799, 13615.931920340336, 13705.451781928612], "value": 10014.080298091623, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 108.0, 105.0, 108.0, 109.0, 106.0, 108.0, 106.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 112.0, 112.0, 114.0, 112.0, 112.0, 114.0, 116.0], "value": 113.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 161.0, 162.0, 164.0, 162.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 74.0, 74.0, 73.0, 74.0, 75.0, 74.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 77.0, 79.0, 78.0, 77.0, 78.0, 77.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 150.0, 150.0, 151.0, 152.0, 150.0, 153.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 44.0, 44.0, 45.0, 43.0, 45.0, 45.0, 44.0, 45.0, 45.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 40.0, 40.0, 39.0, 39.0, 40.0, 39.0, 39.0, 38.0, 39.0], "value": 39.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 72.0, 71.0, 71.0, 74.0, 71.0, 72.0, 71.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 105.0, 107.0, 113.0, 104.0, 105.0, 109.0, 112.0, 114.0, 106.0], "value": 109.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 156.0, 150.0, 153.0, 159.0, 154.0, 155.0, 153.0, 155.0, 156.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 59.0, 60.0, 62.0, 60.0, 61.0, 62.0, 70.0, 62.0], "value": 61.8, "unit": "score"}]}]} 04:42:54 INFO - Return code: 0 04:42:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:54 INFO - # TBPL SUCCESS # 04:42:54 INFO - Running post-action listener: _package_coverage_data 04:42:54 INFO - Running post-action listener: _resource_record_post_action 04:42:54 INFO - [mozharness: 2017-09-26 11:42:54.416908Z] Finished run-tests step (success) 04:42:54 INFO - Running post-run listener: _resource_record_post_run 04:42:54 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323600384; Read time: 16; Write time: 224044 04:42:54 INFO - TinderboxPrint: CPU usage
13.1% 04:42:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:42:54 INFO - TinderboxPrint: I/O write bytes / time
323,600,384 / 224,044 04:42:54 INFO - TinderboxPrint: CPU idle
8,205.0 (86.9%) 04:42:54 INFO - TinderboxPrint: CPU user
1,186.7 (12.6%) 04:42:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:42:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13254656; Read time: 0; Write time: 1852 04:42:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:42:54 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310345728; Read time: 16; Write time: 222192 04:42:55 INFO - Running post-run listener: _upload_blobber_files 04:42:55 INFO - Blob upload gear active. 04:42:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:42:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:56 INFO - (blobuploader) - INFO - Done attempting. 04:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:03 INFO - (blobuploader) - INFO - Done attempting. 04:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:04 INFO - (blobuploader) - INFO - Done attempting. 04:43:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:43:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:06 INFO - (blobuploader) - INFO - Done attempting. 04:43:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:06 INFO - Return code: 0 04:43:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9c041ed9bab8fa5ec198d335c64e42807a19b3c953ad7a8c397201da1f2155c0a7c19cfaca73598553475853fc6b551949d11eb29ff3d99f798bcf2e25b144", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dca6b76701ab4fbd31831553c5d73d402d838f50c08e00e490ff64e05b4e578bfb11be7fa48c2caa9c524917fdab155d8c71fef97e4a58c40f85f6880fd9b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6751e546892cea7f223222936c19012577fe2f60a37e514b131201ad370d1a878a6990988a664a948cd58350ba49bc7cd330146d228877d7f2b24c5c6f609c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81bde6a241595235c4e9726efcd1b642a577f96e4374e100ab3f28b83398321b0405374ac2ba284b5fae052c519da02da03343312a6c1fb247e44d6754ff7b98"} 04:43:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:06 INFO - Contents: 04:43:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9c041ed9bab8fa5ec198d335c64e42807a19b3c953ad7a8c397201da1f2155c0a7c19cfaca73598553475853fc6b551949d11eb29ff3d99f798bcf2e25b144", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dca6b76701ab4fbd31831553c5d73d402d838f50c08e00e490ff64e05b4e578bfb11be7fa48c2caa9c524917fdab155d8c71fef97e4a58c40f85f6880fd9b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6751e546892cea7f223222936c19012577fe2f60a37e514b131201ad370d1a878a6990988a664a948cd58350ba49bc7cd330146d228877d7f2b24c5c6f609c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81bde6a241595235c4e9726efcd1b642a577f96e4374e100ab3f28b83398321b0405374ac2ba284b5fae052c519da02da03343312a6c1fb247e44d6754ff7b98"} 04:43:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:06 INFO - Copying logs to upload dir... 04:43:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.044912 ========= master_lag: 0.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-26 04:43:06.130280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:43:06.135235) ========= 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-1506424741.73082-418985993 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/sha512/8d9c041ed9bab8fa5ec198d335c64e42807a19b3c953ad7a8c397201da1f2155c0a7c19cfaca73598553475853fc6b551949d11eb29ff3d99f798bcf2e25b144", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dca6b76701ab4fbd31831553c5d73d402d838f50c08e00e490ff64e05b4e578bfb11be7fa48c2caa9c524917fdab155d8c71fef97e4a58c40f85f6880fd9b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6751e546892cea7f223222936c19012577fe2f60a37e514b131201ad370d1a878a6990988a664a948cd58350ba49bc7cd330146d228877d7f2b24c5c6f609c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81bde6a241595235c4e9726efcd1b642a577f96e4374e100ab3f28b83398321b0405374ac2ba284b5fae052c519da02da03343312a6c1fb247e44d6754ff7b98"} build_url:https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/F9EpRGDWRzSDGYnb2OX3sQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9c041ed9bab8fa5ec198d335c64e42807a19b3c953ad7a8c397201da1f2155c0a7c19cfaca73598553475853fc6b551949d11eb29ff3d99f798bcf2e25b144", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50dca6b76701ab4fbd31831553c5d73d402d838f50c08e00e490ff64e05b4e578bfb11be7fa48c2caa9c524917fdab155d8c71fef97e4a58c40f85f6880fd9b3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a6751e546892cea7f223222936c19012577fe2f60a37e514b131201ad370d1a878a6990988a664a948cd58350ba49bc7cd330146d228877d7f2b24c5c6f609c", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81bde6a241595235c4e9726efcd1b642a577f96e4374e100ab3f28b83398321b0405374ac2ba284b5fae052c519da02da03343312a6c1fb247e44d6754ff7b98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 04:43:06.166904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:43:06.167234) ========= 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-1506424741.73082-418985993 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 04:43:06.249535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:43:06.249883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 04:43:06.250225) ========= ========= Total master_lag: 0.65 =========