builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-005 starttime: 1505383170.55 results: success (0) revision: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.547894) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.548392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.548748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.686700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.687003) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 02:59:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.9M=0s 2017-09-14 02:59:30 (85.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123581 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.837347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.837661) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.887679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:30.887971) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6266decf217d4da5a18115cb5b1ff70feb76e7a5 --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 6266decf217d4da5a18115cb5b1ff70feb76e7a5 --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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 02:59:30,818 truncating revision to first 12 chars 2017-09-14 02:59:30,818 Setting DEBUG logging. 2017-09-14 02:59:30,818 attempt 1/10 2017-09-14 02:59:30,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6266decf217d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 02:59:31,211 unpacking tar archive at: mozilla-central-6266decf217d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:31.634294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:31.634597) ========= script_repo_revision: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:31.634984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:31.635260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:59:31.648531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-14 02:59:31.648931) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:31 INFO - MultiFileLogger online at 20170914 02:59:31 in /builds/slave/test 02:59:31 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 02:59:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:31 INFO - {'append_to_log': False, 02:59:31 INFO - 'base_work_dir': '/builds/slave/test', 02:59:31 INFO - 'blob_upload_branch': 'Firefox', 02:59:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:31 INFO - 'branch': 'Firefox', 02:59:31 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:31 INFO - 'code_coverage': False, 02:59:31 INFO - 'config_files': ('talos/linux_config.py',), 02:59:31 INFO - 'default_actions': ('clobber', 02:59:31 INFO - 'read-buildbot-config', 02:59:31 INFO - 'download-and-extract', 02:59:31 INFO - 'populate-webroot', 02:59:31 INFO - 'create-virtualenv', 02:59:31 INFO - 'install', 02:59:31 INFO - 'setup-mitmproxy', 02:59:31 INFO - 'run-tests'), 02:59:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:31 INFO - 'disable_ccov_upload': False, 02:59:31 INFO - 'disable_stylo': False, 02:59:31 INFO - 'download_minidump_stackwalk': True, 02:59:31 INFO - 'download_symbols': 'ondemand', 02:59:31 INFO - 'enable_stylo': False, 02:59:31 INFO - 'enable_webrender': False, 02:59:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:59:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:31 INFO - 'gecko_profile': False, 02:59:31 INFO - 'gecko_profile_interval': 0, 02:59:31 INFO - 'installer_path': 'installer.exe', 02:59:31 INFO - 'log_level': 'info', 02:59:31 INFO - 'log_name': 'talos', 02:59:31 INFO - 'log_to_console': True, 02:59:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:31 INFO - 'opt_config_files': (), 02:59:31 INFO - 'pip_index': False, 02:59:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:59:31 INFO - 'system_bits': '32', 02:59:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:31 INFO - 'title': 'talos-linux64-ix-005', 02:59:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:31 INFO - 'use_talos_json': True, 02:59:31 INFO - 'verify': 'False', 02:59:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:31 INFO - 'work_dir': 'build'} 02:59:31 INFO - [mozharness: 2017-09-14 09:59:31.722287Z] Running clobber step. 02:59:31 INFO - Running pre-action listener: _resource_record_pre_action 02:59:31 INFO - Running main action method: clobber 02:59:31 INFO - rmtree: /builds/slave/test/build 02:59:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:33 INFO - Running post-action listener: _resource_record_post_action 02:59:33 INFO - [mozharness: 2017-09-14 09:59:33.235769Z] Finished clobber step (success) 02:59:33 INFO - [mozharness: 2017-09-14 09:59:33.235869Z] Running read-buildbot-config step. 02:59:33 INFO - Running pre-action listener: _resource_record_pre_action 02:59:33 INFO - Running main action method: read_buildbot_config 02:59:33 INFO - Using buildbot properties: 02:59:33 INFO - { 02:59:33 INFO - "project": "", 02:59:33 INFO - "product": "firefox", 02:59:33 INFO - "who": "archaeopteryx@coole-files.de", 02:59:33 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:59:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:59:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 02:59:33 INFO - "stage_platform": "linux64-pgo", 02:59:33 INFO - "basedir": "/builds/slave/test", 02:59:33 INFO - "buildnumber": 17, 02:59:33 INFO - "platform": "ubuntu64_hw", 02:59:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:59:33 INFO - "slavebuilddir": "test", 02:59:33 INFO - "taskId": "F5s5k7tESda0DIMZ5X_2wQ", 02:59:33 INFO - "branch": "mozilla-central", 02:59:33 INFO - "script_repo_revision": "production", 02:59:33 INFO - "revision": "6266decf217d4da5a18115cb5b1ff70feb76e7a5", 02:59:33 INFO - "slavename": "talos-linux64-ix-005", 02:59:33 INFO - "repo_path": "mozilla-central" 02:59:33 INFO - } 02:59:33 INFO - Finding installer, test and symbols from parent task. 02:59:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5s5k7tESda0DIMZ5X_2wQ'}, attempt #1 02:59:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F5s5k7tESda0DIMZ5X_2wQ'}, attempt #1 02:59:34 INFO - Task dependencies: OqnNPITcTbqC9gFtKSh-uQ 02:59:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ'}, attempt #1 02:59:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 02:59:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.test_packages.json 02:59:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.crashreporter-symbols.zip 02:59:34 INFO - Running post-action listener: _resource_record_post_action 02:59:34 INFO - [mozharness: 2017-09-14 09:59:34.669200Z] Finished read-buildbot-config step (success) 02:59:34 INFO - [mozharness: 2017-09-14 09:59:34.669416Z] Running download-and-extract step. 02:59:34 INFO - Running pre-action listener: _resource_record_pre_action 02:59:34 INFO - Running main action method: download_and_extract 02:59:34 INFO - mkdir: /builds/slave/test/build/tests 02:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:34 INFO - trying https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.test_packages.json 02:59:34 INFO - Downloading https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:35 INFO - Downloaded 989 bytes. 02:59:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:35 INFO - Using the following test package requirements: 02:59:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:35 INFO - u'common': [u'target.common.tests.zip'], 02:59:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:35 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:35 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:35 INFO - u'target.web-platform.tests.tar.gz'], 02:59:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.common.tests.zip 02:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.common.tests.zip into memory 02:59:36 INFO - Content-Length response header: 55189712 02:59:36 INFO - Bytes received: 55189712 02:59:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.talos.tests.zip 02:59:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:59:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.talos.tests.zip into memory 02:59:48 INFO - Content-Length response header: 14500356 02:59:48 INFO - Bytes received: 14500356 02:59: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')]} 02:59:48 INFO - trying https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 02:59:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:59:49 INFO - Downloaded 62147113 bytes. 02:59:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 02:59:50 INFO - mkdir: /builds/slave/test/properties 02:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:50 INFO - Contents: 02:59:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 02:59:50 INFO - Running post-action listener: _resource_record_post_action 02:59:50 INFO - Running post-action listener: find_tests_for_verification 02:59:50 INFO - Running post-action listener: set_extra_try_arguments 02:59:50 INFO - [mozharness: 2017-09-14 09:59:50.047406Z] Finished download-and-extract step (success) 02:59:50 INFO - [mozharness: 2017-09-14 09:59:50.047637Z] Running populate-webroot step. 02:59:50 INFO - Running pre-action listener: _resource_record_pre_action 02:59:50 INFO - Running main action method: populate_webroot 02:59:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['tresize', 02:59:50 INFO - 'tcanvasmark']}, 02:59:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['dromaeo_css', 02:59:50 INFO - 'kraken']}, 02:59:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'tests': ['damp', 'tps']}, 02:59:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['damp', 'tps']}, 02:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['dromaeo_dom']}, 02:59:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['basic_compositor_video', 02:59:50 INFO - 'glvideo']}, 02:59:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['ts_paint_webext', 02:59:50 INFO - 'tp5o_webext']}, 02:59:50 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:50 INFO - 'ts_paint', 02:59:50 INFO - 'tpaint', 02:59:50 INFO - 'sessionrestore', 02:59:50 INFO - 'sessionrestore_many_windows', 02:59:50 INFO - 'sessionrestore_no_auto_restore', 02:59:50 INFO - 'tabpaint']}, 02:59:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['a11yr', 02:59:50 INFO - 'ts_paint', 02:59:50 INFO - 'tpaint', 02:59:50 INFO - 'sessionrestore', 02:59:50 INFO - 'sessionrestore_many_windows', 02:59:50 INFO - 'sessionrestore_no_auto_restore', 02:59:50 INFO - 'tabpaint']}, 02:59:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:59:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:59:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['bloom_basic_singleton']}, 02:59:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['bloom_basic']}, 02:59:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:50 INFO - 'tsvgr_opacity', 02:59:50 INFO - 'tart', 02:59:50 INFO - 'tscrollx', 02:59:50 INFO - 'tsvg_static']}, 02:59:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['tsvgx', 02:59:50 INFO - 'tsvgr_opacity', 02:59:50 INFO - 'tart', 02:59:50 INFO - 'tscrollx', 02:59:50 INFO - 'tsvg_static']}, 02:59:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo'], 02:59:50 INFO - 'tests': ['tp5o']}, 02:59:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:50 INFO - 'talos_options': ['--mitmproxy', 02:59:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:50 INFO - '--firstNonBlankPaint'], 02:59:50 INFO - 'tests': ['tp6_google', 02:59:50 INFO - 'tp6_youtube', 02:59:50 INFO - 'tp6_amazon', 02:59:50 INFO - 'tp6_facebook']}, 02:59:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo', 02:59:50 INFO - '--mitmproxy', 02:59:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:50 INFO - '--firstNonBlankPaint'], 02:59:50 INFO - 'tests': ['tp6_google', 02:59:50 INFO - 'tp6_youtube', 02:59:50 INFO - 'tp6_amazon', 02:59:50 INFO - 'tp6_facebook']}, 02:59:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:50 INFO - 'talos_options': ['--stylo-threads=1', 02:59:50 INFO - '--mitmproxy', 02:59:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:50 INFO - '--firstNonBlankPaint'], 02:59:50 INFO - 'tests': ['tp6_google', 02:59:50 INFO - 'tp6_youtube', 02:59:50 INFO - 'tp6_amazon', 02:59:50 INFO - 'tp6_facebook']}, 02:59:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--xperf_path', 02:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:50 INFO - 'tests': ['tp5n']}, 02:59:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:50 INFO - 'talos_options': ['--disable-stylo', 02:59:50 INFO - '--xperf_path', 02:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:50 INFO - 'tests': ['tp5n']}}} 02:59:50 INFO - Running post-action listener: _resource_record_post_action 02:59:50 INFO - [mozharness: 2017-09-14 09:59:50.067637Z] Finished populate-webroot step (success) 02:59:50 INFO - [mozharness: 2017-09-14 09:59:50.067725Z] Running create-virtualenv step. 02:59:50 INFO - Running pre-action listener: _resource_record_pre_action 02:59:50 INFO - Running main action method: create_virtualenv 02:59:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:59:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:59:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:50 INFO - Installing pip...............done. 02:59:50 INFO - Return code: 0 02:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:51 INFO - Reading from file tmpfile_stdout 02:59:51 INFO - Output received: 02:59:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:51 INFO - Using env: {'DISPLAY': ':0', 02:59:51 INFO - 'HOME': '/home/cltbld', 02:59:51 INFO - 'LANG': 'en_US.UTF-8', 02:59:51 INFO - 'LANGUAGE': 'en_US:en', 02:59:51 INFO - 'LOGNAME': 'cltbld', 02:59:51 INFO - 'MAIL': '/var/mail/cltbld', 02:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:51 INFO - 'MOZ_NO_REMOTE': '1', 02:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:51 INFO - 'NO_EM_RESTART': '1', 02:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:51 INFO - 'PWD': '/builds/slave/test', 02:59:51 INFO - 'SHELL': '/bin/bash', 02:59:51 INFO - 'SHLVL': '1', 02:59:51 INFO - 'TERM': 'linux', 02:59:51 INFO - 'TMOUT': '86400', 02:59:51 INFO - 'USER': 'cltbld', 02:59:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:51 INFO - '_': '/tools/buildbot/bin/python'} 02:59:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:59:52 INFO - Downloading/unpacking pip>=1.5 02:59:52 INFO - Running setup.py egg_info for package pip 02:59:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:52 INFO - Installing collected packages: pip 02:59:52 INFO - Found existing installation: pip 1.1 02:59:52 INFO - Uninstalling pip: 02:59:52 INFO - Successfully uninstalled pip 02:59:52 INFO - Running setup.py install for pip 02:59:52 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:52 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:59:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:59:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:59:52 INFO - Successfully installed pip 02:59:52 INFO - Cleaning up... 02:59:52 INFO - Return code: 0 02:59:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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')]} 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59: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', '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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59: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 psutil>=3.1.1 02:59:52 INFO - Using env: {'DISPLAY': ':0', 02:59:52 INFO - 'HOME': '/home/cltbld', 02:59:52 INFO - 'LANG': 'en_US.UTF-8', 02:59:52 INFO - 'LANGUAGE': 'en_US:en', 02:59:52 INFO - 'LOGNAME': 'cltbld', 02:59:52 INFO - 'MAIL': '/var/mail/cltbld', 02:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:52 INFO - 'MOZ_NO_REMOTE': '1', 02:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:52 INFO - 'NO_EM_RESTART': '1', 02:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:52 INFO - 'PWD': '/builds/slave/test', 02:59:52 INFO - 'SHELL': '/bin/bash', 02:59:52 INFO - 'SHLVL': '1', 02:59:52 INFO - 'TERM': 'linux', 02:59:52 INFO - 'TMOUT': '86400', 02:59:52 INFO - 'USER': 'cltbld', 02:59:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:52 INFO - '_': '/tools/buildbot/bin/python'} 02:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:52 INFO - Downloading/unpacking psutil>=3.1.1 02:59: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 02:59: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 02:59: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 02:59: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 02:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:53 INFO - Installing collected packages: psutil 02:59:53 INFO - Running setup.py install for psutil 02:59:53 INFO - building 'psutil._psutil_linux' extension 02:59:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:59:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:59:53 INFO - building 'psutil._psutil_posix' extension 02:59:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:59:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:54 INFO - Successfully installed psutil 02:59:54 INFO - Cleaning up... 02:59:54 INFO - Return code: 0 02:59:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:54 INFO - Using env: {'DISPLAY': ':0', 02:59:54 INFO - 'HOME': '/home/cltbld', 02:59:54 INFO - 'LANG': 'en_US.UTF-8', 02:59:54 INFO - 'LANGUAGE': 'en_US:en', 02:59:54 INFO - 'LOGNAME': 'cltbld', 02:59:54 INFO - 'MAIL': '/var/mail/cltbld', 02:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:54 INFO - 'MOZ_NO_REMOTE': '1', 02:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:54 INFO - 'NO_EM_RESTART': '1', 02:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:54 INFO - 'PWD': '/builds/slave/test', 02:59:54 INFO - 'SHELL': '/bin/bash', 02:59:54 INFO - 'SHLVL': '1', 02:59:54 INFO - 'TERM': 'linux', 02:59:54 INFO - 'TMOUT': '86400', 02:59:54 INFO - 'USER': 'cltbld', 02:59:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:54 INFO - '_': '/tools/buildbot/bin/python'} 02:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:55 INFO - Installing collected packages: mozsystemmonitor 02:59:55 INFO - Running setup.py install for mozsystemmonitor 02:59:55 INFO - Successfully installed mozsystemmonitor 02:59:55 INFO - Cleaning up... 02:59:56 INFO - Return code: 0 02:59:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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')]} 02:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59: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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59: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 02:59: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 02:59:56 INFO - Using env: {'DISPLAY': ':0', 02:59:56 INFO - 'HOME': '/home/cltbld', 02:59:56 INFO - 'LANG': 'en_US.UTF-8', 02:59:56 INFO - 'LANGUAGE': 'en_US:en', 02:59:56 INFO - 'LOGNAME': 'cltbld', 02:59:56 INFO - 'MAIL': '/var/mail/cltbld', 02:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:56 INFO - 'MOZ_NO_REMOTE': '1', 02:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:56 INFO - 'NO_EM_RESTART': '1', 02:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:56 INFO - 'PWD': '/builds/slave/test', 02:59:56 INFO - 'SHELL': '/bin/bash', 02:59:56 INFO - 'SHLVL': '1', 02:59:56 INFO - 'TERM': 'linux', 02:59:56 INFO - 'TMOUT': '86400', 02:59:56 INFO - 'USER': 'cltbld', 02:59:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:56 INFO - '_': '/tools/buildbot/bin/python'} 02:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:56 INFO - Downloading/unpacking jsonschema==2.5.1 02:59: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 02:59: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 02:59: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 02:59: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 02:59:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59: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 02:59: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 02:59: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 02:59: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 02:59:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:58 INFO - warning: no files found matching '*.txt' 02:59:58 INFO - no previously-included directories found matching 'build' 02:59:58 INFO - no previously-included directories found matching 'dist' 02:59:58 INFO - no previously-included directories found matching '.git*' 02:59:58 INFO - Installing collected packages: jsonschema, functools32 02:59:58 INFO - Running setup.py install for functools32 02:59:58 INFO - warning: no files found matching '*.txt' 02:59:58 INFO - no previously-included directories found matching 'build' 02:59:58 INFO - no previously-included directories found matching 'dist' 02:59:58 INFO - no previously-included directories found matching '.git*' 02:59:58 INFO - Successfully installed jsonschema functools32 02:59:58 INFO - Cleaning up... 02:59:58 INFO - Return code: 0 02:59:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59: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')]} 02:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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')]} 02:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59: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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59: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 02:59: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 02:59:58 INFO - Using env: {'DISPLAY': ':0', 02:59:58 INFO - 'HOME': '/home/cltbld', 02:59:58 INFO - 'LANG': 'en_US.UTF-8', 02:59:58 INFO - 'LANGUAGE': 'en_US:en', 02:59:58 INFO - 'LOGNAME': 'cltbld', 02:59:58 INFO - 'MAIL': '/var/mail/cltbld', 02:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:58 INFO - 'MOZ_NO_REMOTE': '1', 02:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:58 INFO - 'NO_EM_RESTART': '1', 02:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:58 INFO - 'PWD': '/builds/slave/test', 02:59:58 INFO - 'SHELL': '/bin/bash', 02:59:58 INFO - 'SHLVL': '1', 02:59:58 INFO - 'TERM': 'linux', 02:59:58 INFO - 'TMOUT': '86400', 02:59:58 INFO - 'USER': 'cltbld', 02:59:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:58 INFO - '_': '/tools/buildbot/bin/python'} 02:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:59 INFO - Cleaning up... 02:59:59 INFO - Return code: 0 02:59:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:59 INFO - Using env: {'DISPLAY': ':0', 02:59:59 INFO - 'HOME': '/home/cltbld', 02:59:59 INFO - 'LANG': 'en_US.UTF-8', 02:59:59 INFO - 'LANGUAGE': 'en_US:en', 02:59:59 INFO - 'LOGNAME': 'cltbld', 02:59:59 INFO - 'MAIL': '/var/mail/cltbld', 02:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:59 INFO - 'MOZ_NO_REMOTE': '1', 02:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:59 INFO - 'NO_EM_RESTART': '1', 02:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:59 INFO - 'PWD': '/builds/slave/test', 02:59:59 INFO - 'SHELL': '/bin/bash', 02:59:59 INFO - 'SHLVL': '1', 02:59:59 INFO - 'TERM': 'linux', 02:59:59 INFO - 'TMOUT': '86400', 02:59:59 INFO - 'USER': 'cltbld', 02:59:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 02:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:59 INFO - '_': '/tools/buildbot/bin/python'} 02:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00: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 03:00: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 03:00: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 03:00: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 03:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00: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 03:00: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 03:00: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 03:00: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 03:00:01 INFO - Downloading docopt-0.6.1.tar.gz 03:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:01 INFO - Running setup.py install for blobuploader 03:00:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:01 INFO - Running setup.py install for requests 03:00:01 INFO - Running setup.py install for docopt 03:00:01 INFO - Successfully installed blobuploader requests docopt 03:00:01 INFO - Cleaning up... 03:00:01 INFO - Return code: 0 03:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00: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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', '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 03:00: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 03:00: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 03:00:01 INFO - Using env: {'DISPLAY': ':0', 03:00:01 INFO - 'HOME': '/home/cltbld', 03:00:01 INFO - 'LANG': 'en_US.UTF-8', 03:00:01 INFO - 'LANGUAGE': 'en_US:en', 03:00:01 INFO - 'LOGNAME': 'cltbld', 03:00:01 INFO - 'MAIL': '/var/mail/cltbld', 03:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:01 INFO - 'MOZ_NO_REMOTE': '1', 03:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:01 INFO - 'NO_EM_RESTART': '1', 03:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:01 INFO - 'PWD': '/builds/slave/test', 03:00:01 INFO - 'SHELL': '/bin/bash', 03:00:01 INFO - 'SHLVL': '1', 03:00:01 INFO - 'TERM': 'linux', 03:00:01 INFO - 'TMOUT': '86400', 03:00:01 INFO - 'USER': 'cltbld', 03:00:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:01 INFO - '_': '/tools/buildbot/bin/python'} 03:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:01 INFO - Running setup.py (path:/tmp/pip-rFPIuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:01 INFO - Running setup.py (path:/tmp/pip-LUDTTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:02 INFO - Running setup.py (path:/tmp/pip-JEXPen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:02 INFO - Running setup.py (path:/tmp/pip-Srahpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:02 INFO - Running setup.py (path:/tmp/pip-rezGaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:02 INFO - Running setup.py (path:/tmp/pip-3bnM2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:02 INFO - Running setup.py (path:/tmp/pip-suQi0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:02 INFO - Running setup.py (path:/tmp/pip-e1ksMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:02 INFO - Running setup.py (path:/tmp/pip-3RG84S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:02 INFO - Running setup.py (path:/tmp/pip-_eVtFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:02 INFO - Running setup.py (path:/tmp/pip-2IfYat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:02 INFO - Running setup.py (path:/tmp/pip-dYpU87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:02 INFO - Running setup.py (path:/tmp/pip-y70Vqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:02 INFO - Running setup.py (path:/tmp/pip-Fk8hjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:02 INFO - Running setup.py (path:/tmp/pip-pKQHuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:02 INFO - Running setup.py (path:/tmp/pip-l8x_vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:03 INFO - Running setup.py (path:/tmp/pip-VHyIBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:03 INFO - Running setup.py install for manifestparser 03:00:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozcrash 03:00:03 INFO - Running setup.py install for mozdebug 03:00:03 INFO - Running setup.py install for mozdevice 03:00:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozfile 03:00:03 INFO - Running setup.py install for mozhttpd 03:00:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozinfo 03:00:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozInstall 03:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozleak 03:00:03 INFO - Running setup.py install for mozlog 03:00:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for moznetwork 03:00:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozprocess 03:00:04 INFO - Running setup.py install for mozprofile 03:00:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozrunner 03:00:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozscreenshot 03:00:04 INFO - Running setup.py install for moztest 03:00:04 INFO - Running setup.py install for mozversion 03:00:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:04 INFO - Cleaning up... 03:00:04 INFO - Return code: 0 03:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00: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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', '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 03:00: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 03:00: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 03:00:04 INFO - Using env: {'DISPLAY': ':0', 03:00:04 INFO - 'HOME': '/home/cltbld', 03:00:04 INFO - 'LANG': 'en_US.UTF-8', 03:00:04 INFO - 'LANGUAGE': 'en_US:en', 03:00:04 INFO - 'LOGNAME': 'cltbld', 03:00:04 INFO - 'MAIL': '/var/mail/cltbld', 03:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:04 INFO - 'MOZ_NO_REMOTE': '1', 03:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:04 INFO - 'NO_EM_RESTART': '1', 03:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:04 INFO - 'PWD': '/builds/slave/test', 03:00:04 INFO - 'SHELL': '/bin/bash', 03:00:04 INFO - 'SHLVL': '1', 03:00:04 INFO - 'TERM': 'linux', 03:00:04 INFO - 'TMOUT': '86400', 03:00:04 INFO - 'USER': 'cltbld', 03:00:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:04 INFO - '_': '/tools/buildbot/bin/python'} 03:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:05 INFO - Running setup.py (path:/tmp/pip-Efm8h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:05 INFO - Running setup.py (path:/tmp/pip-CyhhJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:05 INFO - Running setup.py (path:/tmp/pip-3_RLvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:05 INFO - Running setup.py (path:/tmp/pip-URavAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:05 INFO - Running setup.py (path:/tmp/pip-eCl7Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:05 INFO - Running setup.py (path:/tmp/pip-On1Uk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:05 INFO - Running setup.py (path:/tmp/pip-iwGXnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:05 INFO - Running setup.py (path:/tmp/pip-kn9CWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:05 INFO - Running setup.py (path:/tmp/pip-cU4o33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:05 INFO - Running setup.py (path:/tmp/pip-kmqrHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:05 INFO - Running setup.py (path:/tmp/pip-DdWL4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:05 INFO - Running setup.py (path:/tmp/pip-_rgnDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:05 INFO - Running setup.py (path:/tmp/pip-KC_6Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00: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)) 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:05 INFO - Running setup.py (path:/tmp/pip-V9Tvvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:06 INFO - Running setup.py (path:/tmp/pip-x8WD5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:06 INFO - Running setup.py (path:/tmp/pip-tCARbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:06 INFO - Running setup.py (path:/tmp/pip-wFVECx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:00:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:07 INFO - Downloading blessings-1.6.tar.gz 03:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:07 INFO - Installing collected packages: blessings 03:00:07 INFO - Running setup.py install for blessings 03:00:07 INFO - Successfully installed blessings 03:00:07 INFO - Cleaning up... 03:00:07 INFO - Return code: 0 03:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:07 INFO - Reading from file tmpfile_stdout 03:00:07 INFO - Current package versions: 03:00:07 INFO - argparse == 1.2.1 03:00:07 INFO - blessings == 1.6 03:00:07 INFO - blobuploader == 1.2.4 03:00:07 INFO - docopt == 0.6.1 03:00:07 INFO - functools32 == 3.2.3-2 03:00:07 INFO - jsonschema == 2.5.1 03:00:07 INFO - manifestparser == 1.1 03:00:07 INFO - mozInstall == 1.13 03:00:07 INFO - mozcrash == 1.0 03:00:07 INFO - mozdebug == 0.1 03:00:07 INFO - mozdevice == 0.51 03:00:07 INFO - mozfile == 1.2 03:00:07 INFO - mozhttpd == 0.7 03:00:07 INFO - mozinfo == 0.10 03:00:07 INFO - mozleak == 0.1 03:00:07 INFO - mozlog == 3.5 03:00:07 INFO - moznetwork == 0.27 03:00:07 INFO - mozprocess == 0.25 03:00:07 INFO - mozprofile == 0.28 03:00:07 INFO - mozrunner == 6.13 03:00:07 INFO - mozscreenshot == 0.1 03:00:07 INFO - mozsystemmonitor == 0.3 03:00:07 INFO - moztest == 0.8 03:00:07 INFO - mozversion == 1.4 03:00:07 INFO - psutil == 3.1.1 03:00:07 INFO - requests == 1.2.3 03:00:07 INFO - wsgiref == 0.1.2 03:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00: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')]} 03:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00: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 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', '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 03:00: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 03:00: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 03:00:07 INFO - Using env: {'DISPLAY': ':0', 03:00:07 INFO - 'HOME': '/home/cltbld', 03:00:07 INFO - 'LANG': 'en_US.UTF-8', 03:00:07 INFO - 'LANGUAGE': 'en_US:en', 03:00:07 INFO - 'LOGNAME': 'cltbld', 03:00:07 INFO - 'MAIL': '/var/mail/cltbld', 03:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:07 INFO - 'MOZ_NO_REMOTE': '1', 03:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:07 INFO - 'NO_EM_RESTART': '1', 03:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:07 INFO - 'PWD': '/builds/slave/test', 03:00:07 INFO - 'SHELL': '/bin/bash', 03:00:07 INFO - 'SHLVL': '1', 03:00:07 INFO - 'TERM': 'linux', 03:00:07 INFO - 'TMOUT': '86400', 03:00:07 INFO - 'USER': 'cltbld', 03:00:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:07 INFO - '_': '/tools/buildbot/bin/python'} 03:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:00:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:00:09 INFO - Installing collected packages: simplejson 03:00:09 INFO - Running setup.py install for simplejson 03:00:09 INFO - building 'simplejson._speedups' extension 03:00:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:00:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:00:10 INFO - Successfully installed simplejson 03:00:10 INFO - Cleaning up... 03:00:10 INFO - Return code: 0 03:00:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', '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 03:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:10 INFO - Using env: {'DISPLAY': ':0', 03:00:10 INFO - 'HOME': '/home/cltbld', 03:00:10 INFO - 'LANG': 'en_US.UTF-8', 03:00:10 INFO - 'LANGUAGE': 'en_US:en', 03:00:10 INFO - 'LOGNAME': 'cltbld', 03:00:10 INFO - 'MAIL': '/var/mail/cltbld', 03:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:10 INFO - 'MOZ_NO_REMOTE': '1', 03:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:10 INFO - 'NO_EM_RESTART': '1', 03:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:10 INFO - 'PWD': '/builds/slave/test', 03:00:10 INFO - 'SHELL': '/bin/bash', 03:00:10 INFO - 'SHLVL': '1', 03:00:10 INFO - 'TERM': 'linux', 03:00:10 INFO - 'TMOUT': '86400', 03:00:10 INFO - 'USER': 'cltbld', 03:00:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:10 INFO - '_': '/tools/buildbot/bin/python'} 03:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:10 INFO - Cleaning up... 03:00:10 INFO - Return code: 0 03:00:10 INFO - Running post-action listener: _resource_record_post_action 03:00:10 INFO - Running post-action listener: _start_resource_monitoring 03:00:10 INFO - Starting resource monitoring. 03:00:10 INFO - [mozharness: 2017-09-14 10:00:10.532336Z] Finished create-virtualenv step (success) 03:00:10 INFO - [mozharness: 2017-09-14 10:00:10.532854Z] Running install step. 03:00:10 INFO - Running pre-action listener: _resource_record_pre_action 03:00:10 INFO - Running main action method: install 03:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:10 INFO - Reading from file tmpfile_stdout 03:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:10 INFO - Reading from file tmpfile_stdout 03:00:10 INFO - Output received: 03:00:10 INFO - Usage: mozinstall [options] installer 03:00:10 INFO - Options: 03:00:10 INFO - -h, --help show this help message and exit 03:00:10 INFO - -d DEST, --destination=DEST 03:00:10 INFO - Directory to install application into. [default: 03:00:10 INFO - "/builds/slave/test"] 03:00:10 INFO - --app=APP Application being installed. [default: firefox] 03:00:10 INFO - mkdir: /builds/slave/test/build/application 03:00: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'] 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:00:28 INFO - Reading from file tmpfile_stdout 03:00:28 INFO - Output received: 03:00:28 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:28 INFO - Running post-action listener: _resource_record_post_action 03:00:28 INFO - [mozharness: 2017-09-14 10:00:28.487693Z] Finished install step (success) 03:00:28 INFO - [mozharness: 2017-09-14 10:00:28.487991Z] Running setup-mitmproxy step. 03:00:28 INFO - Running pre-action listener: _resource_record_pre_action 03:00:28 INFO - Running main action method: setup_mitmproxy 03:00:28 INFO - Skipping: mitmproxy is not required 03:00:28 INFO - Running post-action listener: _resource_record_post_action 03:00:28 INFO - [mozharness: 2017-09-14 10:00:28.489129Z] Finished setup-mitmproxy step (success) 03:00:28 INFO - [mozharness: 2017-09-14 10:00:28.489349Z] Running run-tests step. 03:00:28 INFO - Running pre-action listener: _resource_record_pre_action 03:00:28 INFO - Running pre-action listener: _set_gcov_prefix 03:00:28 INFO - Running main action method: run_tests 03:00:28 WARNING - Try message not found. 03:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:28 INFO - Python 2.7.3 03:00:28 INFO - Return code: 0 03:00:28 INFO - grabbing minidump binary from tooltool 03:00: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')]} 03:00: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 0x2841090>, '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 0x2841d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00: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 03:00: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 03:00: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 03:00:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:28 INFO - Return code: 0 03:00:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:28 INFO - ENV: RUST_BACKTRACE is now full 03:00:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00: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/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 03:00: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/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 03:00:28 INFO - Using env: {'DISPLAY': ':0', 03:00:28 INFO - 'HOME': '/home/cltbld', 03:00:28 INFO - 'LANG': 'en_US.UTF-8', 03:00:28 INFO - 'LANGUAGE': 'en_US:en', 03:00:28 INFO - 'LOGNAME': 'cltbld', 03:00:28 INFO - 'MAIL': '/var/mail/cltbld', 03:00:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:28 INFO - 'MOZ_NO_REMOTE': '1', 03:00:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:28 INFO - 'NO_EM_RESTART': '1', 03:00:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:28 INFO - 'PWD': '/builds/slave/test', 03:00:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:28 INFO - 'RUST_BACKTRACE': 'full', 03:00:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:28 INFO - 'SHELL': '/bin/bash', 03:00:28 INFO - 'SHLVL': '1', 03:00:28 INFO - 'TERM': 'linux', 03:00:28 INFO - 'TMOUT': '86400', 03:00:28 INFO - 'USER': 'cltbld', 03:00:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:28 INFO - '_': '/tools/buildbot/bin/python'} 03:00: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/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 03:00:28 INFO - mozversion application_buildid: 20170914084540 03:00:28 INFO - mozversion application_changeset: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 03:00:28 INFO - mozversion application_display_name: Nightly 03:00:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:28 INFO - mozversion application_name: Firefox 03:00:28 INFO - mozversion application_remotingname: firefox 03:00:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:28 INFO - mozversion application_vendor: Mozilla 03:00:28 INFO - mozversion application_version: 57.0a1 03:00:28 INFO - mozversion platform_buildid: 20170914084540 03:00:28 INFO - mozversion platform_changeset: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 03:00:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:28 INFO - mozversion platform_version: 57.0a1 03:00:28 INFO - using testdate: 1505383228 03:00:28 INFO - actual date: 1505383228 03:00:28 INFO - starting webserver on 'localhost:33229' 03:00:28 INFO - SUITE-START | Running 2 tests 03:00:28 INFO - TEST-START | dromaeo_css 03:00:28 INFO - Initialising browser for dromaeo_css test... 03:00:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33229/getInfo.html -profile /tmp/tmp8o8OKA/profile 03:00:28 INFO - TEST-INFO | started process 13860 (/builds/slave/test/build/application/firefox/firefox http://localhost:33229/getInfo.html) 03:00:34 INFO - TEST-INFO | 13860: exit 0 03:00:34 INFO - Browser initialized. 03:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:34 INFO - Using env: {'DISPLAY': ':0', 03:00:34 INFO - 'HOME': '/home/cltbld', 03:00:34 INFO - 'JSGC_DISABLE_POISONING': '1', 03:00:34 INFO - 'LANG': 'en_US.UTF-8', 03:00:34 INFO - 'LANGUAGE': 'en_US:en', 03:00:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:00:34 INFO - 'LOGNAME': 'cltbld', 03:00:34 INFO - 'MAIL': '/var/mail/cltbld', 03:00:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:34 INFO - 'MOZ_CRASHREPORTER': '1', 03:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:00:34 INFO - 'MOZ_NO_REMOTE': '1', 03:00:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:34 INFO - 'NO_EM_RESTART': '1', 03:00:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:34 INFO - 'PWD': '/builds/slave/test', 03:00:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:34 INFO - 'RUST_BACKTRACE': 'full', 03:00:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:34 INFO - 'SHELL': '/bin/bash', 03:00:34 INFO - 'SHLVL': '1', 03:00:34 INFO - 'STYLO_FORCE_DISABLED': '1', 03:00:34 INFO - 'TERM': 'linux', 03:00:34 INFO - 'TMOUT': '86400', 03:00:34 INFO - 'USER': 'cltbld', 03:00:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:34 INFO - '_': '/tools/buildbot/bin/python'} 03:00:34 INFO - TEST-INFO | started process 14095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8o8OKA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:35 INFO - PID 14095 | 03:00:35 INFO - PID 14095 | (/builds/slave/test/build/application/firefox/firefox:14144): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:00:35 INFO - PID 14095 | 03:00:45 INFO - PID 14095 | RSS: Main: 166301696 03:00:45 INFO - PID 14095 | 03:03:42 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33229/tests/dromaeo/cssquery-ext.html) 03:03:43 INFO - PID 14095 | RSS: Main: 169549824 03:03:43 INFO - PID 14095 | 03:06:45 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-ext.html (next: http://localhost:33229/tests/dromaeo/cssquery-jquery.html) 03:06:45 INFO - PID 14095 | RSS: Main: 164904960 03:06:45 INFO - PID 14095 | 03:09:47 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33229/tests/dromaeo/cssquery-mootools.html) 03:09:48 INFO - PID 14095 | RSS: Main: 167825408 03:09:48 INFO - PID 14095 | 03:12:49 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33229/tests/dromaeo/cssquery-prototype.html) 03:12:50 INFO - PID 14095 | RSS: Main: 166162432 03:12:50 INFO - PID 14095 | 03:15:53 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33229/tests/dromaeo/cssquery-yui.html) 03:15:54 INFO - PID 14095 | RSS: Main: 167661568 03:15:54 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-yui.html (next: http://localhost:33229/tests/dromaeo/cssquery-dojo.html) 03:18:55 INFO - PID 14095 | RSS: Main: 170500096 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | __start_tp_report 03:18:55 INFO - PID 14095 | _x_x_mozilla_page_load 03:18:55 INFO - PID 14095 | _x_x_mozilla_page_load_details 03:18:55 INFO - PID 14095 | |i|pagename|runs| 03:18:55 INFO - PID 14095 | |0;dojo.html;3797.563280222774;3798.2403519296145;3808.1241314497684;3812.875201815464;3816.122291872869;5971.223740913681;6005.969970150154;6024.2770867495965;6075.088736689488;6110.572259941806;6082.72627731752;6122.724477398517;6123.63258204508;6134.8159555213415;6156.969215153918;5421.83734487966;5482.479164479368;5505.009098362293;5506.944930550693;5556.416576259475;5542.1132618781;5581.107022876341;5587.525060369873;5591.8042868499615;5625.156226566007;671.2752350071355;5455.781768729246;5509.090999984997;5558.082916318823;5593.216949627055;5456.6725996439945;5460.481254280837;5465.672059676433;5484.8354549363585;5558.221848941152;5450.618456708032;5494.560435165217;5517.420670829585;5528.226048353234;5539.196816461631;5946.70266486674;6006.429389208019;6022.307434644984;6036.185115009462;6113.969430152821;6514.315996820361;6545.509086818508;6594;6631.23740769808;6635.535512514126;6477.870442591169;6551.705173267214;6602.2737498875085;6691.6319602421845;6701.229358623723;6195.721192546302;6263.091851681526;6268.592541484789;6268.717907694165;6303.810885673437;6799.830004249834;6805.829854253683;6810.761623343258;6891.000804883364;6893.551919125241;6484.610923344614;6537.280899101095;6575.704093315812;6579.769708060195;6660.533762636665;6649.63427011519;6677.031830384567;6677.3656502632175;6683.732650694015;6710.597364158166;6557.606543607399;6598.769043083469;6620.635865027373;6628.933710662832;6641.966790166019;6566.1135746674545;6581.703823327962;6599.142111525567;6604.698126095076;6690.866182676319;4807.326974223612;4864.635152363587;4892.437369702458;4939.135651261015;4941.950580494221;4446.73319600825;4461.866144015685;4466.196084704784;4504.234280172379;4528.773561321987;6087.786927457606;6104.4200800923845;6166.9383306167265;6219.626822390671;6222.968885155546;6461.773837915651;6561.343865613496;6613.669316534154;6650.70071846768;6663.533552651268;6082.787102451482;6086.117512960596;6177.1969643946895;6187.443130118221;6188.412100850412;5313.309269794902;5362.195670649434;5376.677399356051;5389.434109418533;5422.48486393792;6772.458203343819;6832.863342733118;6866.896996545056;6871.587704737732;6928.237893831674;6581.967090164614;6595.274519802914;6596.967015164893;6597.868042639025;6600.867982640416;6844.041834143124;6852.6916288768125;6858.725650974105;6883.208431030295;6917.89623155643;6507.219133703986;6517.73929042833;6531.902021469777;6612.669366531751;6628.767993120217;6623.834404139935;6641.767538136142;6724.8991265132045;6734.259231484631;6739.05653208561;6239.968800156152;6336.366363363811;6365.872682546231;6402.135711678864;6414.711337989895;6375.330590288138;6415.550911436155;6417.711202995783;6419.422251997343;6427.3251308611925;6261.405166509175;6271.404216599416;6344.9048264277;6345.4923606112325;6353.491720662243;6358.618482891041;6447.903281450688;6452.451541619015;6467.353264673495;6488.610683359014;6200.255969283715;6235.937640623536;6275.811725648238;6299.716512757029;6310.2743184534365 03:18:55 INFO - PID 14095 | |1;ext.html;921.9539023048845;925.7731855695356;955.6894009446929;998.3460833154282;998.9700308990733;43792.78103609481;44701;44817;44826;44872.3269150963;41918.79040604801;41920.37119443211;41943.370849437284;42085.36871946923;42164.367534487006;7159.749408770694;7188.820279493002;7212;7240.855182896339;7243.167035790872;7293.124825021005;7357.558546487228;7363.631818409058;7365.852682946338;7373;7345.1553071396675;7967.402444816633;7980.521168729866;7981.082175549799;7998.520088794662;7914.683412663487;7977.042754869424;7980.082290536576;7980.720674776413;7994.64024118916;7806.960965195194;7824.1002284737415;7909.209079092045;8032.919670803276;8135.633896474673;39699.40450893239;39740.801295993624;39827.20345593072;40004.599954000376;40007.19985600301;3553.378158822222;3576.946345804789;3578.534790477221;3581.212133330663;3589.3180295743987;33452.163695907795;33490.49764253538;33501.49747753786;33659.83170084158;33697.49453758196;5330.866728331784;5357.571394288448;5386;5390.8921821563745;5446.782128714846;204468;206344;206469;206737;207235;51982;52005.479945200066;52139.73930130325;52253.216201757;52289.47710522922;53955;54168.66650668016;54320.45679543233;54348.18477722837;54431.18353224705;16529.256183471774;16944.57638559046;16948.91525542389;17043.82956170447;17064;13854.584362469142;13913.860861391257;13926.373313200931;13972.231527265894;13973.371198296101;14607.19660418687;14722.190279534514;14826.110433374031;14832;14939.551813445614;5693.3168019837885;5792.82621521355;5921.763129474859;5927.436893495111;5978.133170690313;1086.1419478611965;1087.9238453308192;1102.074257623584;1106.8616422947132;1106.9280496767685;25448.618270725954;25455;25569.360765980626;25591.360215994748;25671.48657026849;1200.5797970710182;1208.848893888264;1216.2459275249403;1218.932958687263;1223.1193540650718;13490.865091349157;13601.31993400326;13696.246706431042;13753.312334383241;13777.724445511034;256696;258325;258812;260556;260758;50717.49282507202;51451.485485145415;58709.11936320959;59576.70211648914;59685.70157149187;1544.8146222453377;1555.673308605183;1568.749000159969;1573.5987323232732;1581.667849751542;30447.847760761055;31010.379792403575;31025.534616980312;31131.37737245197;31159.912836608226;37956.24087518289;38893.61106389013;41647;41830;41839.58160418357;218885;219464;221341;221349;221817;36763.63236367709;36888.26223475462;36959.26081478302;37004;37108.257834843695;45605.315920261884;46685;46786.29820552762;46893.53106468892;47609.28586071281;34402;34634.653653463145;34807.4778878312;34872.47691284683;35310.47034294539;35147.121321967155;35318.64681353256;35419.82290088533;35519;35697.46453803247;40089.39865901956;41094.38358424566;41152.794236028625;41206.381904270864;41213.175736485704;33522.832385837915;33725;33796.662033379354;34327.485087724206;34767.13082172865;25457.618135727607;25624.871875640503;25744;26264.606030909934;26434.86782566075 03:18:55 INFO - PID 14095 | |2;jquery.html;573.9483446489817;591.4263164730211;593.3502814418214;599.182116411099;599.4724642314762;23938.760612393893;24881.502369952614;24881.626775598357;24915.750842491616;24951.75048249517;24742.628860567107;25871.48257034858;26243.47513049738;26244.73755262447;26256.474870502578;6436.871262574746;6569.310222426648;6569.343065693416;6575.342465753411;6589.439897608709;6477.22273327199;6503.089567460559;6590.242122155942;6623.768168114117;6642.767503137391;6519.185101862267;6576.6711664416825;6591.769288074918;6608.603483790964;6608.834779130512;6568.376004279586;6590.1432813734145;6594.274629790719;6595.835104122411;6605.801825945229;6117.877642447171;6122.816315510542;6130.264368275791;6133.018717005258;6152.661603611799;28763;29234.269143271587;29738.553921691193;30080.849595751883;30154.698453015408;2261.807746341563;2283.954320913589;2285.2915596165244;2286.2912497125944;2287.313805858236;19840.801591984186;20473.795262047337;21407.03668334913;21420.571588568142;21463.356099317047;2441.7924476419525;2498.1756020513185;2516.836405633628;2536.8477891326393;2545.6054311581734;139175.30412347976;143801;157582.21208893883;167723;167900.16049919795;15380.385334493163;16191.514254572381;16230;16292.207857135705;16397.508074757778;25381.873090634428;25385.74614253871;25393.492130157294;25442.49115017689;25459.872700636377;10125;10283.485825708834;10378.532966016548;10445.11216546587;10549.156067514581;9534.189593884597;9562;9585.376950498196;9679.903200968041;9718.708438746708;9789.118979291756;9939.403635781731;10012.546926003175;10056.84914726265;10074.748131296776;2951.114665600311;2971.301744090137;2974.836383998901;2978.478766215947;3070.8925187618324;1024.533837104116;1039.9740006499746;1044.3107549017611;1048.3919326790444;1055.1400608504046;21309.893450532647;21439.249626263005;21888.23391181301;22027.229046983277;22102;1077.849101125843;1092.039005675001;1096.1121491591837;1096.6984079378235;1104.5471356743858;11892.464839082262;11930.105242106876;11941.223820451643;11961.46173422198;11977.880221197851;548443;553912;569125;569408;574175;128155;129957;131827;132146.33926830304;136464;1118.3569447567518;1163.988360116405;1174.3130268792852;1240.5906051003146;1309;22648.433789154744;22765.88617056904;22809.65785513252;23229.41926451852;23261.651075233545;65124.674376627816;66270;66449.33550664432;67410;68564;84016;84602.57698711714;85287;85752;86078.56960715157;21059.894700526398;21671.34985950424;21754.12983480643;21768.67346989828;21770.89114554417;24188.879055604608;24570.38574035592;24580.385490362885;24644.630330545413;24906.252812415656;17386.9130654351;19199.616007680048;19571.608567828847;20069.899650501655;20070.89964550168;17167.484975450756;17269.740953885954;17561.56096097608;18036.90981545084;18613.627727445106;20703.792962070187;20704.378868633965;20813.375598732062;20933.16267349289;21084;19841.404757857286;21052.684209737174;21281.467963301042;21325.36023919285;21356.572868542233;20056.69914951306;20096.296629617893;20184.293549725688;20248.291309804084;20318.187272508934 03:18:55 INFO - PID 14095 | |3;mootools.html;1419.4180386041721;1495.1851241073614;1496.0799108548247;1497.6106212384777;1502.5267040882118;16438.09590472525;17144.05707686077;17175.484735457925;17192.914035429836;17197;16714.83285167148;16769.748453773173;16788.99999999997;16828.07445590492;16858.494245172635;2812.5781132830034;2875.6405449318886;2901.695321991192;2907.4766542022426;2914.096630044682;2820.294926268433;2863.8115182199467;2901.3036871150875;2909.4617495763246;2910.9417811643752;2865.813722108067;2878.4387044526325;2885.8989935352265;2885.9278518037113;2886.134159752066;2696.932576685579;2725.127959053104;2726.263908744648;2736;2738.4659991301705;2683.6645419322585;2698.6221928929967;2712.22701530063;2726.481968425993;2730.085421383839;16341.509754707258;16539;16665.083420411993;16675.833241667548;16677.66644667112;8631.6978905738;8905.643774249022;8908.109189081104;8910.376273660846;8924.152205540464;5585.944140558624;5774.16274640179;5791.536677065825;5846.50304724099;5905.527557795409;2060.9690854637042;2106.7471903371693;2126.096409026173;2136.476563242016;2153.6231159547015;30080;30448.54327185094;30601.234969125504;30601.846990764905;30678.386432271454;7171.382445407493;7204.56772593646;7277.38142257914;7544.396448284124;7605.429592780453;18964.43106706801;19048.42854714361;19171.616567668847;19178.232870685017;19184.90407547953;8336.66653333872;8496.277816385553;8582.570871456526;8591.926009248844;8614.655413783505;7754.495957762841;7855.489393189425;7870.645820938072;7905.841883162419;7934.20657934202;5393.973030134903;5537.2524709163745;5553.4724201200825;5612.579056570774;5660.122680984454;1446.240723620108;1495.0805254768238;1574.5984773882587;1575.4328441760956;1631.8041834979879;964.3153361113688;965.3725078698761;965.4931161140317;968.8401413766791;971.3297824501071;9520.285978551636;9572.377795443273;9647.807043859084;9676.612935482643;9698.854517182248;1066.5040756048475;1071.994640026795;1072.120860894075;1072.5548897207727;1076.5855145768935;5490.368607610096;5885.705714714247;5925.762969481259;5933.554983376264;5950.940490595125;24230.151944681853;24459.388515286904;25371.112011079524;25497.872510637328;25641;25160.748392516205;25270.494590108094;25332.493350132892;25564.360890977874;25568.74431255701;11606.187566870238;12545.686357840945;12576.37118144089;12627.179233349803;12657.746845063048;9475.241980641395;9544.522773861141;9585.041495850639;9596.088371604686;9662.903370966482;20592.897035514725;21067.789322106582;21116.366509004754;21506.247281345077;21803.345899623037;21847.126114955223;21926.671099933832;22034.228801991852;22071.227507037176;22101.557968840854;10737.14102871784;10944.452777361259;11053.226274160732;11056;11057;14641.560753177422;14696.412143514568;14779.965402422158;14789.482368117064;14849.331780070139;12473.688157796129;12554.246745195318;12611.558595449114;12832.550860720203;12861.678458038625;11969.401529923643;12256;12434.316112613893;12615.49538018469;12660.87339126597;10723.624673136403;10896.073833724222;10911.072558832588;10914.563417463212;10924.399158046384;8163.428560000743;8280.420370574002;8358.791030224293;8392.412531122764;8428.4942903426;7706.653200605874;7861.292483676497;7876.724314649189;7878.960605197167;7925.207479252029 03:18:55 INFO - PID 14095 | |4;prototype.html;538.7791005687669;560.3835780641296;567.327716655763;567.6508946997598;576.5387689848118;6396.264429590598;6428.164338635983;6454.483641308696;6465.515086368524;6474.255460622024;6361.681915904198;6362.981922892338;6368.554201205918;6383.957133717212;6386.2975072741965;5167.069927413074;5185.948140518603;5210.322658054448;5213.921791173136;5214.634975551713;4899.412070551539;5142.254373115896;5148.485151484859;5219.973900130513;5224.346956630421;5004.924926126111;5008.749562521877;5034.496550344973;5045.470225626312;5059.6458247922665;4932.876678083041;4989.800407983676;5002.24966255061;5008.899822003557;5029.748512574393;4560.315952607136;4819.469858315582;4899.252072164797;4906.533879281463;4949.381327334083;6225.128482012522;6234.937650623527;6277.121203031579;6301;6336;6194.96902515489;6237.126802247689;6275.5252515658785;6302.275238347603;6338.429541341301;6824.931750682479;6825.965870170618;6888.586684798928;6930.965345173242;6935.930640693629;5505.587080968903;5516.200150978126;5543.861403464905;5547.25112109864;5568.192612071227;6865.5537390069485;6870.7595234166565;6933.583984960868;6970.756023539152;7015.754448594274;5654.802081927113;5666.518345940559;5681.119426488901;5699.772009119672;5707.34365547959;5770.682612456271;5793.333766616893;5808.244928159397;5815.302163740378;5854.912176317359;6179.84550386244;6193.628382296986;6200.56596038282;6215.285242197115;6277.623342599459;6819.181698196149;6863.965680171567;6865.588064716133;6883.965580172067;6887.621180835102;1965.164804957887;1982.960340793176;1995.2617531513433;2003.7395138632176;2009.2867032203649;1452.9611327900602;1495.409313321232;1504.6990601879668;1519.566923426818;1531.4716422834103;6366.236051673829;6366.427021568081;6368.395002474757;6378.936210637927;6380.457661098766;6829.351211634887;6863.450923926074;6873.828154296182;6894.276101009422;6937.375636192767;6252.406021427957;6272.181067490468;6360.872782544416;6400.39196276353;6402.8719425611225;3568.2149927016017;3580.872025312018;3600.7479476436397;3619.348517266917;3645.2527231917925;7081.291870812981;7161.641917904084;7220.566765993952;7228.927710722825;7244.963775181091;6764.255931847493;6946.583205007716;6961.686724097428;6965.164180298295;7029.8752199647815;7003.439724822002;7063.364297213276;7117.8932316016335;7129.500934934608;7139.32176443237;6708.6981085850275;6781.559198652072;6855.520113592001;6862.142232220973;6868.351595616916;6574.80275591733;6741.11269329732;6759.107449914032;6760.966195168992;6826.761063362957;7131.215566287808;7207.5675459472595;7230.060092187982;7231.63841807918;7246.673899674633;5697.886042279214;5724.284464441945;5734.942650573441;5737.684427356536;5750.769969201352;6673.699683514351;6711.765088221889;6811.93188068113;6853.476705374429;6999.020137180697;6584.308647592125;6635.767748128792;6646.335366463315;6664.366885145903;6678.198616166092;6445.292976949599;6549.214094308713;6561.671916404256;6640.966795165993;6678.7328506859185;6566.474682025522;6573.638449885111;6591.835204119935;6628.237752658506;6642.6014439133805;6563.34366563359;6613.735450581923;6637.800865974028;6649.135612370361;6685.684880520095;6245.500359971283;6348.968255158695;6349.4920406366455;6435.581687190318;6459.257185423737 03:18:55 INFO - PID 14095 | |5;yui.html;951.2722767083178;983.7294743945419;988.5650313861902;992.1913640383087;1017.781177046935;20491;21215.57568848622;21243.468913277156;21248.256311029116;21279.361619151452;19387.612247755038;19455.31906383277;19527;19661.705074423895;19882.304119355824;1060.0406631998035;1075.6450371377446;1079.4279032112993;1079.5142186016285;1079.5357996061691;1030.3096925060227;1068.0227591753537;1073.3506228731621;1073.393532654048;1073.978520429595;1136.2841409911784;1141.2524796258465;1142.7714457108611;1143.6969203161168;1144.4106285263097;1142.2632402100683;1142.7885841119337;1143.3825734103575;1144.9542018319257;1146.7018575170432;791.8139237279235;808.8261023879835;812.6018251056998;840.2227939156256;840.9698119803193;20516;20629;20669.586608267902;20671.89664051685;20688.379348619565;21633.134674613153;21828.345149645535;21963;22056.669149962763;22082.88958555213;17739.46781596554;17783.822161778477;17815.376461823773;17884.642307153783;17980.1009949502;3977.4033894915706;4018.8392464301687;4019.738716983387;4021.698372622065;4028.536718277406;153130;153351;155734;158491;161402;17989.100544972698;18192.727109093375;18220.45338639843;18481.353152639862;18690.15894284733;33906.49140262898;34903.650963490545;34949.30101397958;34969.47545786815;34993.65006349904;8871.600777965006;9061.093890610886;9197.586108625128;9197.81604367909;9210.539473026322;4540.228161212602;4635.513271106553;4638.072385522909;4640.97679511607;4652.558006989399;5711.543076553866;5743.971280143573;5804.100364443518;5865.090910908816;5889.852753681193;934.2572654739498;949.9572519236651;958.7363475044418;964.7057647417605;965.6764983730529;725.9673314700851;728.7048745258179;736.6169591812335;738.623302115914;760.7793739815502;12744.299063551594;12889.806652900214;12961;13058.21650700961;13073.546815002079;731.989020164698;733.0287369235677;735.0884902720588;739.737393225408;758.3591864874172;6284.308726040132;6327.905081423783;6398.072279519443;6449.838754031093;6455;144702;145025;146676;148119;148715;129571;129706;130730;130949.34525327312;134555.32722336325;102856;103490.96509034964;104746;104914;107953;12029.75940481203;12066.155369124077;12088.032957363566;12139.696507587028;12214.57248996281;54262.3721288362;54747.726261368436;55445;55636.16545751736;56921.43078569327;67806;67811.27038012957;68400.31599683939;68824.6558767203;71427;16574.917125414297;16590.58523536873;16607.916960415605;16640.667186655955;16786.32854685799;18507.35224267144;18732.906335468782;19027.809721902602;19126.61746765085;19356;17320.82679173192;17403.651926961138;17720.734188986917;17773.377931772327;17840.732389013916;17041.914790426465;17492.737608935622;17535.210915509087;17576.91211543934;17695.823041769418;16980.320787168373;17120.914395427943;17183.656326873144;17297.654046919244;17321.9606823591;12010.63968080959;12050.51797928073;12104.273743575413;12112.636620901387;12605.68485787826;12536;12538.93730531378;12659.113862029937;12893.097483176087;12895.226286422469 03:18:55 INFO - PID 14095 | __end_tp_report 03:18:55 INFO - PID 14095 | __start_cc_report 03:18:55 INFO - PID 14095 | _x_x_mozilla_cycle_collect,368 03:18:55 INFO - PID 14095 | __end_cc_report 03:18:55 INFO - PID 14095 | __startTimestamp1505384335740__endTimestamp 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | ------- Summary: start ------- 03:18:55 INFO - PID 14095 | Number of tests: 6 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#0] dojo.html Cycles:165 Average:6071.92 Median:6336.37 stddev:821.68 (13.0%) stddev-sans-first:804.60 03:18:55 INFO - PID 14095 | Values: 3797.6 3798.2 3808.1 3812.9 3816.1 5971.2 6006.0 6024.3 6075.1 6110.6 6082.7 6122.7 6123.6 6134.8 6157.0 5421.8 5482.5 5505.0 5506.9 5556.4 5542.1 5581.1 5587.5 5591.8 5625.2 671.3 5455.8 5509.1 5558.1 5593.2 5456.7 5460.5 5465.7 5484.8 5558.2 5450.6 5494.6 5517.4 5528.2 5539.2 5946.7 6006.4 6022.3 6036.2 6114.0 6514.3 6545.5 6594.0 6631.2 6635.5 6477.9 6551.7 6602.3 6691.6 6701.2 6195.7 6263.1 6268.6 6268.7 6303.8 6799.8 6805.8 6810.8 6891.0 6893.6 6484.6 6537.3 6575.7 6579.8 6660.5 6649.6 6677.0 6677.4 6683.7 6710.6 6557.6 6598.8 6620.6 6628.9 6642.0 6566.1 6581.7 6599.1 6604.7 6690.9 4807.3 4864.6 4892.4 4939.1 4942.0 4446.7 4461.9 4466.2 4504.2 4528.8 6087.8 6104.4 6166.9 6219.6 6223.0 6461.8 6561.3 6613.7 6650.7 6663.5 6082.8 6086.1 6177.2 6187.4 6188.4 5313.3 5362.2 5376.7 5389.4 5422.5 6772.5 6832.9 6866.9 6871.6 6928.2 6582.0 6595.3 6597.0 6597.9 6600.9 6844.0 6852.7 6858.7 6883.2 6917.9 6507.2 6517.7 6531.9 6612.7 6628.8 6623.8 6641.8 6724.9 6734.3 6739.1 6240.0 6336.4 6365.9 6402.1 6414.7 6375.3 6415.6 6417.7 6419.4 6427.3 6261.4 6271.4 6344.9 6345.5 6353.5 6358.6 6447.9 6452.5 6467.4 6488.6 6200.3 6235.9 6275.8 6299.7 6310.3 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#1] ext.html Cycles:180 Average:41034.86 Median:36825.95 stddev:59558.05 (161.7%) stddev-sans-first:59648.97 03:18:55 INFO - PID 14095 | Values: 922.0 925.8 955.7 998.3 999.0 43792.8 44701.0 44817.0 44826.0 44872.3 41918.8 41920.4 41943.4 42085.4 42164.4 7159.7 7188.8 7212.0 7240.9 7243.2 7293.1 7357.6 7363.6 7365.9 7373.0 7345.2 7967.4 7980.5 7981.1 7998.5 7914.7 7977.0 7980.1 7980.7 7994.6 7807.0 7824.1 7909.2 8032.9 8135.6 39699.4 39740.8 39827.2 40004.6 40007.2 3553.4 3576.9 3578.5 3581.2 3589.3 33452.2 33490.5 33501.5 33659.8 33697.5 5330.9 5357.6 5386.0 5390.9 5446.8 204468.0 206344.0 206469.0 206737.0 207235.0 51982.0 52005.5 52139.7 52253.2 52289.5 53955.0 54168.7 54320.5 54348.2 54431.2 16529.3 16944.6 16948.9 17043.8 17064.0 13854.6 13913.9 13926.4 13972.2 13973.4 14607.2 14722.2 14826.1 14832.0 14939.6 5693.3 5792.8 5921.8 5927.4 5978.1 1086.1 1087.9 1102.1 1106.9 1106.9 25448.6 25455.0 25569.4 25591.4 25671.5 1200.6 1208.8 1216.2 1218.9 1223.1 13490.9 13601.3 13696.2 13753.3 13777.7 256696.0 258325.0 258812.0 260556.0 260758.0 50717.5 51451.5 58709.1 59576.7 59685.7 1544.8 1555.7 1568.7 1573.6 1581.7 30447.8 31010.4 31025.5 31131.4 31159.9 37956.2 38893.6 41647.0 41830.0 41839.6 218885.0 219464.0 221341.0 221349.0 221817.0 36763.6 36888.3 36959.3 37004.0 37108.3 45605.3 46685.0 46786.3 46893.5 47609.3 34402.0 34634.7 34807.5 34872.5 35310.5 35147.1 35318.6 35419.8 35519.0 35697.5 40089.4 41094.4 41152.8 41206.4 41213.2 33522.8 33725.0 33796.7 34327.5 34767.1 25457.6 25624.9 25744.0 26264.6 26434.9 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#2] jquery.html Cycles:180 Average:39454.55 Median:12758.37 stddev:94921.89 (744.0%) stddev-sans-first:95143.28 03:18:55 INFO - PID 14095 | Values: 573.9 591.4 593.4 599.2 599.5 23938.8 24881.5 24881.6 24915.8 24951.8 24742.6 25871.5 26243.5 26244.7 26256.5 6436.9 6569.3 6569.3 6575.3 6589.4 6477.2 6503.1 6590.2 6623.8 6642.8 6519.2 6576.7 6591.8 6608.6 6608.8 6568.4 6590.1 6594.3 6595.8 6605.8 6117.9 6122.8 6130.3 6133.0 6152.7 28763.0 29234.3 29738.6 30080.8 30154.7 2261.8 2284.0 2285.3 2286.3 2287.3 19840.8 20473.8 21407.0 21420.6 21463.4 2441.8 2498.2 2516.8 2536.8 2545.6 139175.3 143801.0 157582.2 167723.0 167900.2 15380.4 16191.5 16230.0 16292.2 16397.5 25381.9 25385.7 25393.5 25442.5 25459.9 10125.0 10283.5 10378.5 10445.1 10549.2 9534.2 9562.0 9585.4 9679.9 9718.7 9789.1 9939.4 10012.5 10056.8 10074.7 2951.1 2971.3 2974.8 2978.5 3070.9 1024.5 1040.0 1044.3 1048.4 1055.1 21309.9 21439.2 21888.2 22027.2 22102.0 1077.8 1092.0 1096.1 1096.7 1104.5 11892.5 11930.1 11941.2 11961.5 11977.9 548443.0 553912.0 569125.0 569408.0 574175.0 128155.0 129957.0 131827.0 132146.3 136464.0 1118.4 1164.0 1174.3 1240.6 1309.0 22648.4 22765.9 22809.7 23229.4 23261.7 65124.7 66270.0 66449.3 67410.0 68564.0 84016.0 84602.6 85287.0 85752.0 86078.6 21059.9 21671.3 21754.1 21768.7 21770.9 24188.9 24570.4 24580.4 24644.6 24906.3 17386.9 19199.6 19571.6 20069.9 20070.9 17167.5 17269.7 17561.6 18036.9 18613.6 20703.8 20704.4 20813.4 20933.2 21084.0 19841.4 21052.7 21281.5 21325.4 21356.6 20056.7 20096.3 20184.3 20248.3 20318.2 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#3] mootools.html Cycles:180 Average:10391.21 Median:2690.30 stddev:7687.24 (285.7%) stddev-sans-first:7679.25 03:18:55 INFO - PID 14095 | Values: 1419.4 1495.2 1496.1 1497.6 1502.5 16438.1 17144.1 17175.5 17192.9 17197.0 16714.8 16769.7 16789.0 16828.1 16858.5 2812.6 2875.6 2901.7 2907.5 2914.1 2820.3 2863.8 2901.3 2909.5 2910.9 2865.8 2878.4 2885.9 2885.9 2886.1 2696.9 2725.1 2726.3 2736.0 2738.5 2683.7 2698.6 2712.2 2726.5 2730.1 16341.5 16539.0 16665.1 16675.8 16677.7 8631.7 8905.6 8908.1 8910.4 8924.2 5585.9 5774.2 5791.5 5846.5 5905.5 2061.0 2106.7 2126.1 2136.5 2153.6 30080.0 30448.5 30601.2 30601.8 30678.4 7171.4 7204.6 7277.4 7544.4 7605.4 18964.4 19048.4 19171.6 19178.2 19184.9 8336.7 8496.3 8582.6 8591.9 8614.7 7754.5 7855.5 7870.6 7905.8 7934.2 5394.0 5537.3 5553.5 5612.6 5660.1 1446.2 1495.1 1574.6 1575.4 1631.8 964.3 965.4 965.5 968.8 971.3 9520.3 9572.4 9647.8 9676.6 9698.9 1066.5 1072.0 1072.1 1072.6 1076.6 5490.4 5885.7 5925.8 5933.6 5950.9 24230.2 24459.4 25371.1 25497.9 25641.0 25160.7 25270.5 25332.5 25564.4 25568.7 11606.2 12545.7 12576.4 12627.2 12657.7 9475.2 9544.5 9585.0 9596.1 9662.9 20592.9 21067.8 21116.4 21506.2 21803.3 21847.1 21926.7 22034.2 22071.2 22101.6 10737.1 10944.5 11053.2 11056.0 11057.0 14641.6 14696.4 14780.0 14789.5 14849.3 12473.7 12554.2 12611.6 12832.6 12861.7 11969.4 12256.0 12434.3 12615.5 12660.9 10723.6 10896.1 10911.1 10914.6 10924.4 8163.4 8280.4 8358.8 8392.4 8428.5 7706.7 7861.3 7876.7 7879.0 7925.2 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#4] prototype.html Cycles:180 Average:5806.20 Median:6368.47 stddev:1567.16 (24.6%) stddev-sans-first:1520.87 03:18:55 INFO - PID 14095 | Values: 538.8 560.4 567.3 567.7 576.5 6396.3 6428.2 6454.5 6465.5 6474.3 6361.7 6363.0 6368.6 6384.0 6386.3 5167.1 5185.9 5210.3 5213.9 5214.6 4899.4 5142.3 5148.5 5220.0 5224.3 5004.9 5008.7 5034.5 5045.5 5059.6 4932.9 4989.8 5002.2 5008.9 5029.7 4560.3 4819.5 4899.3 4906.5 4949.4 6225.1 6234.9 6277.1 6301.0 6336.0 6195.0 6237.1 6275.5 6302.3 6338.4 6824.9 6826.0 6888.6 6931.0 6935.9 5505.6 5516.2 5543.9 5547.3 5568.2 6865.6 6870.8 6933.6 6970.8 7015.8 5654.8 5666.5 5681.1 5699.8 5707.3 5770.7 5793.3 5808.2 5815.3 5854.9 6179.8 6193.6 6200.6 6215.3 6277.6 6819.2 6864.0 6865.6 6884.0 6887.6 1965.2 1983.0 1995.3 2003.7 2009.3 1453.0 1495.4 1504.7 1519.6 1531.5 6366.2 6366.4 6368.4 6378.9 6380.5 6829.4 6863.5 6873.8 6894.3 6937.4 6252.4 6272.2 6360.9 6400.4 6402.9 3568.2 3580.9 3600.7 3619.3 3645.3 7081.3 7161.6 7220.6 7228.9 7245.0 6764.3 6946.6 6961.7 6965.2 7029.9 7003.4 7063.4 7117.9 7129.5 7139.3 6708.7 6781.6 6855.5 6862.1 6868.4 6574.8 6741.1 6759.1 6761.0 6826.8 7131.2 7207.6 7230.1 7231.6 7246.7 5697.9 5724.3 5734.9 5737.7 5750.8 6673.7 6711.8 6811.9 6853.5 6999.0 6584.3 6635.8 6646.3 6664.4 6678.2 6445.3 6549.2 6561.7 6641.0 6678.7 6566.5 6573.6 6591.8 6628.2 6642.6 6563.3 6613.7 6637.8 6649.1 6685.7 6245.5 6349.0 6349.5 6435.6 6459.3 03:18:55 INFO - PID 14095 | 03:18:55 INFO - PID 14095 | [#5] yui.html Cycles:180 Average:27603.40 Median:18598.76 stddev:41113.66 (221.1%) stddev-sans-first:41180.29 03:18:55 INFO - PID 14095 | Values: 951.3 983.7 988.6 992.2 1017.8 20491.0 21215.6 21243.5 21248.3 21279.4 19387.6 19455.3 19527.0 19661.7 19882.3 1060.0 1075.6 1079.4 1079.5 1079.5 1030.3 1068.0 1073.4 1073.4 1074.0 1136.3 1141.3 1142.8 1143.7 1144.4 1142.3 1142.8 1143.4 1145.0 1146.7 791.8 808.8 812.6 840.2 841.0 20516.0 20629.0 20669.6 20671.9 20688.4 21633.1 21828.3 21963.0 22056.7 22082.9 17739.5 17783.8 17815.4 17884.6 17980.1 3977.4 4018.8 4019.7 4021.7 4028.5 153130.0 153351.0 155734.0 158491.0 161402.0 17989.1 18192.7 18220.5 18481.4 18690.2 33906.5 34903.7 34949.3 34969.5 34993.7 8871.6 9061.1 9197.6 9197.8 9210.5 4540.2 4635.5 4638.1 4641.0 4652.6 5711.5 5744.0 5804.1 5865.1 5889.9 934.3 950.0 958.7 964.7 965.7 726.0 728.7 736.6 738.6 760.8 12744.3 12889.8 12961.0 13058.2 13073.5 732.0 733.0 735.1 739.7 758.4 6284.3 6327.9 6398.1 6449.8 6455.0 144702.0 145025.0 146676.0 148119.0 148715.0 129571.0 129706.0 130730.0 130949.3 134555.3 102856.0 103491.0 104746.0 104914.0 107953.0 12029.8 12066.2 12088.0 12139.7 12214.6 54262.4 54747.7 55445.0 55636.2 56921.4 67806.0 67811.3 68400.3 68824.7 71427.0 16574.9 16590.6 16607.9 16640.7 16786.3 18507.4 18732.9 19027.8 19126.6 19356.0 17320.8 17403.7 17720.7 17773.4 17840.7 17041.9 17492.7 17535.2 17576.9 17695.8 16980.3 17120.9 17183.7 17297.7 17322.0 12010.6 12050.5 12104.3 12112.6 12605.7 12536.0 12538.9 12659.1 12893.1 12895.2 03:18:55 INFO - PID 14095 | -------- Summary: end -------- 03:18:55 INFO - PID 14095 | 03:18:56 INFO - TEST-INFO | 14095: exit 0 03:18:56 INFO - TEST-OK | dromaeo_css | took 1107528ms 03:18:56 INFO - TEST-START | kraken 03:18:56 INFO - Initialising browser for kraken test... 03:18:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33229/getInfo.html -profile /tmp/tmp5wnxxI/profile 03:18:56 INFO - TEST-INFO | started process 14467 (/builds/slave/test/build/application/firefox/firefox http://localhost:33229/getInfo.html) 03:19:01 INFO - TEST-INFO | 14467: exit 0 03:19:01 INFO - Browser initialized. 03:19:01 INFO - Running cycle 1/1 for kraken test... 03:19:01 INFO - Using env: {'DISPLAY': ':0', 03:19:01 INFO - 'HOME': '/home/cltbld', 03:19:01 INFO - 'JSGC_DISABLE_POISONING': '1', 03:19:01 INFO - 'LANG': 'en_US.UTF-8', 03:19:01 INFO - 'LANGUAGE': 'en_US:en', 03:19:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:19:01 INFO - 'LOGNAME': 'cltbld', 03:19:01 INFO - 'MAIL': '/var/mail/cltbld', 03:19:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:01 INFO - 'MOZ_CRASHREPORTER': '1', 03:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:19:01 INFO - 'MOZ_NO_REMOTE': '1', 03:19:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:01 INFO - 'NO_EM_RESTART': '1', 03:19:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:01 INFO - 'PWD': '/builds/slave/test', 03:19:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:01 INFO - 'RUST_BACKTRACE': 'full', 03:19:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:19:01 INFO - 'SHELL': '/bin/bash', 03:19:01 INFO - 'SHLVL': '1', 03:19:01 INFO - 'STYLO_FORCE_DISABLED': '1', 03:19:01 INFO - 'TERM': 'linux', 03:19:01 INFO - 'TMOUT': '86400', 03:19:01 INFO - 'USER': 'cltbld', 03:19:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969', 03:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:01 INFO - '_': '/tools/buildbot/bin/python'} 03:19:01 INFO - TEST-INFO | started process 14710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wnxxI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:02 INFO - PID 14710 | 03:19:02 INFO - PID 14710 | (/builds/slave/test/build/application/firefox/firefox:14759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:19:02 INFO - PID 14710 | 03:19:12 INFO - PID 14710 | RSS: Main: 164261888 03:19:12 INFO - PID 14710 | 03:19:15 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:16 INFO - PID 14710 | RSS: Main: 168910848 03:19:16 INFO - PID 14710 | 03:19:18 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-dft) 03:19:19 INFO - PID 14710 | RSS: Main: 169500672 03:19:19 INFO - PID 14710 | 03:19:22 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-fft) 03:19:22 INFO - PID 14710 | RSS: Main: 164712448 03:19:22 INFO - PID 14710 | 03:19:24 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-oscillator) 03:19:25 INFO - PID 14710 | RSS: Main: 166105088 03:19:25 INFO - PID 14710 | 03:19:27 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:28 INFO - PID 14710 | RSS: Main: 165556224 03:19:28 INFO - PID 14710 | 03:19:31 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:32 INFO - PID 14710 | RSS: Main: 169660416 03:19:32 INFO - PID 14710 | 03:19:35 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:36 INFO - PID 14710 | RSS: Main: 168222720 03:19:36 INFO - PID 14710 | 03:19:39 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33229/tests/kraken/driver.html?testName=json-parse-financial) 03:19:39 INFO - PID 14710 | RSS: Main: 168886272 03:19:39 INFO - PID 14710 | 03:19:41 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:41 INFO - PID 14710 | RSS: Main: 168386560 03:19:41 INFO - PID 14710 | 03:19:43 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:44 INFO - PID 14710 | RSS: Main: 168988672 03:19:44 INFO - PID 14710 | 03:19:46 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:46 INFO - PID 14710 | RSS: Main: 165801984 03:19:46 INFO - PID 14710 | 03:19:49 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:49 INFO - PID 14710 | RSS: Main: 166395904 03:19:49 INFO - PID 14710 | 03:19:52 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:53 INFO - PID 14710 | RSS: Main: 165842944 03:19:53 INFO - PID 14710 | 03:19:54 INFO - PID 14710 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33229/tests/kraken/driver.html?testName=ai-astar) 03:19:55 INFO - PID 14710 | RSS: Main: 168333312 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | __start_tp_report 03:19:55 INFO - PID 14710 | _x_x_mozilla_page_load 03:19:55 INFO - PID 14710 | _x_x_mozilla_page_load_details 03:19:55 INFO - PID 14710 | |i|pagename|runs| 03:19:55 INFO - PID 14710 | |0;ai-astar;107;107;106;105;106;107;108;105;105;106 03:19:55 INFO - PID 14710 | |1;audio-beat-detection;113;111;113;136;113;111;112;113;135;115 03:19:55 INFO - PID 14710 | |2;audio-dft;162;164;164;162;162;163;163;164;163;171 03:19:55 INFO - PID 14710 | |3;audio-fft;73;73;72;73;74;73;75;73;74;73 03:19:55 INFO - PID 14710 | |4;audio-oscillator;80;79;79;78;78;78;79;79;77;79 03:19:55 INFO - PID 14710 | |5;imaging-gaussian-blur;117;109;113;113;113;115;113;114;114;113 03:19:55 INFO - PID 14710 | |6;imaging-darkroom;153;157;152;150;155;149;150;151;150;153 03:19:55 INFO - PID 14710 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 03:19:55 INFO - PID 14710 | |8;json-parse-financial;45;45;45;43;44;44;45;44;52;44 03:19:55 INFO - PID 14710 | |9;json-stringify-tinderbox;38;38;38;39;40;38;38;38;38;39 03:19:55 INFO - PID 14710 | |10;stanford-crypto-aes;72;73;71;72;71;72;72;75;70;76 03:19:55 INFO - PID 14710 | |11;stanford-crypto-ccm;110;104;106;100;103;107;112;108;117;105 03:19:55 INFO - PID 14710 | |12;stanford-crypto-pbkdf2;180;150;156;151;161;151;154;160;153;157 03:19:55 INFO - PID 14710 | |13;stanford-crypto-sha256-iterative;67;62;59;61;59;60;61;60;62;68 03:19:55 INFO - PID 14710 | __end_tp_report 03:19:55 INFO - PID 14710 | __start_cc_report 03:19:55 INFO - PID 14710 | _x_x_mozilla_cycle_collect,877 03:19:55 INFO - PID 14710 | __end_cc_report 03:19:55 INFO - PID 14710 | __startTimestamp1505384395151__endTimestamp 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | ------- Summary: start ------- 03:19:55 INFO - PID 14710 | Number of tests: 14 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.50 stddev:1.03 (1.0%) stddev-sans-first:1.05 03:19:55 INFO - PID 14710 | Values: 107.0 107.0 106.0 105.0 106.0 107.0 108.0 105.0 105.0 106.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:113.00 stddev:9.72 (8.6%) stddev-sans-first:10.19 03:19:55 INFO - PID 14710 | Values: 113.0 111.0 113.0 136.0 113.0 111.0 112.0 113.0 135.0 115.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.66 (1.6%) stddev-sans-first:2.74 03:19:55 INFO - PID 14710 | Values: 162.0 164.0 164.0 162.0 162.0 163.0 163.0 164.0 163.0 171.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 03:19:55 INFO - PID 14710 | Values: 73.0 73.0 72.0 73.0 74.0 73.0 75.0 73.0 74.0 73.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:0.84 (1.1%) stddev-sans-first:0.73 03:19:55 INFO - PID 14710 | Values: 80.0 79.0 79.0 78.0 78.0 78.0 79.0 79.0 77.0 79.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:2.01 (1.8%) stddev-sans-first:1.66 03:19:55 INFO - PID 14710 | Values: 117.0 109.0 113.0 113.0 113.0 115.0 113.0 114.0 114.0 113.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.50 stddev:2.54 (1.7%) stddev-sans-first:2.67 03:19:55 INFO - PID 14710 | Values: 153.0 157.0 152.0 150.0 155.0 149.0 150.0 151.0 150.0 153.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:19:55 INFO - PID 14710 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.00 stddev:2.51 (5.6%) stddev-sans-first:2.67 03:19:55 INFO - PID 14710 | Values: 45.0 45.0 45.0 43.0 44.0 44.0 45.0 44.0 52.0 44.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:0.70 (1.8%) stddev-sans-first:0.73 03:19:55 INFO - PID 14710 | Values: 38.0 38.0 38.0 39.0 40.0 38.0 38.0 38.0 38.0 39.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.00 stddev:1.84 (2.6%) stddev-sans-first:1.94 03:19:55 INFO - PID 14710 | Values: 72.0 73.0 71.0 72.0 71.0 72.0 72.0 75.0 70.0 76.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:107.50 stddev:4.87 (4.5%) stddev-sans-first:5.06 03:19:55 INFO - PID 14710 | Values: 110.0 104.0 106.0 100.0 103.0 107.0 112.0 108.0 117.0 105.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:156.50 stddev:8.82 (5.6%) stddev-sans-first:3.99 03:19:55 INFO - PID 14710 | Values: 180.0 150.0 156.0 151.0 161.0 151.0 154.0 160.0 153.0 157.0 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:3.14 (5.1%) stddev-sans-first:2.74 03:19:55 INFO - PID 14710 | Values: 67.0 62.0 59.0 61.0 59.0 60.0 61.0 60.0 62.0 68.0 03:19:55 INFO - PID 14710 | -------- Summary: end -------- 03:19:55 INFO - PID 14710 | 03:19:55 INFO - PID 14710 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:19:55 INFO - TEST-INFO | 14710: exit 0 03:19:55 INFO - TEST-OK | kraken | took 59464ms 03:19:55 INFO - SUITE-END | took 1166s 03:19:56 INFO - Completed test suite (00:19:27) 03:19:56 INFO - javascript benchmark 03:19:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9060.223937405459, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3797.563280222774, 3798.2403519296145, 3808.1241314497684, 3812.875201815464, 3816.122291872869, 5971.223740913681, 6005.969970150154, 6024.2770867495965, 6075.088736689488, 6110.572259941806, 6082.72627731752, 6122.724477398517, 6123.63258204508, 6134.8159555213415, 6156.969215153918, 5421.83734487966, 5482.479164479368, 5505.009098362293, 5506.944930550693, 5556.416576259475, 5542.1132618781, 5581.107022876341, 5587.525060369873, 5591.8042868499615, 5625.156226566007, 671.2752350071355, 5455.781768729246, 5509.090999984997, 5558.082916318823, 5593.216949627055, 5456.6725996439945, 5460.481254280837, 5465.672059676433, 5484.8354549363585, 5558.221848941152, 5450.618456708032, 5494.560435165217, 5517.420670829585, 5528.226048353234, 5539.196816461631, 5946.70266486674, 6006.429389208019, 6022.307434644984, 6036.185115009462, 6113.969430152821, 6514.315996820361, 6545.509086818508, 6594.0, 6631.23740769808, 6635.535512514126, 6477.870442591169, 6551.705173267214, 6602.2737498875085, 6691.6319602421845, 6701.229358623723, 6195.721192546302, 6263.091851681526, 6268.592541484789, 6268.717907694165, 6303.810885673437, 6799.830004249834, 6805.829854253683, 6810.761623343258, 6891.000804883364, 6893.551919125241, 6484.610923344614, 6537.280899101095, 6575.704093315812, 6579.769708060195, 6660.533762636665, 6649.63427011519, 6677.031830384567, 6677.3656502632175, 6683.732650694015, 6710.597364158166, 6557.606543607399, 6598.769043083469, 6620.635865027373, 6628.933710662832, 6641.966790166019, 6566.1135746674545, 6581.703823327962, 6599.142111525567, 6604.698126095076, 6690.866182676319, 4807.326974223612, 4864.635152363587, 4892.437369702458, 4939.135651261015, 4941.950580494221, 4446.73319600825, 4461.866144015685, 4466.196084704784, 4504.234280172379, 4528.773561321987, 6087.786927457606, 6104.4200800923845, 6166.9383306167265, 6219.626822390671, 6222.968885155546, 6461.773837915651, 6561.343865613496, 6613.669316534154, 6650.70071846768, 6663.533552651268, 6082.787102451482, 6086.117512960596, 6177.1969643946895, 6187.443130118221, 6188.412100850412, 5313.309269794902, 5362.195670649434, 5376.677399356051, 5389.434109418533, 5422.48486393792, 6772.458203343819, 6832.863342733118, 6866.896996545056, 6871.587704737732, 6928.237893831674, 6581.967090164614, 6595.274519802914, 6596.967015164893, 6597.868042639025, 6600.867982640416, 6844.041834143124, 6852.6916288768125, 6858.725650974105, 6883.208431030295, 6917.89623155643, 6507.219133703986, 6517.73929042833, 6531.902021469777, 6612.669366531751, 6628.767993120217, 6623.834404139935, 6641.767538136142, 6724.8991265132045, 6734.259231484631, 6739.05653208561, 6239.968800156152, 6336.366363363811, 6365.872682546231, 6402.135711678864, 6414.711337989895, 6375.330590288138, 6415.550911436155, 6417.711202995783, 6419.422251997343, 6427.3251308611925, 6261.405166509175, 6271.404216599416, 6344.9048264277, 6345.4923606112325, 6353.491720662243, 6358.618482891041, 6447.903281450688, 6452.451541619015, 6467.353264673495, 6488.610683359014, 6200.255969283715, 6235.937640623536, 6275.811725648238, 6299.716512757029, 6310.2743184534365], "value": 6019.435043622433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.9539023048845, 925.7731855695356, 955.6894009446929, 998.3460833154282, 998.9700308990733, 43792.78103609481, 44701.0, 44817.0, 44826.0, 44872.3269150963, 41918.79040604801, 41920.37119443211, 41943.370849437284, 42085.36871946923, 42164.367534487006, 7159.749408770694, 7188.820279493002, 7212.0, 7240.855182896339, 7243.167035790872, 7293.124825021005, 7357.558546487228, 7363.631818409058, 7365.852682946338, 7373.0, 7345.1553071396675, 7967.402444816633, 7980.521168729866, 7981.082175549799, 7998.520088794662, 7914.683412663487, 7977.042754869424, 7980.082290536576, 7980.720674776413, 7994.64024118916, 7806.960965195194, 7824.1002284737415, 7909.209079092045, 8032.919670803276, 8135.633896474673, 39699.40450893239, 39740.801295993624, 39827.20345593072, 40004.599954000376, 40007.19985600301, 3553.378158822222, 3576.946345804789, 3578.534790477221, 3581.212133330663, 3589.3180295743987, 33452.163695907795, 33490.49764253538, 33501.49747753786, 33659.83170084158, 33697.49453758196, 5330.866728331784, 5357.571394288448, 5386.0, 5390.8921821563745, 5446.782128714846, 204468.0, 206344.0, 206469.0, 206737.0, 207235.0, 51982.0, 52005.479945200066, 52139.73930130325, 52253.216201757, 52289.47710522922, 53955.0, 54168.66650668016, 54320.45679543233, 54348.18477722837, 54431.18353224705, 16529.256183471774, 16944.57638559046, 16948.91525542389, 17043.82956170447, 17064.0, 13854.584362469142, 13913.860861391257, 13926.373313200931, 13972.231527265894, 13973.371198296101, 14607.19660418687, 14722.190279534514, 14826.110433374031, 14832.0, 14939.551813445614, 5693.3168019837885, 5792.82621521355, 5921.763129474859, 5927.436893495111, 5978.133170690313, 1086.1419478611965, 1087.9238453308192, 1102.074257623584, 1106.8616422947132, 1106.9280496767685, 25448.618270725954, 25455.0, 25569.360765980626, 25591.360215994748, 25671.48657026849, 1200.5797970710182, 1208.848893888264, 1216.2459275249403, 1218.932958687263, 1223.1193540650718, 13490.865091349157, 13601.31993400326, 13696.246706431042, 13753.312334383241, 13777.724445511034, 256696.0, 258325.0, 258812.0, 260556.0, 260758.0, 50717.49282507202, 51451.485485145415, 58709.11936320959, 59576.70211648914, 59685.70157149187, 1544.8146222453377, 1555.673308605183, 1568.749000159969, 1573.5987323232732, 1581.667849751542, 30447.847760761055, 31010.379792403575, 31025.534616980312, 31131.37737245197, 31159.912836608226, 37956.24087518289, 38893.61106389013, 41647.0, 41830.0, 41839.58160418357, 218885.0, 219464.0, 221341.0, 221349.0, 221817.0, 36763.63236367709, 36888.26223475462, 36959.26081478302, 37004.0, 37108.257834843695, 45605.315920261884, 46685.0, 46786.29820552762, 46893.53106468892, 47609.28586071281, 34402.0, 34634.653653463145, 34807.4778878312, 34872.47691284683, 35310.47034294539, 35147.121321967155, 35318.64681353256, 35419.82290088533, 35519.0, 35697.46453803247, 40089.39865901956, 41094.38358424566, 41152.794236028625, 41206.381904270864, 41213.175736485704, 33522.832385837915, 33725.0, 33796.662033379354, 34327.485087724206, 34767.13082172865, 25457.618135727607, 25624.871875640503, 25744.0, 26264.606030909934, 26434.86782566075], "value": 18376.9343538668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9483446489817, 591.4263164730211, 593.3502814418214, 599.182116411099, 599.4724642314762, 23938.760612393893, 24881.502369952614, 24881.626775598357, 24915.750842491616, 24951.75048249517, 24742.628860567107, 25871.48257034858, 26243.47513049738, 26244.73755262447, 26256.474870502578, 6436.871262574746, 6569.310222426648, 6569.343065693416, 6575.342465753411, 6589.439897608709, 6477.22273327199, 6503.089567460559, 6590.242122155942, 6623.768168114117, 6642.767503137391, 6519.185101862267, 6576.6711664416825, 6591.769288074918, 6608.603483790964, 6608.834779130512, 6568.376004279586, 6590.1432813734145, 6594.274629790719, 6595.835104122411, 6605.801825945229, 6117.877642447171, 6122.816315510542, 6130.264368275791, 6133.018717005258, 6152.661603611799, 28763.0, 29234.269143271587, 29738.553921691193, 30080.849595751883, 30154.698453015408, 2261.807746341563, 2283.954320913589, 2285.2915596165244, 2286.2912497125944, 2287.313805858236, 19840.801591984186, 20473.795262047337, 21407.03668334913, 21420.571588568142, 21463.356099317047, 2441.7924476419525, 2498.1756020513185, 2516.836405633628, 2536.8477891326393, 2545.6054311581734, 139175.30412347976, 143801.0, 157582.21208893883, 167723.0, 167900.16049919795, 15380.385334493163, 16191.514254572381, 16230.0, 16292.207857135705, 16397.508074757778, 25381.873090634428, 25385.74614253871, 25393.492130157294, 25442.49115017689, 25459.872700636377, 10125.0, 10283.485825708834, 10378.532966016548, 10445.11216546587, 10549.156067514581, 9534.189593884597, 9562.0, 9585.376950498196, 9679.903200968041, 9718.708438746708, 9789.118979291756, 9939.403635781731, 10012.546926003175, 10056.84914726265, 10074.748131296776, 2951.114665600311, 2971.301744090137, 2974.836383998901, 2978.478766215947, 3070.8925187618324, 1024.533837104116, 1039.9740006499746, 1044.3107549017611, 1048.3919326790444, 1055.1400608504046, 21309.893450532647, 21439.249626263005, 21888.23391181301, 22027.229046983277, 22102.0, 1077.849101125843, 1092.039005675001, 1096.1121491591837, 1096.6984079378235, 1104.5471356743858, 11892.464839082262, 11930.105242106876, 11941.223820451643, 11961.46173422198, 11977.880221197851, 548443.0, 553912.0, 569125.0, 569408.0, 574175.0, 128155.0, 129957.0, 131827.0, 132146.33926830304, 136464.0, 1118.3569447567518, 1163.988360116405, 1174.3130268792852, 1240.5906051003146, 1309.0, 22648.433789154744, 22765.88617056904, 22809.65785513252, 23229.41926451852, 23261.651075233545, 65124.674376627816, 66270.0, 66449.33550664432, 67410.0, 68564.0, 84016.0, 84602.57698711714, 85287.0, 85752.0, 86078.56960715157, 21059.894700526398, 21671.34985950424, 21754.12983480643, 21768.67346989828, 21770.89114554417, 24188.879055604608, 24570.38574035592, 24580.385490362885, 24644.630330545413, 24906.252812415656, 17386.9130654351, 19199.616007680048, 19571.608567828847, 20069.899650501655, 20070.89964550168, 17167.484975450756, 17269.740953885954, 17561.56096097608, 18036.90981545084, 18613.627727445106, 20703.792962070187, 20704.378868633965, 20813.375598732062, 20933.16267349289, 21084.0, 19841.404757857286, 21052.684209737174, 21281.467963301042, 21325.36023919285, 21356.572868542233, 20056.69914951306, 20096.296629617893, 20184.293549725688, 20248.291309804084, 20318.187272508934], "value": 13084.596852405411, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.4180386041721, 1495.1851241073614, 1496.0799108548247, 1497.6106212384777, 1502.5267040882118, 16438.09590472525, 17144.05707686077, 17175.484735457925, 17192.914035429836, 17197.0, 16714.83285167148, 16769.748453773173, 16788.99999999997, 16828.07445590492, 16858.494245172635, 2812.5781132830034, 2875.6405449318886, 2901.695321991192, 2907.4766542022426, 2914.096630044682, 2820.294926268433, 2863.8115182199467, 2901.3036871150875, 2909.4617495763246, 2910.9417811643752, 2865.813722108067, 2878.4387044526325, 2885.8989935352265, 2885.9278518037113, 2886.134159752066, 2696.932576685579, 2725.127959053104, 2726.263908744648, 2736.0, 2738.4659991301705, 2683.6645419322585, 2698.6221928929967, 2712.22701530063, 2726.481968425993, 2730.085421383839, 16341.509754707258, 16539.0, 16665.083420411993, 16675.833241667548, 16677.66644667112, 8631.6978905738, 8905.643774249022, 8908.109189081104, 8910.376273660846, 8924.152205540464, 5585.944140558624, 5774.16274640179, 5791.536677065825, 5846.50304724099, 5905.527557795409, 2060.9690854637042, 2106.7471903371693, 2126.096409026173, 2136.476563242016, 2153.6231159547015, 30080.0, 30448.54327185094, 30601.234969125504, 30601.846990764905, 30678.386432271454, 7171.382445407493, 7204.56772593646, 7277.38142257914, 7544.396448284124, 7605.429592780453, 18964.43106706801, 19048.42854714361, 19171.616567668847, 19178.232870685017, 19184.90407547953, 8336.66653333872, 8496.277816385553, 8582.570871456526, 8591.926009248844, 8614.655413783505, 7754.495957762841, 7855.489393189425, 7870.645820938072, 7905.841883162419, 7934.20657934202, 5393.973030134903, 5537.2524709163745, 5553.4724201200825, 5612.579056570774, 5660.122680984454, 1446.240723620108, 1495.0805254768238, 1574.5984773882587, 1575.4328441760956, 1631.8041834979879, 964.3153361113688, 965.3725078698761, 965.4931161140317, 968.8401413766791, 971.3297824501071, 9520.285978551636, 9572.377795443273, 9647.807043859084, 9676.612935482643, 9698.854517182248, 1066.5040756048475, 1071.994640026795, 1072.120860894075, 1072.5548897207727, 1076.5855145768935, 5490.368607610096, 5885.705714714247, 5925.762969481259, 5933.554983376264, 5950.940490595125, 24230.151944681853, 24459.388515286904, 25371.112011079524, 25497.872510637328, 25641.0, 25160.748392516205, 25270.494590108094, 25332.493350132892, 25564.360890977874, 25568.74431255701, 11606.187566870238, 12545.686357840945, 12576.37118144089, 12627.179233349803, 12657.746845063048, 9475.241980641395, 9544.522773861141, 9585.041495850639, 9596.088371604686, 9662.903370966482, 20592.897035514725, 21067.789322106582, 21116.366509004754, 21506.247281345077, 21803.345899623037, 21847.126114955223, 21926.671099933832, 22034.228801991852, 22071.227507037176, 22101.557968840854, 10737.14102871784, 10944.452777361259, 11053.226274160732, 11056.0, 11057.0, 14641.560753177422, 14696.412143514568, 14779.965402422158, 14789.482368117064, 14849.331780070139, 12473.688157796129, 12554.246745195318, 12611.558595449114, 12832.550860720203, 12861.678458038625, 11969.401529923643, 12256.0, 12434.316112613893, 12615.49538018469, 12660.87339126597, 10723.624673136403, 10896.073833724222, 10911.072558832588, 10914.563417463212, 10924.399158046384, 8163.428560000743, 8280.420370574002, 8358.791030224293, 8392.412531122764, 8428.4942903426, 7706.653200605874, 7861.292483676497, 7876.724314649189, 7878.960605197167, 7925.207479252029], "value": 7304.821401537278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7791005687669, 560.3835780641296, 567.327716655763, 567.6508946997598, 576.5387689848118, 6396.264429590598, 6428.164338635983, 6454.483641308696, 6465.515086368524, 6474.255460622024, 6361.681915904198, 6362.981922892338, 6368.554201205918, 6383.957133717212, 6386.2975072741965, 5167.069927413074, 5185.948140518603, 5210.322658054448, 5213.921791173136, 5214.634975551713, 4899.412070551539, 5142.254373115896, 5148.485151484859, 5219.973900130513, 5224.346956630421, 5004.924926126111, 5008.749562521877, 5034.496550344973, 5045.470225626312, 5059.6458247922665, 4932.876678083041, 4989.800407983676, 5002.24966255061, 5008.899822003557, 5029.748512574393, 4560.315952607136, 4819.469858315582, 4899.252072164797, 4906.533879281463, 4949.381327334083, 6225.128482012522, 6234.937650623527, 6277.121203031579, 6301.0, 6336.0, 6194.96902515489, 6237.126802247689, 6275.5252515658785, 6302.275238347603, 6338.429541341301, 6824.931750682479, 6825.965870170618, 6888.586684798928, 6930.965345173242, 6935.930640693629, 5505.587080968903, 5516.200150978126, 5543.861403464905, 5547.25112109864, 5568.192612071227, 6865.5537390069485, 6870.7595234166565, 6933.583984960868, 6970.756023539152, 7015.754448594274, 5654.802081927113, 5666.518345940559, 5681.119426488901, 5699.772009119672, 5707.34365547959, 5770.682612456271, 5793.333766616893, 5808.244928159397, 5815.302163740378, 5854.912176317359, 6179.84550386244, 6193.628382296986, 6200.56596038282, 6215.285242197115, 6277.623342599459, 6819.181698196149, 6863.965680171567, 6865.588064716133, 6883.965580172067, 6887.621180835102, 1965.164804957887, 1982.960340793176, 1995.2617531513433, 2003.7395138632176, 2009.2867032203649, 1452.9611327900602, 1495.409313321232, 1504.6990601879668, 1519.566923426818, 1531.4716422834103, 6366.236051673829, 6366.427021568081, 6368.395002474757, 6378.936210637927, 6380.457661098766, 6829.351211634887, 6863.450923926074, 6873.828154296182, 6894.276101009422, 6937.375636192767, 6252.406021427957, 6272.181067490468, 6360.872782544416, 6400.39196276353, 6402.8719425611225, 3568.2149927016017, 3580.872025312018, 3600.7479476436397, 3619.348517266917, 3645.2527231917925, 7081.291870812981, 7161.641917904084, 7220.566765993952, 7228.927710722825, 7244.963775181091, 6764.255931847493, 6946.583205007716, 6961.686724097428, 6965.164180298295, 7029.8752199647815, 7003.439724822002, 7063.364297213276, 7117.8932316016335, 7129.500934934608, 7139.32176443237, 6708.6981085850275, 6781.559198652072, 6855.520113592001, 6862.142232220973, 6868.351595616916, 6574.80275591733, 6741.11269329732, 6759.107449914032, 6760.966195168992, 6826.761063362957, 7131.215566287808, 7207.5675459472595, 7230.060092187982, 7231.63841807918, 7246.673899674633, 5697.886042279214, 5724.284464441945, 5734.942650573441, 5737.684427356536, 5750.769969201352, 6673.699683514351, 6711.765088221889, 6811.93188068113, 6853.476705374429, 6999.020137180697, 6584.308647592125, 6635.767748128792, 6646.335366463315, 6664.366885145903, 6678.198616166092, 6445.292976949599, 6549.214094308713, 6561.671916404256, 6640.966795165993, 6678.7328506859185, 6566.474682025522, 6573.638449885111, 6591.835204119935, 6628.237752658506, 6642.6014439133805, 6563.34366563359, 6613.735450581923, 6637.800865974028, 6649.135612370361, 6685.684880520095, 6245.500359971283, 6348.968255158695, 6349.4920406366455, 6435.581687190318, 6459.257185423737], "value": 5362.9640580322675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [951.2722767083178, 983.7294743945419, 988.5650313861902, 992.1913640383087, 1017.781177046935, 20491.0, 21215.57568848622, 21243.468913277156, 21248.256311029116, 21279.361619151452, 19387.612247755038, 19455.31906383277, 19527.0, 19661.705074423895, 19882.304119355824, 1060.0406631998035, 1075.6450371377446, 1079.4279032112993, 1079.5142186016285, 1079.5357996061691, 1030.3096925060227, 1068.0227591753537, 1073.3506228731621, 1073.393532654048, 1073.978520429595, 1136.2841409911784, 1141.2524796258465, 1142.7714457108611, 1143.6969203161168, 1144.4106285263097, 1142.2632402100683, 1142.7885841119337, 1143.3825734103575, 1144.9542018319257, 1146.7018575170432, 791.8139237279235, 808.8261023879835, 812.6018251056998, 840.2227939156256, 840.9698119803193, 20516.0, 20629.0, 20669.586608267902, 20671.89664051685, 20688.379348619565, 21633.134674613153, 21828.345149645535, 21963.0, 22056.669149962763, 22082.88958555213, 17739.46781596554, 17783.822161778477, 17815.376461823773, 17884.642307153783, 17980.1009949502, 3977.4033894915706, 4018.8392464301687, 4019.738716983387, 4021.698372622065, 4028.536718277406, 153130.0, 153351.0, 155734.0, 158491.0, 161402.0, 17989.100544972698, 18192.727109093375, 18220.45338639843, 18481.353152639862, 18690.15894284733, 33906.49140262898, 34903.650963490545, 34949.30101397958, 34969.47545786815, 34993.65006349904, 8871.600777965006, 9061.093890610886, 9197.586108625128, 9197.81604367909, 9210.539473026322, 4540.228161212602, 4635.513271106553, 4638.072385522909, 4640.97679511607, 4652.558006989399, 5711.543076553866, 5743.971280143573, 5804.100364443518, 5865.090910908816, 5889.852753681193, 934.2572654739498, 949.9572519236651, 958.7363475044418, 964.7057647417605, 965.6764983730529, 725.9673314700851, 728.7048745258179, 736.6169591812335, 738.623302115914, 760.7793739815502, 12744.299063551594, 12889.806652900214, 12961.0, 13058.21650700961, 13073.546815002079, 731.989020164698, 733.0287369235677, 735.0884902720588, 739.737393225408, 758.3591864874172, 6284.308726040132, 6327.905081423783, 6398.072279519443, 6449.838754031093, 6455.0, 144702.0, 145025.0, 146676.0, 148119.0, 148715.0, 129571.0, 129706.0, 130730.0, 130949.34525327312, 134555.32722336325, 102856.0, 103490.96509034964, 104746.0, 104914.0, 107953.0, 12029.75940481203, 12066.155369124077, 12088.032957363566, 12139.696507587028, 12214.57248996281, 54262.3721288362, 54747.726261368436, 55445.0, 55636.16545751736, 56921.43078569327, 67806.0, 67811.27038012957, 68400.31599683939, 68824.6558767203, 71427.0, 16574.917125414297, 16590.58523536873, 16607.916960415605, 16640.667186655955, 16786.32854685799, 18507.35224267144, 18732.906335468782, 19027.809721902602, 19126.61746765085, 19356.0, 17320.82679173192, 17403.651926961138, 17720.734188986917, 17773.377931772327, 17840.732389013916, 17041.914790426465, 17492.737608935622, 17535.210915509087, 17576.91211543934, 17695.823041769418, 16980.320787168373, 17120.914395427943, 17183.656326873144, 17297.654046919244, 17321.9606823591, 12010.63968080959, 12050.51797928073, 12104.273743575413, 12112.636620901387, 12605.68485787826, 12536.0, 12538.93730531378, 12659.113862029937, 12893.097483176087, 12895.226286422469], "value": 9754.469246882449, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 105.0, 106.0, 107.0, 108.0, 105.0, 105.0, 106.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 136.0, 113.0, 111.0, 112.0, 113.0, 135.0, 115.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 162.0, 162.0, 163.0, 163.0, 164.0, 163.0, 171.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 74.0, 73.0, 75.0, 73.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 77.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 113.0, 113.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 152.0, 150.0, 155.0, 149.0, 150.0, 151.0, 150.0, 153.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 43.0, 44.0, 44.0, 45.0, 44.0, 52.0, 44.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 40.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 72.0, 71.0, 72.0, 72.0, 75.0, 70.0, 76.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 106.0, 100.0, 103.0, 107.0, 112.0, 108.0, 117.0, 105.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 150.0, 156.0, 151.0, 161.0, 151.0, 154.0, 160.0, 153.0, 157.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 59.0, 61.0, 59.0, 60.0, 61.0, 60.0, 62.0, 68.0], "value": 61.9, "unit": "score"}]}]} 03:19:56 INFO - Return code: 0 03:19:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:56 INFO - # TBPL SUCCESS # 03:19:56 INFO - Running post-action listener: _package_coverage_data 03:19:56 INFO - Running post-action listener: _resource_record_post_action 03:19:56 INFO - [mozharness: 2017-09-14 10:19:56.472111Z] Finished run-tests step (success) 03:19:56 INFO - Running post-run listener: _resource_record_post_run 03:19:56 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336969728; Read time: 8; Write time: 198180 03:19:56 INFO - TinderboxPrint: CPU usage
13.1% 03:19:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:19:56 INFO - TinderboxPrint: I/O write bytes / time
336,969,728 / 198,180 03:19:56 INFO - TinderboxPrint: CPU idle
8,212.6 (86.9%) 03:19:56 INFO - TinderboxPrint: CPU user
1,188.7 (12.6%) 03:19:56 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12783616; Read time: 0; Write time: 1384 03:19:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:19:56 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323571712; Read time: 8; Write time: 196796 03:19:57 INFO - Running post-run listener: _upload_blobber_files 03:19:57 INFO - Blob upload gear active. 03:19:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:19:57 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'] 03:19:57 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 03:19:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:19:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:58 INFO - (blobuploader) - INFO - Done attempting. 03:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:59 INFO - (blobuploader) - INFO - Done attempting. 03:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:06 INFO - (blobuploader) - INFO - Done attempting. 03:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:07 INFO - (blobuploader) - INFO - Done attempting. 03:20:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:07 INFO - Return code: 0 03:20:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75ac1e59869548d71bd4992189f5729ef83b3a26eb155c3df05fd8dfbf3a3d2097d3d95d08da15f8f49697e352ec90c647d8c73c3eaf02ea9989cf391599c194", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d82542022d44144edc8024bf47cb9367a1e8e16019a5f1a5c780aa84e441ee563a0fee0ac0a3e3c9c35ddb3e5c488c79ec6bc5abb0861941524fef063b42ed3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e597df11940f902eac294aa4df27fa08c1adf73c03e1f5db8bec584b11344644b05666bbd9ea03465d17542473f32fbdb9c91f0f01d696eb68287ee1091a5eb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec1017913b1aa803482515b28f4cb2a796a8040b8044befc2e15306bef44c8c6007c04bc1d88d0ffd455ad5d7a8be1105afaef9adfa5c00f17b8cd16f190d0aa"} 03:20:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:07 INFO - Contents: 03:20:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75ac1e59869548d71bd4992189f5729ef83b3a26eb155c3df05fd8dfbf3a3d2097d3d95d08da15f8f49697e352ec90c647d8c73c3eaf02ea9989cf391599c194", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d82542022d44144edc8024bf47cb9367a1e8e16019a5f1a5c780aa84e441ee563a0fee0ac0a3e3c9c35ddb3e5c488c79ec6bc5abb0861941524fef063b42ed3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e597df11940f902eac294aa4df27fa08c1adf73c03e1f5db8bec584b11344644b05666bbd9ea03465d17542473f32fbdb9c91f0f01d696eb68287ee1091a5eb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec1017913b1aa803482515b28f4cb2a796a8040b8044befc2e15306bef44c8c6007c04bc1d88d0ffd455ad5d7a8be1105afaef9adfa5c00f17b8cd16f190d0aa"} 03:20:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:07 INFO - Copying logs to upload dir... 03:20:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.430238 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-14 03:20:08.127014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:20:08.130978) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 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/75ac1e59869548d71bd4992189f5729ef83b3a26eb155c3df05fd8dfbf3a3d2097d3d95d08da15f8f49697e352ec90c647d8c73c3eaf02ea9989cf391599c194", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d82542022d44144edc8024bf47cb9367a1e8e16019a5f1a5c780aa84e441ee563a0fee0ac0a3e3c9c35ddb3e5c488c79ec6bc5abb0861941524fef063b42ed3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e597df11940f902eac294aa4df27fa08c1adf73c03e1f5db8bec584b11344644b05666bbd9ea03465d17542473f32fbdb9c91f0f01d696eb68287ee1091a5eb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec1017913b1aa803482515b28f4cb2a796a8040b8044befc2e15306bef44c8c6007c04bc1d88d0ffd455ad5d7a8be1105afaef9adfa5c00f17b8cd16f190d0aa"} build_url:https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/OqnNPITcTbqC9gFtKSh-uQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75ac1e59869548d71bd4992189f5729ef83b3a26eb155c3df05fd8dfbf3a3d2097d3d95d08da15f8f49697e352ec90c647d8c73c3eaf02ea9989cf391599c194", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d82542022d44144edc8024bf47cb9367a1e8e16019a5f1a5c780aa84e441ee563a0fee0ac0a3e3c9c35ddb3e5c488c79ec6bc5abb0861941524fef063b42ed3", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e597df11940f902eac294aa4df27fa08c1adf73c03e1f5db8bec584b11344644b05666bbd9ea03465d17542473f32fbdb9c91f0f01d696eb68287ee1091a5eb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec1017913b1aa803482515b28f4cb2a796a8040b8044befc2e15306bef44c8c6007c04bc1d88d0ffd455ad5d7a8be1105afaef9adfa5c00f17b8cd16f190d0aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 03:20:08.166118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:20:08.166725) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505377439.707600-2112872969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 03:20:08.252040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:20:08.252595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 03:20:08.253125) ========= ========= Total master_lag: 0.22 =========