builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-065 starttime: 1505760691.53 results: success (0) revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.528273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.528706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.529017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.559689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.560015) ========= 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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 11:51:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.6M=0s 2017-09-18 11:51:31 (85.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.668401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.668943) ========= 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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.724135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:31.724712) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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 42151fcd6cfc216d147730d0f2c6a2acd52d22fd --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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 11:51:31,778 truncating revision to first 12 chars 2017-09-18 11:51:31,778 Setting DEBUG logging. 2017-09-18 11:51:31,779 attempt 1/10 2017-09-18 11:51:31,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42151fcd6cfc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 11:51:32,056 unpacking tar archive at: mozilla-central-42151fcd6cfc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562309 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:32.306905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:32.307227) ========= script_repo_revision: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:32.307611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:32.307876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 11:51:32.321528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-18 11:51:32.321959) ========= /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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:51:32 INFO - MultiFileLogger online at 20170918 11:51:32 in /builds/slave/test 11:51:32 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 11:51:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:51:32 INFO - {'append_to_log': False, 11:51:32 INFO - 'base_work_dir': '/builds/slave/test', 11:51:32 INFO - 'blob_upload_branch': 'Firefox', 11:51:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:51:32 INFO - 'branch': 'Firefox', 11:51:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:51:32 INFO - 'code_coverage': False, 11:51:32 INFO - 'config_files': ('talos/linux_config.py',), 11:51:32 INFO - 'default_actions': ('clobber', 11:51:32 INFO - 'read-buildbot-config', 11:51:32 INFO - 'download-and-extract', 11:51:32 INFO - 'populate-webroot', 11:51:32 INFO - 'create-virtualenv', 11:51:32 INFO - 'install', 11:51:32 INFO - 'setup-mitmproxy', 11:51:32 INFO - 'run-tests'), 11:51:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:51:32 INFO - 'disable_ccov_upload': False, 11:51:32 INFO - 'disable_stylo': False, 11:51:32 INFO - 'download_minidump_stackwalk': True, 11:51:32 INFO - 'download_symbols': 'ondemand', 11:51:32 INFO - 'enable_stylo': False, 11:51:32 INFO - 'enable_webrender': False, 11:51:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:51:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:51:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:51:32 INFO - 'gecko_profile': False, 11:51:32 INFO - 'gecko_profile_interval': 0, 11:51:32 INFO - 'installer_path': 'installer.exe', 11:51:32 INFO - 'log_level': 'info', 11:51:32 INFO - 'log_name': 'talos', 11:51:32 INFO - 'log_to_console': True, 11:51:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:51:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:51:32 INFO - 'opt_config_files': (), 11:51:32 INFO - 'pip_index': False, 11:51:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:51:32 INFO - 'system_bits': '32', 11:51:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:51:32 INFO - 'title': 'talos-linux64-ix-065', 11:51:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:51:32 INFO - 'use_talos_json': True, 11:51:32 INFO - 'verify': 'False', 11:51:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:51:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:51:32 INFO - 'work_dir': 'build'} 11:51:32 INFO - [mozharness: 2017-09-18 18:51:32.516193Z] Running clobber step. 11:51:32 INFO - Running pre-action listener: _resource_record_pre_action 11:51:32 INFO - Running main action method: clobber 11:51:32 INFO - rmtree: /builds/slave/test/build 11:51:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:51:33 INFO - Running post-action listener: _resource_record_post_action 11:51:33 INFO - [mozharness: 2017-09-18 18:51:33.527432Z] Finished clobber step (success) 11:51:33 INFO - [mozharness: 2017-09-18 18:51:33.527530Z] Running read-buildbot-config step. 11:51:33 INFO - Running pre-action listener: _resource_record_pre_action 11:51:33 INFO - Running main action method: read_buildbot_config 11:51:33 INFO - Using buildbot properties: 11:51:33 INFO - { 11:51:33 INFO - "project": "", 11:51:33 INFO - "product": "firefox", 11:51:33 INFO - "who": "ffxbld@noreply.mozilla.org", 11:51:33 INFO - "installer_path": "public/build/target.tar.bz2", 11:51:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:51:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:51:33 INFO - "stage_platform": "linux64-pgo", 11:51:33 INFO - "basedir": "/builds/slave/test", 11:51:33 INFO - "buildnumber": 28, 11:51:33 INFO - "platform": "ubuntu64_hw", 11:51:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:51:33 INFO - "slavebuilddir": "test", 11:51:33 INFO - "taskId": "VyL2iM5_Ti2gB6ZL3-RZjg", 11:51:33 INFO - "branch": "mozilla-central", 11:51:33 INFO - "script_repo_revision": "production", 11:51:33 INFO - "revision": "42151fcd6cfc216d147730d0f2c6a2acd52d22fd", 11:51:33 INFO - "slavename": "talos-linux64-ix-065", 11:51:33 INFO - "repo_path": "mozilla-central" 11:51:33 INFO - } 11:51:33 INFO - Finding installer, test and symbols from parent task. 11:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VyL2iM5_Ti2gB6ZL3-RZjg'}, attempt #1 11:51:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VyL2iM5_Ti2gB6ZL3-RZjg'}, attempt #1 11:51:34 INFO - Task dependencies: SCsIEorPRfqct5c1S2alwA 11:51:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA'}, attempt #1 11:51:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json 11:51:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip 11:51:34 INFO - Running post-action listener: _resource_record_post_action 11:51:34 INFO - [mozharness: 2017-09-18 18:51:34.947863Z] Finished read-buildbot-config step (success) 11:51:34 INFO - [mozharness: 2017-09-18 18:51:34.948079Z] Running download-and-extract step. 11:51:34 INFO - Running pre-action listener: _resource_record_pre_action 11:51:34 INFO - Running main action method: download_and_extract 11:51:34 INFO - mkdir: /builds/slave/test/build/tests 11:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:34 INFO - trying https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json 11:51:34 INFO - Downloading https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:51:35 INFO - Downloaded 989 bytes. 11:51:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:51:35 INFO - Using the following test package requirements: 11:51:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:51:35 INFO - u'common': [u'target.common.tests.zip'], 11:51:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:51:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:51:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:51:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:51:35 INFO - u'mozbase': [u'target.common.tests.zip'], 11:51:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:51:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:51:35 INFO - u'web-platform': [u'target.common.tests.zip', 11:51:35 INFO - u'target.web-platform.tests.tar.gz'], 11:51:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:51:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:51:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip 11:51:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:51:35 INFO - Fetch https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.common.tests.zip into memory 11:51:36 INFO - Content-Length response header: 55323859 11:51:36 INFO - Bytes received: 55323859 11:51:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip 11:51:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:51:47 INFO - Fetch https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.talos.tests.zip into memory 11:51:48 INFO - Content-Length response header: 14508748 11:51:48 INFO - Bytes received: 14508748 11:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:48 INFO - trying https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:51:49 INFO - Downloaded 62162901 bytes. 11:51:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:49 INFO - mkdir: /builds/slave/test/properties 11:51:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:49 INFO - Contents: 11:51:49 INFO - build_url:https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 11:51:49 INFO - Running post-action listener: _resource_record_post_action 11:51:49 INFO - Running post-action listener: find_tests_for_verification 11:51:49 INFO - Running post-action listener: set_extra_try_arguments 11:51:49 INFO - [mozharness: 2017-09-18 18:51:49.500245Z] Finished download-and-extract step (success) 11:51:49 INFO - [mozharness: 2017-09-18 18:51:49.500342Z] Running populate-webroot step. 11:51:49 INFO - Running pre-action listener: _resource_record_pre_action 11:51:49 INFO - Running main action method: populate_webroot 11:51:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:51:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['tresize', 11:51:49 INFO - 'tcanvasmark']}, 11:51:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:51:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['dromaeo_css', 11:51:49 INFO - 'kraken']}, 11:51:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'tests': ['damp', 'tps']}, 11:51:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['damp', 'tps']}, 11:51:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['dromaeo_dom']}, 11:51:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:51:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['basic_compositor_video', 11:51:49 INFO - 'glvideo']}, 11:51:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:51:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['ts_paint_webext', 11:51:49 INFO - 'tp5o_webext']}, 11:51:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:51:49 INFO - 'ts_paint', 11:51:49 INFO - 'tpaint', 11:51:49 INFO - 'sessionrestore', 11:51:49 INFO - 'sessionrestore_many_windows', 11:51:49 INFO - 'sessionrestore_no_auto_restore', 11:51:49 INFO - 'tabpaint']}, 11:51:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['a11yr', 11:51:49 INFO - 'ts_paint', 11:51:49 INFO - 'tpaint', 11:51:49 INFO - 'sessionrestore', 11:51:49 INFO - 'sessionrestore_many_windows', 11:51:49 INFO - 'sessionrestore_no_auto_restore', 11:51:49 INFO - 'tabpaint']}, 11:51:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:51:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:51:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['perf_reftest_singletons']}, 11:51:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['bloom_basic']}, 11:51:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:51:49 INFO - 'tsvgr_opacity', 11:51:49 INFO - 'tart', 11:51:49 INFO - 'tscrollx', 11:51:49 INFO - 'tsvg_static']}, 11:51:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['tsvgx', 11:51:49 INFO - 'tsvgr_opacity', 11:51:49 INFO - 'tart', 11:51:49 INFO - 'tscrollx', 11:51:49 INFO - 'tsvg_static']}, 11:51:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:51:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo'], 11:51:49 INFO - 'tests': ['tp5o']}, 11:51:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:49 INFO - 'talos_options': ['--mitmproxy', 11:51:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:49 INFO - '--firstNonBlankPaint'], 11:51:49 INFO - 'tests': ['tp6_google', 11:51:49 INFO - 'tp6_youtube', 11:51:49 INFO - 'tp6_amazon', 11:51:49 INFO - 'tp6_facebook']}, 11:51:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo', 11:51:49 INFO - '--mitmproxy', 11:51:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:49 INFO - '--firstNonBlankPaint'], 11:51:49 INFO - 'tests': ['tp6_google', 11:51:49 INFO - 'tp6_youtube', 11:51:49 INFO - 'tp6_amazon', 11:51:49 INFO - 'tp6_facebook']}, 11:51:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:51:49 INFO - 'talos_options': ['--stylo-threads=1', 11:51:49 INFO - '--mitmproxy', 11:51:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:51:49 INFO - '--firstNonBlankPaint'], 11:51:49 INFO - 'tests': ['tp6_google', 11:51:49 INFO - 'tp6_youtube', 11:51:49 INFO - 'tp6_amazon', 11:51:49 INFO - 'tp6_facebook']}, 11:51:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--xperf_path', 11:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:49 INFO - 'tests': ['tp5n']}, 11:51:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:51:49 INFO - 'talos_options': ['--disable-stylo', 11:51:49 INFO - '--xperf_path', 11:51:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:49 INFO - 'tests': ['tp5n']}}} 11:51:49 INFO - Running post-action listener: _resource_record_post_action 11:51:49 INFO - [mozharness: 2017-09-18 18:51:49.515244Z] Finished populate-webroot step (success) 11:51:49 INFO - [mozharness: 2017-09-18 18:51:49.515365Z] Running create-virtualenv step. 11:51:49 INFO - Running pre-action listener: _resource_record_pre_action 11:51:49 INFO - Running main action method: create_virtualenv 11:51:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:51:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:51:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:51:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:51:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:51:50 INFO - Installing pip...............done. 11:51:50 INFO - Return code: 0 11:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:51:50 INFO - Reading from file tmpfile_stdout 11:51:50 INFO - Output received: 11:51:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:51:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:51:50 INFO - Using env: {'DISPLAY': ':0', 11:51:50 INFO - 'HOME': '/home/cltbld', 11:51:50 INFO - 'LANG': 'en_US.UTF-8', 11:51:50 INFO - 'LANGUAGE': 'en_US:en', 11:51:50 INFO - 'LOGNAME': 'cltbld', 11:51:50 INFO - 'MAIL': '/var/mail/cltbld', 11:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:50 INFO - 'MOZ_NO_REMOTE': '1', 11:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:50 INFO - 'NO_EM_RESTART': '1', 11:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:50 INFO - 'PWD': '/builds/slave/test', 11:51:50 INFO - 'SHELL': '/bin/bash', 11:51:50 INFO - 'SHLVL': '1', 11:51:50 INFO - 'TERM': 'linux', 11:51:50 INFO - 'TMOUT': '86400', 11:51:50 INFO - 'USER': 'cltbld', 11:51:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:50 INFO - '_': '/tools/buildbot/bin/python'} 11:51:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:51:51 INFO - Downloading/unpacking pip>=1.5 11:51:51 INFO - Running setup.py egg_info for package pip 11:51:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:51:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:51:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:51:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:51:51 INFO - Installing collected packages: pip 11:51:51 INFO - Found existing installation: pip 1.1 11:51:51 INFO - Uninstalling pip: 11:51:51 INFO - Successfully uninstalled pip 11:51:51 INFO - Running setup.py install for pip 11:51:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:51:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:51:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:51:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:51:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:51:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:51:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:51:51 INFO - Successfully installed pip 11:51:51 INFO - Cleaning up... 11:51:51 INFO - Return code: 0 11:51:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:51:51 INFO - Using env: {'DISPLAY': ':0', 11:51:51 INFO - 'HOME': '/home/cltbld', 11:51:51 INFO - 'LANG': 'en_US.UTF-8', 11:51:51 INFO - 'LANGUAGE': 'en_US:en', 11:51:51 INFO - 'LOGNAME': 'cltbld', 11:51:51 INFO - 'MAIL': '/var/mail/cltbld', 11:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:51 INFO - 'MOZ_NO_REMOTE': '1', 11:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:51 INFO - 'NO_EM_RESTART': '1', 11:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:51 INFO - 'PWD': '/builds/slave/test', 11:51:51 INFO - 'SHELL': '/bin/bash', 11:51:51 INFO - 'SHLVL': '1', 11:51:51 INFO - 'TERM': 'linux', 11:51:51 INFO - 'TMOUT': '86400', 11:51:51 INFO - 'USER': 'cltbld', 11:51:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:51 INFO - '_': '/tools/buildbot/bin/python'} 11:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:51 INFO - Downloading/unpacking psutil>=3.1.1 11:51:51 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 11:51:51 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 11:51:51 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 11:51:51 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 11:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:53 INFO - Installing collected packages: psutil 11:51:53 INFO - Running setup.py install for psutil 11:51:53 INFO - building 'psutil._psutil_linux' extension 11:51:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:51:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:51:53 INFO - building 'psutil._psutil_posix' extension 11:51:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:51:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:51:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:51:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:51:53 INFO - Successfully installed psutil 11:51:53 INFO - Cleaning up... 11:51:53 INFO - Return code: 0 11:51:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:51:53 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')]} 11:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:53 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')]} 11:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:53 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 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:53 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 11:51:53 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 11:51:53 INFO - Using env: {'DISPLAY': ':0', 11:51:53 INFO - 'HOME': '/home/cltbld', 11:51:53 INFO - 'LANG': 'en_US.UTF-8', 11:51:53 INFO - 'LANGUAGE': 'en_US:en', 11:51:53 INFO - 'LOGNAME': 'cltbld', 11:51:53 INFO - 'MAIL': '/var/mail/cltbld', 11:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:53 INFO - 'MOZ_NO_REMOTE': '1', 11:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:53 INFO - 'NO_EM_RESTART': '1', 11:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:53 INFO - 'PWD': '/builds/slave/test', 11:51:53 INFO - 'SHELL': '/bin/bash', 11:51:53 INFO - 'SHLVL': '1', 11:51:53 INFO - 'TERM': 'linux', 11:51:53 INFO - 'TMOUT': '86400', 11:51:53 INFO - 'USER': 'cltbld', 11:51:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:53 INFO - '_': '/tools/buildbot/bin/python'} 11:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:51:53 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 11:51:53 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 11:51:53 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 11:51:53 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 11:51:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:51:55 INFO - Installing collected packages: mozsystemmonitor 11:51:55 INFO - Running setup.py install for mozsystemmonitor 11:51:55 INFO - Successfully installed mozsystemmonitor 11:51:55 INFO - Cleaning up... 11:51:55 INFO - Return code: 0 11:51:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:51:55 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')]} 11:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:55 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')]} 11:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:55 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 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:55 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 11:51:55 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 11:51:55 INFO - Using env: {'DISPLAY': ':0', 11:51:55 INFO - 'HOME': '/home/cltbld', 11:51:55 INFO - 'LANG': 'en_US.UTF-8', 11:51:55 INFO - 'LANGUAGE': 'en_US:en', 11:51:55 INFO - 'LOGNAME': 'cltbld', 11:51:55 INFO - 'MAIL': '/var/mail/cltbld', 11:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:55 INFO - 'MOZ_NO_REMOTE': '1', 11:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:55 INFO - 'NO_EM_RESTART': '1', 11:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:55 INFO - 'PWD': '/builds/slave/test', 11:51:55 INFO - 'SHELL': '/bin/bash', 11:51:55 INFO - 'SHLVL': '1', 11:51:55 INFO - 'TERM': 'linux', 11:51:55 INFO - 'TMOUT': '86400', 11:51:55 INFO - 'USER': 'cltbld', 11:51:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:55 INFO - '_': '/tools/buildbot/bin/python'} 11:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:57 INFO - warning: no files found matching '*.txt' 11:51:57 INFO - no previously-included directories found matching 'build' 11:51:57 INFO - no previously-included directories found matching 'dist' 11:51:57 INFO - no previously-included directories found matching '.git*' 11:51:57 INFO - Installing collected packages: jsonschema, functools32 11:51:58 INFO - Running setup.py install for functools32 11:51:58 INFO - warning: no files found matching '*.txt' 11:51:58 INFO - no previously-included directories found matching 'build' 11:51:58 INFO - no previously-included directories found matching 'dist' 11:51:58 INFO - no previously-included directories found matching '.git*' 11:51:59 INFO - Successfully installed jsonschema functools32 11:51:59 INFO - Cleaning up... 11:51:59 INFO - Return code: 0 11:51:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:51:59 INFO - Using env: {'DISPLAY': ':0', 11:51:59 INFO - 'HOME': '/home/cltbld', 11:51:59 INFO - 'LANG': 'en_US.UTF-8', 11:51:59 INFO - 'LANGUAGE': 'en_US:en', 11:51:59 INFO - 'LOGNAME': 'cltbld', 11:51:59 INFO - 'MAIL': '/var/mail/cltbld', 11:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:59 INFO - 'MOZ_NO_REMOTE': '1', 11:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:59 INFO - 'NO_EM_RESTART': '1', 11:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:59 INFO - 'PWD': '/builds/slave/test', 11:51:59 INFO - 'SHELL': '/bin/bash', 11:51:59 INFO - 'SHLVL': '1', 11:51:59 INFO - 'TERM': 'linux', 11:51:59 INFO - 'TMOUT': '86400', 11:51:59 INFO - 'USER': 'cltbld', 11:51:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:59 INFO - '_': '/tools/buildbot/bin/python'} 11:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:51:59 INFO - Cleaning up... 11:51:59 INFO - Return code: 0 11:51:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:51:59 INFO - Using env: {'DISPLAY': ':0', 11:51:59 INFO - 'HOME': '/home/cltbld', 11:51:59 INFO - 'LANG': 'en_US.UTF-8', 11:51:59 INFO - 'LANGUAGE': 'en_US:en', 11:51:59 INFO - 'LOGNAME': 'cltbld', 11:51:59 INFO - 'MAIL': '/var/mail/cltbld', 11:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:59 INFO - 'MOZ_NO_REMOTE': '1', 11:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:59 INFO - 'NO_EM_RESTART': '1', 11:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:59 INFO - 'PWD': '/builds/slave/test', 11:51:59 INFO - 'SHELL': '/bin/bash', 11:51:59 INFO - 'SHLVL': '1', 11:51:59 INFO - 'TERM': 'linux', 11:51:59 INFO - 'TMOUT': '86400', 11:51:59 INFO - 'USER': 'cltbld', 11:51:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:59 INFO - '_': '/tools/buildbot/bin/python'} 11:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:52:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:01 INFO - Downloading docopt-0.6.1.tar.gz 11:52:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:52:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:52:01 INFO - Running setup.py install for blobuploader 11:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:52:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:52:01 INFO - Running setup.py install for requests 11:52:01 INFO - Running setup.py install for docopt 11:52:01 INFO - Successfully installed blobuploader requests docopt 11:52:01 INFO - Cleaning up... 11:52:01 INFO - Return code: 0 11:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:52:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:52:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:52:01 INFO - Using env: {'DISPLAY': ':0', 11:52:01 INFO - 'HOME': '/home/cltbld', 11:52:01 INFO - 'LANG': 'en_US.UTF-8', 11:52:01 INFO - 'LANGUAGE': 'en_US:en', 11:52:01 INFO - 'LOGNAME': 'cltbld', 11:52:01 INFO - 'MAIL': '/var/mail/cltbld', 11:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:01 INFO - 'MOZ_NO_REMOTE': '1', 11:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:01 INFO - 'NO_EM_RESTART': '1', 11:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:01 INFO - 'PWD': '/builds/slave/test', 11:52:01 INFO - 'SHELL': '/bin/bash', 11:52:01 INFO - 'SHLVL': '1', 11:52:01 INFO - 'TERM': 'linux', 11:52:01 INFO - 'TMOUT': '86400', 11:52:01 INFO - 'USER': 'cltbld', 11:52:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:01 INFO - '_': '/tools/buildbot/bin/python'} 11:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:02 INFO - Running setup.py (path:/tmp/pip-Q4XFJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:02 INFO - Running setup.py (path:/tmp/pip-j9Wv8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:02 INFO - Running setup.py (path:/tmp/pip-IdbmJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:02 INFO - Running setup.py (path:/tmp/pip-MPlKF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:02 INFO - Running setup.py (path:/tmp/pip-fwuGjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:02 INFO - Running setup.py (path:/tmp/pip-kouEc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:02 INFO - Running setup.py (path:/tmp/pip-eQLHV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:02 INFO - Running setup.py (path:/tmp/pip-7QIPPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:02 INFO - Running setup.py (path:/tmp/pip-Rk4d_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:02 INFO - Running setup.py (path:/tmp/pip-K9OgAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:02 INFO - Running setup.py (path:/tmp/pip-ZfEvIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:02 INFO - Running setup.py (path:/tmp/pip-kBCDZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:02 INFO - Running setup.py (path:/tmp/pip-kr_81r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:02 INFO - Running setup.py (path:/tmp/pip-0iUXqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:02 INFO - Running setup.py (path:/tmp/pip-ylVTlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:03 INFO - Running setup.py (path:/tmp/pip-BngpNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:03 INFO - Running setup.py (path:/tmp/pip-a3tMJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:52:03 INFO - Running setup.py install for manifestparser 11:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozcrash 11:52:03 INFO - Running setup.py install for mozdebug 11:52:03 INFO - Running setup.py install for mozdevice 11:52:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozfile 11:52:03 INFO - Running setup.py install for mozhttpd 11:52:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozinfo 11:52:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozInstall 11:52:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:52:03 INFO - Running setup.py install for mozleak 11:52:04 INFO - Running setup.py install for mozlog 11:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Running setup.py install for moznetwork 11:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Running setup.py install for mozprocess 11:52:04 INFO - Running setup.py install for mozprofile 11:52:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Running setup.py install for mozrunner 11:52:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Running setup.py install for mozscreenshot 11:52:04 INFO - Running setup.py install for moztest 11:52:04 INFO - Running setup.py install for mozversion 11:52:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:52:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:52:04 INFO - Cleaning up... 11:52:04 INFO - Return code: 0 11:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:52:04 INFO - Using env: {'DISPLAY': ':0', 11:52:04 INFO - 'HOME': '/home/cltbld', 11:52:04 INFO - 'LANG': 'en_US.UTF-8', 11:52:04 INFO - 'LANGUAGE': 'en_US:en', 11:52:04 INFO - 'LOGNAME': 'cltbld', 11:52:04 INFO - 'MAIL': '/var/mail/cltbld', 11:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:04 INFO - 'MOZ_NO_REMOTE': '1', 11:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:04 INFO - 'NO_EM_RESTART': '1', 11:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:04 INFO - 'PWD': '/builds/slave/test', 11:52:04 INFO - 'SHELL': '/bin/bash', 11:52:04 INFO - 'SHLVL': '1', 11:52:04 INFO - 'TERM': 'linux', 11:52:04 INFO - 'TMOUT': '86400', 11:52:04 INFO - 'USER': 'cltbld', 11:52:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:04 INFO - '_': '/tools/buildbot/bin/python'} 11:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:05 INFO - Running setup.py (path:/tmp/pip-qgRvh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:05 INFO - Running setup.py (path:/tmp/pip-3zqlvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:05 INFO - Running setup.py (path:/tmp/pip-ogBr1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:05 INFO - Running setup.py (path:/tmp/pip-jsnkCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:05 INFO - Running setup.py (path:/tmp/pip-EbMpzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:05 INFO - Running setup.py (path:/tmp/pip-iHNrAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:05 INFO - Running setup.py (path:/tmp/pip-JTVZk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:05 INFO - Running setup.py (path:/tmp/pip-lWr6xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:05 INFO - Running setup.py (path:/tmp/pip-8N6NNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:05 INFO - Running setup.py (path:/tmp/pip-gTJyle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:05 INFO - Running setup.py (path:/tmp/pip-dr5sBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:06 INFO - Running setup.py (path:/tmp/pip-6MSUuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:06 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)) 11:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:06 INFO - Running setup.py (path:/tmp/pip-n1PZ9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:06 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)) 11:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:06 INFO - Running setup.py (path:/tmp/pip-43dYfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:06 INFO - Running setup.py (path:/tmp/pip-kgtyok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:06 INFO - Running setup.py (path:/tmp/pip-RX2pBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:06 INFO - Running setup.py (path:/tmp/pip-3WC203-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:07 INFO - Downloading blessings-1.6.tar.gz 11:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:52:07 INFO - Installing collected packages: blessings 11:52:07 INFO - Running setup.py install for blessings 11:52:07 INFO - Successfully installed blessings 11:52:07 INFO - Cleaning up... 11:52:07 INFO - Return code: 0 11:52:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:07 INFO - Reading from file tmpfile_stdout 11:52:07 INFO - Current package versions: 11:52:07 INFO - argparse == 1.2.1 11:52:07 INFO - blessings == 1.6 11:52:07 INFO - blobuploader == 1.2.4 11:52:07 INFO - docopt == 0.6.1 11:52:07 INFO - functools32 == 3.2.3-2 11:52:07 INFO - jsonschema == 2.5.1 11:52:07 INFO - manifestparser == 1.1 11:52:07 INFO - mozInstall == 1.13 11:52:07 INFO - mozcrash == 1.0 11:52:07 INFO - mozdebug == 0.1 11:52:07 INFO - mozdevice == 0.51 11:52:07 INFO - mozfile == 1.2 11:52:07 INFO - mozhttpd == 0.7 11:52:07 INFO - mozinfo == 0.10 11:52:07 INFO - mozleak == 0.1 11:52:07 INFO - mozlog == 3.5 11:52:07 INFO - moznetwork == 0.27 11:52:07 INFO - mozprocess == 0.25 11:52:07 INFO - mozprofile == 0.28 11:52:07 INFO - mozrunner == 6.13 11:52:07 INFO - mozscreenshot == 0.1 11:52:07 INFO - mozsystemmonitor == 0.3 11:52:07 INFO - moztest == 0.8 11:52:07 INFO - mozversion == 1.4 11:52:07 INFO - psutil == 3.1.1 11:52:07 INFO - requests == 1.2.3 11:52:07 INFO - wsgiref == 0.1.2 11:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:08 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 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:52:08 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 11:52:08 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 11:52:08 INFO - Using env: {'DISPLAY': ':0', 11:52:08 INFO - 'HOME': '/home/cltbld', 11:52:08 INFO - 'LANG': 'en_US.UTF-8', 11:52:08 INFO - 'LANGUAGE': 'en_US:en', 11:52:08 INFO - 'LOGNAME': 'cltbld', 11:52:08 INFO - 'MAIL': '/var/mail/cltbld', 11:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:08 INFO - 'MOZ_NO_REMOTE': '1', 11:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:08 INFO - 'NO_EM_RESTART': '1', 11:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:08 INFO - 'PWD': '/builds/slave/test', 11:52:08 INFO - 'SHELL': '/bin/bash', 11:52:08 INFO - 'SHLVL': '1', 11:52:08 INFO - 'TERM': 'linux', 11:52:08 INFO - 'TMOUT': '86400', 11:52:08 INFO - 'USER': 'cltbld', 11:52:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:08 INFO - '_': '/tools/buildbot/bin/python'} 11:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:52:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:52:09 INFO - Installing collected packages: simplejson 11:52:09 INFO - Running setup.py install for simplejson 11:52:09 INFO - building 'simplejson._speedups' extension 11:52:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:52:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:52:10 INFO - Successfully installed simplejson 11:52:10 INFO - Cleaning up... 11:52:10 INFO - Return code: 0 11:52:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd891f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf52a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, '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': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', '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 11:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:52:10 INFO - Using env: {'DISPLAY': ':0', 11:52:10 INFO - 'HOME': '/home/cltbld', 11:52:10 INFO - 'LANG': 'en_US.UTF-8', 11:52:10 INFO - 'LANGUAGE': 'en_US:en', 11:52:10 INFO - 'LOGNAME': 'cltbld', 11:52:10 INFO - 'MAIL': '/var/mail/cltbld', 11:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:10 INFO - 'MOZ_NO_REMOTE': '1', 11:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:10 INFO - 'NO_EM_RESTART': '1', 11:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:10 INFO - 'PWD': '/builds/slave/test', 11:52:10 INFO - 'SHELL': '/bin/bash', 11:52:10 INFO - 'SHLVL': '1', 11:52:10 INFO - 'TERM': 'linux', 11:52:10 INFO - 'TMOUT': '86400', 11:52:10 INFO - 'USER': 'cltbld', 11:52:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:10 INFO - '_': '/tools/buildbot/bin/python'} 11:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:52:10 INFO - Cleaning up... 11:52:10 INFO - Return code: 0 11:52:10 INFO - Running post-action listener: _resource_record_post_action 11:52:10 INFO - Running post-action listener: _start_resource_monitoring 11:52:10 INFO - Starting resource monitoring. 11:52:10 INFO - [mozharness: 2017-09-18 18:52:10.699935Z] Finished create-virtualenv step (success) 11:52:10 INFO - [mozharness: 2017-09-18 18:52:10.700401Z] Running install step. 11:52:10 INFO - Running pre-action listener: _resource_record_pre_action 11:52:10 INFO - Running main action method: install 11:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:10 INFO - Reading from file tmpfile_stdout 11:52:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:52:11 INFO - Reading from file tmpfile_stdout 11:52:11 INFO - Output received: 11:52:11 INFO - Usage: mozinstall [options] installer 11:52:11 INFO - Options: 11:52:11 INFO - -h, --help show this help message and exit 11:52:11 INFO - -d DEST, --destination=DEST 11:52:11 INFO - Directory to install application into. [default: 11:52:11 INFO - "/builds/slave/test"] 11:52:11 INFO - --app=APP Application being installed. [default: firefox] 11:52:11 INFO - mkdir: /builds/slave/test/build/application 11:52:11 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'] 11:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:52:28 INFO - Reading from file tmpfile_stdout 11:52:28 INFO - Output received: 11:52:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:52:28 INFO - Running post-action listener: _resource_record_post_action 11:52:28 INFO - [mozharness: 2017-09-18 18:52:28.632912Z] Finished install step (success) 11:52:28 INFO - [mozharness: 2017-09-18 18:52:28.633164Z] Running setup-mitmproxy step. 11:52:28 INFO - Running pre-action listener: _resource_record_pre_action 11:52:28 INFO - Running main action method: setup_mitmproxy 11:52:28 INFO - Skipping: mitmproxy is not required 11:52:28 INFO - Running post-action listener: _resource_record_post_action 11:52:28 INFO - [mozharness: 2017-09-18 18:52:28.634297Z] Finished setup-mitmproxy step (success) 11:52:28 INFO - [mozharness: 2017-09-18 18:52:28.634517Z] Running run-tests step. 11:52:28 INFO - Running pre-action listener: _resource_record_pre_action 11:52:28 INFO - Running pre-action listener: _set_gcov_prefix 11:52:28 INFO - Running main action method: run_tests 11:52:28 WARNING - Try message not found. 11:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:28 INFO - Python 2.7.3 11:52:28 INFO - Return code: 0 11:52:28 INFO - grabbing minidump binary from tooltool 11:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9090>, '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 0x10f9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:52:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:52:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:52:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:28 INFO - Return code: 0 11:52:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:52:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:28 INFO - ENV: RUST_BACKTRACE is now full 11:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 11:52:28 INFO - Using env: {'DISPLAY': ':0', 11:52:28 INFO - 'HOME': '/home/cltbld', 11:52:28 INFO - 'LANG': 'en_US.UTF-8', 11:52:28 INFO - 'LANGUAGE': 'en_US:en', 11:52:28 INFO - 'LOGNAME': 'cltbld', 11:52:28 INFO - 'MAIL': '/var/mail/cltbld', 11:52:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:28 INFO - 'MOZ_NO_REMOTE': '1', 11:52:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:28 INFO - 'NO_EM_RESTART': '1', 11:52:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:28 INFO - 'PWD': '/builds/slave/test', 11:52:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:28 INFO - 'RUST_BACKTRACE': 'full', 11:52:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:28 INFO - 'SHELL': '/bin/bash', 11:52:28 INFO - 'SHLVL': '1', 11:52:28 INFO - 'TERM': 'linux', 11:52:28 INFO - 'TMOUT': '86400', 11:52:28 INFO - 'USER': 'cltbld', 11:52:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:28 INFO - '_': '/tools/buildbot/bin/python'} 11:52:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 11:52:28 INFO - mozversion application_buildid: 20170918173522 11:52:28 INFO - mozversion application_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:52:28 INFO - mozversion application_display_name: Nightly 11:52:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:29 INFO - mozversion application_name: Firefox 11:52:29 INFO - mozversion application_remotingname: firefox 11:52:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:52:29 INFO - mozversion application_vendor: Mozilla 11:52:29 INFO - mozversion application_version: 57.0a1 11:52:29 INFO - mozversion platform_buildid: 20170918173522 11:52:29 INFO - mozversion platform_changeset: 42151fcd6cfc216d147730d0f2c6a2acd52d22fd 11:52:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:52:29 INFO - mozversion platform_version: 57.0a1 11:52:29 INFO - using testdate: 1505760748 11:52:29 INFO - actual date: 1505760748 11:52:29 INFO - starting webserver on 'localhost:45856' 11:52:29 INFO - SUITE-START | Running 2 tests 11:52:29 INFO - TEST-START | dromaeo_css 11:52:29 INFO - Initialising browser for dromaeo_css test... 11:52:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45856/getInfo.html -profile /tmp/tmpkyVGiu/profile 11:52:29 INFO - TEST-INFO | started process 26267 (/builds/slave/test/build/application/firefox/firefox http://localhost:45856/getInfo.html) 11:52:33 INFO - TEST-INFO | 26267: exit 0 11:52:33 INFO - Browser initialized. 11:52:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:52:33 INFO - Using env: {'DISPLAY': ':0', 11:52:33 INFO - 'HOME': '/home/cltbld', 11:52:33 INFO - 'JSGC_DISABLE_POISONING': '1', 11:52:33 INFO - 'LANG': 'en_US.UTF-8', 11:52:33 INFO - 'LANGUAGE': 'en_US:en', 11:52:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:52:33 INFO - 'LOGNAME': 'cltbld', 11:52:33 INFO - 'MAIL': '/var/mail/cltbld', 11:52:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:33 INFO - 'MOZ_CRASHREPORTER': '1', 11:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:52:33 INFO - 'MOZ_NO_REMOTE': '1', 11:52:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:33 INFO - 'NO_EM_RESTART': '1', 11:52:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:33 INFO - 'PWD': '/builds/slave/test', 11:52:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:33 INFO - 'RUST_BACKTRACE': 'full', 11:52:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:33 INFO - 'SHELL': '/bin/bash', 11:52:33 INFO - 'SHLVL': '1', 11:52:33 INFO - 'STYLO_FORCE_DISABLED': '1', 11:52:33 INFO - 'TERM': 'linux', 11:52:33 INFO - 'TMOUT': '86400', 11:52:33 INFO - 'USER': 'cltbld', 11:52:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 11:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:33 INFO - '_': '/tools/buildbot/bin/python'} 11:52:33 INFO - TEST-INFO | started process 26503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkyVGiu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:34 INFO - PID 26503 | 11:52:34 INFO - PID 26503 | (/builds/slave/test/build/application/firefox/firefox:26552): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:52:34 INFO - PID 26503 | 11:52:45 INFO - PID 26503 | RSS: Main: 147902464 11:52:45 INFO - PID 26503 | 11:55:42 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45856/tests/dromaeo/cssquery-ext.html) 11:55:43 INFO - PID 26503 | RSS: Main: 148230144 11:55:43 INFO - PID 26503 | 11:58:45 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-ext.html (next: http://localhost:45856/tests/dromaeo/cssquery-jquery.html) 11:58:45 INFO - PID 26503 | RSS: Main: 147759104 11:58:45 INFO - PID 26503 | 12:01:47 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45856/tests/dromaeo/cssquery-mootools.html) 12:01:47 INFO - PID 26503 | RSS: Main: 150188032 12:01:47 INFO - PID 26503 | 12:04:49 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45856/tests/dromaeo/cssquery-prototype.html) 12:04:49 INFO - PID 26503 | RSS: Main: 149172224 12:04:49 INFO - PID 26503 | 12:07:52 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45856/tests/dromaeo/cssquery-yui.html) 12:07:53 INFO - PID 26503 | RSS: Main: 150409216 12:07:53 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | Cycle 1(1): loaded http://localhost:45856/tests/dromaeo/cssquery-yui.html (next: http://localhost:45856/tests/dromaeo/cssquery-dojo.html) 12:10:55 INFO - PID 26503 | RSS: Main: 152363008 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | __start_tp_report 12:10:55 INFO - PID 26503 | _x_x_mozilla_page_load 12:10:55 INFO - PID 26503 | _x_x_mozilla_page_load_details 12:10:55 INFO - PID 26503 | |i|pagename|runs| 12:10:55 INFO - PID 26503 | |0;dojo.html;3868.0716628009286;3896.82464289107;3908.628680275374;3925.4896863407753;3932.901677458065;6210.31686514483;6215.875682486348;6266.1540692006565;6298.6535740534255;6349.492040636749;6253.062040693887;6276.905846412296;6282.2147231596055;6285.811425657238;6294;5567.693776842272;5577.9163312550345;5599.944000559994;5625.071863142576;5714.799982000631;5677.205191273225;5677.716114194294;5685.715714214293;5730.341010783751;5734.655920644754;528.965691466966;5531.723413829292;5613.915791263134;5723.828285151452;5736.6558006519535;5578.665280083208;5591.804286849941;5613.859653508654;5668.8866222675315;5691.857703557403;5571.8607034824045;5574.777008919638;5650.660960342392;5661.094224923992;5662.66024038559;6142.815715528542;6221.3156552779155;6235.189425374672;6279.780207692755;6296.527760417941;6767.526273160881;6785.694643741043;6825.1127353443735;6860.142482189726;6868.656567171622;6701.128853249095;6808;6810.795676129724;6834.419074378684;6897.896531552031;6293.968530157365;6300.369963003663;6317.589356691847;6317.684115794238;6319.778807741753;6873.690683919235;6963.721451141999;7062.399696025793;7062.964685176541;7068.646567671596;6705.564138330993;6716;6800.217974932946;6800.93199068003;6809.965950170217;6708.53040287185;6810.931890681129;6844.5208835381045;6915.585064896122;6928;6667.43326817226;6757.054012438262;6793.116894803644;6817.965910170417;6834.2482326944;6719.496037797185;6769.661516924232;6806.897896531556;6855.725770969205;6859.657017149222;4870.756462176877;4880.365552478155;4942.332785074041;4954.430240522314;4954.8761280968265;4413.271810151353;4429.645628349725;4509.2559727644575;4509.729416235036;4510.526394728507;6225.408586184305;6245.375462453809;6293.024581189923;6299.244090709144;6299.811005669837;6742.5280230383405;6811.93188068113;6823.863522729517;6833.453323734089;6840.076589660432;6232.657203853741;6234.376562343729;6255.0617407388345;6328.272248691367;6329.651869147241;5387.595930305243;5443.673379597237;5445.754941027663;5465;5517.751701173457;7025.964870175719;7062.081929349254;7122.28777122294;7124.679389427488;7124.821879453055;6598.703058362481;6625.4037136657935;6707.698153583003;6743.224529179109;6861.691223894937;6969.1985421677155;6986.54587451814;7034.577925324497;7038.085048943604;7119.786406407816;6734.528582999143;6808.761693340709;6820.283870193558;6821.556598821061;6824.897626535507;6719.966400167968;6796.830079248059;6799.694013769294;6821.386075253251;6912.377885990285;6636.7345306189145;6643.069970204272;6649.301823308677;6652.434543063894;6655.667216639052;6574.3754343337305;6627.3372662733345;6652.966735166487;6653.700583473658;6672.599644021374;6531.183602049744;6535.673216339259;6545.083688283549;6621.635810030302;6626.072349870926;6501.804945851632;6608.339166083353;6618.07346971434;6664.8000559983275;6735.292794256533;6351.237851457855;6443.226812782496;6540.051692504655;6544.6727663617585;6556.475481961527 12:10:55 INFO - PID 26503 | |1;ext.html;932.7015355086376;942.6700654770829;961.5384615384615;994.1251698505314;997.5511020040983;41453.58546414535;43340;43411.56588434119;43429.56570434299;43485.56514434855;41045;41337;41429.17141657165;41576.58423415765;41614.7919260404;7479.401647868158;7562.962185189094;7580.317771400573;7581.090269167707;7589.051368578927;7445.813854653623;7500.5874676892745;7546.622668866535;7551.433642476809;7554.131274903374;8114.066882308522;8288.378371622122;8292.17078292172;8293.087760346358;8295.95852020739;8101.675932962675;8193.221643943816;8239;8244.958775206116;8252.051014133362;8053.677852885878;8057.5165490070785;8062.07286162093;8103.108658047669;8130.878036829452;39463.8026809867;39718.80140599279;39773;39782.80108599467;39854.60145398538;3663.523741913561;3704.8888533344043;3714.517112775349;3718.4980027696456;3723.590405055442;32940.670593294;33079;33096.50355244673;33106.6689333106;33150;5371.435999220064;5396.733371983776;5412.107002344608;5415.620906536544;5457.890842183134;205225;206017;207630;207987;209813;51941.22088168681;52017.219741703906;52186.478135218924;52235.73882130565;52286;53982.730086349315;54181;54210.72894635502;54368.72815635976;54577.72711136419;15254.542363729106;15569.221538923008;15620.140892251035;15638;15640.921795391178;12423.31671758062;12424.627261182179;12428.502859885502;12430.12989090773;12455.128141030222;15247.771283430757;15253;15322.23388830554;15415.537533874001;15503.457378991681;6087.360827113178;6237;6237.563370564108;6246.531510136758;6273.278572964076;1107.4684151607273;1107.7950579142885;1112.9666110016713;1116.7040734205443;1117.3686866920164;25387.61918571223;25628.615570766455;25854.353641159123;25877;25960.09139680102;1197.4132674989194;1202.386782740791;1211.7091897944606;1216.2823933879054;1235.178606226867;13462.798058029137;13631.322869731244;13645;13740.862591374158;13866.445342186402;254899;255455;256846;256953;257736;55522;59547.70226148841;59843;60072.39927600668;60181;1473.8452462491498;1499.7975273338177;1504.2178067404889;1514.35639853062;1523.9771403428958;30693.079207623807;30783.2304192397;30868.845655772475;31076.68923310738;31237.8438107808;39759;40198;40227.59772402239;40287.79856100818;40304.1939161221;231626;233001;233464;233932;235124;33670.49494257539;34534.30931381408;34949.30101397907;35064.12339691528;35096.824515877255;45788;45931.311030333905;46125;46292.07415851732;46294.76852615715;33872;33936.77600627936;34069.48895766516;34109.82945085259;34360.82819585986;33445.83277083599;33792.662073379935;34099;34482.482762758074;34524.48213276853;37989.24021519609;39227.803860980515;39290;39448.21103577855;40052;32797.508037379936;33067.33865322632;33468.49797253092;33811.4928276081;33876.15309617279;24872.005119795005;24906.309025313938;25058.498830022934;25614;25941.35146621274 12:10:55 INFO - PID 26503 | |2;jquery.html;595.9702014899254;604.4559896093515;610.7862248213125;611.1291409741118;612.6079309242085;22296.442588935286;23103.422414439647;23120.42198945027;23123.07507699692;23156.76843231567;23589.174378896743;25609.743902560967;25729.87135064327;25799.87100064497;25800;6666.466682665375;6679.899801502969;6697.330266973288;6727.428168605675;6742.089817874573;6433.903491447632;6549.148610680605;6651.600903945755;6688.765893193739;6698.698558564876;6644.136262285896;6644.302348253436;6663.3336666333225;6674.199096108474;6679.43224825888;6327.936720632781;6600.00999850024;6618.106555615027;6638.933610663904;6640.501962352819;6123.326434092246;6147.508199344042;6148.569600127993;6150.231221097363;6160.168377269101;31151.37697246065;31449.842750786327;31576.36847263065;31611;31692.841535792173;2268.8071513921336;2305.262316058862;2308.56137333906;2311.5492478966607;2318.802901753353;20747.89626051875;21276;21587.892060539598;21700.891495542422;21922;2566.884490197927;2568.8330258533138;2601.0766178006725;2603.453274812273;2613.137664570706;130600;137530;138108;144595;145171;15587.220638968007;15708.293126809092;15866.682666346609;16110.194490275673;16292.266847991868;25162.119325823507;25241.62137567938;25271.115510957396;25281.87359063193;25290.241292761246;10238.385696858064;10239.692809215736;10304.381737095799;10313.12338451225;10385.117265032557;9037;9102.772430689154;9110.225630821455;9122.452652840851;9133.497657628894;9741.172000380047;9814.263930205263;9942.154916832005;9959.850602240827;9962.900370996342;2984.7910646254554;2989.6963854940414;3000.3849210911712;3009.6689364169924;3042.4067306874945;1012.0840639221516;1028.5782829040058;1030.4384110659707;1050.4590136079926;1053.1732589916878;21016;21382;21431.249906253208;21794.78205217959;21814.127434902744;1091.5251865438402;1093.3658478082853;1097.632293181793;1099.6536091131268;1113.6603335982604;11515.481803318871;11764.88235117655;11826.940865295619;11953.70115747096;11980.88019119815;588246;598050;599312;617106;625837;125036.37481812533;128490;129182.35408822895;131942.34028829794;132332;1110.8666959964694;1212.2544635049558;1219.116140797932;1239.318374893823;1276.4447465352416;22365.217217397312;22416.551668966204;22488.662670059635;22537.098516059174;22540.985655645207;60123;61188.694056529435;61255.693721531105;62062;62627.37372626215;72758;73097.26902730904;73498;75047.62476187803;77215.61392193002;15417.460388886335;15530.689386211987;15560.688786223986;15619.531414057596;15632.843671563594;24303.392415189053;24349;24432.633510497002;24488.040956723777;24666.63000054965;19851.503712407306;19989.800101998793;20161.798382015993;20191.19235230633;20298.188072476936;17537.912310438365;17787.46637600874;17861.28554857791;18278.634427311645;18307.450776476726;19995.300164494172;20210.696839547712;20260.290889818785;20380.38858834237;20679.68980465264;15226.390944362101;15340.769888451905;15355.30901109475;15393.615159620651;15410.768838467207;19295.614087717888;19619.901900490408;19916.103775330434;20067.899660501604;20294.289699860434 12:10:55 INFO - PID 26503 | |3;mootools.html;1414.9009569330144;1479.312119864263;1480.9629759256018;1502.8947973641846;1504.7818066380376;16295.83704162958;17021.65956680867;17030.999999999985;17043.147842607883;17075.14624268788;16877.83122168778;17084.231209595568;17094.31622735089;17113.22990465429;17135.742963855522;2840.9715902841017;2864.4557534068563;2867.6558812942476;2868.411975545019;2875.309925617847;2713;2825.251308403275;2826.5760135979563;2827.4910516107093;2833.886644534216;2245.079517397859;2306.0660432524855;2768.5431903735857;2841.0340484235358;2866.9426611467757;2785.247983044567;2820.774338052951;2829.052267490393;2832.9150125496167;2835;2766.183975727145;2775.2506823157837;2791.52544067509;2799.6780370257275;2809.7049809769883;16389.672206555922;16525.173741312887;16530.83469165305;16569.088700121487;16577.088260145687;7934.761957141295;8251.051129120107;8252;8252.092269850311;8275.379346549033;5195.766190521398;5382.407935127172;5384.91922621161;5585.525230355424;5613.4386561343945;2092.98953505233;2099.4856260216193;2125.4048866317457;2131.360591822447;2155.892205389724;29093.70906290931;29174.854125729235;29209.123726288246;29236.122916312546;29351.85324073387;7150.141982962078;7193.676284567103;7240.782776516713;7349.191588925214;7380.483366164317;22298.44253893633;22585.774142258695;22588.66117008246;22596.88701556482;22622.434439138822;8451.66193352259;8476.152384761475;8488.193621605938;8490.872636910452;8497.66009359631;7449.292317229854;7632.618369081635;7649.694012239448;7654.693812247448;7713.65288562016;5709.115087161496;5817.9527685016255;5871.412858714094;5955.166276721263;6149.723262453201;1690.704126777809;1732.4369579886588;1830.4691639424418;1844.7048472244376;1864.4406677996546;906.2613969614742;940.416941496263;954.2175416158822;967.3035414501547;968.5254225429488;9204;9358.204552612968;9394.295427842802;9425.575849086808;9580;1058.6030238660503;1058.7353161709573;1059.6185373265619;1074.215822449616;1078.7141407527013;4842.782074806642;4972.90054198914;4988.226824842155;5019.29729837823;5045.167547354718;23766.287011389686;24787;24914.626280605804;25109;25168.622470662955;23273.301800946;24461.510769784505;24680.506389872462;24684.5063098737;24739.25782226536;12166.087543434101;12395.380230988414;12421.254724716546;12477.251364918135;12575.245485270912;9034.819303614022;9112.142536307778;9124.31567632417;9192.49441280736;9230.907690923274;20113.39659810208;20947.8952605236;21087.156513739894;21160.576788463837;21728.565428691654;21321.78678213198;21381.144754209658;21874.125034998422;21991.890040549693;22020.229291974705;13130.606081817561;13253;13290.40193191328;13312.600621981355;13348.799768003682;15462.690746185239;15484.612884677974;15680.843191567938;15753.133577652881;15798.92100539536;12075.75848483043;12101.939490302491;12485.812712809133;12493.812592810933;12689.175203611736;12404.56584019555;12422.37888105573;12456.626301210616;12782.936085319514;12959.287239201558;10643.201759867887;10659.14726821868;10679.57281708754;10757.677269681923;10760.892391076302;7321.121465424183;7354.154272258545;7372.852542949218;7422.220666829905;7483.251674832691;7900.012498437695;7932.008498937633;8047.195280471906;8097.352211822922;8155.102938676622 12:10:55 INFO - PID 26503 | |4;prototype.html;537.889732604816;553.283497870258;567.5970061256509;573.1889376532207;575.5137804683765;6138.391183746912;6220.191375121233;6234.625922444651;6295.527835412339;6301.2438507379065;6067.302260240073;6067.7572897084065;6121.143039974407;6170.382961703827;6176.598521096137;5057.721825299607;5058.747062646871;5069.290299358084;5096.184610462326;5124.180131179012;5029.924551131736;5030.163990143589;5043.293938848564;5068.138416469191;5075.568576670988;4795;4862.319275301461;4868.123737727207;4923.236898280772;4928.359313289267;4863.8540843774745;4875.366202393684;4895.779689913962;4945.381827271591;4945.851624451272;4384.430024096879;4412.426384570017;4425.446819147606;4450.2434586120435;4472.664550158751;6076.118962750421;6079.179310793074;6081.422264884873;6098.634081955097;6106.328303886569;5751.597388182829;5790;5792.68140252286;5813.651180929115;5822.330432000332;6571.967140164316;6575.178102737158;6595.439387652055;6615.17310336208;6643.900341494881;4970.527799859007;4972.353594032788;4980.228064649985;4988.5260900214425;4991.251312303148;6577.539572229945;6597.4062334389655;6652;6656.201255849281;6884.65576721162;5453.972730136404;5502.972485137549;5544.584156188302;5562.332520097614;5599.244102046172;5560.499555040065;5684.403137670568;5712.914306285409;5728.942710572925;5735.11105778605;6074.726637301332;6118.847028824315;6121.571489995747;6130.816075517741;6133.202683651097;6451.967740161269;6547.803565893031;6550.574212676161;6556.606603603704;6648.501362397743;1873.4192400355932;1894.7063205203215;1907.399169261678;1927.5566619677272;1930.5173706573357;1391.248725688117;1420.9928950355181;1466.7579849324743;1486.539172856418;1504.3456096598015;5792.9710351447975;5905.43898329658;6031.60794548353;6057.151998720183;6073.119397687311;6559.639219842859;6566.409023187936;6604.405603495708;6652.467802575782;6659.2008958925235;6068.302145253264;6074.179985701962;6112.969435152796;6113.480354169946;6145.8156255312415;3457.152997515625;3473.913152171165;3494.3884820156372;3503.264314493934;3534.505169276303;6729.899051514231;6790.422814060761;6848.383645471931;6931.1682598088555;6985.545939513915;6861.176658800876;6868.828279292958;6886.51794374389;6930.410915072174;6937.930620693829;6875.449964002868;6877.415419689282;6964.686589103604;6980.720771169096;6993.0209770632155;6553.279139294578;6631.3700198481065;6636.336366363325;6638.468922486286;6688.4983626229205;6610.603363798187;6650.667466626553;6676.566023208476;6705.262421133574;6720.8319792005595;6819.727210911508;6851.45188384938;6944.236134025152;6992.3357281058215;7017.859642807218;5074.31496747949;5085.491450855033;5120.923186152285;5159.819406320761;5166.6125040621355;6724.29394913527;6726.39462448382;6731.461483081243;6767.966160169168;6781.152355955505;6381.160383629241;6436.581622194542;6456.773213089498;6458.838529036811;6468.223813142453;6391.680415979089;6470.28826829039;6493.350664933469;6515.869682606416;6542.1168142300185;6319.557630965788;6346.667199888076;6413.294537600954;6451.1936007999;6469.320721324381;6501.2523559791225;6505.5446118773125;6544.938344421492;6546.24718157418;6559;6315.600071972621;6350.269718982191;6354.887894618516;6358.523110766803;6365.649889256136 12:10:55 INFO - PID 26503 | |5;yui.html;978.7699890525728;980.475445636585;988.6687959533556;992.2756387836877;994.9751256218593;18952.905235473805;19089.52276193096;19385.903070484663;19544.609107817854;19623.803761962376;18519.351822686207;18940.71588926164;18942.526436839085;19014;19029.809701902977;1053.4311471805236;1075.0539525217837;1075.9731006724817;1076.95692172313;1079.2391364088298;1048.7011201807486;1098.1160166066354;1099.312929419113;1099.76355083657;1100.1693721240451;1128.8814674459186;1135.6536256441823;1136.6817291158447;1140.7376303450212;1144.6279959013311;1084.4740300954031;1129.232122156933;1138.100900288775;1141.3380239461092;1141.343727356765;813.5647428625716;816.2735165702529;816.322452364536;816.6733306677318;816.930560902324;19468.70796938047;19781.802181978284;19973.600527989503;20027.699584506245;20064;20795.896020519802;21210.893945530326;21324.786752132437;21401.357959261248;21450.356489305344;16396.50810475676;16779.412720554843;16826.158692065346;16865.32538698463;16888.831111688847;3780.3762379207396;3799.8480060797533;3805.296020236265;3805.9429108563395;3812.1994381179707;150959;153508;154204;154925.99999999886;157430;15206.695866082617;15459.304331305118;15649.530514084596;15733.527994160193;16330.183490825411;28776.71223287782;28822;28901.56647650287;29183.270418239288;29218.853905730335;8263.876041859377;8514.829703405898;8652.221300083023;8663.306935445149;8689.348298877609;4471.306947423154;4532.478764942008;4561.110583436264;4571.611413029863;4590.632749380042;5781.8554536136935;5819.098039803837;5885.499732522698;5885.646861188342;5907.763689452459;1005.4369553050316;1022.2792930983638;1035.0994634667736;1035.337384074193;1040.3289878028781;706.4842664854582;719.5538765965135;720.5352547606765;724.8477819657826;732.4762794601885;12364.381780910919;12812.231266124063;13311.201327920162;14085.788713169311;14218.146911185362;672.8116127484312;674.3256743256743;677.8000489855505;688.1226436293765;692.2731132311053;6168.290646575611;6185.979313413236;6209.192804935329;6255.530835187379;6262.2172228471445;156086;157458.21270893572;157571;158189.2090539563;158842;106557;135339;136575;137301;145587;107758.46120769346;109839.45080274547;110406;110700;111782.44108779567;14181.503647372292;14194.503192388216;14349.282535873373;14398.352074156897;14528.927355363156;56778;57030;57088;57355.7132214353;57686;75076.62461687875;75247.62376188303;76329;77097.61451192932;77392;18152.546186345447;18461.81538184601;18591.53521161982;18595.721064183777;18655.626887462447;20802.375928722162;20925;21105.89447052755;21277.255296064563;21532.13871445125;18470.353537626117;18760.343387981356;18892.716609250598;19027.524311892314;19105.426837194907;19022.524436889187;19110.23559057622;19140.425787226406;19257.614847703248;19419;18670.346537871108;18761.906190469508;18862.24551017944;18913.054347282305;19082.904585476983;12595.496180152692;12830.87169128334;12925.54760583375;12977.091603587658;13005.089643724848;14135;14509.129452232477;14517.346719397863;14602.269886505419;14626 12:10:55 INFO - PID 26503 | __end_tp_report 12:10:55 INFO - PID 26503 | __start_cc_report 12:10:55 INFO - PID 26503 | _x_x_mozilla_cycle_collect,255 12:10:55 INFO - PID 26503 | __end_cc_report 12:10:55 INFO - PID 26503 | __startTimestamp1505761855352__endTimestamp 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | ------- Summary: start ------- 12:10:55 INFO - PID 26503 | Number of tests: 6 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#0] dojo.html Cycles:165 Average:6231.34 Median:6545.08 stddev:871.62 (13.3%) stddev-sans-first:854.35 12:10:55 INFO - PID 26503 | Values: 3868.1 3896.8 3908.6 3925.5 3932.9 6210.3 6215.9 6266.2 6298.7 6349.5 6253.1 6276.9 6282.2 6285.8 6294.0 5567.7 5577.9 5599.9 5625.1 5714.8 5677.2 5677.7 5685.7 5730.3 5734.7 529.0 5531.7 5613.9 5723.8 5736.7 5578.7 5591.8 5613.9 5668.9 5691.9 5571.9 5574.8 5650.7 5661.1 5662.7 6142.8 6221.3 6235.2 6279.8 6296.5 6767.5 6785.7 6825.1 6860.1 6868.7 6701.1 6808.0 6810.8 6834.4 6897.9 6294.0 6300.4 6317.6 6317.7 6319.8 6873.7 6963.7 7062.4 7063.0 7068.6 6705.6 6716.0 6800.2 6800.9 6810.0 6708.5 6810.9 6844.5 6915.6 6928.0 6667.4 6757.1 6793.1 6818.0 6834.2 6719.5 6769.7 6806.9 6855.7 6859.7 4870.8 4880.4 4942.3 4954.4 4954.9 4413.3 4429.6 4509.3 4509.7 4510.5 6225.4 6245.4 6293.0 6299.2 6299.8 6742.5 6811.9 6823.9 6833.5 6840.1 6232.7 6234.4 6255.1 6328.3 6329.7 5387.6 5443.7 5445.8 5465.0 5517.8 7026.0 7062.1 7122.3 7124.7 7124.8 6598.7 6625.4 6707.7 6743.2 6861.7 6969.2 6986.5 7034.6 7038.1 7119.8 6734.5 6808.8 6820.3 6821.6 6824.9 6720.0 6796.8 6799.7 6821.4 6912.4 6636.7 6643.1 6649.3 6652.4 6655.7 6574.4 6627.3 6653.0 6653.7 6672.6 6531.2 6535.7 6545.1 6621.6 6626.1 6501.8 6608.3 6618.1 6664.8 6735.3 6351.2 6443.2 6540.1 6544.7 6556.5 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#1] ext.html Cycles:180 Average:41114.84 Median:3684.21 stddev:60522.93 (1642.8%) stddev-sans-first:60617.51 12:10:55 INFO - PID 26503 | Values: 932.7 942.7 961.5 994.1 997.6 41453.6 43340.0 43411.6 43429.6 43485.6 41045.0 41337.0 41429.2 41576.6 41614.8 7479.4 7563.0 7580.3 7581.1 7589.1 7445.8 7500.6 7546.6 7551.4 7554.1 8114.1 8288.4 8292.2 8293.1 8296.0 8101.7 8193.2 8239.0 8245.0 8252.1 8053.7 8057.5 8062.1 8103.1 8130.9 39463.8 39718.8 39773.0 39782.8 39854.6 3663.5 3704.9 3714.5 3718.5 3723.6 32940.7 33079.0 33096.5 33106.7 33150.0 5371.4 5396.7 5412.1 5415.6 5457.9 205225.0 206017.0 207630.0 207987.0 209813.0 51941.2 52017.2 52186.5 52235.7 52286.0 53982.7 54181.0 54210.7 54368.7 54577.7 15254.5 15569.2 15620.1 15638.0 15640.9 12423.3 12424.6 12428.5 12430.1 12455.1 15247.8 15253.0 15322.2 15415.5 15503.5 6087.4 6237.0 6237.6 6246.5 6273.3 1107.5 1107.8 1113.0 1116.7 1117.4 25387.6 25628.6 25854.4 25877.0 25960.1 1197.4 1202.4 1211.7 1216.3 1235.2 13462.8 13631.3 13645.0 13740.9 13866.4 254899.0 255455.0 256846.0 256953.0 257736.0 55522.0 59547.7 59843.0 60072.4 60181.0 1473.8 1499.8 1504.2 1514.4 1524.0 30693.1 30783.2 30868.8 31076.7 31237.8 39759.0 40198.0 40227.6 40287.8 40304.2 231626.0 233001.0 233464.0 233932.0 235124.0 33670.5 34534.3 34949.3 35064.1 35096.8 45788.0 45931.3 46125.0 46292.1 46294.8 33872.0 33936.8 34069.5 34109.8 34360.8 33445.8 33792.7 34099.0 34482.5 34524.5 37989.2 39227.8 39290.0 39448.2 40052.0 32797.5 33067.3 33468.5 33811.5 33876.2 24872.0 24906.3 25058.5 25614.0 25941.4 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#2] jquery.html Cycles:180 Average:39321.50 Median:12715.99 stddev:100920.41 (793.6%) stddev-sans-first:101161.63 12:10:55 INFO - PID 26503 | Values: 596.0 604.5 610.8 611.1 612.6 22296.4 23103.4 23120.4 23123.1 23156.8 23589.2 25609.7 25729.9 25799.9 25800.0 6666.5 6679.9 6697.3 6727.4 6742.1 6433.9 6549.1 6651.6 6688.8 6698.7 6644.1 6644.3 6663.3 6674.2 6679.4 6327.9 6600.0 6618.1 6638.9 6640.5 6123.3 6147.5 6148.6 6150.2 6160.2 31151.4 31449.8 31576.4 31611.0 31692.8 2268.8 2305.3 2308.6 2311.5 2318.8 20747.9 21276.0 21587.9 21700.9 21922.0 2566.9 2568.8 2601.1 2603.5 2613.1 130600.0 137530.0 138108.0 144595.0 145171.0 15587.2 15708.3 15866.7 16110.2 16292.3 25162.1 25241.6 25271.1 25281.9 25290.2 10238.4 10239.7 10304.4 10313.1 10385.1 9037.0 9102.8 9110.2 9122.5 9133.5 9741.2 9814.3 9942.2 9959.9 9962.9 2984.8 2989.7 3000.4 3009.7 3042.4 1012.1 1028.6 1030.4 1050.5 1053.2 21016.0 21382.0 21431.2 21794.8 21814.1 1091.5 1093.4 1097.6 1099.7 1113.7 11515.5 11764.9 11826.9 11953.7 11980.9 588246.0 598050.0 599312.0 617106.0 625837.0 125036.4 128490.0 129182.4 131942.3 132332.0 1110.9 1212.3 1219.1 1239.3 1276.4 22365.2 22416.6 22488.7 22537.1 22541.0 60123.0 61188.7 61255.7 62062.0 62627.4 72758.0 73097.3 73498.0 75047.6 77215.6 15417.5 15530.7 15560.7 15619.5 15632.8 24303.4 24349.0 24432.6 24488.0 24666.6 19851.5 19989.8 20161.8 20191.2 20298.2 17537.9 17787.5 17861.3 18278.6 18307.5 19995.3 20210.7 20260.3 20380.4 20679.7 15226.4 15340.8 15355.3 15393.6 15410.8 19295.6 19619.9 19916.1 20067.9 20294.3 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#3] mootools.html Cycles:180 Average:10393.06 Median:25138.81 stddev:7702.38 (30.6%) stddev-sans-first:7694.45 12:10:55 INFO - PID 26503 | Values: 1414.9 1479.3 1481.0 1502.9 1504.8 16295.8 17021.7 17031.0 17043.1 17075.1 16877.8 17084.2 17094.3 17113.2 17135.7 2841.0 2864.5 2867.7 2868.4 2875.3 2713.0 2825.3 2826.6 2827.5 2833.9 2245.1 2306.1 2768.5 2841.0 2866.9 2785.2 2820.8 2829.1 2832.9 2835.0 2766.2 2775.3 2791.5 2799.7 2809.7 16389.7 16525.2 16530.8 16569.1 16577.1 7934.8 8251.1 8252.0 8252.1 8275.4 5195.8 5382.4 5384.9 5585.5 5613.4 2093.0 2099.5 2125.4 2131.4 2155.9 29093.7 29174.9 29209.1 29236.1 29351.9 7150.1 7193.7 7240.8 7349.2 7380.5 22298.4 22585.8 22588.7 22596.9 22622.4 8451.7 8476.2 8488.2 8490.9 8497.7 7449.3 7632.6 7649.7 7654.7 7713.7 5709.1 5818.0 5871.4 5955.2 6149.7 1690.7 1732.4 1830.5 1844.7 1864.4 906.3 940.4 954.2 967.3 968.5 9204.0 9358.2 9394.3 9425.6 9580.0 1058.6 1058.7 1059.6 1074.2 1078.7 4842.8 4972.9 4988.2 5019.3 5045.2 23766.3 24787.0 24914.6 25109.0 25168.6 23273.3 24461.5 24680.5 24684.5 24739.3 12166.1 12395.4 12421.3 12477.3 12575.2 9034.8 9112.1 9124.3 9192.5 9230.9 20113.4 20947.9 21087.2 21160.6 21728.6 21321.8 21381.1 21874.1 21991.9 22020.2 13130.6 13253.0 13290.4 13312.6 13348.8 15462.7 15484.6 15680.8 15753.1 15798.9 12075.8 12101.9 12485.8 12493.8 12689.2 12404.6 12422.4 12456.6 12782.9 12959.3 10643.2 10659.1 10679.6 10757.7 10760.9 7321.1 7354.2 7372.9 7422.2 7483.3 7900.0 7932.0 8047.2 8097.4 8155.1 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#4] prototype.html Cycles:180 Average:5605.80 Median:6132.01 stddev:1530.78 (25.0%) stddev-sans-first:1487.07 12:10:55 INFO - PID 26503 | Values: 537.9 553.3 567.6 573.2 575.5 6138.4 6220.2 6234.6 6295.5 6301.2 6067.3 6067.8 6121.1 6170.4 6176.6 5057.7 5058.7 5069.3 5096.2 5124.2 5029.9 5030.2 5043.3 5068.1 5075.6 4795.0 4862.3 4868.1 4923.2 4928.4 4863.9 4875.4 4895.8 4945.4 4945.9 4384.4 4412.4 4425.4 4450.2 4472.7 6076.1 6079.2 6081.4 6098.6 6106.3 5751.6 5790.0 5792.7 5813.7 5822.3 6572.0 6575.2 6595.4 6615.2 6643.9 4970.5 4972.4 4980.2 4988.5 4991.3 6577.5 6597.4 6652.0 6656.2 6884.7 5454.0 5503.0 5544.6 5562.3 5599.2 5560.5 5684.4 5712.9 5728.9 5735.1 6074.7 6118.8 6121.6 6130.8 6133.2 6452.0 6547.8 6550.6 6556.6 6648.5 1873.4 1894.7 1907.4 1927.6 1930.5 1391.2 1421.0 1466.8 1486.5 1504.3 5793.0 5905.4 6031.6 6057.2 6073.1 6559.6 6566.4 6604.4 6652.5 6659.2 6068.3 6074.2 6113.0 6113.5 6145.8 3457.2 3473.9 3494.4 3503.3 3534.5 6729.9 6790.4 6848.4 6931.2 6985.5 6861.2 6868.8 6886.5 6930.4 6937.9 6875.4 6877.4 6964.7 6980.7 6993.0 6553.3 6631.4 6636.3 6638.5 6688.5 6610.6 6650.7 6676.6 6705.3 6720.8 6819.7 6851.5 6944.2 6992.3 7017.9 5074.3 5085.5 5120.9 5159.8 5166.6 6724.3 6726.4 6731.5 6768.0 6781.2 6381.2 6436.6 6456.8 6458.8 6468.2 6391.7 6470.3 6493.4 6515.9 6542.1 6319.6 6346.7 6413.3 6451.2 6469.3 6501.3 6505.5 6544.9 6546.2 6559.0 6315.6 6350.3 6354.9 6358.5 6365.6 12:10:55 INFO - PID 26503 | 12:10:55 INFO - PID 26503 | [#5] yui.html Cycles:180 Average:28264.50 Median:18983.45 stddev:42449.69 (223.6%) stddev-sans-first:42519.33 12:10:55 INFO - PID 26503 | Values: 978.8 980.5 988.7 992.3 995.0 18952.9 19089.5 19385.9 19544.6 19623.8 18519.4 18940.7 18942.5 19014.0 19029.8 1053.4 1075.1 1076.0 1077.0 1079.2 1048.7 1098.1 1099.3 1099.8 1100.2 1128.9 1135.7 1136.7 1140.7 1144.6 1084.5 1129.2 1138.1 1141.3 1141.3 813.6 816.3 816.3 816.7 816.9 19468.7 19781.8 19973.6 20027.7 20064.0 20795.9 21210.9 21324.8 21401.4 21450.4 16396.5 16779.4 16826.2 16865.3 16888.8 3780.4 3799.8 3805.3 3805.9 3812.2 150959.0 153508.0 154204.0 154926.0 157430.0 15206.7 15459.3 15649.5 15733.5 16330.2 28776.7 28822.0 28901.6 29183.3 29218.9 8263.9 8514.8 8652.2 8663.3 8689.3 4471.3 4532.5 4561.1 4571.6 4590.6 5781.9 5819.1 5885.5 5885.6 5907.8 1005.4 1022.3 1035.1 1035.3 1040.3 706.5 719.6 720.5 724.8 732.5 12364.4 12812.2 13311.2 14085.8 14218.1 672.8 674.3 677.8 688.1 692.3 6168.3 6186.0 6209.2 6255.5 6262.2 156086.0 157458.2 157571.0 158189.2 158842.0 106557.0 135339.0 136575.0 137301.0 145587.0 107758.5 109839.5 110406.0 110700.0 111782.4 14181.5 14194.5 14349.3 14398.4 14528.9 56778.0 57030.0 57088.0 57355.7 57686.0 75076.6 75247.6 76329.0 77097.6 77392.0 18152.5 18461.8 18591.5 18595.7 18655.6 20802.4 20925.0 21105.9 21277.3 21532.1 18470.4 18760.3 18892.7 19027.5 19105.4 19022.5 19110.2 19140.4 19257.6 19419.0 18670.3 18761.9 18862.2 18913.1 19082.9 12595.5 12830.9 12925.5 12977.1 13005.1 14135.0 14509.1 14517.3 14602.3 14626.0 12:10:55 INFO - PID 26503 | -------- Summary: end -------- 12:10:55 INFO - PID 26503 | 12:10:56 INFO - TEST-INFO | 26503: exit 0 12:10:56 INFO - TEST-OK | dromaeo_css | took 1107082ms 12:10:56 INFO - TEST-START | kraken 12:10:56 INFO - Initialising browser for kraken test... 12:10:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45856/getInfo.html -profile /tmp/tmprTeVo4/profile 12:10:56 INFO - TEST-INFO | started process 26866 (/builds/slave/test/build/application/firefox/firefox http://localhost:45856/getInfo.html) 12:11:01 INFO - TEST-INFO | 26866: exit 0 12:11:01 INFO - Browser initialized. 12:11:01 INFO - Running cycle 1/1 for kraken test... 12:11:01 INFO - Using env: {'DISPLAY': ':0', 12:11:01 INFO - 'HOME': '/home/cltbld', 12:11:01 INFO - 'JSGC_DISABLE_POISONING': '1', 12:11:01 INFO - 'LANG': 'en_US.UTF-8', 12:11:01 INFO - 'LANGUAGE': 'en_US:en', 12:11:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:11:01 INFO - 'LOGNAME': 'cltbld', 12:11:01 INFO - 'MAIL': '/var/mail/cltbld', 12:11:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:11:01 INFO - 'MOZ_CRASHREPORTER': '1', 12:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:11:01 INFO - 'MOZ_NO_REMOTE': '1', 12:11:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:01 INFO - 'NO_EM_RESTART': '1', 12:11:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:01 INFO - 'PWD': '/builds/slave/test', 12:11:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:01 INFO - 'RUST_BACKTRACE': 'full', 12:11:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:11:01 INFO - 'SHELL': '/bin/bash', 12:11:01 INFO - 'SHLVL': '1', 12:11:01 INFO - 'STYLO_FORCE_DISABLED': '1', 12:11:01 INFO - 'TERM': 'linux', 12:11:01 INFO - 'TMOUT': '86400', 12:11:01 INFO - 'USER': 'cltbld', 12:11:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928', 12:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:01 INFO - '_': '/tools/buildbot/bin/python'} 12:11:01 INFO - TEST-INFO | started process 27108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprTeVo4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:02 INFO - PID 27108 | 12:11:02 INFO - PID 27108 | (/builds/slave/test/build/application/firefox/firefox:27157): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:11:02 INFO - PID 27108 | 12:11:12 INFO - PID 27108 | RSS: Main: 147951616 12:11:12 INFO - PID 27108 | 12:11:14 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:15 INFO - PID 27108 | RSS: Main: 153440256 12:11:15 INFO - PID 27108 | 12:11:18 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-dft) 12:11:18 INFO - PID 27108 | RSS: Main: 153694208 12:11:18 INFO - PID 27108 | 12:11:21 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-fft) 12:11:22 INFO - PID 27108 | RSS: Main: 149807104 12:11:22 INFO - PID 27108 | 12:11:24 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator) 12:11:25 INFO - PID 27108 | RSS: Main: 151048192 12:11:25 INFO - PID 27108 | 12:11:27 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:11:27 INFO - PID 27108 | RSS: Main: 150650880 12:11:27 INFO - PID 27108 | 12:11:30 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom) 12:11:31 INFO - PID 27108 | RSS: Main: 150913024 12:11:31 INFO - PID 27108 | 12:11:35 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate) 12:11:35 INFO - PID 27108 | RSS: Main: 152186880 12:11:35 INFO - PID 27108 | 12:11:38 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial) 12:11:39 INFO - PID 27108 | RSS: Main: 153751552 12:11:39 INFO - PID 27108 | 12:11:40 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:11:41 INFO - PID 27108 | RSS: Main: 153370624 12:11:41 INFO - PID 27108 | 12:11:42 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:11:43 INFO - PID 27108 | RSS: Main: 153686016 12:11:43 INFO - PID 27108 | 12:11:45 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:46 INFO - PID 27108 | RSS: Main: 150568960 12:11:46 INFO - PID 27108 | 12:11:48 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:49 INFO - PID 27108 | RSS: Main: 150638592 12:11:49 INFO - PID 27108 | 12:11:51 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:52 INFO - PID 27108 | RSS: Main: 151642112 12:11:52 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | Cycle 1(1): loaded http://localhost:45856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45856/tests/kraken/driver.html?testName=ai-astar) 12:11:54 INFO - PID 27108 | RSS: Main: 152608768 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | __start_tp_report 12:11:54 INFO - PID 27108 | _x_x_mozilla_page_load 12:11:54 INFO - PID 27108 | _x_x_mozilla_page_load_details 12:11:54 INFO - PID 27108 | |i|pagename|runs| 12:11:54 INFO - PID 27108 | |0;ai-astar;109;107;106;106;107;106;108;107;105;105 12:11:54 INFO - PID 27108 | |1;audio-beat-detection;116;110;110;112;144;112;140;114;119;119 12:11:54 INFO - PID 27108 | |2;audio-dft;162;163;163;163;162;164;162;163;166;165 12:11:54 INFO - PID 27108 | |3;audio-fft;73;74;73;85;74;73;72;73;73;73 12:11:54 INFO - PID 27108 | |4;audio-oscillator;77;78;77;78;77;84;78;78;82;77 12:11:54 INFO - PID 27108 | |5;imaging-gaussian-blur;111;113;113;110;113;114;113;114;114;114 12:11:54 INFO - PID 27108 | |6;imaging-darkroom;148;148;148;148;151;148;149;152;149;149 12:11:54 INFO - PID 27108 | |7;imaging-desaturate;94;95;93;94;94;94;99;93;93;94 12:11:54 INFO - PID 27108 | |8;json-parse-financial;45;47;45;44;46;48;50;45;44;43 12:11:54 INFO - PID 27108 | |9;json-stringify-tinderbox;37;37;37;37;37;37;37;38;38;38 12:11:54 INFO - PID 27108 | |10;stanford-crypto-aes;72;72;71;73;75;70;73;71;70;72 12:11:54 INFO - PID 27108 | |11;stanford-crypto-ccm;114;110;109;109;105;106;105;114;111;106 12:11:54 INFO - PID 27108 | |12;stanford-crypto-pbkdf2;154;156;156;153;157;155;157;151;155;154 12:11:54 INFO - PID 27108 | |13;stanford-crypto-sha256-iterative;64;59;59;59;60;60;63;60;59;58 12:11:54 INFO - PID 27108 | __end_tp_report 12:11:54 INFO - PID 27108 | __start_cc_report 12:11:54 INFO - PID 27108 | _x_x_mozilla_cycle_collect,748 12:11:54 INFO - PID 27108 | __end_cc_report 12:11:54 INFO - PID 27108 | __startTimestamp1505761914506__endTimestamp 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | ------- Summary: start ------- 12:11:54 INFO - PID 27108 | Number of tests: 14 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:1.26 (1.2%) stddev-sans-first:1.00 12:11:54 INFO - PID 27108 | Values: 109.0 107.0 106.0 106.0 107.0 106.0 108.0 107.0 105.0 105.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#1] audio-beat-detection Cycles:10 Average:119.60 Median:117.50 stddev:12.28 (10.4%) stddev-sans-first:12.95 12:11:54 INFO - PID 27108 | Values: 116.0 110.0 110.0 112.0 144.0 112.0 140.0 114.0 119.0 119.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 12:11:54 INFO - PID 27108 | Values: 162.0 163.0 163.0 163.0 162.0 164.0 162.0 163.0 166.0 165.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#3] audio-fft Cycles:10 Average:74.30 Median:73.00 stddev:3.80 (5.2%) stddev-sans-first:4.00 12:11:54 INFO - PID 27108 | Values: 73.0 74.0 73.0 85.0 74.0 73.0 72.0 73.0 73.0 73.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:2.41 (3.1%) stddev-sans-first:2.49 12:11:54 INFO - PID 27108 | Values: 77.0 78.0 77.0 78.0 77.0 84.0 78.0 78.0 82.0 77.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.50 stddev:1.37 (1.2%) stddev-sans-first:1.27 12:11:54 INFO - PID 27108 | Values: 111.0 113.0 113.0 110.0 113.0 114.0 113.0 114.0 114.0 114.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 12:11:54 INFO - PID 27108 | Values: 148.0 148.0 148.0 148.0 151.0 148.0 149.0 152.0 149.0 149.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.77 (1.9%) stddev-sans-first:1.87 12:11:54 INFO - PID 27108 | Values: 94.0 95.0 93.0 94.0 94.0 94.0 99.0 93.0 93.0 94.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:45.50 stddev:2.11 (4.6%) stddev-sans-first:2.22 12:11:54 INFO - PID 27108 | Values: 45.0 47.0 45.0 44.0 46.0 48.0 50.0 45.0 44.0 43.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 12:11:54 INFO - PID 27108 | Values: 37.0 37.0 37.0 37.0 37.0 37.0 37.0 38.0 38.0 38.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#10] stanford-crypto-aes Cycles:10 Average:71.90 Median:72.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 12:11:54 INFO - PID 27108 | Values: 72.0 72.0 71.0 73.0 75.0 70.0 73.0 71.0 70.0 72.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#11] stanford-crypto-ccm Cycles:10 Average:108.90 Median:109.50 stddev:3.41 (3.1%) stddev-sans-first:3.08 12:11:54 INFO - PID 27108 | Values: 114.0 110.0 109.0 109.0 105.0 106.0 105.0 114.0 111.0 106.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.50 stddev:1.87 (1.2%) stddev-sans-first:1.96 12:11:54 INFO - PID 27108 | Values: 154.0 156.0 156.0 153.0 157.0 155.0 157.0 151.0 155.0 154.0 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:1.91 (3.2%) stddev-sans-first:1.41 12:11:54 INFO - PID 27108 | Values: 64.0 59.0 59.0 59.0 60.0 60.0 63.0 60.0 59.0 58.0 12:11:54 INFO - PID 27108 | -------- Summary: end -------- 12:11:54 INFO - PID 27108 | 12:11:54 INFO - PID 27108 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:11:55 INFO - TEST-INFO | 27108: exit 0 12:11:55 INFO - TEST-OK | kraken | took 59075ms 12:11:55 INFO - SUITE-END | took 1166s 12:11:55 INFO - Completed test suite (00:19:26) 12:11:55 INFO - javascript benchmark 12:11:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9010.378605853752, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3868.0716628009286, 3896.82464289107, 3908.628680275374, 3925.4896863407753, 3932.901677458065, 6210.31686514483, 6215.875682486348, 6266.1540692006565, 6298.6535740534255, 6349.492040636749, 6253.062040693887, 6276.905846412296, 6282.2147231596055, 6285.811425657238, 6294.0, 5567.693776842272, 5577.9163312550345, 5599.944000559994, 5625.071863142576, 5714.799982000631, 5677.205191273225, 5677.716114194294, 5685.715714214293, 5730.341010783751, 5734.655920644754, 528.965691466966, 5531.723413829292, 5613.915791263134, 5723.828285151452, 5736.6558006519535, 5578.665280083208, 5591.804286849941, 5613.859653508654, 5668.8866222675315, 5691.857703557403, 5571.8607034824045, 5574.777008919638, 5650.660960342392, 5661.094224923992, 5662.66024038559, 6142.815715528542, 6221.3156552779155, 6235.189425374672, 6279.780207692755, 6296.527760417941, 6767.526273160881, 6785.694643741043, 6825.1127353443735, 6860.142482189726, 6868.656567171622, 6701.128853249095, 6808.0, 6810.795676129724, 6834.419074378684, 6897.896531552031, 6293.968530157365, 6300.369963003663, 6317.589356691847, 6317.684115794238, 6319.778807741753, 6873.690683919235, 6963.721451141999, 7062.399696025793, 7062.964685176541, 7068.646567671596, 6705.564138330993, 6716.0, 6800.217974932946, 6800.93199068003, 6809.965950170217, 6708.53040287185, 6810.931890681129, 6844.5208835381045, 6915.585064896122, 6928.0, 6667.43326817226, 6757.054012438262, 6793.116894803644, 6817.965910170417, 6834.2482326944, 6719.496037797185, 6769.661516924232, 6806.897896531556, 6855.725770969205, 6859.657017149222, 4870.756462176877, 4880.365552478155, 4942.332785074041, 4954.430240522314, 4954.8761280968265, 4413.271810151353, 4429.645628349725, 4509.2559727644575, 4509.729416235036, 4510.526394728507, 6225.408586184305, 6245.375462453809, 6293.024581189923, 6299.244090709144, 6299.811005669837, 6742.5280230383405, 6811.93188068113, 6823.863522729517, 6833.453323734089, 6840.076589660432, 6232.657203853741, 6234.376562343729, 6255.0617407388345, 6328.272248691367, 6329.651869147241, 5387.595930305243, 5443.673379597237, 5445.754941027663, 5465.0, 5517.751701173457, 7025.964870175719, 7062.081929349254, 7122.28777122294, 7124.679389427488, 7124.821879453055, 6598.703058362481, 6625.4037136657935, 6707.698153583003, 6743.224529179109, 6861.691223894937, 6969.1985421677155, 6986.54587451814, 7034.577925324497, 7038.085048943604, 7119.786406407816, 6734.528582999143, 6808.761693340709, 6820.283870193558, 6821.556598821061, 6824.897626535507, 6719.966400167968, 6796.830079248059, 6799.694013769294, 6821.386075253251, 6912.377885990285, 6636.7345306189145, 6643.069970204272, 6649.301823308677, 6652.434543063894, 6655.667216639052, 6574.3754343337305, 6627.3372662733345, 6652.966735166487, 6653.700583473658, 6672.599644021374, 6531.183602049744, 6535.673216339259, 6545.083688283549, 6621.635810030302, 6626.072349870926, 6501.804945851632, 6608.339166083353, 6618.07346971434, 6664.8000559983275, 6735.292794256533, 6351.237851457855, 6443.226812782496, 6540.051692504655, 6544.6727663617585, 6556.475481961527], "value": 6173.556177290334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [932.7015355086376, 942.6700654770829, 961.5384615384615, 994.1251698505314, 997.5511020040983, 41453.58546414535, 43340.0, 43411.56588434119, 43429.56570434299, 43485.56514434855, 41045.0, 41337.0, 41429.17141657165, 41576.58423415765, 41614.7919260404, 7479.401647868158, 7562.962185189094, 7580.317771400573, 7581.090269167707, 7589.051368578927, 7445.813854653623, 7500.5874676892745, 7546.622668866535, 7551.433642476809, 7554.131274903374, 8114.066882308522, 8288.378371622122, 8292.17078292172, 8293.087760346358, 8295.95852020739, 8101.675932962675, 8193.221643943816, 8239.0, 8244.958775206116, 8252.051014133362, 8053.677852885878, 8057.5165490070785, 8062.07286162093, 8103.108658047669, 8130.878036829452, 39463.8026809867, 39718.80140599279, 39773.0, 39782.80108599467, 39854.60145398538, 3663.523741913561, 3704.8888533344043, 3714.517112775349, 3718.4980027696456, 3723.590405055442, 32940.670593294, 33079.0, 33096.50355244673, 33106.6689333106, 33150.0, 5371.435999220064, 5396.733371983776, 5412.107002344608, 5415.620906536544, 5457.890842183134, 205225.0, 206017.0, 207630.0, 207987.0, 209813.0, 51941.22088168681, 52017.219741703906, 52186.478135218924, 52235.73882130565, 52286.0, 53982.730086349315, 54181.0, 54210.72894635502, 54368.72815635976, 54577.72711136419, 15254.542363729106, 15569.221538923008, 15620.140892251035, 15638.0, 15640.921795391178, 12423.31671758062, 12424.627261182179, 12428.502859885502, 12430.12989090773, 12455.128141030222, 15247.771283430757, 15253.0, 15322.23388830554, 15415.537533874001, 15503.457378991681, 6087.360827113178, 6237.0, 6237.563370564108, 6246.531510136758, 6273.278572964076, 1107.4684151607273, 1107.7950579142885, 1112.9666110016713, 1116.7040734205443, 1117.3686866920164, 25387.61918571223, 25628.615570766455, 25854.353641159123, 25877.0, 25960.09139680102, 1197.4132674989194, 1202.386782740791, 1211.7091897944606, 1216.2823933879054, 1235.178606226867, 13462.798058029137, 13631.322869731244, 13645.0, 13740.862591374158, 13866.445342186402, 254899.0, 255455.0, 256846.0, 256953.0, 257736.0, 55522.0, 59547.70226148841, 59843.0, 60072.39927600668, 60181.0, 1473.8452462491498, 1499.7975273338177, 1504.2178067404889, 1514.35639853062, 1523.9771403428958, 30693.079207623807, 30783.2304192397, 30868.845655772475, 31076.68923310738, 31237.8438107808, 39759.0, 40198.0, 40227.59772402239, 40287.79856100818, 40304.1939161221, 231626.0, 233001.0, 233464.0, 233932.0, 235124.0, 33670.49494257539, 34534.30931381408, 34949.30101397907, 35064.12339691528, 35096.824515877255, 45788.0, 45931.311030333905, 46125.0, 46292.07415851732, 46294.76852615715, 33872.0, 33936.77600627936, 34069.48895766516, 34109.82945085259, 34360.82819585986, 33445.83277083599, 33792.662073379935, 34099.0, 34482.482762758074, 34524.48213276853, 37989.24021519609, 39227.803860980515, 39290.0, 39448.21103577855, 40052.0, 32797.508037379936, 33067.33865322632, 33468.49797253092, 33811.4928276081, 33876.15309617279, 24872.005119795005, 24906.309025313938, 25058.498830022934, 25614.0, 25941.35146621274], "value": 18323.639926731703, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9702014899254, 604.4559896093515, 610.7862248213125, 611.1291409741118, 612.6079309242085, 22296.442588935286, 23103.422414439647, 23120.42198945027, 23123.07507699692, 23156.76843231567, 23589.174378896743, 25609.743902560967, 25729.87135064327, 25799.87100064497, 25800.0, 6666.466682665375, 6679.899801502969, 6697.330266973288, 6727.428168605675, 6742.089817874573, 6433.903491447632, 6549.148610680605, 6651.600903945755, 6688.765893193739, 6698.698558564876, 6644.136262285896, 6644.302348253436, 6663.3336666333225, 6674.199096108474, 6679.43224825888, 6327.936720632781, 6600.00999850024, 6618.106555615027, 6638.933610663904, 6640.501962352819, 6123.326434092246, 6147.508199344042, 6148.569600127993, 6150.231221097363, 6160.168377269101, 31151.37697246065, 31449.842750786327, 31576.36847263065, 31611.0, 31692.841535792173, 2268.8071513921336, 2305.262316058862, 2308.56137333906, 2311.5492478966607, 2318.802901753353, 20747.89626051875, 21276.0, 21587.892060539598, 21700.891495542422, 21922.0, 2566.884490197927, 2568.8330258533138, 2601.0766178006725, 2603.453274812273, 2613.137664570706, 130600.0, 137530.0, 138108.0, 144595.0, 145171.0, 15587.220638968007, 15708.293126809092, 15866.682666346609, 16110.194490275673, 16292.266847991868, 25162.119325823507, 25241.62137567938, 25271.115510957396, 25281.87359063193, 25290.241292761246, 10238.385696858064, 10239.692809215736, 10304.381737095799, 10313.12338451225, 10385.117265032557, 9037.0, 9102.772430689154, 9110.225630821455, 9122.452652840851, 9133.497657628894, 9741.172000380047, 9814.263930205263, 9942.154916832005, 9959.850602240827, 9962.900370996342, 2984.7910646254554, 2989.6963854940414, 3000.3849210911712, 3009.6689364169924, 3042.4067306874945, 1012.0840639221516, 1028.5782829040058, 1030.4384110659707, 1050.4590136079926, 1053.1732589916878, 21016.0, 21382.0, 21431.249906253208, 21794.78205217959, 21814.127434902744, 1091.5251865438402, 1093.3658478082853, 1097.632293181793, 1099.6536091131268, 1113.6603335982604, 11515.481803318871, 11764.88235117655, 11826.940865295619, 11953.70115747096, 11980.88019119815, 588246.0, 598050.0, 599312.0, 617106.0, 625837.0, 125036.37481812533, 128490.0, 129182.35408822895, 131942.34028829794, 132332.0, 1110.8666959964694, 1212.2544635049558, 1219.116140797932, 1239.318374893823, 1276.4447465352416, 22365.217217397312, 22416.551668966204, 22488.662670059635, 22537.098516059174, 22540.985655645207, 60123.0, 61188.694056529435, 61255.693721531105, 62062.0, 62627.37372626215, 72758.0, 73097.26902730904, 73498.0, 75047.62476187803, 77215.61392193002, 15417.460388886335, 15530.689386211987, 15560.688786223986, 15619.531414057596, 15632.843671563594, 24303.392415189053, 24349.0, 24432.633510497002, 24488.040956723777, 24666.63000054965, 19851.503712407306, 19989.800101998793, 20161.798382015993, 20191.19235230633, 20298.188072476936, 17537.912310438365, 17787.46637600874, 17861.28554857791, 18278.634427311645, 18307.450776476726, 19995.300164494172, 20210.696839547712, 20260.290889818785, 20380.38858834237, 20679.68980465264, 15226.390944362101, 15340.769888451905, 15355.30901109475, 15393.615159620651, 15410.768838467207, 19295.614087717888, 19619.901900490408, 19916.103775330434, 20067.899660501604, 20294.289699860434], "value": 12751.311995559789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.9009569330144, 1479.312119864263, 1480.9629759256018, 1502.8947973641846, 1504.7818066380376, 16295.83704162958, 17021.65956680867, 17030.999999999985, 17043.147842607883, 17075.14624268788, 16877.83122168778, 17084.231209595568, 17094.31622735089, 17113.22990465429, 17135.742963855522, 2840.9715902841017, 2864.4557534068563, 2867.6558812942476, 2868.411975545019, 2875.309925617847, 2713.0, 2825.251308403275, 2826.5760135979563, 2827.4910516107093, 2833.886644534216, 2245.079517397859, 2306.0660432524855, 2768.5431903735857, 2841.0340484235358, 2866.9426611467757, 2785.247983044567, 2820.774338052951, 2829.052267490393, 2832.9150125496167, 2835.0, 2766.183975727145, 2775.2506823157837, 2791.52544067509, 2799.6780370257275, 2809.7049809769883, 16389.672206555922, 16525.173741312887, 16530.83469165305, 16569.088700121487, 16577.088260145687, 7934.761957141295, 8251.051129120107, 8252.0, 8252.092269850311, 8275.379346549033, 5195.766190521398, 5382.407935127172, 5384.91922621161, 5585.525230355424, 5613.4386561343945, 2092.98953505233, 2099.4856260216193, 2125.4048866317457, 2131.360591822447, 2155.892205389724, 29093.70906290931, 29174.854125729235, 29209.123726288246, 29236.122916312546, 29351.85324073387, 7150.141982962078, 7193.676284567103, 7240.782776516713, 7349.191588925214, 7380.483366164317, 22298.44253893633, 22585.774142258695, 22588.66117008246, 22596.88701556482, 22622.434439138822, 8451.66193352259, 8476.152384761475, 8488.193621605938, 8490.872636910452, 8497.66009359631, 7449.292317229854, 7632.618369081635, 7649.694012239448, 7654.693812247448, 7713.65288562016, 5709.115087161496, 5817.9527685016255, 5871.412858714094, 5955.166276721263, 6149.723262453201, 1690.704126777809, 1732.4369579886588, 1830.4691639424418, 1844.7048472244376, 1864.4406677996546, 906.2613969614742, 940.416941496263, 954.2175416158822, 967.3035414501547, 968.5254225429488, 9204.0, 9358.204552612968, 9394.295427842802, 9425.575849086808, 9580.0, 1058.6030238660503, 1058.7353161709573, 1059.6185373265619, 1074.215822449616, 1078.7141407527013, 4842.782074806642, 4972.90054198914, 4988.226824842155, 5019.29729837823, 5045.167547354718, 23766.287011389686, 24787.0, 24914.626280605804, 25109.0, 25168.622470662955, 23273.301800946, 24461.510769784505, 24680.506389872462, 24684.5063098737, 24739.25782226536, 12166.087543434101, 12395.380230988414, 12421.254724716546, 12477.251364918135, 12575.245485270912, 9034.819303614022, 9112.142536307778, 9124.31567632417, 9192.49441280736, 9230.907690923274, 20113.39659810208, 20947.8952605236, 21087.156513739894, 21160.576788463837, 21728.565428691654, 21321.78678213198, 21381.144754209658, 21874.125034998422, 21991.890040549693, 22020.229291974705, 13130.606081817561, 13253.0, 13290.40193191328, 13312.600621981355, 13348.799768003682, 15462.690746185239, 15484.612884677974, 15680.843191567938, 15753.133577652881, 15798.92100539536, 12075.75848483043, 12101.939490302491, 12485.812712809133, 12493.812592810933, 12689.175203611736, 12404.56584019555, 12422.37888105573, 12456.626301210616, 12782.936085319514, 12959.287239201558, 10643.201759867887, 10659.14726821868, 10679.57281708754, 10757.677269681923, 10760.892391076302, 7321.121465424183, 7354.154272258545, 7372.852542949218, 7422.220666829905, 7483.251674832691, 7900.012498437695, 7932.008498937633, 8047.195280471906, 8097.352211822922, 8155.102938676622], "value": 7278.864195904951, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.889732604816, 553.283497870258, 567.5970061256509, 573.1889376532207, 575.5137804683765, 6138.391183746912, 6220.191375121233, 6234.625922444651, 6295.527835412339, 6301.2438507379065, 6067.302260240073, 6067.7572897084065, 6121.143039974407, 6170.382961703827, 6176.598521096137, 5057.721825299607, 5058.747062646871, 5069.290299358084, 5096.184610462326, 5124.180131179012, 5029.924551131736, 5030.163990143589, 5043.293938848564, 5068.138416469191, 5075.568576670988, 4795.0, 4862.319275301461, 4868.123737727207, 4923.236898280772, 4928.359313289267, 4863.8540843774745, 4875.366202393684, 4895.779689913962, 4945.381827271591, 4945.851624451272, 4384.430024096879, 4412.426384570017, 4425.446819147606, 4450.2434586120435, 4472.664550158751, 6076.118962750421, 6079.179310793074, 6081.422264884873, 6098.634081955097, 6106.328303886569, 5751.597388182829, 5790.0, 5792.68140252286, 5813.651180929115, 5822.330432000332, 6571.967140164316, 6575.178102737158, 6595.439387652055, 6615.17310336208, 6643.900341494881, 4970.527799859007, 4972.353594032788, 4980.228064649985, 4988.5260900214425, 4991.251312303148, 6577.539572229945, 6597.4062334389655, 6652.0, 6656.201255849281, 6884.65576721162, 5453.972730136404, 5502.972485137549, 5544.584156188302, 5562.332520097614, 5599.244102046172, 5560.499555040065, 5684.403137670568, 5712.914306285409, 5728.942710572925, 5735.11105778605, 6074.726637301332, 6118.847028824315, 6121.571489995747, 6130.816075517741, 6133.202683651097, 6451.967740161269, 6547.803565893031, 6550.574212676161, 6556.606603603704, 6648.501362397743, 1873.4192400355932, 1894.7063205203215, 1907.399169261678, 1927.5566619677272, 1930.5173706573357, 1391.248725688117, 1420.9928950355181, 1466.7579849324743, 1486.539172856418, 1504.3456096598015, 5792.9710351447975, 5905.43898329658, 6031.60794548353, 6057.151998720183, 6073.119397687311, 6559.639219842859, 6566.409023187936, 6604.405603495708, 6652.467802575782, 6659.2008958925235, 6068.302145253264, 6074.179985701962, 6112.969435152796, 6113.480354169946, 6145.8156255312415, 3457.152997515625, 3473.913152171165, 3494.3884820156372, 3503.264314493934, 3534.505169276303, 6729.899051514231, 6790.422814060761, 6848.383645471931, 6931.1682598088555, 6985.545939513915, 6861.176658800876, 6868.828279292958, 6886.51794374389, 6930.410915072174, 6937.930620693829, 6875.449964002868, 6877.415419689282, 6964.686589103604, 6980.720771169096, 6993.0209770632155, 6553.279139294578, 6631.3700198481065, 6636.336366363325, 6638.468922486286, 6688.4983626229205, 6610.603363798187, 6650.667466626553, 6676.566023208476, 6705.262421133574, 6720.8319792005595, 6819.727210911508, 6851.45188384938, 6944.236134025152, 6992.3357281058215, 7017.859642807218, 5074.31496747949, 5085.491450855033, 5120.923186152285, 5159.819406320761, 5166.6125040621355, 6724.29394913527, 6726.39462448382, 6731.461483081243, 6767.966160169168, 6781.152355955505, 6381.160383629241, 6436.581622194542, 6456.773213089498, 6458.838529036811, 6468.223813142453, 6391.680415979089, 6470.28826829039, 6493.350664933469, 6515.869682606416, 6542.1168142300185, 6319.557630965788, 6346.667199888076, 6413.294537600954, 6451.1936007999, 6469.320721324381, 6501.2523559791225, 6505.5446118773125, 6544.938344421492, 6546.24718157418, 6559.0, 6315.600071972621, 6350.269718982191, 6354.887894618516, 6358.523110766803, 6365.649889256136], "value": 5177.461470149231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [978.7699890525728, 980.475445636585, 988.6687959533556, 992.2756387836877, 994.9751256218593, 18952.905235473805, 19089.52276193096, 19385.903070484663, 19544.609107817854, 19623.803761962376, 18519.351822686207, 18940.71588926164, 18942.526436839085, 19014.0, 19029.809701902977, 1053.4311471805236, 1075.0539525217837, 1075.9731006724817, 1076.95692172313, 1079.2391364088298, 1048.7011201807486, 1098.1160166066354, 1099.312929419113, 1099.76355083657, 1100.1693721240451, 1128.8814674459186, 1135.6536256441823, 1136.6817291158447, 1140.7376303450212, 1144.6279959013311, 1084.4740300954031, 1129.232122156933, 1138.100900288775, 1141.3380239461092, 1141.343727356765, 813.5647428625716, 816.2735165702529, 816.322452364536, 816.6733306677318, 816.930560902324, 19468.70796938047, 19781.802181978284, 19973.600527989503, 20027.699584506245, 20064.0, 20795.896020519802, 21210.893945530326, 21324.786752132437, 21401.357959261248, 21450.356489305344, 16396.50810475676, 16779.412720554843, 16826.158692065346, 16865.32538698463, 16888.831111688847, 3780.3762379207396, 3799.8480060797533, 3805.296020236265, 3805.9429108563395, 3812.1994381179707, 150959.0, 153508.0, 154204.0, 154925.99999999886, 157430.0, 15206.695866082617, 15459.304331305118, 15649.530514084596, 15733.527994160193, 16330.183490825411, 28776.71223287782, 28822.0, 28901.56647650287, 29183.270418239288, 29218.853905730335, 8263.876041859377, 8514.829703405898, 8652.221300083023, 8663.306935445149, 8689.348298877609, 4471.306947423154, 4532.478764942008, 4561.110583436264, 4571.611413029863, 4590.632749380042, 5781.8554536136935, 5819.098039803837, 5885.499732522698, 5885.646861188342, 5907.763689452459, 1005.4369553050316, 1022.2792930983638, 1035.0994634667736, 1035.337384074193, 1040.3289878028781, 706.4842664854582, 719.5538765965135, 720.5352547606765, 724.8477819657826, 732.4762794601885, 12364.381780910919, 12812.231266124063, 13311.201327920162, 14085.788713169311, 14218.146911185362, 672.8116127484312, 674.3256743256743, 677.8000489855505, 688.1226436293765, 692.2731132311053, 6168.290646575611, 6185.979313413236, 6209.192804935329, 6255.530835187379, 6262.2172228471445, 156086.0, 157458.21270893572, 157571.0, 158189.2090539563, 158842.0, 106557.0, 135339.0, 136575.0, 137301.0, 145587.0, 107758.46120769346, 109839.45080274547, 110406.0, 110700.0, 111782.44108779567, 14181.503647372292, 14194.503192388216, 14349.282535873373, 14398.352074156897, 14528.927355363156, 56778.0, 57030.0, 57088.0, 57355.7132214353, 57686.0, 75076.62461687875, 75247.62376188303, 76329.0, 77097.61451192932, 77392.0, 18152.546186345447, 18461.81538184601, 18591.53521161982, 18595.721064183777, 18655.626887462447, 20802.375928722162, 20925.0, 21105.89447052755, 21277.255296064563, 21532.13871445125, 18470.353537626117, 18760.343387981356, 18892.716609250598, 19027.524311892314, 19105.426837194907, 19022.524436889187, 19110.23559057622, 19140.425787226406, 19257.614847703248, 19419.0, 18670.346537871108, 18761.906190469508, 18862.24551017944, 18913.054347282305, 19082.904585476983, 12595.496180152692, 12830.87169128334, 12925.54760583375, 12977.091603587658, 13005.089643724848, 14135.0, 14509.129452232477, 14517.346719397863, 14602.269886505419, 14626.0], "value": 9843.491020492274, "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": [109.0, 107.0, 106.0, 106.0, 107.0, 106.0, 108.0, 107.0, 105.0, 105.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 110.0, 112.0, 144.0, 112.0, 140.0, 114.0, 119.0, 119.0], "value": 119.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 164.0, 162.0, 163.0, 166.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 85.0, 74.0, 73.0, 72.0, 73.0, 73.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 78.0, 77.0, 84.0, 78.0, 78.0, 82.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 110.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 151.0, 148.0, 149.0, 152.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 99.0, 93.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 45.0, 44.0, 46.0, 48.0, 50.0, 45.0, 44.0, 43.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0, 38.0, 38.0, 38.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 73.0, 75.0, 70.0, 73.0, 71.0, 70.0, 72.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 109.0, 109.0, 105.0, 106.0, 105.0, 114.0, 111.0, 106.0], "value": 108.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 156.0, 153.0, 157.0, 155.0, 157.0, 151.0, 155.0, 154.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 59.0, 59.0, 59.0, 60.0, 60.0, 63.0, 60.0, 59.0, 58.0], "value": 60.1, "unit": "score"}]}]} 12:11:55 INFO - Return code: 0 12:11:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:11:55 INFO - # TBPL SUCCESS # 12:11:55 INFO - Running post-action listener: _package_coverage_data 12:11:55 INFO - Running post-action listener: _resource_record_post_action 12:11:55 INFO - [mozharness: 2017-09-18 19:11:55.328011Z] Finished run-tests step (success) 12:11:55 INFO - Running post-run listener: _resource_record_post_run 12:11:55 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 319291392; Read time: 0; Write time: 208772 12:11:55 INFO - TinderboxPrint: CPU usage
13.0% 12:11:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:11:55 INFO - TinderboxPrint: I/O write bytes / time
319,291,392 / 208,772 12:11:55 INFO - TinderboxPrint: CPU idle
8,208.1 (86.9%) 12:11:55 INFO - TinderboxPrint: CPU user
1,185.7 (12.6%) 12:11:55 INFO - TinderboxPrint: Swap in / out
0 / 0 12:11:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9752576; Read time: 0; Write time: 784 12:11:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:11:55 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 308514816; Read time: 0; Write time: 207968 12:11:55 INFO - Running post-run listener: _upload_blobber_files 12:11:55 INFO - Blob upload gear active. 12:11:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:11:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:57 INFO - (blobuploader) - INFO - Done attempting. 12:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:58 INFO - (blobuploader) - INFO - Done attempting. 12:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:01 INFO - (blobuploader) - INFO - Done attempting. 12:12:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:12:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:12:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:02 INFO - (blobuploader) - INFO - Done attempting. 12:12:02 INFO - (blobuploader) - INFO - Iteration through files over. 12:12:02 INFO - Return code: 0 12:12:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:12:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:12:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12debc9e24b6b70ea5b6e8a4afa791f5824e85ca007b2524896c5cac121180a499032ed2540f4007c6d8ee1e1767829b35636e76c9b2b796c1dda209ed7c37e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d2e3e16dc07764de7e6d3c52f7b10838f4c865d28ec7c2fd4c22e088fd1624b9cf13879504d6e913417fd6a0fb48dc1fcbbdda60a41674d519890685795f6b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de13bb010642c0b2930404123a1f4830548106c38e195edddd639ba831829bc3eaa16cf0b9da174a0732603d3e2130a31aedacd10c9ab2098e822a5b7567a4b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55ccf8019def4b1663f6ca0865e000f3230cc8627c47fda215e3ff78e8dd788774ede39a426936e7c1763ab12f5c03d568a3293abf8f37acc1705fb89f6a93d1"} 12:12:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:12:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:12:02 INFO - Contents: 12:12:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12debc9e24b6b70ea5b6e8a4afa791f5824e85ca007b2524896c5cac121180a499032ed2540f4007c6d8ee1e1767829b35636e76c9b2b796c1dda209ed7c37e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d2e3e16dc07764de7e6d3c52f7b10838f4c865d28ec7c2fd4c22e088fd1624b9cf13879504d6e913417fd6a0fb48dc1fcbbdda60a41674d519890685795f6b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de13bb010642c0b2930404123a1f4830548106c38e195edddd639ba831829bc3eaa16cf0b9da174a0732603d3e2130a31aedacd10c9ab2098e822a5b7567a4b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55ccf8019def4b1663f6ca0865e000f3230cc8627c47fda215e3ff78e8dd788774ede39a426936e7c1763ab12f5c03d568a3293abf8f37acc1705fb89f6a93d1"} 12:12:02 INFO - Running post-run listener: copy_logs_to_upload_dir 12:12:02 INFO - Copying logs to upload dir... 12:12:02 INFO - mkdir: /builds/slave/test/build/upload/logs 12:12:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.595011 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-18 12:12:02.961835) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:02.965748) ========= 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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 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/12debc9e24b6b70ea5b6e8a4afa791f5824e85ca007b2524896c5cac121180a499032ed2540f4007c6d8ee1e1767829b35636e76c9b2b796c1dda209ed7c37e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d2e3e16dc07764de7e6d3c52f7b10838f4c865d28ec7c2fd4c22e088fd1624b9cf13879504d6e913417fd6a0fb48dc1fcbbdda60a41674d519890685795f6b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de13bb010642c0b2930404123a1f4830548106c38e195edddd639ba831829bc3eaa16cf0b9da174a0732603d3e2130a31aedacd10c9ab2098e822a5b7567a4b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55ccf8019def4b1663f6ca0865e000f3230cc8627c47fda215e3ff78e8dd788774ede39a426936e7c1763ab12f5c03d568a3293abf8f37acc1705fb89f6a93d1"} build_url:https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011911 build_url: 'https://queue.taskcluster.net/v1/task/SCsIEorPRfqct5c1S2alwA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12debc9e24b6b70ea5b6e8a4afa791f5824e85ca007b2524896c5cac121180a499032ed2540f4007c6d8ee1e1767829b35636e76c9b2b796c1dda209ed7c37e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76d2e3e16dc07764de7e6d3c52f7b10838f4c865d28ec7c2fd4c22e088fd1624b9cf13879504d6e913417fd6a0fb48dc1fcbbdda60a41674d519890685795f6b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8de13bb010642c0b2930404123a1f4830548106c38e195edddd639ba831829bc3eaa16cf0b9da174a0732603d3e2130a31aedacd10c9ab2098e822a5b7567a4b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55ccf8019def4b1663f6ca0865e000f3230cc8627c47fda215e3ff78e8dd788774ede39a426936e7c1763ab12f5c03d568a3293abf8f37acc1705fb89f6a93d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:02.996753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:02.997113) ========= 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=523ca41ca1e0623de333ad52000001bf-1505753887.612903-1190236928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 12:12:03.080791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 12:12:03.081167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 12:12:03.081582) ========= ========= Total master_lag: 0.21 =========