builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-056 starttime: 1505622892.19 results: success (0) revision: be5bddf32db0a1ed27251295b7711d06f9189b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.190205) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.190761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.191048) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.305952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.306369) ========= 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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 21:34:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.0M=0s 2017-09-16 21:34:51 (87.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178268 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.538307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.538625) ========= 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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020400 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.595438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:34:52.595821) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be5bddf32db0a1ed27251295b7711d06f9189b11 --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 be5bddf32db0a1ed27251295b7711d06f9189b11 --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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 21:34:52,082 truncating revision to first 12 chars 2017-09-16 21:34:52,082 Setting DEBUG logging. 2017-09-16 21:34:52,082 attempt 1/10 2017-09-16 21:34:52,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be5bddf32db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 21:34:53,368 unpacking tar archive at: mozilla-central-be5bddf32db0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:34:54.212115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:54.212475) ========= script_repo_revision: be5bddf32db0a1ed27251295b7711d06f9189b11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:54.212890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:54.213576) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:54.227113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-16 21:34:54.227531) ========= /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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:53 INFO - MultiFileLogger online at 20170916 21:34:53 in /builds/slave/test 21:34:53 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 21:34:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:53 INFO - {'append_to_log': False, 21:34:53 INFO - 'base_work_dir': '/builds/slave/test', 21:34:53 INFO - 'blob_upload_branch': 'Firefox', 21:34:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:53 INFO - 'branch': 'Firefox', 21:34:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:53 INFO - 'code_coverage': False, 21:34:53 INFO - 'config_files': ('talos/linux_config.py',), 21:34:53 INFO - 'default_actions': ('clobber', 21:34:53 INFO - 'read-buildbot-config', 21:34:53 INFO - 'download-and-extract', 21:34:53 INFO - 'populate-webroot', 21:34:53 INFO - 'create-virtualenv', 21:34:53 INFO - 'install', 21:34:53 INFO - 'setup-mitmproxy', 21:34:53 INFO - 'run-tests'), 21:34:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:53 INFO - 'disable_ccov_upload': False, 21:34:53 INFO - 'disable_stylo': False, 21:34:53 INFO - 'download_minidump_stackwalk': True, 21:34:53 INFO - 'download_symbols': 'ondemand', 21:34:53 INFO - 'enable_stylo': False, 21:34:53 INFO - 'enable_webrender': False, 21:34:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:34:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:53 INFO - 'gecko_profile': False, 21:34:53 INFO - 'gecko_profile_interval': 0, 21:34:53 INFO - 'installer_path': 'installer.exe', 21:34:53 INFO - 'log_level': 'info', 21:34:53 INFO - 'log_name': 'talos', 21:34:53 INFO - 'log_to_console': True, 21:34:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:53 INFO - 'opt_config_files': (), 21:34:53 INFO - 'pip_index': False, 21:34:53 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 21:34:53 INFO - 'system_bits': '32', 21:34:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:53 INFO - 'title': 'talos-linux64-ix-056', 21:34:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:53 INFO - 'use_talos_json': True, 21:34:53 INFO - 'verify': 'False', 21:34:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:53 INFO - 'work_dir': 'build'} 21:34:53 INFO - [mozharness: 2017-09-17 04:34:53.950165Z] Running clobber step. 21:34:53 INFO - Running pre-action listener: _resource_record_pre_action 21:34:53 INFO - Running main action method: clobber 21:34:53 INFO - rmtree: /builds/slave/test/build 21:34:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:54 INFO - Running post-action listener: _resource_record_post_action 21:34:54 INFO - [mozharness: 2017-09-17 04:34:54.889193Z] Finished clobber step (success) 21:34:54 INFO - [mozharness: 2017-09-17 04:34:54.889290Z] Running read-buildbot-config step. 21:34:54 INFO - Running pre-action listener: _resource_record_pre_action 21:34:54 INFO - Running main action method: read_buildbot_config 21:34:54 INFO - Using buildbot properties: 21:34:54 INFO - { 21:34:54 INFO - "project": "", 21:34:54 INFO - "product": "firefox", 21:34:54 INFO - "who": "ryanvm@gmail.com", 21:34:54 INFO - "installer_path": "public/build/target.tar.bz2", 21:34:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 21:34:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:34:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 21:34:54 INFO - "stage_platform": "linux64-pgo", 21:34:54 INFO - "basedir": "/builds/slave/test", 21:34:54 INFO - "buildnumber": 25, 21:34:54 INFO - "platform": "ubuntu64_hw", 21:34:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:34:54 INFO - "slavebuilddir": "test", 21:34:54 INFO - "taskId": "LkUYFwU6QW64TwUTC-SwVA", 21:34:54 INFO - "branch": "mozilla-central", 21:34:54 INFO - "script_repo_revision": "production", 21:34:54 INFO - "revision": "be5bddf32db0a1ed27251295b7711d06f9189b11", 21:34:54 INFO - "slavename": "talos-linux64-ix-056", 21:34:54 INFO - "repo_path": "mozilla-central" 21:34:54 INFO - } 21:34:54 INFO - Finding installer, test and symbols from parent task. 21:34:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LkUYFwU6QW64TwUTC-SwVA'}, attempt #1 21:34:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LkUYFwU6QW64TwUTC-SwVA'}, attempt #1 21:34:55 INFO - Task dependencies: FH5rI8fZSoORX0XmnXiq8A 21:34:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A'}, attempt #1 21:34:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:34:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json 21:34:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip 21:34:56 INFO - Running post-action listener: _resource_record_post_action 21:34:56 INFO - [mozharness: 2017-09-17 04:34:56.297987Z] Finished read-buildbot-config step (success) 21:34:56 INFO - [mozharness: 2017-09-17 04:34:56.298203Z] Running download-and-extract step. 21:34:56 INFO - Running pre-action listener: _resource_record_pre_action 21:34:56 INFO - Running main action method: download_and_extract 21:34:56 INFO - mkdir: /builds/slave/test/build/tests 21:34: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')]} 21:34:56 INFO - trying https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json 21:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:34:56 INFO - Downloaded 989 bytes. 21:34:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:34:56 INFO - Using the following test package requirements: 21:34:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:34:56 INFO - u'common': [u'target.common.tests.zip'], 21:34:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:34:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:34:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:34:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:34:56 INFO - u'mozbase': [u'target.common.tests.zip'], 21:34:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:34:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:34:56 INFO - u'web-platform': [u'target.common.tests.zip', 21:34:56 INFO - u'target.web-platform.tests.tar.gz'], 21:34:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:34:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:34:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip 21:34:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:34:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip into memory 21:34:58 INFO - Content-Length response header: 55323758 21:34:58 INFO - Bytes received: 55323758 21:35:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip 21:35:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:35:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip into memory 21:35:11 INFO - Content-Length response header: 14508748 21:35:11 INFO - Bytes received: 14508748 21:35:11 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')]} 21:35:11 INFO - trying https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:35:15 INFO - Downloaded 62187569 bytes. 21:35:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:15 INFO - mkdir: /builds/slave/test/properties 21:35:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:15 INFO - Contents: 21:35:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:15 INFO - Running post-action listener: _resource_record_post_action 21:35:15 INFO - Running post-action listener: find_tests_for_verification 21:35:15 INFO - Running post-action listener: set_extra_try_arguments 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.064898Z] Finished download-and-extract step (success) 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.065127Z] Running populate-webroot step. 21:35:15 INFO - Running pre-action listener: _resource_record_pre_action 21:35:15 INFO - Running main action method: populate_webroot 21:35:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:15 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tresize', 21:35:15 INFO - 'tcanvasmark']}, 21:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:15 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['dromaeo_css', 21:35:15 INFO - 'kraken']}, 21:35:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:15 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['damp', 'tps']}, 21:35:15 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['damp', 'tps']}, 21:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:15 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['dromaeo_dom']}, 21:35:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:35:15 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['basic_compositor_video', 21:35:15 INFO - 'glvideo']}, 21:35:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:35:15 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['ts_paint_webext', 21:35:15 INFO - 'tp5o_webext']}, 21:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:15 INFO - 'ts_paint', 21:35:15 INFO - 'tpaint', 21:35:15 INFO - 'sessionrestore', 21:35:15 INFO - 'sessionrestore_many_windows', 21:35:15 INFO - 'sessionrestore_no_auto_restore', 21:35:15 INFO - 'tabpaint']}, 21:35:15 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['a11yr', 21:35:15 INFO - 'ts_paint', 21:35:15 INFO - 'tpaint', 21:35:15 INFO - 'sessionrestore', 21:35:15 INFO - 'sessionrestore_many_windows', 21:35:15 INFO - 'sessionrestore_no_auto_restore', 21:35:15 INFO - 'tabpaint']}, 21:35:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:35:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:35:15 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['perf_reftest_singletons']}, 21:35:15 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['bloom_basic']}, 21:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:15 INFO - 'tsvgr_opacity', 21:35:15 INFO - 'tart', 21:35:15 INFO - 'tscrollx', 21:35:15 INFO - 'tsvg_static']}, 21:35:15 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tsvgx', 21:35:15 INFO - 'tsvgr_opacity', 21:35:15 INFO - 'tart', 21:35:15 INFO - 'tscrollx', 21:35:15 INFO - 'tsvg_static']}, 21:35:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:35:15 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tp5o']}, 21:35:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo', 21:35:15 INFO - '--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--stylo-threads=1', 21:35:15 INFO - '--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--xperf_path', 21:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:15 INFO - 'tests': ['tp5n']}, 21:35:15 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo', 21:35:15 INFO - '--xperf_path', 21:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:15 INFO - 'tests': ['tp5n']}}} 21:35:15 INFO - Running post-action listener: _resource_record_post_action 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.086959Z] Finished populate-webroot step (success) 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.087048Z] Running create-virtualenv step. 21:35:15 INFO - Running pre-action listener: _resource_record_pre_action 21:35:15 INFO - Running main action method: create_virtualenv 21:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:15 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:35:15 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:35:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:16 INFO - Installing pip...............done. 21:35:16 INFO - Return code: 0 21:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:16 INFO - Reading from file tmpfile_stdout 21:35:16 INFO - Output received: 21:35:16 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:35:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:16 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')]} 21:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:16 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')]} 21:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:16 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:16 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 21:35:16 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 21:35:16 INFO - Using env: {'DISPLAY': ':0', 21:35:16 INFO - 'HOME': '/home/cltbld', 21:35:16 INFO - 'LANG': 'en_US.UTF-8', 21:35:16 INFO - 'LANGUAGE': 'en_US:en', 21:35:16 INFO - 'LOGNAME': 'cltbld', 21:35:16 INFO - 'MAIL': '/var/mail/cltbld', 21:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:16 INFO - 'MOZ_NO_REMOTE': '1', 21:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:16 INFO - 'NO_EM_RESTART': '1', 21:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:16 INFO - 'PWD': '/builds/slave/test', 21:35:16 INFO - 'SHELL': '/bin/bash', 21:35:16 INFO - 'SHLVL': '1', 21:35:16 INFO - 'TERM': 'linux', 21:35:16 INFO - 'TMOUT': '86400', 21:35:16 INFO - 'USER': 'cltbld', 21:35:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:16 INFO - '_': '/tools/buildbot/bin/python'} 21:35:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:35:17 INFO - Downloading/unpacking pip>=1.5 21:35:17 INFO - Running setup.py egg_info for package pip 21:35:17 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:17 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:17 INFO - Installing collected packages: pip 21:35:17 INFO - Found existing installation: pip 1.1 21:35:17 INFO - Uninstalling pip: 21:35:17 INFO - Successfully uninstalled pip 21:35:17 INFO - Running setup.py install for pip 21:35:17 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:17 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Successfully installed pip 21:35:17 INFO - Cleaning up... 21:35:17 INFO - Return code: 0 21:35:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:17 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')]} 21:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:17 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')]} 21:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:17 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:17 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 21:35:17 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 21:35:17 INFO - Using env: {'DISPLAY': ':0', 21:35:17 INFO - 'HOME': '/home/cltbld', 21:35:17 INFO - 'LANG': 'en_US.UTF-8', 21:35:17 INFO - 'LANGUAGE': 'en_US:en', 21:35:17 INFO - 'LOGNAME': 'cltbld', 21:35:17 INFO - 'MAIL': '/var/mail/cltbld', 21:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:17 INFO - 'MOZ_NO_REMOTE': '1', 21:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:17 INFO - 'NO_EM_RESTART': '1', 21:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:17 INFO - 'PWD': '/builds/slave/test', 21:35:17 INFO - 'SHELL': '/bin/bash', 21:35:17 INFO - 'SHLVL': '1', 21:35:17 INFO - 'TERM': 'linux', 21:35:17 INFO - 'TMOUT': '86400', 21:35:17 INFO - 'USER': 'cltbld', 21:35:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:17 INFO - '_': '/tools/buildbot/bin/python'} 21:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:18 INFO - Downloading/unpacking psutil>=3.1.1 21:35:18 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 21:35:18 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 21:35:18 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 21:35:18 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 21:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:19 INFO - Installing collected packages: psutil 21:35:19 INFO - Running setup.py install for psutil 21:35:19 INFO - building 'psutil._psutil_linux' extension 21:35:19 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 21:35:21 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 21:35:21 INFO - building 'psutil._psutil_posix' extension 21:35:21 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 21:35:21 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 21:35:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:21 INFO - Successfully installed psutil 21:35:21 INFO - Cleaning up... 21:35:21 INFO - Return code: 0 21:35:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:21 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')]} 21:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:21 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')]} 21:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:21 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:21 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 21:35:21 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 21:35:21 INFO - Using env: {'DISPLAY': ':0', 21:35:21 INFO - 'HOME': '/home/cltbld', 21:35:21 INFO - 'LANG': 'en_US.UTF-8', 21:35:21 INFO - 'LANGUAGE': 'en_US:en', 21:35:21 INFO - 'LOGNAME': 'cltbld', 21:35:21 INFO - 'MAIL': '/var/mail/cltbld', 21:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:21 INFO - 'MOZ_NO_REMOTE': '1', 21:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:21 INFO - 'NO_EM_RESTART': '1', 21:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:21 INFO - 'PWD': '/builds/slave/test', 21:35:21 INFO - 'SHELL': '/bin/bash', 21:35:21 INFO - 'SHLVL': '1', 21:35:21 INFO - 'TERM': 'linux', 21:35:21 INFO - 'TMOUT': '86400', 21:35:21 INFO - 'USER': 'cltbld', 21:35:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:21 INFO - '_': '/tools/buildbot/bin/python'} 21:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:21 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 21:35:21 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 21:35:21 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 21:35:21 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 21:35:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:22 INFO - Installing collected packages: mozsystemmonitor 21:35:22 INFO - Running setup.py install for mozsystemmonitor 21:35:23 INFO - Successfully installed mozsystemmonitor 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:23 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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:23 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 21:35:23 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 21:35:23 INFO - Using env: {'DISPLAY': ':0', 21:35:23 INFO - 'HOME': '/home/cltbld', 21:35:23 INFO - 'LANG': 'en_US.UTF-8', 21:35:23 INFO - 'LANGUAGE': 'en_US:en', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MAIL': '/var/mail/cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SHLVL': '1', 21:35:23 INFO - 'TERM': 'linux', 21:35:23 INFO - 'TMOUT': '86400', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - '_': '/tools/buildbot/bin/python'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:23 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 21:35:23 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 21:35:23 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 21:35:23 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 21:35:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:24 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 21:35:24 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 21:35:24 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 21:35:24 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 21:35:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:24 INFO - warning: no files found matching '*.txt' 21:35:24 INFO - no previously-included directories found matching 'build' 21:35:24 INFO - no previously-included directories found matching 'dist' 21:35:24 INFO - no previously-included directories found matching '.git*' 21:35:24 INFO - Installing collected packages: jsonschema, functools32 21:35:24 INFO - Running setup.py install for functools32 21:35:24 INFO - warning: no files found matching '*.txt' 21:35:24 INFO - no previously-included directories found matching 'build' 21:35:24 INFO - no previously-included directories found matching 'dist' 21:35:24 INFO - no previously-included directories found matching '.git*' 21:35:24 INFO - Successfully installed jsonschema functools32 21:35:24 INFO - Cleaning up... 21:35:24 INFO - Return code: 0 21:35:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:24 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')]} 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:24 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')]} 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:24 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:24 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 21:35:24 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 21:35:24 INFO - Using env: {'DISPLAY': ':0', 21:35:24 INFO - 'HOME': '/home/cltbld', 21:35:24 INFO - 'LANG': 'en_US.UTF-8', 21:35:24 INFO - 'LANGUAGE': 'en_US:en', 21:35:24 INFO - 'LOGNAME': 'cltbld', 21:35:24 INFO - 'MAIL': '/var/mail/cltbld', 21:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:24 INFO - 'MOZ_NO_REMOTE': '1', 21:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:24 INFO - 'NO_EM_RESTART': '1', 21:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:24 INFO - 'PWD': '/builds/slave/test', 21:35:24 INFO - 'SHELL': '/bin/bash', 21:35:24 INFO - 'SHLVL': '1', 21:35:24 INFO - 'TERM': 'linux', 21:35:24 INFO - 'TMOUT': '86400', 21:35:24 INFO - 'USER': 'cltbld', 21:35:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:24 INFO - '_': '/tools/buildbot/bin/python'} 21:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:24 INFO - Cleaning up... 21:35:24 INFO - Return code: 0 21:35:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:24 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')]} 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:24 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')]} 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:24 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:24 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 21:35:24 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 21:35:25 INFO - Using env: {'DISPLAY': ':0', 21:35:25 INFO - 'HOME': '/home/cltbld', 21:35:25 INFO - 'LANG': 'en_US.UTF-8', 21:35:25 INFO - 'LANGUAGE': 'en_US:en', 21:35:25 INFO - 'LOGNAME': 'cltbld', 21:35:25 INFO - 'MAIL': '/var/mail/cltbld', 21:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:25 INFO - 'MOZ_NO_REMOTE': '1', 21:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:25 INFO - 'NO_EM_RESTART': '1', 21:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:25 INFO - 'PWD': '/builds/slave/test', 21:35:25 INFO - 'SHELL': '/bin/bash', 21:35:25 INFO - 'SHLVL': '1', 21:35:25 INFO - 'TERM': 'linux', 21:35:25 INFO - 'TMOUT': '86400', 21:35:25 INFO - 'USER': 'cltbld', 21:35:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:25 INFO - '_': '/tools/buildbot/bin/python'} 21:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:25 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:25 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 21:35:25 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 21:35:25 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 21:35:25 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 21:35:26 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:26 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 21:35:26 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 21:35:26 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 21:35:26 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 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:26 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 21:35:26 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 21:35:26 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 21:35:26 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 21:35:26 INFO - Downloading docopt-0.6.1.tar.gz 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:26 INFO - Running setup.py install for blobuploader 21:35:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:27 INFO - Running setup.py install for requests 21:35:27 INFO - Running setup.py install for docopt 21:35:27 INFO - Successfully installed blobuploader requests docopt 21:35:27 INFO - Cleaning up... 21:35:27 INFO - Return code: 0 21:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:27 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:27 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 21:35:27 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 21:35:27 INFO - Using env: {'DISPLAY': ':0', 21:35:27 INFO - 'HOME': '/home/cltbld', 21:35:27 INFO - 'LANG': 'en_US.UTF-8', 21:35:27 INFO - 'LANGUAGE': 'en_US:en', 21:35:27 INFO - 'LOGNAME': 'cltbld', 21:35:27 INFO - 'MAIL': '/var/mail/cltbld', 21:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:27 INFO - 'MOZ_NO_REMOTE': '1', 21:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:27 INFO - 'NO_EM_RESTART': '1', 21:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:27 INFO - 'PWD': '/builds/slave/test', 21:35:27 INFO - 'SHELL': '/bin/bash', 21:35:27 INFO - 'SHLVL': '1', 21:35:27 INFO - 'TERM': 'linux', 21:35:27 INFO - 'TMOUT': '86400', 21:35:27 INFO - 'USER': 'cltbld', 21:35:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:27 INFO - '_': '/tools/buildbot/bin/python'} 21:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Running setup.py (path:/tmp/pip-h2mI9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Running setup.py (path:/tmp/pip-_57xkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Running setup.py (path:/tmp/pip-NSFe4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:27 INFO - Running setup.py (path:/tmp/pip-3vy5KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:28 INFO - Running setup.py (path:/tmp/pip-EJjqGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:28 INFO - Running setup.py (path:/tmp/pip-qtlrVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:28 INFO - Running setup.py (path:/tmp/pip-P0c5IO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:28 INFO - Running setup.py (path:/tmp/pip-dAzmhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:28 INFO - Running setup.py (path:/tmp/pip-X6sgSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:28 INFO - Running setup.py (path:/tmp/pip-rHNlh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:28 INFO - Running setup.py (path:/tmp/pip-bHCrYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:28 INFO - Running setup.py (path:/tmp/pip-2bU7X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:28 INFO - Running setup.py (path:/tmp/pip-YsabGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:28 INFO - Running setup.py (path:/tmp/pip-7DmzBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Running setup.py (path:/tmp/pip-PjSDPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Running setup.py (path:/tmp/pip-833RIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Running setup.py (path:/tmp/pip-u_0wPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:28 INFO - Running setup.py install for manifestparser 21:35:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozcrash 21:35:29 INFO - Running setup.py install for mozdebug 21:35:29 INFO - Running setup.py install for mozdevice 21:35:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozfile 21:35:29 INFO - Running setup.py install for mozhttpd 21:35:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozinfo 21:35:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozInstall 21:35:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozleak 21:35:29 INFO - Running setup.py install for mozlog 21:35:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for moznetwork 21:35:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Running setup.py install for mozprocess 21:35:30 INFO - Running setup.py install for mozprofile 21:35:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Running setup.py install for mozrunner 21:35:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Running setup.py install for mozscreenshot 21:35:30 INFO - Running setup.py install for moztest 21:35:30 INFO - Running setup.py install for mozversion 21:35:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:30 INFO - Cleaning up... 21:35:30 INFO - Return code: 0 21:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:30 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')]} 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:30 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')]} 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:30 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:30 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 21:35:30 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 21:35:30 INFO - Using env: {'DISPLAY': ':0', 21:35:30 INFO - 'HOME': '/home/cltbld', 21:35:30 INFO - 'LANG': 'en_US.UTF-8', 21:35:30 INFO - 'LANGUAGE': 'en_US:en', 21:35:30 INFO - 'LOGNAME': 'cltbld', 21:35:30 INFO - 'MAIL': '/var/mail/cltbld', 21:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:30 INFO - 'MOZ_NO_REMOTE': '1', 21:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:30 INFO - 'NO_EM_RESTART': '1', 21:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:30 INFO - 'PWD': '/builds/slave/test', 21:35:30 INFO - 'SHELL': '/bin/bash', 21:35:30 INFO - 'SHLVL': '1', 21:35:30 INFO - 'TERM': 'linux', 21:35:30 INFO - 'TMOUT': '86400', 21:35:30 INFO - 'USER': 'cltbld', 21:35:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:30 INFO - '_': '/tools/buildbot/bin/python'} 21:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:30 INFO - Running setup.py (path:/tmp/pip-PNCLwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:31 INFO - Running setup.py (path:/tmp/pip-u7Wzo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:31 INFO - Running setup.py (path:/tmp/pip-nRXRKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:31 INFO - Running setup.py (path:/tmp/pip-dfxtoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:31 INFO - Running setup.py (path:/tmp/pip-KjXnxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:31 INFO - Running setup.py (path:/tmp/pip-dV47NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:31 INFO - Running setup.py (path:/tmp/pip-0tfYR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:31 INFO - Running setup.py (path:/tmp/pip-6vbeE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:31 INFO - Running setup.py (path:/tmp/pip-BcFFzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:31 INFO - Running setup.py (path:/tmp/pip-Olh0oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:31 INFO - Running setup.py (path:/tmp/pip-StK2JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:31 INFO - Running setup.py (path:/tmp/pip-11Emxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 INFO - Running setup.py (path:/tmp/pip-yD1WfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 INFO - Running setup.py (path:/tmp/pip-BF7KDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 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)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:31 INFO - Running setup.py (path:/tmp/pip-nhpUoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:32 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)) 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:32 INFO - Running setup.py (path:/tmp/pip-6yLPW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:32 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)) 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:32 INFO - Running setup.py (path:/tmp/pip-N60ZTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:32 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)) 21:35:32 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)) 21:35:32 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)) 21:35:32 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)) 21:35:32 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)) 21:35:32 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)) 21:35:32 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)) 21:35:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:32 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 21:35:32 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 21:35:32 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 21:35:32 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 21:35:33 INFO - Downloading blessings-1.6.tar.gz 21:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:33 INFO - Installing collected packages: blessings 21:35:33 INFO - Running setup.py install for blessings 21:35:33 INFO - Successfully installed blessings 21:35:33 INFO - Cleaning up... 21:35:33 INFO - Return code: 0 21:35:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:33 INFO - Reading from file tmpfile_stdout 21:35:33 INFO - Current package versions: 21:35:33 INFO - argparse == 1.2.1 21:35:33 INFO - blessings == 1.6 21:35:33 INFO - blobuploader == 1.2.4 21:35:33 INFO - docopt == 0.6.1 21:35:33 INFO - functools32 == 3.2.3-2 21:35:33 INFO - jsonschema == 2.5.1 21:35:33 INFO - manifestparser == 1.1 21:35:33 INFO - mozInstall == 1.13 21:35:33 INFO - mozcrash == 1.0 21:35:33 INFO - mozdebug == 0.1 21:35:33 INFO - mozdevice == 0.51 21:35:33 INFO - mozfile == 1.2 21:35:33 INFO - mozhttpd == 0.7 21:35:33 INFO - mozinfo == 0.10 21:35:33 INFO - mozleak == 0.1 21:35:33 INFO - mozlog == 3.5 21:35:33 INFO - moznetwork == 0.27 21:35:33 INFO - mozprocess == 0.25 21:35:33 INFO - mozprofile == 0.28 21:35:33 INFO - mozrunner == 6.13 21:35:33 INFO - mozscreenshot == 0.1 21:35:33 INFO - mozsystemmonitor == 0.3 21:35:33 INFO - moztest == 0.8 21:35:33 INFO - mozversion == 1.4 21:35:33 INFO - psutil == 3.1.1 21:35:33 INFO - requests == 1.2.3 21:35:33 INFO - wsgiref == 0.1.2 21:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:33 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')]} 21:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:33 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')]} 21:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:33 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:33 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 21:35:33 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 21:35:33 INFO - Using env: {'DISPLAY': ':0', 21:35:33 INFO - 'HOME': '/home/cltbld', 21:35:33 INFO - 'LANG': 'en_US.UTF-8', 21:35:33 INFO - 'LANGUAGE': 'en_US:en', 21:35:33 INFO - 'LOGNAME': 'cltbld', 21:35:33 INFO - 'MAIL': '/var/mail/cltbld', 21:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:33 INFO - 'MOZ_NO_REMOTE': '1', 21:35:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:33 INFO - 'NO_EM_RESTART': '1', 21:35:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:33 INFO - 'PWD': '/builds/slave/test', 21:35:33 INFO - 'SHELL': '/bin/bash', 21:35:33 INFO - 'SHLVL': '1', 21:35:33 INFO - 'TERM': 'linux', 21:35:33 INFO - 'TMOUT': '86400', 21:35:33 INFO - 'USER': 'cltbld', 21:35:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:33 INFO - '_': '/tools/buildbot/bin/python'} 21:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 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)) 21:35:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:35:33 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 21:35:33 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 21:35:33 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 21:35:33 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 21:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:35:35 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)) 21:35:35 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)) 21:35:35 INFO - Installing collected packages: simplejson 21:35:35 INFO - Running setup.py install for simplejson 21:35:35 INFO - building 'simplejson._speedups' extension 21:35:35 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 21:35:36 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 21:35:36 INFO - Successfully installed simplejson 21:35:36 INFO - Cleaning up... 21:35:36 INFO - Return code: 0 21:35:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:36 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')]} 21:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:36 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')]} 21:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:36 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 0x108e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1257a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13faa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, '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': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', '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 21:35:36 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 21:35:36 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 21:35:36 INFO - Using env: {'DISPLAY': ':0', 21:35:36 INFO - 'HOME': '/home/cltbld', 21:35:36 INFO - 'LANG': 'en_US.UTF-8', 21:35:36 INFO - 'LANGUAGE': 'en_US:en', 21:35:36 INFO - 'LOGNAME': 'cltbld', 21:35:36 INFO - 'MAIL': '/var/mail/cltbld', 21:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:36 INFO - 'MOZ_NO_REMOTE': '1', 21:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:36 INFO - 'NO_EM_RESTART': '1', 21:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:36 INFO - 'PWD': '/builds/slave/test', 21:35:36 INFO - 'SHELL': '/bin/bash', 21:35:36 INFO - 'SHLVL': '1', 21:35:36 INFO - 'TERM': 'linux', 21:35:36 INFO - 'TMOUT': '86400', 21:35:36 INFO - 'USER': 'cltbld', 21:35:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:36 INFO - '_': '/tools/buildbot/bin/python'} 21:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:36 INFO - Cleaning up... 21:35:36 INFO - Return code: 0 21:35:36 INFO - Running post-action listener: _resource_record_post_action 21:35:36 INFO - Running post-action listener: _start_resource_monitoring 21:35:36 INFO - Starting resource monitoring. 21:35:36 INFO - [mozharness: 2017-09-17 04:35:36.472905Z] Finished create-virtualenv step (success) 21:35:36 INFO - [mozharness: 2017-09-17 04:35:36.473910Z] Running install step. 21:35:36 INFO - Running pre-action listener: _resource_record_pre_action 21:35:36 INFO - Running main action method: install 21:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:36 INFO - Reading from file tmpfile_stdout 21:35:36 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:36 INFO - Reading from file tmpfile_stdout 21:35:36 INFO - Output received: 21:35:36 INFO - Usage: mozinstall [options] installer 21:35:36 INFO - Options: 21:35:36 INFO - -h, --help show this help message and exit 21:35:36 INFO - -d DEST, --destination=DEST 21:35:36 INFO - Directory to install application into. [default: 21:35:36 INFO - "/builds/slave/test"] 21:35:36 INFO - --app=APP Application being installed. [default: firefox] 21:35:36 INFO - mkdir: /builds/slave/test/build/application 21:35:36 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'] 21:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:35:54 INFO - Reading from file tmpfile_stdout 21:35:54 INFO - Output received: 21:35:54 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:54 INFO - Running post-action listener: _resource_record_post_action 21:35:54 INFO - [mozharness: 2017-09-17 04:35:54.464310Z] Finished install step (success) 21:35:54 INFO - [mozharness: 2017-09-17 04:35:54.464429Z] Running setup-mitmproxy step. 21:35:54 INFO - Running pre-action listener: _resource_record_pre_action 21:35:54 INFO - Running main action method: setup_mitmproxy 21:35:54 INFO - Skipping: mitmproxy is not required 21:35:54 INFO - Running post-action listener: _resource_record_post_action 21:35:54 INFO - [mozharness: 2017-09-17 04:35:54.464936Z] Finished setup-mitmproxy step (success) 21:35:54 INFO - [mozharness: 2017-09-17 04:35:54.465027Z] Running run-tests step. 21:35:54 INFO - Running pre-action listener: _resource_record_pre_action 21:35:54 INFO - Running pre-action listener: _set_gcov_prefix 21:35:54 INFO - Running main action method: run_tests 21:35:54 WARNING - Try message not found. 21:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:54 INFO - Python 2.7.3 21:35:54 INFO - Return code: 0 21:35:54 INFO - grabbing minidump binary from tooltool 21:35: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')]} 21:35:54 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 0x13fe090>, '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 0x13fed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f8f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:54 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 21:35:54 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 21:35:54 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 21:35:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:54 INFO - Return code: 0 21:35:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:54 INFO - ENV: RUST_BACKTRACE is now full 21:35:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:54 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 21:35:54 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 21:35:54 INFO - Using env: {'DISPLAY': ':0', 21:35:54 INFO - 'HOME': '/home/cltbld', 21:35:54 INFO - 'LANG': 'en_US.UTF-8', 21:35:54 INFO - 'LANGUAGE': 'en_US:en', 21:35:54 INFO - 'LOGNAME': 'cltbld', 21:35:54 INFO - 'MAIL': '/var/mail/cltbld', 21:35:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:54 INFO - 'MOZ_NO_REMOTE': '1', 21:35:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:54 INFO - 'NO_EM_RESTART': '1', 21:35:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:54 INFO - 'PWD': '/builds/slave/test', 21:35:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:54 INFO - 'RUST_BACKTRACE': 'full', 21:35:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:35:54 INFO - 'SHELL': '/bin/bash', 21:35:54 INFO - 'SHLVL': '1', 21:35:54 INFO - 'TERM': 'linux', 21:35:54 INFO - 'TMOUT': '86400', 21:35:54 INFO - 'USER': 'cltbld', 21:35:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:54 INFO - '_': '/tools/buildbot/bin/python'} 21:35:54 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 21:35:55 INFO - mozversion application_buildid: 20170917031344 21:35:55 INFO - mozversion application_changeset: be5bddf32db0a1ed27251295b7711d06f9189b11 21:35:55 INFO - mozversion application_display_name: Nightly 21:35:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:55 INFO - mozversion application_name: Firefox 21:35:55 INFO - mozversion application_remotingname: firefox 21:35:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:35:55 INFO - mozversion application_vendor: Mozilla 21:35:55 INFO - mozversion application_version: 57.0a1 21:35:55 INFO - mozversion platform_buildid: 20170917031344 21:35:55 INFO - mozversion platform_changeset: be5bddf32db0a1ed27251295b7711d06f9189b11 21:35:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:35:55 INFO - mozversion platform_version: 57.0a1 21:35:55 INFO - using testdate: 1505622955 21:35:55 INFO - actual date: 1505622955 21:35:55 INFO - starting webserver on 'localhost:59157' 21:35:55 INFO - SUITE-START | Running 2 tests 21:35:55 INFO - TEST-START | dromaeo_css 21:35:55 INFO - Initialising browser for dromaeo_css test... 21:35:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59157/getInfo.html -profile /tmp/tmpyDMihC/profile 21:35:55 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox http://localhost:59157/getInfo.html) 21:36:04 INFO - TEST-INFO | 3560: exit 0 21:36:04 INFO - Browser initialized. 21:36:04 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:04 INFO - Using env: {'DISPLAY': ':0', 21:36:04 INFO - 'HOME': '/home/cltbld', 21:36:04 INFO - 'JSGC_DISABLE_POISONING': '1', 21:36:04 INFO - 'LANG': 'en_US.UTF-8', 21:36:04 INFO - 'LANGUAGE': 'en_US:en', 21:36:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:36:04 INFO - 'LOGNAME': 'cltbld', 21:36:04 INFO - 'MAIL': '/var/mail/cltbld', 21:36:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:36:04 INFO - 'MOZ_CRASHREPORTER': '1', 21:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:36:04 INFO - 'MOZ_NO_REMOTE': '1', 21:36:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:04 INFO - 'NO_EM_RESTART': '1', 21:36:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:04 INFO - 'PWD': '/builds/slave/test', 21:36:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:04 INFO - 'RUST_BACKTRACE': 'full', 21:36:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:36:04 INFO - 'SHELL': '/bin/bash', 21:36:04 INFO - 'SHLVL': '1', 21:36:04 INFO - 'STYLO_FORCE_DISABLED': '1', 21:36:04 INFO - 'TERM': 'linux', 21:36:04 INFO - 'TMOUT': '86400', 21:36:04 INFO - 'USER': 'cltbld', 21:36:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:04 INFO - '_': '/tools/buildbot/bin/python'} 21:36:04 INFO - TEST-INFO | started process 3796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyDMihC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:05 INFO - PID 3796 | 21:36:05 INFO - PID 3796 | (/builds/slave/test/build/application/firefox/firefox:3845): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:36:05 INFO - PID 3796 | 21:36:15 INFO - PID 3796 | RSS: Main: 144121856 21:36:15 INFO - PID 3796 | 21:39:12 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59157/tests/dromaeo/cssquery-ext.html) 21:39:13 INFO - PID 3796 | RSS: Main: 148488192 21:39:13 INFO - PID 3796 | 21:42:15 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-ext.html (next: http://localhost:59157/tests/dromaeo/cssquery-jquery.html) 21:42:15 INFO - PID 3796 | RSS: Main: 148090880 21:42:15 INFO - PID 3796 | 21:45:17 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59157/tests/dromaeo/cssquery-mootools.html) 21:45:18 INFO - PID 3796 | RSS: Main: 150212608 21:45:18 INFO - PID 3796 | 21:48:19 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59157/tests/dromaeo/cssquery-prototype.html) 21:48:20 INFO - PID 3796 | RSS: Main: 149147648 21:48:20 INFO - PID 3796 | 21:51:23 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59157/tests/dromaeo/cssquery-yui.html) 21:51:24 INFO - PID 3796 | RSS: Main: 150155264 21:51:24 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:59157/tests/dromaeo/cssquery-yui.html (next: http://localhost:59157/tests/dromaeo/cssquery-dojo.html) 21:54:25 INFO - PID 3796 | RSS: Main: 152719360 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | __start_tp_report 21:54:25 INFO - PID 3796 | _x_x_mozilla_page_load 21:54:25 INFO - PID 3796 | _x_x_mozilla_page_load_details 21:54:25 INFO - PID 3796 | |i|pagename|runs| 21:54:25 INFO - PID 3796 | |0;dojo.html;3812.4662547243374;3835;3856.035991002249;3880.359740642794;3883.592222816604;6117.938820611804;6131.448169664729;6177.258728952526;6185.690715464226;6252.84367890803;6244.032175012869;6246.937530624692;6254.280757712864;6260.718267677954;6271.090691849679;5559.555235581154;5584.944150558483;5652.802151924683;5669.546436285087;5697.03150464422;5595.328560572737;5646.18130371098;5655.26481557397;5658.971705141468;5663.4336566343245;268.7902806925192;5547.140193270049;5555.2778138841695;5571;5701.401352857953;5548.55611551075;5601.719914004324;5630.071038278679;5632.098864181711;5640.0693885508845;5536.557075433956;5541;5596.804111856106;5619.775208991636;5626.4654857788855;6076.361981991871;6136.570440069197;6191.226096737908;6193.690315484253;6238.9376106238815;6626.072349871022;6627.768028118992;6649.867002659968;6726;6744.93255067448;6743.527953043289;6757.594544327307;6814.897776533356;6827.761028363983;6853.691583878737;6194.9070763938125;6207.627542347428;6251;6260.029695397221;6274.560780745304;7000.824979375557;7036.577805331696;7037.155541334971;7037.437005039585;7049.08361912948;6584.8353791155605;6666.166729158856;6670.699818508178;6742.494312926452;6756.391924726799;6671.066050752898;6750.864982700318;6780.220274668378;6847.21257055435;6852.417544508673;6680;6681.966590167018;6688.899666505006;6691.397774200248;6693.598384096969;6759.425448836806;6761.8647627047185;6774.085498457645;6823.727050917908;6854.9657251713425;4871.050145221719;4872.610191184767;4925.581325587294;4942.135126352874;4943.1596628573225;4425.468943726709;4430.490493593278;4466.3523789050405;4491.101779644019;4495.617872480876;6169.784057558054;6208.875822483525;6214.782482613087;6228;6252.656103914328;6635.071090047397;6687.832804179934;6695.631740254235;6704.597724136567;6773.221079575912;6190.50475961922;6216.409441103088;6222.595531290452;6303.36966303366;6303.9684801575695;5291.973540132275;5369.3556773187465;5432.891342173213;5473.644213126134;5488.25908502355;6854.451643868479;6913.619750913748;6937.202221744564;6950.513464057467;6969.233384327821;6660.533762636569;6675.165604299463;6697.430718388991;6702.36327548882;6724.025016372599;6951.304869513008;7050.788476345718;7056.788296351117;7064.611446370499;7072.151341838807;6604.603723776589;6647.268800432045;6659.500537459613;6703.095082164041;6714.127163468718;6611.933880661324;6661.933380666325;6667.866642667216;6675.599464032173;6751.864962700817;6402.775902843378;6403;6434;6436;6448.355164483514;6305.621662700252;6387.329330420239;6436.549441539048;6457.4511166551365;6470.191226096738;6424.51816113784;6427.164468619237;6447.6453795041725;6449.419552240321;6484.481241500763;6507.511936604868;6557.082008518716;6569;6611.735530578915;6624.470042396693;6306.873862522815;6394.23269207698;6439.613623182624;6482.57863238888;6489.383508566679 21:54:25 INFO - PID 3796 | |1;ext.html;942.3262367407302;957.3968399908057;971.3249291742239;990.059443528648;1006.7231511334383;43641;44216.55783442165;44300.556994430044;44328.55671443289;44395.55604443959;40679.38980915281;44116.11767764643;45437.545624543745;45447;45466.545334546645;8218.219269169434;8360.623771930277;8361.916380836205;8367.456115352483;8367.707130250443;8110.270075693186;8142.145074767123;8142.47073940195;8151;8167.959160204191;8246.546439945801;8268.462549934266;8272.627731752056;8281.83436331273;8285.171482851727;8186.222308880647;8211.05572859123;8230.053543842474;8235.011798584179;8251.051129120138;8114.756557303232;8182.631781569844;8185.79535511611;8194.836103277961;8201.097879233279;40988.59011409878;41098;41153.382699259535;41232.38151427731;41276.587234127575;3678.668919797204;3706.796126213057;3723.404255319136;3730.477733117366;3732.9440058399146;33824.154396140046;33987.83006084978;34175;34190.14524636879;34233.6576634233;5230.895382092375;5262.526372626482;5355.794946137127;5372.785088596452;5528.640638358494;223604;223753;224937;224981;226286.86856565776;51771.74114129405;51771.741141294806;51785.482145178066;51819;51867.740661296455;53773.46226537763;53818.192727109126;53842.307884606395;53868;54073.459265407626;15442.691146177238;15490.380384784483;15494.147821869905;15586.844131558539;15600.92199538995;12569.87430125687;12572.874271257353;12589.87410125887;12596.496140154291;12671.17637353569;12840.61478155657;13284.335783210994;13330.066895317235;13349.199048057148;13455;5545.362283337387;5549.1676248563035;5594.944050559524;5657.660540367591;5728.742206600713;1080.3841810168285;1093.8960798724108;1096.7313008312856;1099.6371197504805;1115.7489564847845;24777;24948;25166.748332516807;25211.49577008486;25395.87302063478;1188.1564089496553;1196.0969468051564;1209.1233855454725;1215.1676101870248;1220.2068655374078;13324.169667269323;13386.397612107285;13454.52909148175;13514.864851351558;13658.931705341409;278229;283858;284871;284879;285435;58346.708266458394;60923;62194.37805621886;62355;62379.68810156011;1521.8325984141736;1527.3737767515488;1536;1545.37412347997;1549.264099552726;29321.413571728874;29880;30070.84964575163;30128.849355753082;30159.09522714322;41639.7918010408;41861.37207941822;41980.370294445;42096.789516052224;42451;247307;248415;248635;249078;250168;35232.823835880656;35241.29517409586;35319;35405.114872128404;35515.82242088773;44411.33382999193;45761;45988;46073.76963115297;46173;34119.82940085284;34782.47826282557;34800.65199348075;35129;35244.823775880956;33877.322453551285;33962;33990.830045849616;34018.82990585031;34196.82901585476;40785.388219176144;40835.59164408318;40888.1822363557;41015.794921025205;41029.79485102555;33309.50035749514;33529.66470335265;33820.154496137795;33852.492212617326;33971.320573587895;24425.38936526601;24469.877650611634;24893.502129957662;25416.618750719124;25712.100076497234 21:54:25 INFO - PID 3796 | |2;jquery.html;582.7494177503675;593.8366949089003;595.6961949405802;598.8742364103537;607.8024641991352;23236.65145022826;23928.162514312004;23978.88010559947;24067.398315042134;24087.15694950675;25001.874990625067;25477.74522254777;26681;26989.865050674718;26991.460170796574;6602.10871532343;6621.702023408934;6752.729890804387;6754.290799466059;6759.763408280711;6499.902501462482;6598;6646.302138275484;6652.334766523358;6686.565373250747;6669.866602667944;6671.266160722341;6671.59970401775;6680.365365290289;6685.5320127591085;6568.901466478007;6666.833329166785;6884.724611015554;6898.241193468714;6899.999500072461;6326.715297811609;6347.809565713036;6372.553921225516;6382.425581697669;6383.648899310536;30743;30904.0728778137;30917.227069323446;30981;31049.534256986164;2097.328854766475;2218.4342992536963;2221.8111460525874;2236.9217077402377;2246.6854640350366;19274.807251927443;19999.700004499944;20105.698414523795;20187;20224.39326820183;2424.4423782530116;2440.3777036855668;2496.900123995038;2511.296836885675;2527.545041892459;136163.31918340444;142000.28999854936;145251;150407;150751.24624376808;15278.923605382124;16085.276162572713;16101.67796644084;16185;16950.576235593962;26100.086496972515;26141.607875881877;26159.869200653873;26213.344666383495;26279.474410511684;10150.796984060278;10242.743931401774;10297.279190456597;10385.324953877975;10412.895871041344;8834.381593288408;8880.644774208959;9046.185843274137;9121.179093881583;9181.816363672822;9657.261692895207;9936.254780891317;10070.395776253448;10139.645112421178;10222.335548189343;2738.780897528193;2815.324322162707;2824.8728807203725;2918.255844759573;2943.45546073977;1043.9478026098664;1054.641421916552;1082.9079528240031;1083.47992963378;1089.3082892363407;22034;22079.66880496794;22114.22600209017;22262.888685556467;22284.88575571215;1112.2825777373548;1118;1118.4016551145262;1118.949647265875;1125.1842414249604;11915.761684766256;12120.757584848254;12205;12205.389730513616;12308.26150430977;583433;595973;596387;597226;601819;122614.38692806479;124428;124995;125994;127565.36217318854;1196.6649338185323;1206.3907726598188;1238.9194702344319;1243.7388148488737;1251.7496500699897;19236.326728564432;19613.803861961198;19660.80339196647;19764.11061502207;19955.401337959884;60146.361945893506;60644;60684;62014.689926550076;63482;76971.61514192393;76986;77102.61448692721;77233;77782.6110869442;15373.1544765039;15543.300551474984;15570.377184912477;15582.14298213609;15702;24080.397990050387;24180.63729044101;24306;24633.137840175506;24808.751912480646;19215.90392048087;19732.802671973095;19862.900685497058;19953.60092798165;20019.29932452357;17693.646127077645;17956.371526997016;17984;18416.815831842046;18529.351472698392;20136.496587584843;20511.8974405127;20797.688034679795;20820.895895520425;20893.059812308788;15505.457308994131;15528.767068494208;15595.610109747347;15609.219539022777;15702.293396796944;19119.617607648048;19210.135543900837;19629.901850490656;19819.801801981797;19896.60206795885 21:54:25 INFO - PID 3796 | |3;mootools.html;1391.1722525097566;1490.7018596280743;1503.7669161279998;1507.4723846653665;1509.667873067926;17114.486565403044;17546.91226543869;17547.561310967234;17554.034528100965;17574.384896528623;17236.396726114588;17353.91323043386;17388.47834564965;17409.65180696385;17434.651306973883;2724.6594175728032;2816.9154925352273;2818.1545536339117;2819.7744180465515;2826.349939513913;2397.376682062659;2787.7212278772063;2837.1204926472756;2849.6437945256844;2853.129795412409;2441.2310122311505;2455.3984273852843;2816.4648716743854;2888.422315536901;2898.9130326090253;2693.690225624039;2739.5068887600223;2743.6981931987466;2761.8342899425998;2765.8617069146662;2603.5964425514076;2632.289281893878;2634.315078079694;2641.537730897085;2647.0735242664914;16387.508374748657;16468.258928348132;16537.421190258403;16572.50282491527;16589.91705041467;8309.95845020777;8553.529555874424;8604.440711353742;8614.310855131574;8625.137486251388;4750.548697873696;4884.096442158212;4918.188498897677;5432.886258317075;5585.385607583163;2041.7549894012666;2042.3974927396453;2060.701198326234;2084.395525297662;2091.72807535021;29218.269543261376;29708.70291297081;29805.40389192226;29998.25004374908;30004.8499757502;7124.50128491011;7282.635868206568;7341.70633174667;7375.631218439056;7425.888611670829;18697;19214;22368.44078898008;22404.439889002904;22415.663765043537;7443.404527637776;7561.017067781153;7562.205968373351;7568.848623027508;7600.2779735925;6985.231624521299;6987.615681137485;7008.824779380557;7085.504014719023;7133.072700548895;5582;5700.3444603871085;5744.942550574524;5761.242820939654;5761.625494342854;1618.8947718398267;1623.8294979027269;1656.5527307627115;1665.600255938566;1674.4139551156998;961.9711408657752;980.1129977370491;985.8176237396104;1001.7195185348114;1005.261133067195;8485.915140848636;8511.65953361871;8522.232999029993;8527.488350698977;8628.396012279205;767.4052609227894;782.3076577229193;796.1998191817187;797.6490344248512;816.1593558634615;5846.298444186725;5874.647521148745;5880;5892.705364731746;5981.5214782817275;23589.410264743517;23851.642225366635;24436.633450498255;24654.260372188863;25184.24447266585;24048.278551643478;24315;24333.14833980802;24724;25028.4994300113;12244.265344079384;12403.317817519943;12513;12518.937405313098;12604.432800523815;8984.056674049392;9077;9143.908560914571;9206.493642849708;9318.440893546409;20473.590528189055;21079.367618971457;21249.57500850005;21367.78632213658;21505;21346.252881149085;21579;21610.89194554017;21788.564228715655;21829.563408731417;11940.16418850707;11964.521419143137;11982.10134239918;12052.578159764365;12103.697407564528;14996.47512337063;15198.240087995335;15214.087154770748;15260.618484537532;15263.236838157825;11285.266457680225;11345.432728363383;11473.426328683365;11680.415979201176;11737.413129343327;11954.565452145798;12216.389180541115;12290.262584244974;12379.442925068573;12826.871731282568;10633.521491532745;10645.733856653645;10769;10782.622608208674;10836;7919.762407127795;8010.919890801018;8036.955195824506;8044.35645148375;8084.353251739729;7960.890364053646;7986.3610911128135;8032.357411407191;8067.193280671886;8129.430939834391 21:54:25 INFO - PID 3796 | |4;prototype.html;547.3076558153936;550.4742970463207;561.4385614385615;578.236727519674;580.1240127407616;6143.634700640252;6178.196834411531;6213.627182369055;6232.719527621257;6240.407161319678;6068.812519361649;6079.422454866781;6117.6329420234815;6128.2646082470055;6188.288346840115;4793.544613261734;5095.694258344512;5107.948920510803;5120.436751957282;5140.974295128519;4898.975505122469;4950.55445009949;4956.4547899731;4970.2296144097545;4980.252962055684;4898.7060776353355;4923.212286034235;4930.556249937505;4931.235658472924;4955.826546070888;4899.191633380488;4912.901741965176;4918.311436398907;4925.655204135712;4944.307796908436;4495.595396414338;4513.458384993822;4521.728696278234;4521.796519156645;4532.229520981408;6172.84567885802;6186.536009799283;6199.938000619981;6218.657973811439;6227.750889964396;5831.708414579254;5855.092460668603;5856.882862342772;5863.2670916135485;5869.148973398876;6496.642684652342;6560.835979100513;6568.211814582233;6632.137822083147;6641.468682505388;4998.150314446517;5004.699718016895;5009.674371165899;5021.497850214986;5022.221555658879;6914.9308506915295;6945.687444065029;6956.999999999949;6963.442924566022;6971.4771392145285;5181.248718935733;5183.429822719498;5190.40310364313;5192.221166825007;5217.765200565984;5251.343582052244;5258.132408152612;5263.526282634582;5280.524752772269;5294.523492885659;5758.712064396764;5763.625364351304;5782.409837294777;5853.795117170878;5892.234009578728;6213.440790328892;6326.652034138075;6454.160959075384;6459.354064593503;6528.433176037716;1748;1757.9121043948007;1779.3861117914298;1782.6256486137797;1784.3308759215295;1233.9197952133084;1249.312877917142;1255.428779905141;1277.2974863824859;1288.3830792355534;6031.366706495843;6070.362611925684;6093.6343819370095;6098.420650038239;6164.753409863645;6526.34736526353;6612.23959244693;6667.799966000931;6715.731370745116;6716.3955244028275;6044.184035155197;6047.606905551125;6058.1215723719815;6115.235595550556;6180.103884936659;3471.409860323751;3487.302539492112;3500.8949731508096;3503.3518799022263;3522.330757156132;6793.048973143764;6798.76204332846;6903.378695917291;6924.515283930177;6958.756443524452;6244.344343843922;6691.5650482718465;6797.218319893177;6808.6255255960405;6900.2409734929115;6882.8623427531165;6887.862242755117;6893.20728116273;6929.757458488929;6995.440364770908;6521.152250207632;6562.704678289393;6563.343665633399;6608.570442921195;6627.436667883284;6411.455026322815;6554.344565543408;6593.571417857824;6638.402543771083;6672.266050734513;6880.621565813928;6885.173779146535;6915.273896240822;6941.791746247621;6947.7220911162985;5059.519345662156;5104.285400043923;5128.871778205575;5131.076406246912;5154.948450515447;6451.806445806634;6511.446527045254;6609.603423794588;6741.325867413219;6769.073937116559;6276.1799078266795;6393.392627700547;6412.5632259741;6428.817735221095;6452.22573291208;6342.23893132827;6399.680015999088;6407.199100112486;6472.676366181578;6477.51418643613;6423.935760642334;6439.645819479973;6441.774537891151;6448.709808058555;6462.4506916910705;6475.7733479328;6502.772402965874;6523.217213934358;6562.671866406756;6608.140941677551;6306.842328941813;6313.873722525432;6326.9683651581445;6327.892618791601;6365.3316401779 21:54:25 INFO - PID 3796 | |5;yui.html;972.3388096094653;999.9400035997841;1002.9398236105834;1013.062916801958;1015.7257540464077;20498.180072797088;20634.793652063476;20867.26964556241;21068.89465552672;21083.789162108373;19222.13500392482;19436.319728809496;19523.902380488114;19530.414087577396;19536.706949395735;1046.7016900183448;1064.79236548873;1066.6426747039711;1075.4837677914607;1080.0927221134245;1076.0960792933934;1078.6979645699216;1082.5615625671617;1084.967450976472;1085.0939465546278;1007.450939238117;1032.272248065116;1134.778718149957;1139.8005349063922;1152.9308241505494;1140.4525827602756;1145.507431804328;1145.9885401145966;1146.455433669009;1148.1847887999531;798.5448294472153;823.0411570520337;827.5820710541199;829.9170082991652;830.485099238476;20690.172393104258;20882.58234835295;20918;20992.265270715605;20997.160113595437;22806.543869122524;22983.425414364607;23276.65085023726;23480.178193763135;23552.057917683273;17444.73832892495;17655;17725.734113988172;17799.555011124696;17831.197596108075;4097.323941549641;4098.077932465201;4119.649829764474;4121.979390103061;4125.855595054159;125999;150334;150621;151006.24496877554;153820.23089884478;18336.174872130785;18580.721289180674;18714.71927921082;18846.81153188478;18927.053647317578;32446.35107297888;32676;32897.34205315928;32981.17547061342;33131.668683312855;9248.075192480697;9301.348905576544;9310.115539023782;9343.813123737487;9353.064693530729;4420.447444069491;4494.37078808967;4515.480719717209;4525.864224073283;4540.545945405433;5745.770169193185;5766.221560089418;5779;5821.18503409523;5885.61743486672;1221.1268942706008;1236.3385588709998;1247.3513772838255;1249.0819247852821;1261.0668105601972;740.6148802622606;758.9051368578928;760.4296777416937;770.6069904348823;781.6638845296577;12925.870741292654;13074.738505229841;13666.701663341966;13950.511732089532;13990.790138147935;719.6761457344217;720.9603471808996;730.7332823519378;744.5421066044452;746.3805041815281;5906.2912450505355;5923.911141332884;5929.525637948954;5961.254843144607;6077.4226448487325;143701;143951;146008;146487;148677;100065.49967250263;102248.48875755574;121242.39378803226;123240.38379808223;127480;105590;108829;109898.45050774695;109947;111302.44348778366;13122.671933201746;13620.250886201355;13626.659333516742;14133.646658833612;14197;49558;51907;52734;52814.47185528096;53855.192172116665;68980.3101968974;69436.30563694298;69580.30419695738;69681.65159174171;70236.6488167556;20763;20772.79227207769;20826.1669533217;21041;21263.149474020865;21261.255856044965;21340.573188535833;21404.57190856205;21486.785132148478;21495.462613434163;18403.631927361646;18412.079396030415;18563.72154417712;18661.813381866552;18750;18207.362742303954;18390.264389424272;18483.815161848208;18537.16582753806;18608.627827443644;19307.613847722685;19639.410817675493;19697.507562310482;19773.60452790965;19816.801831982073;14060.648483787987;14092.718145636825;14408.783868241775;14419.279036048365;14420.42318307256;13571.253581052742;13630.591082267549;13642;13695.86304136946;13845.653858653212 21:54:25 INFO - PID 3796 | __end_tp_report 21:54:25 INFO - PID 3796 | __start_cc_report 21:54:25 INFO - PID 3796 | _x_x_mozilla_cycle_collect,290 21:54:25 INFO - PID 3796 | __end_cc_report 21:54:25 INFO - PID 3796 | __startTimestamp1505624065416__endTimestamp 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | ------- Summary: start ------- 21:54:25 INFO - PID 3796 | Number of tests: 6 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#0] dojo.html Cycles:165 Average:6162.44 Median:6427.16 stddev:863.73 (13.4%) stddev-sans-first:846.48 21:54:25 INFO - PID 3796 | Values: 3812.5 3835.0 3856.0 3880.4 3883.6 6117.9 6131.4 6177.3 6185.7 6252.8 6244.0 6246.9 6254.3 6260.7 6271.1 5559.6 5584.9 5652.8 5669.5 5697.0 5595.3 5646.2 5655.3 5659.0 5663.4 268.8 5547.1 5555.3 5571.0 5701.4 5548.6 5601.7 5630.1 5632.1 5640.1 5536.6 5541.0 5596.8 5619.8 5626.5 6076.4 6136.6 6191.2 6193.7 6238.9 6626.1 6627.8 6649.9 6726.0 6744.9 6743.5 6757.6 6814.9 6827.8 6853.7 6194.9 6207.6 6251.0 6260.0 6274.6 7000.8 7036.6 7037.2 7037.4 7049.1 6584.8 6666.2 6670.7 6742.5 6756.4 6671.1 6750.9 6780.2 6847.2 6852.4 6680.0 6682.0 6688.9 6691.4 6693.6 6759.4 6761.9 6774.1 6823.7 6855.0 4871.1 4872.6 4925.6 4942.1 4943.2 4425.5 4430.5 4466.4 4491.1 4495.6 6169.8 6208.9 6214.8 6228.0 6252.7 6635.1 6687.8 6695.6 6704.6 6773.2 6190.5 6216.4 6222.6 6303.4 6304.0 5292.0 5369.4 5432.9 5473.6 5488.3 6854.5 6913.6 6937.2 6950.5 6969.2 6660.5 6675.2 6697.4 6702.4 6724.0 6951.3 7050.8 7056.8 7064.6 7072.2 6604.6 6647.3 6659.5 6703.1 6714.1 6611.9 6661.9 6667.9 6675.6 6751.9 6402.8 6403.0 6434.0 6436.0 6448.4 6305.6 6387.3 6436.5 6457.5 6470.2 6424.5 6427.2 6447.6 6449.4 6484.5 6507.5 6557.1 6569.0 6611.7 6624.5 6306.9 6394.2 6439.6 6482.6 6489.4 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#1] ext.html Cycles:180 Average:43038.42 Median:19597.25 stddev:65956.35 (336.6%) stddev-sans-first:66065.64 21:54:25 INFO - PID 3796 | Values: 942.3 957.4 971.3 990.1 1006.7 43641.0 44216.6 44300.6 44328.6 44395.6 40679.4 44116.1 45437.5 45447.0 45466.5 8218.2 8360.6 8361.9 8367.5 8367.7 8110.3 8142.1 8142.5 8151.0 8168.0 8246.5 8268.5 8272.6 8281.8 8285.2 8186.2 8211.1 8230.1 8235.0 8251.1 8114.8 8182.6 8185.8 8194.8 8201.1 40988.6 41098.0 41153.4 41232.4 41276.6 3678.7 3706.8 3723.4 3730.5 3732.9 33824.2 33987.8 34175.0 34190.1 34233.7 5230.9 5262.5 5355.8 5372.8 5528.6 223604.0 223753.0 224937.0 224981.0 226286.9 51771.7 51771.7 51785.5 51819.0 51867.7 53773.5 53818.2 53842.3 53868.0 54073.5 15442.7 15490.4 15494.1 15586.8 15600.9 12569.9 12572.9 12589.9 12596.5 12671.2 12840.6 13284.3 13330.1 13349.2 13455.0 5545.4 5549.2 5594.9 5657.7 5728.7 1080.4 1093.9 1096.7 1099.6 1115.7 24777.0 24948.0 25166.7 25211.5 25395.9 1188.2 1196.1 1209.1 1215.2 1220.2 13324.2 13386.4 13454.5 13514.9 13658.9 278229.0 283858.0 284871.0 284879.0 285435.0 58346.7 60923.0 62194.4 62355.0 62379.7 1521.8 1527.4 1536.0 1545.4 1549.3 29321.4 29880.0 30070.8 30128.8 30159.1 41639.8 41861.4 41980.4 42096.8 42451.0 247307.0 248415.0 248635.0 249078.0 250168.0 35232.8 35241.3 35319.0 35405.1 35515.8 44411.3 45761.0 45988.0 46073.8 46173.0 34119.8 34782.5 34800.7 35129.0 35244.8 33877.3 33962.0 33990.8 34018.8 34196.8 40785.4 40835.6 40888.2 41015.8 41029.8 33309.5 33529.7 33820.2 33852.5 33971.3 24425.4 24469.9 24893.5 25416.6 25712.1 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#2] jquery.html Cycles:180 Average:39122.50 Median:12260.90 stddev:99308.21 (810.0%) stddev-sans-first:99544.64 21:54:25 INFO - PID 3796 | Values: 582.7 593.8 595.7 598.9 607.8 23236.7 23928.2 23978.9 24067.4 24087.2 25001.9 25477.7 26681.0 26989.9 26991.5 6602.1 6621.7 6752.7 6754.3 6759.8 6499.9 6598.0 6646.3 6652.3 6686.6 6669.9 6671.3 6671.6 6680.4 6685.5 6568.9 6666.8 6884.7 6898.2 6900.0 6326.7 6347.8 6372.6 6382.4 6383.6 30743.0 30904.1 30917.2 30981.0 31049.5 2097.3 2218.4 2221.8 2236.9 2246.7 19274.8 19999.7 20105.7 20187.0 20224.4 2424.4 2440.4 2496.9 2511.3 2527.5 136163.3 142000.3 145251.0 150407.0 150751.2 15278.9 16085.3 16101.7 16185.0 16950.6 26100.1 26141.6 26159.9 26213.3 26279.5 10150.8 10242.7 10297.3 10385.3 10412.9 8834.4 8880.6 9046.2 9121.2 9181.8 9657.3 9936.3 10070.4 10139.6 10222.3 2738.8 2815.3 2824.9 2918.3 2943.5 1043.9 1054.6 1082.9 1083.5 1089.3 22034.0 22079.7 22114.2 22262.9 22284.9 1112.3 1118.0 1118.4 1118.9 1125.2 11915.8 12120.8 12205.0 12205.4 12308.3 583433.0 595973.0 596387.0 597226.0 601819.0 122614.4 124428.0 124995.0 125994.0 127565.4 1196.7 1206.4 1238.9 1243.7 1251.7 19236.3 19613.8 19660.8 19764.1 19955.4 60146.4 60644.0 60684.0 62014.7 63482.0 76971.6 76986.0 77102.6 77233.0 77782.6 15373.2 15543.3 15570.4 15582.1 15702.0 24080.4 24180.6 24306.0 24633.1 24808.8 19215.9 19732.8 19862.9 19953.6 20019.3 17693.6 17956.4 17984.0 18416.8 18529.4 20136.5 20511.9 20797.7 20820.9 20893.1 15505.5 15528.8 15595.6 15609.2 15702.3 19119.6 19210.1 19629.9 19819.8 19896.6 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#3] mootools.html Cycles:180 Average:10261.57 Median:2617.94 stddev:7687.09 (293.6%) stddev-sans-first:7679.77 21:54:25 INFO - PID 3796 | Values: 1391.2 1490.7 1503.8 1507.5 1509.7 17114.5 17546.9 17547.6 17554.0 17574.4 17236.4 17353.9 17388.5 17409.7 17434.7 2724.7 2816.9 2818.2 2819.8 2826.3 2397.4 2787.7 2837.1 2849.6 2853.1 2441.2 2455.4 2816.5 2888.4 2898.9 2693.7 2739.5 2743.7 2761.8 2765.9 2603.6 2632.3 2634.3 2641.5 2647.1 16387.5 16468.3 16537.4 16572.5 16589.9 8310.0 8553.5 8604.4 8614.3 8625.1 4750.5 4884.1 4918.2 5432.9 5585.4 2041.8 2042.4 2060.7 2084.4 2091.7 29218.3 29708.7 29805.4 29998.3 30004.8 7124.5 7282.6 7341.7 7375.6 7425.9 18697.0 19214.0 22368.4 22404.4 22415.7 7443.4 7561.0 7562.2 7568.8 7600.3 6985.2 6987.6 7008.8 7085.5 7133.1 5582.0 5700.3 5744.9 5761.2 5761.6 1618.9 1623.8 1656.6 1665.6 1674.4 962.0 980.1 985.8 1001.7 1005.3 8485.9 8511.7 8522.2 8527.5 8628.4 767.4 782.3 796.2 797.6 816.2 5846.3 5874.6 5880.0 5892.7 5981.5 23589.4 23851.6 24436.6 24654.3 25184.2 24048.3 24315.0 24333.1 24724.0 25028.5 12244.3 12403.3 12513.0 12518.9 12604.4 8984.1 9077.0 9143.9 9206.5 9318.4 20473.6 21079.4 21249.6 21367.8 21505.0 21346.3 21579.0 21610.9 21788.6 21829.6 11940.2 11964.5 11982.1 12052.6 12103.7 14996.5 15198.2 15214.1 15260.6 15263.2 11285.3 11345.4 11473.4 11680.4 11737.4 11954.6 12216.4 12290.3 12379.4 12826.9 10633.5 10645.7 10769.0 10782.6 10836.0 7919.8 8010.9 8037.0 8044.4 8084.4 7960.9 7986.4 8032.4 8067.2 8129.4 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#4] prototype.html Cycles:180 Average:5563.09 Median:6179.15 stddev:1547.83 (25.0%) stddev-sans-first:1505.69 21:54:25 INFO - PID 3796 | Values: 547.3 550.5 561.4 578.2 580.1 6143.6 6178.2 6213.6 6232.7 6240.4 6068.8 6079.4 6117.6 6128.3 6188.3 4793.5 5095.7 5107.9 5120.4 5141.0 4899.0 4950.6 4956.5 4970.2 4980.3 4898.7 4923.2 4930.6 4931.2 4955.8 4899.2 4912.9 4918.3 4925.7 4944.3 4495.6 4513.5 4521.7 4521.8 4532.2 6172.8 6186.5 6199.9 6218.7 6227.8 5831.7 5855.1 5856.9 5863.3 5869.1 6496.6 6560.8 6568.2 6632.1 6641.5 4998.2 5004.7 5009.7 5021.5 5022.2 6914.9 6945.7 6957.0 6963.4 6971.5 5181.2 5183.4 5190.4 5192.2 5217.8 5251.3 5258.1 5263.5 5280.5 5294.5 5758.7 5763.6 5782.4 5853.8 5892.2 6213.4 6326.7 6454.2 6459.4 6528.4 1748.0 1757.9 1779.4 1782.6 1784.3 1233.9 1249.3 1255.4 1277.3 1288.4 6031.4 6070.4 6093.6 6098.4 6164.8 6526.3 6612.2 6667.8 6715.7 6716.4 6044.2 6047.6 6058.1 6115.2 6180.1 3471.4 3487.3 3500.9 3503.4 3522.3 6793.0 6798.8 6903.4 6924.5 6958.8 6244.3 6691.6 6797.2 6808.6 6900.2 6882.9 6887.9 6893.2 6929.8 6995.4 6521.2 6562.7 6563.3 6608.6 6627.4 6411.5 6554.3 6593.6 6638.4 6672.3 6880.6 6885.2 6915.3 6941.8 6947.7 5059.5 5104.3 5128.9 5131.1 5154.9 6451.8 6511.4 6609.6 6741.3 6769.1 6276.2 6393.4 6412.6 6428.8 6452.2 6342.2 6399.7 6407.2 6472.7 6477.5 6423.9 6439.6 6441.8 6448.7 6462.5 6475.8 6502.8 6523.2 6562.7 6608.1 6306.8 6313.9 6327.0 6327.9 6365.3 21:54:25 INFO - PID 3796 | 21:54:25 INFO - PID 3796 | [#5] yui.html Cycles:180 Average:27340.90 Median:19480.11 stddev:39239.24 (201.4%) stddev-sans-first:39299.36 21:54:25 INFO - PID 3796 | Values: 972.3 999.9 1002.9 1013.1 1015.7 20498.2 20634.8 20867.3 21068.9 21083.8 19222.1 19436.3 19523.9 19530.4 19536.7 1046.7 1064.8 1066.6 1075.5 1080.1 1076.1 1078.7 1082.6 1085.0 1085.1 1007.5 1032.3 1134.8 1139.8 1152.9 1140.5 1145.5 1146.0 1146.5 1148.2 798.5 823.0 827.6 829.9 830.5 20690.2 20882.6 20918.0 20992.3 20997.2 22806.5 22983.4 23276.7 23480.2 23552.1 17444.7 17655.0 17725.7 17799.6 17831.2 4097.3 4098.1 4119.6 4122.0 4125.9 125999.0 150334.0 150621.0 151006.2 153820.2 18336.2 18580.7 18714.7 18846.8 18927.1 32446.4 32676.0 32897.3 32981.2 33131.7 9248.1 9301.3 9310.1 9343.8 9353.1 4420.4 4494.4 4515.5 4525.9 4540.5 5745.8 5766.2 5779.0 5821.2 5885.6 1221.1 1236.3 1247.4 1249.1 1261.1 740.6 758.9 760.4 770.6 781.7 12925.9 13074.7 13666.7 13950.5 13990.8 719.7 721.0 730.7 744.5 746.4 5906.3 5923.9 5929.5 5961.3 6077.4 143701.0 143951.0 146008.0 146487.0 148677.0 100065.5 102248.5 121242.4 123240.4 127480.0 105590.0 108829.0 109898.5 109947.0 111302.4 13122.7 13620.3 13626.7 14133.6 14197.0 49558.0 51907.0 52734.0 52814.5 53855.2 68980.3 69436.3 69580.3 69681.7 70236.6 20763.0 20772.8 20826.2 21041.0 21263.1 21261.3 21340.6 21404.6 21486.8 21495.5 18403.6 18412.1 18563.7 18661.8 18750.0 18207.4 18390.3 18483.8 18537.2 18608.6 19307.6 19639.4 19697.5 19773.6 19816.8 14060.6 14092.7 14408.8 14419.3 14420.4 13571.3 13630.6 13642.0 13695.9 13845.7 21:54:25 INFO - PID 3796 | -------- Summary: end -------- 21:54:25 INFO - PID 3796 | 21:54:26 INFO - TEST-INFO | 3796: exit 0 21:54:26 INFO - TEST-OK | dromaeo_css | took 1110900ms 21:54:26 INFO - TEST-START | kraken 21:54:26 INFO - Initialising browser for kraken test... 21:54:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59157/getInfo.html -profile /tmp/tmpKN2plp/profile 21:54:26 INFO - TEST-INFO | started process 4164 (/builds/slave/test/build/application/firefox/firefox http://localhost:59157/getInfo.html) 21:54:32 INFO - TEST-INFO | 4164: exit 0 21:54:32 INFO - Browser initialized. 21:54:32 INFO - Running cycle 1/1 for kraken test... 21:54:32 INFO - Using env: {'DISPLAY': ':0', 21:54:32 INFO - 'HOME': '/home/cltbld', 21:54:32 INFO - 'JSGC_DISABLE_POISONING': '1', 21:54:32 INFO - 'LANG': 'en_US.UTF-8', 21:54:32 INFO - 'LANGUAGE': 'en_US:en', 21:54:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:54:32 INFO - 'LOGNAME': 'cltbld', 21:54:32 INFO - 'MAIL': '/var/mail/cltbld', 21:54:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:54:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:54:32 INFO - 'MOZ_CRASHREPORTER': '1', 21:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:54:32 INFO - 'MOZ_NO_REMOTE': '1', 21:54:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:32 INFO - 'NO_EM_RESTART': '1', 21:54:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:32 INFO - 'PWD': '/builds/slave/test', 21:54:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:54:32 INFO - 'RUST_BACKTRACE': 'full', 21:54:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:54:32 INFO - 'SHELL': '/bin/bash', 21:54:32 INFO - 'SHLVL': '1', 21:54:32 INFO - 'STYLO_FORCE_DISABLED': '1', 21:54:32 INFO - 'TERM': 'linux', 21:54:32 INFO - 'TMOUT': '86400', 21:54:32 INFO - 'USER': 'cltbld', 21:54:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1505622210.345626-785723519', 21:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:32 INFO - '_': '/tools/buildbot/bin/python'} 21:54:32 INFO - TEST-INFO | started process 4405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKN2plp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:33 INFO - PID 4405 | 21:54:33 INFO - PID 4405 | (/builds/slave/test/build/application/firefox/firefox:4454): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:54:33 INFO - PID 4405 | 21:54:43 INFO - PID 4405 | RSS: Main: 144134144 21:54:43 INFO - PID 4405 | 21:54:46 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59157/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:47 INFO - PID 4405 | RSS: Main: 149712896 21:54:47 INFO - PID 4405 | 21:54:49 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59157/tests/kraken/driver.html?testName=audio-dft) 21:54:50 INFO - PID 4405 | RSS: Main: 149774336 21:54:50 INFO - PID 4405 | 21:54:53 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59157/tests/kraken/driver.html?testName=audio-fft) 21:54:53 INFO - PID 4405 | RSS: Main: 145932288 21:54:53 INFO - PID 4405 | 21:54:55 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59157/tests/kraken/driver.html?testName=audio-oscillator) 21:54:56 INFO - PID 4405 | RSS: Main: 147009536 21:54:56 INFO - PID 4405 | 21:54:58 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:59 INFO - PID 4405 | RSS: Main: 147263488 21:54:59 INFO - PID 4405 | 21:55:02 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59157/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:02 INFO - PID 4405 | RSS: Main: 147243008 21:55:02 INFO - PID 4405 | 21:55:06 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59157/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:06 INFO - PID 4405 | RSS: Main: 148525056 21:55:06 INFO - PID 4405 | 21:55:09 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59157/tests/kraken/driver.html?testName=json-parse-financial) 21:55:10 INFO - PID 4405 | RSS: Main: 150233088 21:55:10 INFO - PID 4405 | 21:55:11 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:12 INFO - PID 4405 | RSS: Main: 149827584 21:55:12 INFO - PID 4405 | 21:55:14 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:14 INFO - PID 4405 | RSS: Main: 149909504 21:55:14 INFO - PID 4405 | 21:55:16 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:17 INFO - PID 4405 | RSS: Main: 150052864 21:55:17 INFO - PID 4405 | 21:55:19 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:20 INFO - PID 4405 | RSS: Main: 149827584 21:55:20 INFO - PID 4405 | 21:55:23 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:23 INFO - PID 4405 | RSS: Main: 150548480 21:55:23 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | Cycle 1(1): loaded http://localhost:59157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59157/tests/kraken/driver.html?testName=ai-astar) 21:55:25 INFO - PID 4405 | RSS: Main: 152150016 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | __start_tp_report 21:55:25 INFO - PID 4405 | _x_x_mozilla_page_load 21:55:25 INFO - PID 4405 | _x_x_mozilla_page_load_details 21:55:25 INFO - PID 4405 | |i|pagename|runs| 21:55:25 INFO - PID 4405 | |0;ai-astar;106;108;106;106;105;108;106;107;106;106 21:55:25 INFO - PID 4405 | |1;audio-beat-detection;112;117;115;111;114;112;113;112;112;139 21:55:25 INFO - PID 4405 | |2;audio-dft;162;162;163;163;162;162;163;161;168;165 21:55:25 INFO - PID 4405 | |3;audio-fft;74;73;79;74;73;74;73;75;74;73 21:55:25 INFO - PID 4405 | |4;audio-oscillator;82;83;81;77;78;79;78;84;79;78 21:55:25 INFO - PID 4405 | |5;imaging-gaussian-blur;114;114;114;114;116;114;116;111;114;114 21:55:25 INFO - PID 4405 | |6;imaging-darkroom;150;149;149;149;150;151;150;151;150;149 21:55:25 INFO - PID 4405 | |7;imaging-desaturate;94;100;94;94;94;94;95;95;96;94 21:55:25 INFO - PID 4405 | |8;json-parse-financial;47;47;45;46;46;45;45;44;43;43 21:55:25 INFO - PID 4405 | |9;json-stringify-tinderbox;38;37;39;39;40;38;38;37;38;38 21:55:25 INFO - PID 4405 | |10;stanford-crypto-aes;71;71;76;70;72;71;77;70;71;70 21:55:25 INFO - PID 4405 | |11;stanford-crypto-ccm;107;104;104;112;107;128;109;110;106;104 21:55:25 INFO - PID 4405 | |12;stanford-crypto-pbkdf2;156;159;156;153;151;156;150;155;155;157 21:55:25 INFO - PID 4405 | |13;stanford-crypto-sha256-iterative;66;60;59;59;63;60;57;58;58;60 21:55:25 INFO - PID 4405 | __end_tp_report 21:55:25 INFO - PID 4405 | __start_cc_report 21:55:25 INFO - PID 4405 | _x_x_mozilla_cycle_collect,706 21:55:25 INFO - PID 4405 | __end_cc_report 21:55:25 INFO - PID 4405 | __startTimestamp1505624125676__endTimestamp 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | ------- Summary: start ------- 21:55:25 INFO - PID 4405 | Number of tests: 14 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#0] ai-astar Cycles:10 Average:106.40 Median:106.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 21:55:25 INFO - PID 4405 | Values: 106.0 108.0 106.0 106.0 105.0 108.0 106.0 107.0 106.0 106.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:113.50 stddev:8.38 (7.4%) stddev-sans-first:8.78 21:55:25 INFO - PID 4405 | Values: 112.0 117.0 115.0 111.0 114.0 112.0 113.0 112.0 112.0 139.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.02 (1.2%) stddev-sans-first:2.11 21:55:25 INFO - PID 4405 | Values: 162.0 162.0 163.0 163.0 162.0 162.0 163.0 161.0 168.0 165.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.00 stddev:1.81 (2.5%) stddev-sans-first:1.92 21:55:25 INFO - PID 4405 | Values: 74.0 73.0 79.0 74.0 73.0 74.0 73.0 75.0 74.0 73.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:80.00 stddev:2.42 (3.0%) stddev-sans-first:2.45 21:55:25 INFO - PID 4405 | Values: 82.0 83.0 81.0 77.0 78.0 79.0 78.0 84.0 79.0 78.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.37 (1.2%) stddev-sans-first:1.45 21:55:25 INFO - PID 4405 | Values: 114.0 114.0 114.0 114.0 116.0 114.0 116.0 111.0 114.0 114.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 21:55:25 INFO - PID 4405 | Values: 150.0 149.0 149.0 149.0 150.0 151.0 150.0 151.0 150.0 149.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:1.89 (2.0%) stddev-sans-first:1.96 21:55:25 INFO - PID 4405 | Values: 94.0 100.0 94.0 94.0 94.0 94.0 95.0 95.0 96.0 94.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:45.50 stddev:1.45 (3.2%) stddev-sans-first:1.36 21:55:25 INFO - PID 4405 | Values: 47.0 47.0 45.0 46.0 46.0 45.0 45.0 44.0 43.0 43.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.92 (2.4%) stddev-sans-first:0.97 21:55:25 INFO - PID 4405 | Values: 38.0 37.0 39.0 39.0 40.0 38.0 38.0 37.0 38.0 38.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:71.00 stddev:2.51 (3.5%) stddev-sans-first:2.65 21:55:25 INFO - PID 4405 | Values: 71.0 71.0 76.0 70.0 72.0 71.0 77.0 70.0 71.0 70.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#11] stanford-crypto-ccm Cycles:10 Average:109.10 Median:108.00 stddev:7.17 (6.6%) stddev-sans-first:7.57 21:55:25 INFO - PID 4405 | Values: 107.0 104.0 104.0 112.0 107.0 128.0 109.0 110.0 106.0 104.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:156.00 stddev:2.74 (1.8%) stddev-sans-first:2.87 21:55:25 INFO - PID 4405 | Values: 156.0 159.0 156.0 153.0 151.0 156.0 150.0 155.0 155.0 157.0 21:55:25 INFO - PID 4405 | 21:55:25 INFO - PID 4405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:2.67 (4.4%) stddev-sans-first:1.73 21:55:25 INFO - PID 4405 | Values: 66.0 60.0 59.0 59.0 63.0 60.0 57.0 58.0 58.0 60.0 21:55:25 INFO - PID 4405 | -------- Summary: end -------- 21:55:25 INFO - PID 4405 | 21:55:27 INFO - PID 4405 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:55:27 INFO - TEST-INFO | 4405: exit 0 21:55:27 INFO - TEST-OK | kraken | took 61531ms 21:55:27 INFO - SUITE-END | took 1172s 21:55:27 INFO - Completed test suite (00:19:32) 21:55:27 INFO - javascript benchmark 21:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8989.243100148584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3812.4662547243374, 3835.0, 3856.035991002249, 3880.359740642794, 3883.592222816604, 6117.938820611804, 6131.448169664729, 6177.258728952526, 6185.690715464226, 6252.84367890803, 6244.032175012869, 6246.937530624692, 6254.280757712864, 6260.718267677954, 6271.090691849679, 5559.555235581154, 5584.944150558483, 5652.802151924683, 5669.546436285087, 5697.03150464422, 5595.328560572737, 5646.18130371098, 5655.26481557397, 5658.971705141468, 5663.4336566343245, 268.7902806925192, 5547.140193270049, 5555.2778138841695, 5571.0, 5701.401352857953, 5548.55611551075, 5601.719914004324, 5630.071038278679, 5632.098864181711, 5640.0693885508845, 5536.557075433956, 5541.0, 5596.804111856106, 5619.775208991636, 5626.4654857788855, 6076.361981991871, 6136.570440069197, 6191.226096737908, 6193.690315484253, 6238.9376106238815, 6626.072349871022, 6627.768028118992, 6649.867002659968, 6726.0, 6744.93255067448, 6743.527953043289, 6757.594544327307, 6814.897776533356, 6827.761028363983, 6853.691583878737, 6194.9070763938125, 6207.627542347428, 6251.0, 6260.029695397221, 6274.560780745304, 7000.824979375557, 7036.577805331696, 7037.155541334971, 7037.437005039585, 7049.08361912948, 6584.8353791155605, 6666.166729158856, 6670.699818508178, 6742.494312926452, 6756.391924726799, 6671.066050752898, 6750.864982700318, 6780.220274668378, 6847.21257055435, 6852.417544508673, 6680.0, 6681.966590167018, 6688.899666505006, 6691.397774200248, 6693.598384096969, 6759.425448836806, 6761.8647627047185, 6774.085498457645, 6823.727050917908, 6854.9657251713425, 4871.050145221719, 4872.610191184767, 4925.581325587294, 4942.135126352874, 4943.1596628573225, 4425.468943726709, 4430.490493593278, 4466.3523789050405, 4491.101779644019, 4495.617872480876, 6169.784057558054, 6208.875822483525, 6214.782482613087, 6228.0, 6252.656103914328, 6635.071090047397, 6687.832804179934, 6695.631740254235, 6704.597724136567, 6773.221079575912, 6190.50475961922, 6216.409441103088, 6222.595531290452, 6303.36966303366, 6303.9684801575695, 5291.973540132275, 5369.3556773187465, 5432.891342173213, 5473.644213126134, 5488.25908502355, 6854.451643868479, 6913.619750913748, 6937.202221744564, 6950.513464057467, 6969.233384327821, 6660.533762636569, 6675.165604299463, 6697.430718388991, 6702.36327548882, 6724.025016372599, 6951.304869513008, 7050.788476345718, 7056.788296351117, 7064.611446370499, 7072.151341838807, 6604.603723776589, 6647.268800432045, 6659.500537459613, 6703.095082164041, 6714.127163468718, 6611.933880661324, 6661.933380666325, 6667.866642667216, 6675.599464032173, 6751.864962700817, 6402.775902843378, 6403.0, 6434.0, 6436.0, 6448.355164483514, 6305.621662700252, 6387.329330420239, 6436.549441539048, 6457.4511166551365, 6470.191226096738, 6424.51816113784, 6427.164468619237, 6447.6453795041725, 6449.419552240321, 6484.481241500763, 6507.511936604868, 6557.082008518716, 6569.0, 6611.735530578915, 6624.470042396693, 6306.873862522815, 6394.23269207698, 6439.613623182624, 6482.57863238888, 6489.383508566679], "value": 6106.108990404219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.3262367407302, 957.3968399908057, 971.3249291742239, 990.059443528648, 1006.7231511334383, 43641.0, 44216.55783442165, 44300.556994430044, 44328.55671443289, 44395.55604443959, 40679.38980915281, 44116.11767764643, 45437.545624543745, 45447.0, 45466.545334546645, 8218.219269169434, 8360.623771930277, 8361.916380836205, 8367.456115352483, 8367.707130250443, 8110.270075693186, 8142.145074767123, 8142.47073940195, 8151.0, 8167.959160204191, 8246.546439945801, 8268.462549934266, 8272.627731752056, 8281.83436331273, 8285.171482851727, 8186.222308880647, 8211.05572859123, 8230.053543842474, 8235.011798584179, 8251.051129120138, 8114.756557303232, 8182.631781569844, 8185.79535511611, 8194.836103277961, 8201.097879233279, 40988.59011409878, 41098.0, 41153.382699259535, 41232.38151427731, 41276.587234127575, 3678.668919797204, 3706.796126213057, 3723.404255319136, 3730.477733117366, 3732.9440058399146, 33824.154396140046, 33987.83006084978, 34175.0, 34190.14524636879, 34233.6576634233, 5230.895382092375, 5262.526372626482, 5355.794946137127, 5372.785088596452, 5528.640638358494, 223604.0, 223753.0, 224937.0, 224981.0, 226286.86856565776, 51771.74114129405, 51771.741141294806, 51785.482145178066, 51819.0, 51867.740661296455, 53773.46226537763, 53818.192727109126, 53842.307884606395, 53868.0, 54073.459265407626, 15442.691146177238, 15490.380384784483, 15494.147821869905, 15586.844131558539, 15600.92199538995, 12569.87430125687, 12572.874271257353, 12589.87410125887, 12596.496140154291, 12671.17637353569, 12840.61478155657, 13284.335783210994, 13330.066895317235, 13349.199048057148, 13455.0, 5545.362283337387, 5549.1676248563035, 5594.944050559524, 5657.660540367591, 5728.742206600713, 1080.3841810168285, 1093.8960798724108, 1096.7313008312856, 1099.6371197504805, 1115.7489564847845, 24777.0, 24948.0, 25166.748332516807, 25211.49577008486, 25395.87302063478, 1188.1564089496553, 1196.0969468051564, 1209.1233855454725, 1215.1676101870248, 1220.2068655374078, 13324.169667269323, 13386.397612107285, 13454.52909148175, 13514.864851351558, 13658.931705341409, 278229.0, 283858.0, 284871.0, 284879.0, 285435.0, 58346.708266458394, 60923.0, 62194.37805621886, 62355.0, 62379.68810156011, 1521.8325984141736, 1527.3737767515488, 1536.0, 1545.37412347997, 1549.264099552726, 29321.413571728874, 29880.0, 30070.84964575163, 30128.849355753082, 30159.09522714322, 41639.7918010408, 41861.37207941822, 41980.370294445, 42096.789516052224, 42451.0, 247307.0, 248415.0, 248635.0, 249078.0, 250168.0, 35232.823835880656, 35241.29517409586, 35319.0, 35405.114872128404, 35515.82242088773, 44411.33382999193, 45761.0, 45988.0, 46073.76963115297, 46173.0, 34119.82940085284, 34782.47826282557, 34800.65199348075, 35129.0, 35244.823775880956, 33877.322453551285, 33962.0, 33990.830045849616, 34018.82990585031, 34196.82901585476, 40785.388219176144, 40835.59164408318, 40888.1822363557, 41015.794921025205, 41029.79485102555, 33309.50035749514, 33529.66470335265, 33820.154496137795, 33852.492212617326, 33971.320573587895, 24425.38936526601, 24469.877650611634, 24893.502129957662, 25416.618750719124, 25712.100076497234], "value": 18541.091100147933, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7494177503675, 593.8366949089003, 595.6961949405802, 598.8742364103537, 607.8024641991352, 23236.65145022826, 23928.162514312004, 23978.88010559947, 24067.398315042134, 24087.15694950675, 25001.874990625067, 25477.74522254777, 26681.0, 26989.865050674718, 26991.460170796574, 6602.10871532343, 6621.702023408934, 6752.729890804387, 6754.290799466059, 6759.763408280711, 6499.902501462482, 6598.0, 6646.302138275484, 6652.334766523358, 6686.565373250747, 6669.866602667944, 6671.266160722341, 6671.59970401775, 6680.365365290289, 6685.5320127591085, 6568.901466478007, 6666.833329166785, 6884.724611015554, 6898.241193468714, 6899.999500072461, 6326.715297811609, 6347.809565713036, 6372.553921225516, 6382.425581697669, 6383.648899310536, 30743.0, 30904.0728778137, 30917.227069323446, 30981.0, 31049.534256986164, 2097.328854766475, 2218.4342992536963, 2221.8111460525874, 2236.9217077402377, 2246.6854640350366, 19274.807251927443, 19999.700004499944, 20105.698414523795, 20187.0, 20224.39326820183, 2424.4423782530116, 2440.3777036855668, 2496.900123995038, 2511.296836885675, 2527.545041892459, 136163.31918340444, 142000.28999854936, 145251.0, 150407.0, 150751.24624376808, 15278.923605382124, 16085.276162572713, 16101.67796644084, 16185.0, 16950.576235593962, 26100.086496972515, 26141.607875881877, 26159.869200653873, 26213.344666383495, 26279.474410511684, 10150.796984060278, 10242.743931401774, 10297.279190456597, 10385.324953877975, 10412.895871041344, 8834.381593288408, 8880.644774208959, 9046.185843274137, 9121.179093881583, 9181.816363672822, 9657.261692895207, 9936.254780891317, 10070.395776253448, 10139.645112421178, 10222.335548189343, 2738.780897528193, 2815.324322162707, 2824.8728807203725, 2918.255844759573, 2943.45546073977, 1043.9478026098664, 1054.641421916552, 1082.9079528240031, 1083.47992963378, 1089.3082892363407, 22034.0, 22079.66880496794, 22114.22600209017, 22262.888685556467, 22284.88575571215, 1112.2825777373548, 1118.0, 1118.4016551145262, 1118.949647265875, 1125.1842414249604, 11915.761684766256, 12120.757584848254, 12205.0, 12205.389730513616, 12308.26150430977, 583433.0, 595973.0, 596387.0, 597226.0, 601819.0, 122614.38692806479, 124428.0, 124995.0, 125994.0, 127565.36217318854, 1196.6649338185323, 1206.3907726598188, 1238.9194702344319, 1243.7388148488737, 1251.7496500699897, 19236.326728564432, 19613.803861961198, 19660.80339196647, 19764.11061502207, 19955.401337959884, 60146.361945893506, 60644.0, 60684.0, 62014.689926550076, 63482.0, 76971.61514192393, 76986.0, 77102.61448692721, 77233.0, 77782.6110869442, 15373.1544765039, 15543.300551474984, 15570.377184912477, 15582.14298213609, 15702.0, 24080.397990050387, 24180.63729044101, 24306.0, 24633.137840175506, 24808.751912480646, 19215.90392048087, 19732.802671973095, 19862.900685497058, 19953.60092798165, 20019.29932452357, 17693.646127077645, 17956.371526997016, 17984.0, 18416.815831842046, 18529.351472698392, 20136.496587584843, 20511.8974405127, 20797.688034679795, 20820.895895520425, 20893.059812308788, 15505.457308994131, 15528.767068494208, 15595.610109747347, 15609.219539022777, 15702.293396796944, 19119.617607648048, 19210.135543900837, 19629.901850490656, 19819.801801981797, 19896.60206795885], "value": 12740.139421058726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.1722525097566, 1490.7018596280743, 1503.7669161279998, 1507.4723846653665, 1509.667873067926, 17114.486565403044, 17546.91226543869, 17547.561310967234, 17554.034528100965, 17574.384896528623, 17236.396726114588, 17353.91323043386, 17388.47834564965, 17409.65180696385, 17434.651306973883, 2724.6594175728032, 2816.9154925352273, 2818.1545536339117, 2819.7744180465515, 2826.349939513913, 2397.376682062659, 2787.7212278772063, 2837.1204926472756, 2849.6437945256844, 2853.129795412409, 2441.2310122311505, 2455.3984273852843, 2816.4648716743854, 2888.422315536901, 2898.9130326090253, 2693.690225624039, 2739.5068887600223, 2743.6981931987466, 2761.8342899425998, 2765.8617069146662, 2603.5964425514076, 2632.289281893878, 2634.315078079694, 2641.537730897085, 2647.0735242664914, 16387.508374748657, 16468.258928348132, 16537.421190258403, 16572.50282491527, 16589.91705041467, 8309.95845020777, 8553.529555874424, 8604.440711353742, 8614.310855131574, 8625.137486251388, 4750.548697873696, 4884.096442158212, 4918.188498897677, 5432.886258317075, 5585.385607583163, 2041.7549894012666, 2042.3974927396453, 2060.701198326234, 2084.395525297662, 2091.72807535021, 29218.269543261376, 29708.70291297081, 29805.40389192226, 29998.25004374908, 30004.8499757502, 7124.50128491011, 7282.635868206568, 7341.70633174667, 7375.631218439056, 7425.888611670829, 18697.0, 19214.0, 22368.44078898008, 22404.439889002904, 22415.663765043537, 7443.404527637776, 7561.017067781153, 7562.205968373351, 7568.848623027508, 7600.2779735925, 6985.231624521299, 6987.615681137485, 7008.824779380557, 7085.504014719023, 7133.072700548895, 5582.0, 5700.3444603871085, 5744.942550574524, 5761.242820939654, 5761.625494342854, 1618.8947718398267, 1623.8294979027269, 1656.5527307627115, 1665.600255938566, 1674.4139551156998, 961.9711408657752, 980.1129977370491, 985.8176237396104, 1001.7195185348114, 1005.261133067195, 8485.915140848636, 8511.65953361871, 8522.232999029993, 8527.488350698977, 8628.396012279205, 767.4052609227894, 782.3076577229193, 796.1998191817187, 797.6490344248512, 816.1593558634615, 5846.298444186725, 5874.647521148745, 5880.0, 5892.705364731746, 5981.5214782817275, 23589.410264743517, 23851.642225366635, 24436.633450498255, 24654.260372188863, 25184.24447266585, 24048.278551643478, 24315.0, 24333.14833980802, 24724.0, 25028.4994300113, 12244.265344079384, 12403.317817519943, 12513.0, 12518.937405313098, 12604.432800523815, 8984.056674049392, 9077.0, 9143.908560914571, 9206.493642849708, 9318.440893546409, 20473.590528189055, 21079.367618971457, 21249.57500850005, 21367.78632213658, 21505.0, 21346.252881149085, 21579.0, 21610.89194554017, 21788.564228715655, 21829.563408731417, 11940.16418850707, 11964.521419143137, 11982.10134239918, 12052.578159764365, 12103.697407564528, 14996.47512337063, 15198.240087995335, 15214.087154770748, 15260.618484537532, 15263.236838157825, 11285.266457680225, 11345.432728363383, 11473.426328683365, 11680.415979201176, 11737.413129343327, 11954.565452145798, 12216.389180541115, 12290.262584244974, 12379.442925068573, 12826.871731282568, 10633.521491532745, 10645.733856653645, 10769.0, 10782.622608208674, 10836.0, 7919.762407127795, 8010.919890801018, 8036.955195824506, 8044.35645148375, 8084.353251739729, 7960.890364053646, 7986.3610911128135, 8032.357411407191, 8067.193280671886, 8129.430939834391], "value": 7125.090138214915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3076558153936, 550.4742970463207, 561.4385614385615, 578.236727519674, 580.1240127407616, 6143.634700640252, 6178.196834411531, 6213.627182369055, 6232.719527621257, 6240.407161319678, 6068.812519361649, 6079.422454866781, 6117.6329420234815, 6128.2646082470055, 6188.288346840115, 4793.544613261734, 5095.694258344512, 5107.948920510803, 5120.436751957282, 5140.974295128519, 4898.975505122469, 4950.55445009949, 4956.4547899731, 4970.2296144097545, 4980.252962055684, 4898.7060776353355, 4923.212286034235, 4930.556249937505, 4931.235658472924, 4955.826546070888, 4899.191633380488, 4912.901741965176, 4918.311436398907, 4925.655204135712, 4944.307796908436, 4495.595396414338, 4513.458384993822, 4521.728696278234, 4521.796519156645, 4532.229520981408, 6172.84567885802, 6186.536009799283, 6199.938000619981, 6218.657973811439, 6227.750889964396, 5831.708414579254, 5855.092460668603, 5856.882862342772, 5863.2670916135485, 5869.148973398876, 6496.642684652342, 6560.835979100513, 6568.211814582233, 6632.137822083147, 6641.468682505388, 4998.150314446517, 5004.699718016895, 5009.674371165899, 5021.497850214986, 5022.221555658879, 6914.9308506915295, 6945.687444065029, 6956.999999999949, 6963.442924566022, 6971.4771392145285, 5181.248718935733, 5183.429822719498, 5190.40310364313, 5192.221166825007, 5217.765200565984, 5251.343582052244, 5258.132408152612, 5263.526282634582, 5280.524752772269, 5294.523492885659, 5758.712064396764, 5763.625364351304, 5782.409837294777, 5853.795117170878, 5892.234009578728, 6213.440790328892, 6326.652034138075, 6454.160959075384, 6459.354064593503, 6528.433176037716, 1748.0, 1757.9121043948007, 1779.3861117914298, 1782.6256486137797, 1784.3308759215295, 1233.9197952133084, 1249.312877917142, 1255.428779905141, 1277.2974863824859, 1288.3830792355534, 6031.366706495843, 6070.362611925684, 6093.6343819370095, 6098.420650038239, 6164.753409863645, 6526.34736526353, 6612.23959244693, 6667.799966000931, 6715.731370745116, 6716.3955244028275, 6044.184035155197, 6047.606905551125, 6058.1215723719815, 6115.235595550556, 6180.103884936659, 3471.409860323751, 3487.302539492112, 3500.8949731508096, 3503.3518799022263, 3522.330757156132, 6793.048973143764, 6798.76204332846, 6903.378695917291, 6924.515283930177, 6958.756443524452, 6244.344343843922, 6691.5650482718465, 6797.218319893177, 6808.6255255960405, 6900.2409734929115, 6882.8623427531165, 6887.862242755117, 6893.20728116273, 6929.757458488929, 6995.440364770908, 6521.152250207632, 6562.704678289393, 6563.343665633399, 6608.570442921195, 6627.436667883284, 6411.455026322815, 6554.344565543408, 6593.571417857824, 6638.402543771083, 6672.266050734513, 6880.621565813928, 6885.173779146535, 6915.273896240822, 6941.791746247621, 6947.7220911162985, 5059.519345662156, 5104.285400043923, 5128.871778205575, 5131.076406246912, 5154.948450515447, 6451.806445806634, 6511.446527045254, 6609.603423794588, 6741.325867413219, 6769.073937116559, 6276.1799078266795, 6393.392627700547, 6412.5632259741, 6428.817735221095, 6452.22573291208, 6342.23893132827, 6399.680015999088, 6407.199100112486, 6472.676366181578, 6477.51418643613, 6423.935760642334, 6439.645819479973, 6441.774537891151, 6448.709808058555, 6462.4506916910705, 6475.7733479328, 6502.772402965874, 6523.217213934358, 6562.671866406756, 6608.140941677551, 6306.842328941813, 6313.873722525432, 6326.9683651581445, 6327.892618791601, 6365.3316401779], "value": 5117.731723083263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.3388096094653, 999.9400035997841, 1002.9398236105834, 1013.062916801958, 1015.7257540464077, 20498.180072797088, 20634.793652063476, 20867.26964556241, 21068.89465552672, 21083.789162108373, 19222.13500392482, 19436.319728809496, 19523.902380488114, 19530.414087577396, 19536.706949395735, 1046.7016900183448, 1064.79236548873, 1066.6426747039711, 1075.4837677914607, 1080.0927221134245, 1076.0960792933934, 1078.6979645699216, 1082.5615625671617, 1084.967450976472, 1085.0939465546278, 1007.450939238117, 1032.272248065116, 1134.778718149957, 1139.8005349063922, 1152.9308241505494, 1140.4525827602756, 1145.507431804328, 1145.9885401145966, 1146.455433669009, 1148.1847887999531, 798.5448294472153, 823.0411570520337, 827.5820710541199, 829.9170082991652, 830.485099238476, 20690.172393104258, 20882.58234835295, 20918.0, 20992.265270715605, 20997.160113595437, 22806.543869122524, 22983.425414364607, 23276.65085023726, 23480.178193763135, 23552.057917683273, 17444.73832892495, 17655.0, 17725.734113988172, 17799.555011124696, 17831.197596108075, 4097.323941549641, 4098.077932465201, 4119.649829764474, 4121.979390103061, 4125.855595054159, 125999.0, 150334.0, 150621.0, 151006.24496877554, 153820.23089884478, 18336.174872130785, 18580.721289180674, 18714.71927921082, 18846.81153188478, 18927.053647317578, 32446.35107297888, 32676.0, 32897.34205315928, 32981.17547061342, 33131.668683312855, 9248.075192480697, 9301.348905576544, 9310.115539023782, 9343.813123737487, 9353.064693530729, 4420.447444069491, 4494.37078808967, 4515.480719717209, 4525.864224073283, 4540.545945405433, 5745.770169193185, 5766.221560089418, 5779.0, 5821.18503409523, 5885.61743486672, 1221.1268942706008, 1236.3385588709998, 1247.3513772838255, 1249.0819247852821, 1261.0668105601972, 740.6148802622606, 758.9051368578928, 760.4296777416937, 770.6069904348823, 781.6638845296577, 12925.870741292654, 13074.738505229841, 13666.701663341966, 13950.511732089532, 13990.790138147935, 719.6761457344217, 720.9603471808996, 730.7332823519378, 744.5421066044452, 746.3805041815281, 5906.2912450505355, 5923.911141332884, 5929.525637948954, 5961.254843144607, 6077.4226448487325, 143701.0, 143951.0, 146008.0, 146487.0, 148677.0, 100065.49967250263, 102248.48875755574, 121242.39378803226, 123240.38379808223, 127480.0, 105590.0, 108829.0, 109898.45050774695, 109947.0, 111302.44348778366, 13122.671933201746, 13620.250886201355, 13626.659333516742, 14133.646658833612, 14197.0, 49558.0, 51907.0, 52734.0, 52814.47185528096, 53855.192172116665, 68980.3101968974, 69436.30563694298, 69580.30419695738, 69681.65159174171, 70236.6488167556, 20763.0, 20772.79227207769, 20826.1669533217, 21041.0, 21263.149474020865, 21261.255856044965, 21340.573188535833, 21404.57190856205, 21486.785132148478, 21495.462613434163, 18403.631927361646, 18412.079396030415, 18563.72154417712, 18661.813381866552, 18750.0, 18207.362742303954, 18390.264389424272, 18483.815161848208, 18537.16582753806, 18608.627827443644, 19307.613847722685, 19639.410817675493, 19697.507562310482, 19773.60452790965, 19816.801831982073, 14060.648483787987, 14092.718145636825, 14408.783868241775, 14419.279036048365, 14420.42318307256, 13571.253581052742, 13630.591082267549, 13642.0, 13695.86304136946, 13845.653858653212], "value": 10031.57195707503, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 106.0, 106.0, 105.0, 108.0, 106.0, 107.0, 106.0, 106.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 117.0, 115.0, 111.0, 114.0, 112.0, 113.0, 112.0, 112.0, 139.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 161.0, 168.0, 165.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 79.0, 74.0, 73.0, 74.0, 73.0, 75.0, 74.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 77.0, 78.0, 79.0, 78.0, 84.0, 79.0, 78.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 116.0, 111.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 150.0, 151.0, 150.0, 151.0, 150.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 45.0, 46.0, 46.0, 45.0, 45.0, 44.0, 43.0, 43.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 39.0, 39.0, 40.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 76.0, 70.0, 72.0, 71.0, 77.0, 70.0, 71.0, 70.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 104.0, 112.0, 107.0, 128.0, 109.0, 110.0, 106.0, 104.0], "value": 109.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 156.0, 153.0, 151.0, 156.0, 150.0, 155.0, 155.0, 157.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 60.0, 59.0, 59.0, 63.0, 60.0, 57.0, 58.0, 58.0, 60.0], "value": 60.0, "unit": "score"}]}]} 21:55:27 INFO - Return code: 0 21:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:27 INFO - # TBPL SUCCESS # 21:55:27 INFO - Running post-action listener: _package_coverage_data 21:55:27 INFO - Running post-action listener: _resource_record_post_action 21:55:27 INFO - [mozharness: 2017-09-17 04:55:27.993133Z] Finished run-tests step (success) 21:55:27 INFO - Running post-run listener: _resource_record_post_run 21:55:28 INFO - Total resource usage - Wall time: 1191s; CPU: 12.0%; Read bytes: 8953856; Write bytes: 561258496; Read time: 3664; Write time: 615400 21:55:28 INFO - TinderboxPrint: CPU usage
11.5% 21:55:28 INFO - TinderboxPrint: I/O read bytes / time
8,953,856 / 3,664 21:55:28 INFO - TinderboxPrint: I/O write bytes / time
561,258,496 / 615,400 21:55:28 INFO - TinderboxPrint: CPU idle
8,243.7 (86.8%) 21:55:28 INFO - TinderboxPrint: CPU user
1,186.5 (12.5%) 21:55:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74629120; Read time: 0; Write time: 59112 21:55:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:55:28 INFO - run-tests - Wall time: 1174s; CPU: 11.0%; Read bytes: 8953856; Write bytes: 447672320; Read time: 3664; Write time: 536560 21:55:28 INFO - Running post-run listener: _upload_blobber_files 21:55:28 INFO - Blob upload gear active. 21:55:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:28 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 21:55:28 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'] 21:55:28 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 21:55:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 21:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 21:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:29 INFO - (blobuploader) - INFO - Done attempting. 21:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 21:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 21:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:31 INFO - (blobuploader) - INFO - Done attempting. 21:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:37 INFO - (blobuploader) - INFO - Done attempting. 21:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:38 INFO - (blobuploader) - INFO - Done attempting. 21:55:38 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:38 INFO - Return code: 0 21:55:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4bb07c5237a484c59eabed45f8a211805123887e29f554293947753dd3f2bd6ba86ef2d9ba269a7bf94cd5710a1b5b8d6014c9ded2f6ecf25c07c2daad2404", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5949c3cfb6775c192013a9fedd97fdb7c1dc087e88554c04c37bdae300d54f687170b5b61fde853beeba0645200042bd3d7b1420a96452cd1af937702c6c584d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02b9f1c96757832015c4a2219731c4553437ff9a1b2e51b34dbb418cc14396c05fd08852b9898259e2c70bfcca4b2af077755559cdf2207a7cb338b660fb096b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1416d93f9fc53e1f33e744b1afc9c8ac7316f3cba4c49ff4258dad3a99adaf64850ea931e75647e7db3d0e9a5e2f851f9c08eb86a9eb4a5037d26b91fcbaf32e"} 21:55:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:38 INFO - Contents: 21:55:38 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4bb07c5237a484c59eabed45f8a211805123887e29f554293947753dd3f2bd6ba86ef2d9ba269a7bf94cd5710a1b5b8d6014c9ded2f6ecf25c07c2daad2404", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5949c3cfb6775c192013a9fedd97fdb7c1dc087e88554c04c37bdae300d54f687170b5b61fde853beeba0645200042bd3d7b1420a96452cd1af937702c6c584d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02b9f1c96757832015c4a2219731c4553437ff9a1b2e51b34dbb418cc14396c05fd08852b9898259e2c70bfcca4b2af077755559cdf2207a7cb338b660fb096b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1416d93f9fc53e1f33e744b1afc9c8ac7316f3cba4c49ff4258dad3a99adaf64850ea931e75647e7db3d0e9a5e2f851f9c08eb86a9eb4a5037d26b91fcbaf32e"} 21:55:38 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:38 INFO - Copying logs to upload dir... 21:55:38 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.897390 ========= master_lag: -0.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-16 21:55:38.585910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:38.589905) ========= 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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 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/0a4bb07c5237a484c59eabed45f8a211805123887e29f554293947753dd3f2bd6ba86ef2d9ba269a7bf94cd5710a1b5b8d6014c9ded2f6ecf25c07c2daad2404", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5949c3cfb6775c192013a9fedd97fdb7c1dc087e88554c04c37bdae300d54f687170b5b61fde853beeba0645200042bd3d7b1420a96452cd1af937702c6c584d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02b9f1c96757832015c4a2219731c4553437ff9a1b2e51b34dbb418cc14396c05fd08852b9898259e2c70bfcca4b2af077755559cdf2207a7cb338b660fb096b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1416d93f9fc53e1f33e744b1afc9c8ac7316f3cba4c49ff4258dad3a99adaf64850ea931e75647e7db3d0e9a5e2f851f9c08eb86a9eb4a5037d26b91fcbaf32e"} build_url:https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a4bb07c5237a484c59eabed45f8a211805123887e29f554293947753dd3f2bd6ba86ef2d9ba269a7bf94cd5710a1b5b8d6014c9ded2f6ecf25c07c2daad2404", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5949c3cfb6775c192013a9fedd97fdb7c1dc087e88554c04c37bdae300d54f687170b5b61fde853beeba0645200042bd3d7b1420a96452cd1af937702c6c584d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02b9f1c96757832015c4a2219731c4553437ff9a1b2e51b34dbb418cc14396c05fd08852b9898259e2c70bfcca4b2af077755559cdf2207a7cb338b660fb096b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1416d93f9fc53e1f33e744b1afc9c8ac7316f3cba4c49ff4258dad3a99adaf64850ea931e75647e7db3d0e9a5e2f851f9c08eb86a9eb4a5037d26b91fcbaf32e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:38.621491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:38.621876) ========= 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=52faae308a556c440401f8e5000001e8-1505622210.345626-785723519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:38.707597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:55:38.708072) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:55:38.708841) ========= ========= Total master_lag: -0.33 =========