builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-016 starttime: 1505066782.71 results: success (0) revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.710727) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.711207) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.711677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.761077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.761378) ========= 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=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-10 11:06:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-10 11:06:22 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.909432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.909790) ========= 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=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.959332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:22.959709) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd87bb184e299fec695f69bd2977276c25719b98 --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 fd87bb184e299fec695f69bd2977276c25719b98 --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=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-10 11:06:23,022 truncating revision to first 12 chars 2017-09-10 11:06:23,022 Setting DEBUG logging. 2017-09-10 11:06:23,022 attempt 1/10 2017-09-10 11:06:23,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd87bb184e29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-10 11:06:23,584 unpacking tar archive at: mozilla-central-fd87bb184e29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.817163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.817475) ========= script_repo_revision: fd87bb184e299fec695f69bd2977276c25719b98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.817850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.818119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-10 11:06:23.831529) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-10 11:06:23.831821) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:24 INFO - MultiFileLogger online at 20170910 11:06:24 in /builds/slave/test 11:06:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:24 INFO - {'append_to_log': False, 11:06:24 INFO - 'base_work_dir': '/builds/slave/test', 11:06:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:24 INFO - 'branch': 'Firefox-Non-PGO', 11:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:24 INFO - 'code_coverage': False, 11:06:24 INFO - 'config_files': ('talos/linux_config.py',), 11:06:24 INFO - 'default_actions': ('clobber', 11:06:24 INFO - 'read-buildbot-config', 11:06:24 INFO - 'download-and-extract', 11:06:24 INFO - 'populate-webroot', 11:06:24 INFO - 'create-virtualenv', 11:06:24 INFO - 'install', 11:06:24 INFO - 'setup-mitmproxy', 11:06:24 INFO - 'run-tests'), 11:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:24 INFO - 'disable_ccov_upload': False, 11:06:24 INFO - 'disable_stylo': False, 11:06:24 INFO - 'download_minidump_stackwalk': True, 11:06:24 INFO - 'download_symbols': 'ondemand', 11:06:24 INFO - 'enable_stylo': False, 11:06:24 INFO - 'enable_webrender': False, 11:06:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:24 INFO - 'gecko_profile': False, 11:06:24 INFO - 'gecko_profile_interval': 0, 11:06:24 INFO - 'installer_path': 'installer.exe', 11:06:24 INFO - 'log_level': 'info', 11:06:24 INFO - 'log_name': 'talos', 11:06:24 INFO - 'log_to_console': True, 11:06:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:24 INFO - 'opt_config_files': (), 11:06:24 INFO - 'pip_index': False, 11:06:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:06:24 INFO - 'system_bits': '32', 11:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:24 INFO - 'title': 'talos-linux64-ix-016', 11:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:24 INFO - 'use_talos_json': True, 11:06:24 INFO - 'verify': 'False', 11:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:24 INFO - 'work_dir': 'build'} 11:06:24 INFO - [mozharness: 2017-09-10 18:06:24.033151Z] Running clobber step. 11:06:24 INFO - Running pre-action listener: _resource_record_pre_action 11:06:24 INFO - Running main action method: clobber 11:06:24 INFO - rmtree: /builds/slave/test/build 11:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:25 INFO - Running post-action listener: _resource_record_post_action 11:06:25 INFO - [mozharness: 2017-09-10 18:06:25.051356Z] Finished clobber step (success) 11:06:25 INFO - [mozharness: 2017-09-10 18:06:25.051453Z] Running read-buildbot-config step. 11:06:25 INFO - Running pre-action listener: _resource_record_pre_action 11:06:25 INFO - Running main action method: read_buildbot_config 11:06:25 INFO - Using buildbot properties: 11:06:25 INFO - { 11:06:25 INFO - "project": "", 11:06:25 INFO - "product": "firefox", 11:06:25 INFO - "who": "ffxbld@noreply.mozilla.org", 11:06:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:06:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:06:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:06:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:06:25 INFO - "stage_platform": "linux64", 11:06:25 INFO - "basedir": "/builds/slave/test", 11:06:25 INFO - "buildnumber": 7, 11:06:25 INFO - "platform": "ubuntu64_hw", 11:06:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:25 INFO - "slavebuilddir": "test", 11:06:25 INFO - "taskId": "O31AttxDSxyrHGn9CZx1DQ", 11:06:25 INFO - "branch": "mozilla-central", 11:06:25 INFO - "script_repo_revision": "production", 11:06:25 INFO - "revision": "fd87bb184e299fec695f69bd2977276c25719b98", 11:06:25 INFO - "slavename": "talos-linux64-ix-016", 11:06:25 INFO - "repo_path": "mozilla-central" 11:06:25 INFO - } 11:06:25 INFO - Finding installer, test and symbols from parent task. 11:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O31AttxDSxyrHGn9CZx1DQ'}, attempt #1 11:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O31AttxDSxyrHGn9CZx1DQ'}, attempt #1 11:06:25 INFO - Task dependencies: UZWMEdQaTLGG8H3YMvQkdw 11:06:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw'}, attempt #1 11:06:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json 11:06:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip 11:06:26 INFO - Running post-action listener: _resource_record_post_action 11:06:26 INFO - [mozharness: 2017-09-10 18:06:26.418256Z] Finished read-buildbot-config step (success) 11:06:26 INFO - [mozharness: 2017-09-10 18:06:26.418474Z] Running download-and-extract step. 11:06:26 INFO - Running pre-action listener: _resource_record_pre_action 11:06:26 INFO - Running main action method: download_and_extract 11:06:26 INFO - mkdir: /builds/slave/test/build/tests 11:06:26 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:06:26 INFO - trying https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json 11:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:06:27 INFO - Downloaded 989 bytes. 11:06:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:06:27 INFO - Using the following test package requirements: 11:06:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:06:27 INFO - u'common': [u'target.common.tests.zip'], 11:06:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:06:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:06:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:06:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:06:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:06:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:06:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:06:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:06:27 INFO - u'target.web-platform.tests.tar.gz'], 11:06:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:06:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:06:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip 11:06:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:06:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.common.tests.zip into memory 11:06:28 INFO - Content-Length response header: 55028530 11:06:28 INFO - Bytes received: 55028530 11:06:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip 11:06:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:06:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.talos.tests.zip into memory 11:06:40 INFO - Content-Length response header: 14497963 11:06:40 INFO - Bytes received: 14497963 11:06:40 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:06:40 INFO - trying https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:40 INFO - Downloading https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:06:43 INFO - Downloaded 62940438 bytes. 11:06:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:43 INFO - mkdir: /builds/slave/test/properties 11:06:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:43 INFO - Contents: 11:06:43 INFO - build_url:https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 11:06:43 INFO - Running post-action listener: _resource_record_post_action 11:06:43 INFO - Running post-action listener: find_tests_for_verification 11:06:43 INFO - Running post-action listener: set_extra_try_arguments 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.781217Z] Finished download-and-extract step (success) 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.781493Z] Running populate-webroot step. 11:06:43 INFO - Running pre-action listener: _resource_record_pre_action 11:06:43 INFO - Running main action method: populate_webroot 11:06:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tresize', 11:06:43 INFO - 'tcanvasmark']}, 11:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['dromaeo_css', 11:06:43 INFO - 'kraken']}, 11:06:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['damp', 'tps']}, 11:06:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['damp', 'tps']}, 11:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['dromaeo_dom']}, 11:06:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:06:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['basic_compositor_video', 11:06:43 INFO - 'glvideo']}, 11:06:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:06:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['ts_paint_webext', 11:06:43 INFO - 'tp5o_webext']}, 11:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:43 INFO - 'ts_paint', 11:06:43 INFO - 'tpaint', 11:06:43 INFO - 'sessionrestore', 11:06:43 INFO - 'sessionrestore_many_windows', 11:06:43 INFO - 'sessionrestore_no_auto_restore', 11:06:43 INFO - 'tabpaint']}, 11:06:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['a11yr', 11:06:43 INFO - 'ts_paint', 11:06:43 INFO - 'tpaint', 11:06:43 INFO - 'sessionrestore', 11:06:43 INFO - 'sessionrestore_many_windows', 11:06:43 INFO - 'sessionrestore_no_auto_restore', 11:06:43 INFO - 'tabpaint']}, 11:06:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:06:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:06:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['bloom_basic_singleton']}, 11:06:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['bloom_basic']}, 11:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:43 INFO - 'tsvgr_opacity', 11:06:43 INFO - 'tart', 11:06:43 INFO - 'tscrollx', 11:06:43 INFO - 'tsvg_static']}, 11:06:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tsvgx', 11:06:43 INFO - 'tsvgr_opacity', 11:06:43 INFO - 'tart', 11:06:43 INFO - 'tscrollx', 11:06:43 INFO - 'tsvg_static']}, 11:06:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:06:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo'], 11:06:43 INFO - 'tests': ['tp5o']}, 11:06:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo', 11:06:43 INFO - '--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:06:43 INFO - 'talos_options': ['--stylo-threads=1', 11:06:43 INFO - '--mitmproxy', 11:06:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:06:43 INFO - '--firstNonBlankPaint'], 11:06:43 INFO - 'tests': ['tp6_google', 11:06:43 INFO - 'tp6_youtube', 11:06:43 INFO - 'tp6_amazon', 11:06:43 INFO - 'tp6_facebook']}, 11:06:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--xperf_path', 11:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:43 INFO - 'tests': ['tp5n']}, 11:06:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:06:43 INFO - 'talos_options': ['--disable-stylo', 11:06:43 INFO - '--xperf_path', 11:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:43 INFO - 'tests': ['tp5n']}}} 11:06:43 INFO - Running post-action listener: _resource_record_post_action 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.799806Z] Finished populate-webroot step (success) 11:06:43 INFO - [mozharness: 2017-09-10 18:06:43.799915Z] Running create-virtualenv step. 11:06:43 INFO - Running pre-action listener: _resource_record_pre_action 11:06:43 INFO - Running main action method: create_virtualenv 11:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:06:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:06:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:45 INFO - Installing pip...............done. 11:06:45 INFO - Return code: 0 11:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:06:45 INFO - Reading from file tmpfile_stdout 11:06:45 INFO - Output received: 11:06:45 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:06:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:45 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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:45 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:06:45 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:06:45 INFO - Using env: {'DISPLAY': ':0', 11:06:45 INFO - 'HOME': '/home/cltbld', 11:06:45 INFO - 'LANG': 'en_US.UTF-8', 11:06:45 INFO - 'LANGUAGE': 'en_US:en', 11:06:45 INFO - 'LOGNAME': 'cltbld', 11:06:45 INFO - 'MAIL': '/var/mail/cltbld', 11:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:45 INFO - 'MOZ_NO_REMOTE': '1', 11:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:45 INFO - 'NO_EM_RESTART': '1', 11:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:45 INFO - 'PWD': '/builds/slave/test', 11:06:45 INFO - 'SHELL': '/bin/bash', 11:06:45 INFO - 'SHLVL': '1', 11:06:45 INFO - 'TERM': 'linux', 11:06:45 INFO - 'TMOUT': '86400', 11:06:45 INFO - 'USER': 'cltbld', 11:06:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:45 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:06:46 INFO - Downloading/unpacking pip>=1.5 11:06:46 INFO - Running setup.py egg_info for package pip 11:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:46 INFO - Installing collected packages: pip 11:06:46 INFO - Found existing installation: pip 1.1 11:06:46 INFO - Uninstalling pip: 11:06:46 INFO - Successfully uninstalled pip 11:06:46 INFO - Running setup.py install for pip 11:06:46 INFO - warning: no files found matching 'pip/cacert.pem' 11:06:46 INFO - warning: no files found matching '*.html' under directory 'docs' 11:06:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:06:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:06:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:06:46 INFO - Successfully installed pip 11:06:46 INFO - Cleaning up... 11:06:46 INFO - Return code: 0 11:06:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:46 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:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:46 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:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:46 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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:46 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:06:46 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:06:46 INFO - Using env: {'DISPLAY': ':0', 11:06:46 INFO - 'HOME': '/home/cltbld', 11:06:46 INFO - 'LANG': 'en_US.UTF-8', 11:06:46 INFO - 'LANGUAGE': 'en_US:en', 11:06:46 INFO - 'LOGNAME': 'cltbld', 11:06:46 INFO - 'MAIL': '/var/mail/cltbld', 11:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:46 INFO - 'MOZ_NO_REMOTE': '1', 11:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:46 INFO - 'NO_EM_RESTART': '1', 11:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:46 INFO - 'PWD': '/builds/slave/test', 11:06:46 INFO - 'SHELL': '/bin/bash', 11:06:46 INFO - 'SHLVL': '1', 11:06:46 INFO - 'TERM': 'linux', 11:06:46 INFO - 'TMOUT': '86400', 11:06:46 INFO - 'USER': 'cltbld', 11:06:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:46 INFO - '_': '/tools/buildbot/bin/python'} 11:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:46 INFO - Downloading/unpacking psutil>=3.1.1 11:06:46 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:06:46 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:06:46 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:06:46 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:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:47 INFO - Installing collected packages: psutil 11:06:47 INFO - Running setup.py install for psutil 11:06:47 INFO - building 'psutil._psutil_linux' extension 11:06:47 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:06:48 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:06:48 INFO - building 'psutil._psutil_posix' extension 11:06:48 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:06:48 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:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:48 INFO - Successfully installed psutil 11:06:48 INFO - Cleaning up... 11:06:48 INFO - Return code: 0 11:06:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06: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:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:06:48 INFO - Using env: {'DISPLAY': ':0', 11:06:48 INFO - 'HOME': '/home/cltbld', 11:06:48 INFO - 'LANG': 'en_US.UTF-8', 11:06:48 INFO - 'LANGUAGE': 'en_US:en', 11:06:48 INFO - 'LOGNAME': 'cltbld', 11:06:48 INFO - 'MAIL': '/var/mail/cltbld', 11:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:48 INFO - 'MOZ_NO_REMOTE': '1', 11:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:48 INFO - 'NO_EM_RESTART': '1', 11:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:48 INFO - 'PWD': '/builds/slave/test', 11:06:48 INFO - 'SHELL': '/bin/bash', 11:06:48 INFO - 'SHLVL': '1', 11:06:48 INFO - 'TERM': 'linux', 11:06:48 INFO - 'TMOUT': '86400', 11:06:48 INFO - 'USER': 'cltbld', 11:06:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:48 INFO - '_': '/tools/buildbot/bin/python'} 11:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:48 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:06:48 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:06:48 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:06:48 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:06:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:49 INFO - Installing collected packages: mozsystemmonitor 11:06:49 INFO - Running setup.py install for mozsystemmonitor 11:06:49 INFO - Successfully installed mozsystemmonitor 11:06:49 INFO - Cleaning up... 11:06:50 INFO - Return code: 0 11:06:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06: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:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06: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:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06: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', '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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:06: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 jsonschema==2.5.1 11:06:50 INFO - Using env: {'DISPLAY': ':0', 11:06:50 INFO - 'HOME': '/home/cltbld', 11:06:50 INFO - 'LANG': 'en_US.UTF-8', 11:06:50 INFO - 'LANGUAGE': 'en_US:en', 11:06:50 INFO - 'LOGNAME': 'cltbld', 11:06:50 INFO - 'MAIL': '/var/mail/cltbld', 11:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:50 INFO - 'MOZ_NO_REMOTE': '1', 11:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:50 INFO - 'NO_EM_RESTART': '1', 11:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:50 INFO - 'PWD': '/builds/slave/test', 11:06:50 INFO - 'SHELL': '/bin/bash', 11:06:50 INFO - 'SHLVL': '1', 11:06:50 INFO - 'TERM': 'linux', 11:06:50 INFO - 'TMOUT': '86400', 11:06:50 INFO - 'USER': 'cltbld', 11:06:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:50 INFO - '_': '/tools/buildbot/bin/python'} 11:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06: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:06: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:06: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:06: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:06:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:51 INFO - warning: no files found matching '*.txt' 11:06:51 INFO - no previously-included directories found matching 'build' 11:06:51 INFO - no previously-included directories found matching 'dist' 11:06:51 INFO - no previously-included directories found matching '.git*' 11:06:51 INFO - Installing collected packages: jsonschema, functools32 11:06:51 INFO - Running setup.py install for functools32 11:06:52 INFO - warning: no files found matching '*.txt' 11:06:52 INFO - no previously-included directories found matching 'build' 11:06:52 INFO - no previously-included directories found matching 'dist' 11:06:52 INFO - no previously-included directories found matching '.git*' 11:06:52 INFO - Successfully installed jsonschema functools32 11:06:52 INFO - Cleaning up... 11:06:52 INFO - Return code: 0 11:06:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:06:52 INFO - Using env: {'DISPLAY': ':0', 11:06:52 INFO - 'HOME': '/home/cltbld', 11:06:52 INFO - 'LANG': 'en_US.UTF-8', 11:06:52 INFO - 'LANGUAGE': 'en_US:en', 11:06:52 INFO - 'LOGNAME': 'cltbld', 11:06:52 INFO - 'MAIL': '/var/mail/cltbld', 11:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:52 INFO - 'MOZ_NO_REMOTE': '1', 11:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:52 INFO - 'NO_EM_RESTART': '1', 11:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:52 INFO - 'PWD': '/builds/slave/test', 11:06:52 INFO - 'SHELL': '/bin/bash', 11:06:52 INFO - 'SHLVL': '1', 11:06:52 INFO - 'TERM': 'linux', 11:06:52 INFO - 'TMOUT': '86400', 11:06:52 INFO - 'USER': 'cltbld', 11:06:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:52 INFO - '_': '/tools/buildbot/bin/python'} 11:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:52 INFO - Cleaning up... 11:06:52 INFO - Return code: 0 11:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:06:52 INFO - Using env: {'DISPLAY': ':0', 11:06:52 INFO - 'HOME': '/home/cltbld', 11:06:52 INFO - 'LANG': 'en_US.UTF-8', 11:06:52 INFO - 'LANGUAGE': 'en_US:en', 11:06:52 INFO - 'LOGNAME': 'cltbld', 11:06:52 INFO - 'MAIL': '/var/mail/cltbld', 11:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:52 INFO - 'MOZ_NO_REMOTE': '1', 11:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:52 INFO - 'NO_EM_RESTART': '1', 11:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:52 INFO - 'PWD': '/builds/slave/test', 11:06:52 INFO - 'SHELL': '/bin/bash', 11:06:52 INFO - 'SHLVL': '1', 11:06:52 INFO - 'TERM': 'linux', 11:06:52 INFO - 'TMOUT': '86400', 11:06:52 INFO - 'USER': 'cltbld', 11:06:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:52 INFO - '_': '/tools/buildbot/bin/python'} 11:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06: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:06: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:06: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:06: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:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:54 INFO - Downloading docopt-0.6.1.tar.gz 11:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:54 INFO - Running setup.py install for blobuploader 11:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:54 INFO - Running setup.py install for requests 11:06:54 INFO - Running setup.py install for docopt 11:06:54 INFO - Successfully installed blobuploader requests docopt 11:06:54 INFO - Cleaning up... 11:06:54 INFO - Return code: 0 11:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:54 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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 11:06:54 INFO - 'HOME': '/home/cltbld', 11:06:54 INFO - 'LANG': 'en_US.UTF-8', 11:06:54 INFO - 'LANGUAGE': 'en_US:en', 11:06:54 INFO - 'LOGNAME': 'cltbld', 11:06:54 INFO - 'MAIL': '/var/mail/cltbld', 11:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:54 INFO - 'MOZ_NO_REMOTE': '1', 11:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:54 INFO - 'NO_EM_RESTART': '1', 11:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:54 INFO - 'PWD': '/builds/slave/test', 11:06:54 INFO - 'SHELL': '/bin/bash', 11:06:54 INFO - 'SHLVL': '1', 11:06:54 INFO - 'TERM': 'linux', 11:06:54 INFO - 'TMOUT': '86400', 11:06:54 INFO - 'USER': 'cltbld', 11:06:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:54 INFO - '_': '/tools/buildbot/bin/python'} 11:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 INFO - Running setup.py (path:/tmp/pip-6QAgGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 INFO - Running setup.py (path:/tmp/pip-qOXnV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 INFO - Running setup.py (path:/tmp/pip-R6RfW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Running setup.py (path:/tmp/pip-bPPUPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:55 INFO - Running setup.py (path:/tmp/pip-tx8YTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:55 INFO - Running setup.py (path:/tmp/pip-AEZPD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:55 INFO - Running setup.py (path:/tmp/pip-BsCP32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:55 INFO - Running setup.py (path:/tmp/pip-RPWBKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:55 INFO - Running setup.py (path:/tmp/pip-y79qwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:55 INFO - Running setup.py (path:/tmp/pip-qRm3aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:55 INFO - Running setup.py (path:/tmp/pip-w6Ci3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:55 INFO - Running setup.py (path:/tmp/pip-VyCjmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:55 INFO - Running setup.py (path:/tmp/pip-4aVEeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:55 INFO - Running setup.py (path:/tmp/pip-nsp0QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 INFO - Running setup.py (path:/tmp/pip-XeFoot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:56 INFO - Running setup.py (path:/tmp/pip-uLC8YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:56 INFO - Running setup.py (path:/tmp/pip-o2YhA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:56 INFO - Running setup.py install for manifestparser 11:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:56 INFO - Running setup.py install for mozcrash 11:06:56 INFO - Running setup.py install for mozdebug 11:06:56 INFO - Running setup.py install for mozdevice 11:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:56 INFO - Running setup.py install for mozfile 11:06:56 INFO - Running setup.py install for mozhttpd 11:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:56 INFO - Running setup.py install for mozinfo 11:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:56 INFO - Running setup.py install for mozInstall 11:06:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozleak 11:06:57 INFO - Running setup.py install for mozlog 11:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for moznetwork 11:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozprocess 11:06:57 INFO - Running setup.py install for mozprofile 11:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozrunner 11:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Running setup.py install for mozscreenshot 11:06:57 INFO - Running setup.py install for moztest 11:06:57 INFO - Running setup.py install for mozversion 11:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:57 INFO - Cleaning up... 11:06:57 INFO - Return code: 0 11:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:57 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:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:57 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:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:58 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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:06:58 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:06:58 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:06:58 INFO - Using env: {'DISPLAY': ':0', 11:06:58 INFO - 'HOME': '/home/cltbld', 11:06:58 INFO - 'LANG': 'en_US.UTF-8', 11:06:58 INFO - 'LANGUAGE': 'en_US:en', 11:06:58 INFO - 'LOGNAME': 'cltbld', 11:06:58 INFO - 'MAIL': '/var/mail/cltbld', 11:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:58 INFO - 'MOZ_NO_REMOTE': '1', 11:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:58 INFO - 'NO_EM_RESTART': '1', 11:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:58 INFO - 'PWD': '/builds/slave/test', 11:06:58 INFO - 'SHELL': '/bin/bash', 11:06:58 INFO - 'SHLVL': '1', 11:06:58 INFO - 'TERM': 'linux', 11:06:58 INFO - 'TMOUT': '86400', 11:06:58 INFO - 'USER': 'cltbld', 11:06:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:58 INFO - '_': '/tools/buildbot/bin/python'} 11:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:58 INFO - Running setup.py (path:/tmp/pip-VVc8az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:58 INFO - Running setup.py (path:/tmp/pip-wrx1s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:58 INFO - Running setup.py (path:/tmp/pip-25zWGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:58 INFO - Running setup.py (path:/tmp/pip-tqd5Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:58 INFO - Running setup.py (path:/tmp/pip-x42pao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:58 INFO - Running setup.py (path:/tmp/pip-DpVxOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:58 INFO - Running setup.py (path:/tmp/pip-Bo5gO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:58 INFO - Running setup.py (path:/tmp/pip-1zL4wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:58 INFO - Running setup.py (path:/tmp/pip-lNL1J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:58 INFO - Running setup.py (path:/tmp/pip-sjeEiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:58 INFO - Running setup.py (path:/tmp/pip-46RKft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:59 INFO - Running setup.py (path:/tmp/pip-_KPZ28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:59 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:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:59 INFO - Running setup.py (path:/tmp/pip-JzpbWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:59 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:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:59 INFO - Running setup.py (path:/tmp/pip-RuUBPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:59 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:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:59 INFO - Running setup.py (path:/tmp/pip-0nPV2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:59 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:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:59 INFO - Running setup.py (path:/tmp/pip-FJd5D5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:59 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:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:59 INFO - Running setup.py (path:/tmp/pip-hhYVnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 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:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06: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:06: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:06: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:06: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:07:00 INFO - Downloading blessings-1.6.tar.gz 11:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:00 INFO - Installing collected packages: blessings 11:07:00 INFO - Running setup.py install for blessings 11:07:00 INFO - Successfully installed blessings 11:07:00 INFO - Cleaning up... 11:07:00 INFO - Return code: 0 11:07:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:00 INFO - Reading from file tmpfile_stdout 11:07:00 INFO - Current package versions: 11:07:00 INFO - argparse == 1.2.1 11:07:00 INFO - blessings == 1.6 11:07:00 INFO - blobuploader == 1.2.4 11:07:00 INFO - docopt == 0.6.1 11:07:00 INFO - functools32 == 3.2.3-2 11:07:00 INFO - jsonschema == 2.5.1 11:07:00 INFO - manifestparser == 1.1 11:07:00 INFO - mozInstall == 1.13 11:07:00 INFO - mozcrash == 1.0 11:07:00 INFO - mozdebug == 0.1 11:07:00 INFO - mozdevice == 0.51 11:07:00 INFO - mozfile == 1.2 11:07:00 INFO - mozhttpd == 0.7 11:07:00 INFO - mozinfo == 0.10 11:07:00 INFO - mozleak == 0.1 11:07:00 INFO - mozlog == 3.5 11:07:00 INFO - moznetwork == 0.27 11:07:00 INFO - mozprocess == 0.25 11:07:00 INFO - mozprofile == 0.28 11:07:00 INFO - mozrunner == 6.13 11:07:00 INFO - mozscreenshot == 0.1 11:07:00 INFO - mozsystemmonitor == 0.3 11:07:00 INFO - moztest == 0.8 11:07:00 INFO - mozversion == 1.4 11:07:00 INFO - psutil == 3.1.1 11:07:00 INFO - requests == 1.2.3 11:07:00 INFO - wsgiref == 0.1.2 11:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:00 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 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:07:00 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:07:00 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:07:00 INFO - Using env: {'DISPLAY': ':0', 11:07:00 INFO - 'HOME': '/home/cltbld', 11:07:00 INFO - 'LANG': 'en_US.UTF-8', 11:07:00 INFO - 'LANGUAGE': 'en_US:en', 11:07:00 INFO - 'LOGNAME': 'cltbld', 11:07:00 INFO - 'MAIL': '/var/mail/cltbld', 11:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:00 INFO - 'MOZ_NO_REMOTE': '1', 11:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:00 INFO - 'NO_EM_RESTART': '1', 11:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:00 INFO - 'PWD': '/builds/slave/test', 11:07:00 INFO - 'SHELL': '/bin/bash', 11:07:00 INFO - 'SHLVL': '1', 11:07:00 INFO - 'TERM': 'linux', 11:07:00 INFO - 'TMOUT': '86400', 11:07:00 INFO - 'USER': 'cltbld', 11:07:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:00 INFO - '_': '/tools/buildbot/bin/python'} 11:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:07: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:07: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:07: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:07: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:07:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:07:02 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:07:02 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:07:02 INFO - Installing collected packages: simplejson 11:07:02 INFO - Running setup.py install for simplejson 11:07:02 INFO - building 'simplejson._speedups' extension 11:07:02 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:07:03 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:07:03 INFO - Successfully installed simplejson 11:07:03 INFO - Cleaning up... 11:07:03 INFO - Return code: 0 11:07:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1823a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, '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': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', '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:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:07:03 INFO - Using env: {'DISPLAY': ':0', 11:07:03 INFO - 'HOME': '/home/cltbld', 11:07:03 INFO - 'LANG': 'en_US.UTF-8', 11:07:03 INFO - 'LANGUAGE': 'en_US:en', 11:07:03 INFO - 'LOGNAME': 'cltbld', 11:07:03 INFO - 'MAIL': '/var/mail/cltbld', 11:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:03 INFO - 'MOZ_NO_REMOTE': '1', 11:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:03 INFO - 'NO_EM_RESTART': '1', 11:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:03 INFO - 'PWD': '/builds/slave/test', 11:07:03 INFO - 'SHELL': '/bin/bash', 11:07:03 INFO - 'SHLVL': '1', 11:07:03 INFO - 'TERM': 'linux', 11:07:03 INFO - 'TMOUT': '86400', 11:07:03 INFO - 'USER': 'cltbld', 11:07:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:03 INFO - '_': '/tools/buildbot/bin/python'} 11:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:03 INFO - Cleaning up... 11:07:03 INFO - Return code: 0 11:07:03 INFO - Running post-action listener: _resource_record_post_action 11:07:03 INFO - Running post-action listener: _start_resource_monitoring 11:07:03 INFO - Starting resource monitoring. 11:07:03 INFO - [mozharness: 2017-09-10 18:07:03.697167Z] Finished create-virtualenv step (success) 11:07:03 INFO - [mozharness: 2017-09-10 18:07:03.697682Z] Running install step. 11:07:03 INFO - Running pre-action listener: _resource_record_pre_action 11:07:03 INFO - Running main action method: install 11:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:03 INFO - Reading from file tmpfile_stdout 11:07:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:04 INFO - Reading from file tmpfile_stdout 11:07:04 INFO - Output received: 11:07:04 INFO - Usage: mozinstall [options] installer 11:07:04 INFO - Options: 11:07:04 INFO - -h, --help show this help message and exit 11:07:04 INFO - -d DEST, --destination=DEST 11:07:04 INFO - Directory to install application into. [default: 11:07:04 INFO - "/builds/slave/test"] 11:07:04 INFO - --app=APP Application being installed. [default: firefox] 11:07:04 INFO - mkdir: /builds/slave/test/build/application 11:07:04 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:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:07:20 INFO - Reading from file tmpfile_stdout 11:07:20 INFO - Output received: 11:07:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:20 INFO - Running post-action listener: _resource_record_post_action 11:07:20 INFO - [mozharness: 2017-09-10 18:07:20.596249Z] Finished install step (success) 11:07:20 INFO - [mozharness: 2017-09-10 18:07:20.596499Z] Running setup-mitmproxy step. 11:07:20 INFO - Running pre-action listener: _resource_record_pre_action 11:07:20 INFO - Running main action method: setup_mitmproxy 11:07:20 INFO - Skipping: mitmproxy is not required 11:07:20 INFO - Running post-action listener: _resource_record_post_action 11:07:20 INFO - [mozharness: 2017-09-10 18:07:20.597687Z] Finished setup-mitmproxy step (success) 11:07:20 INFO - [mozharness: 2017-09-10 18:07:20.597908Z] Running run-tests step. 11:07:20 INFO - Running pre-action listener: _resource_record_pre_action 11:07:20 INFO - Running pre-action listener: _set_gcov_prefix 11:07:20 INFO - Running main action method: run_tests 11:07:20 WARNING - Try message not found. 11:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:20 INFO - Python 2.7.3 11:07:20 INFO - Return code: 0 11:07:20 INFO - grabbing minidump binary from tooltool 11:07:20 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:07:20 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 0x19ca090>, '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 0x19cad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:20 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:07:20 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:07:20 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:07:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:20 INFO - Return code: 0 11:07:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:20 INFO - ENV: RUST_BACKTRACE is now full 11:07:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:20 INFO - 'RUST_BACKTRACE': 'full', 11:07:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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:07:20 INFO - mozversion application_buildid: 20170910171456 11:07:20 INFO - mozversion application_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:07:20 INFO - mozversion application_display_name: Nightly 11:07:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:20 INFO - mozversion application_name: Firefox 11:07:20 INFO - mozversion application_remotingname: firefox 11:07:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:07:20 INFO - mozversion application_vendor: Mozilla 11:07:20 INFO - mozversion application_version: 57.0a1 11:07:20 INFO - mozversion platform_buildid: 20170910171456 11:07:20 INFO - mozversion platform_changeset: fd87bb184e299fec695f69bd2977276c25719b98 11:07:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:07:20 INFO - mozversion platform_version: 57.0a1 11:07:20 INFO - using testdate: 1505066840 11:07:20 INFO - actual date: 1505066840 11:07:20 INFO - starting webserver on 'localhost:39487' 11:07:20 INFO - SUITE-START | Running 2 tests 11:07:20 INFO - TEST-START | dromaeo_css 11:07:20 INFO - Initialising browser for dromaeo_css test... 11:07:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39487/getInfo.html -profile /tmp/tmpsU0md6/profile 11:07:20 INFO - TEST-INFO | started process 5662 (/builds/slave/test/build/application/firefox/firefox http://localhost:39487/getInfo.html) 11:07:26 INFO - TEST-INFO | 5662: exit 0 11:07:26 INFO - Browser initialized. 11:07:26 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:26 INFO - Using env: {'DISPLAY': ':0', 11:07:26 INFO - 'HOME': '/home/cltbld', 11:07:26 INFO - 'JSGC_DISABLE_POISONING': '1', 11:07:26 INFO - 'LANG': 'en_US.UTF-8', 11:07:26 INFO - 'LANGUAGE': 'en_US:en', 11:07:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:07:26 INFO - 'LOGNAME': 'cltbld', 11:07:26 INFO - 'MAIL': '/var/mail/cltbld', 11:07:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:26 INFO - 'MOZ_CRASHREPORTER': '1', 11:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:07:26 INFO - 'MOZ_NO_REMOTE': '1', 11:07:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:26 INFO - 'NO_EM_RESTART': '1', 11:07:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:26 INFO - 'PWD': '/builds/slave/test', 11:07:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:26 INFO - 'RUST_BACKTRACE': 'full', 11:07:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:07:26 INFO - 'SHELL': '/bin/bash', 11:07:26 INFO - 'SHLVL': '1', 11:07:26 INFO - 'STYLO_FORCE_DISABLED': '1', 11:07:26 INFO - 'TERM': 'linux', 11:07:26 INFO - 'TMOUT': '86400', 11:07:26 INFO - 'USER': 'cltbld', 11:07:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:26 INFO - '_': '/tools/buildbot/bin/python'} 11:07:26 INFO - TEST-INFO | started process 5864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsU0md6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:27 INFO - PID 5864 | 11:07:27 INFO - PID 5864 | (/builds/slave/test/build/application/firefox/firefox:5915): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:07:27 INFO - PID 5864 | 11:07:38 INFO - PID 5864 | RSS: Main: 164696064 11:07:38 INFO - PID 5864 | 11:10:34 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39487/tests/dromaeo/cssquery-ext.html) 11:10:35 INFO - PID 5864 | RSS: Main: 171458560 11:10:35 INFO - PID 5864 | 11:13:37 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-ext.html (next: http://localhost:39487/tests/dromaeo/cssquery-jquery.html) 11:13:37 INFO - PID 5864 | RSS: Main: 168599552 11:13:37 INFO - PID 5864 | 11:16:39 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39487/tests/dromaeo/cssquery-mootools.html) 11:16:40 INFO - PID 5864 | RSS: Main: 170143744 11:16:40 INFO - PID 5864 | 11:19:42 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39487/tests/dromaeo/cssquery-prototype.html) 11:19:42 INFO - PID 5864 | RSS: Main: 166473728 11:19:42 INFO - PID 5864 | 11:22:45 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39487/tests/dromaeo/cssquery-yui.html) 11:22:46 INFO - PID 5864 | RSS: Main: 170545152 11:22:46 INFO - PID 5864 | 11:25:47 INFO - PID 5864 | Cycle 1(1): loaded http://localhost:39487/tests/dromaeo/cssquery-yui.html (next: http://localhost:39487/tests/dromaeo/cssquery-dojo.html) 11:25:48 INFO - PID 5864 | RSS: Main: 172797952 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | __start_tp_report 11:25:48 INFO - PID 5864 | _x_x_mozilla_page_load 11:25:48 INFO - PID 5864 | _x_x_mozilla_page_load_details 11:25:48 INFO - PID 5864 | |i|pagename|runs| 11:25:48 INFO - PID 5864 | |0;dojo.html;3137.9372412551747;3144.1353627752364;3152.55864179015;3157.6368717597484;3170.4134735074;6110.266767987837;6227.159333489977;6244.344343843899;6280.968595157024;6356.618602883825;6225.128482012522;6232.034034724614;6234.5324100692515;6266.342034086424;6284.937150628492;5816.651000939936;5869.706514674271;5894.88210235795;5897.764089436418;5920.111983202511;128.16729448388787;5725.112607545837;5772.451617096369;5784.652920824743;5806.129080637896;5264.552513036397;5594.888102237953;5600.5799565032585;5797.797077102281;5809.767609295644;5701.942980570183;5710.628809127435;5773.509251713609;5787.189793428924;5790.565707571949;5705.65766054034;5739.626924249952;5804.8839023219725;5810.360860305363;5818.505427038707;6051.273847138327;6184.257889053342;6252.2809876864285;6264.87470250597;6334.588251763666;6497.545171837974;6633.568818026861;6647.401733843977;6680.231773346079;6749.898751518682;6718.932810671929;6719.0593316935665;6742.52802303839;6743.15710536183;6749.0551322814845;6210.72051757672;6238.376162383725;6279.717412716439;6314.368563143695;6320.557560970734;6903.275156108536;6926.341997510229;6983.511154219156;6990.965045174741;7014.438844892396;6485.286618471964;6579.539432239697;6602.900956485657;6677.799666010027;6682.63245521501;6618.569792963442;6720.495962802809;6800.8299792504595;6802.4217941474535;6814.2163651180745;6696.83257918556;6780.559263647847;6783;6804.21751498584;6819.24988251292;6765.560238584476;6775;6846.726130954806;6857.177138743383;6863.485238607124;5190.169572868398;5273.604479664041;5323.334583177103;5331.44019877915;5339.172428273624;4559.202139625552;4568;4600.6549508786975;4664.043871006435;4675.76621168947;5762.855928601818;5810.157527158538;5822.126680997884;5833.066709326487;5834.183214349994;6727.058211850345;6733.091032710521;6749.291324410866;6754.3245675433045;6821.113255276782;5766.365699773021;5812.883742325214;5817.825465236049;5822.82531524055;5829.300483941955;5797.652140871562;5845.707714614252;5849.853753656107;5850.034744267148;5854.970725146347;6277.2781130170615;6394.712237949303;6424.26120996082;6446.419822215929;6535.803925882231;6768.390844823891;6813.625250611264;6854.5201835873;6856.725730970706;6878.621675807879;6355.809325720235;6405.391487808651;6442.2591401989375;6443.2590252119735;6538.084668146368;6559.245686746085;6567.211934567882;6597.901031484627;6599.142111525471;6616;6789.15135608049;6832.453403727591;6846.178458585002;6860.348266914635;6863.897041544481;6533.346665333429;6536.803895883131;6597.2742998271115;6624.966875165594;6642.43539299165;6479.157709497735;6497.317781632861;6510.056041873996;6587.703553340207;6590.5716128451495;6406.775762848278;6463.741450341934;6466.256380516301;6468.547201696025;6492.610443373413;6513.902291465726;6533.738650453929;6619.503537234823;6622;6633;6176.320604733386;6281.497480201664;6310.495160387066;6380.840478988062;6406 11:25:48 INFO - PID 5864 | |1;ext.html;829.7386323308158;863.1584205399735;887.3699673232003;896.8116695493947;897.4704924094783;39194.804025979865;40107.79946100265;40876.59123408765;40898;40941.59058409415;41284.793576032156;41767.79116104423;41783;41795;41876.79061604695;7675.002249707544;7792.688292468294;7793.298603125718;7802.648880800378;7812.843743125162;7707.807304817368;7776.066871975371;7778.922210777905;7801.1028731696015;7810.531368117931;7768.611569421535;7776.105747838986;7843.764687059369;7854.3716502679645;7859.331956783652;7754.806129846743;7796.298333150044;7805.180456052118;7829.530228186299;7835.177306382805;7630.351420129296;7661.961690191513;7687.115981662125;7687.654055567513;7689.269519395649;37209;37394;37406.43890341647;37459;37534;3453.2920751245933;3481.860725570974;3486.3027394520946;3486.843092060838;3489.8080605566684;31239.219019524466;31329.84335078333;31369.215769605944;31386.843065784753;31388.843055784575;5018.2974383586325;5140.254663073871;5215.217717342391;5215.3741551013745;5217.921731174036;170758;171348;171768;172597;173582;44050.559494404646;44173.77913110414;44376.556234437245;48262.27606585904;48763.26855097176;50296.24555631669;50723.49276507262;50737.23894141591;50752;50808.49191508112;14610.561683149523;14697.26513674312;14746.483873064606;15738.134402607737;16043.358265669476;12689.365531723377;12763.106582539318;12774.68063298425;12781.68045798844;12822.871771282167;14929.178895160654;14972.326245318987;15035.54893353201;15060.698786024219;15212.46756363522;5812.244408226988;5922.851928701731;5954.910676339859;6035.245594300713;6039.973204555148;1004.7287232447198;1004.9748756281151;1007.0533698323552;1009.3943633819796;1011.3577878047346;22394.32817015492;22429.32712018642;22838.31485055451;22865.657015144454;23311.300660980196;1092.945352732376;1094.9124070074374;1109.1459576126338;1115.9888401116048;1118.2060736876747;12071.758564828655;12309.93845030787;12345.876541234473;12353.135280530456;12419;222755;226351;228981;229644;229900;53633;54234.18648720272;54319.45680543144;54414.18378724322;54470.45529544733;1434.411891124634;1455.1850963460283;1458.4968185975822;1459.88320934325;1461.4081297074702;26069.73930260673;26777.33056673599;26821.865890670422;27012.189634311002;27443.31391715223;36761.81619091887;36809.447858282685;36956;37177.44233836549;37230;197453;197473;197605;197903.01048494666;198204;34215.65784342225;34452.48321275233;34487;34488.482672759426;34536.654633454345;41064.58935410727;43116.353254700574;43577.78211108924;43582.56417435912;43772.56227437685;30778;31369.52945705862;31406.214844628154;31423.21441963969;31505.684943150274;30744.692553074183;31032;31375.84312078425;31786.205344866565;32085.83957080293;34911.12722181966;35048;35068.64931350654;35130.64869351274;35253.47119793154;30341.69658303389;30385.24036899095;30457;31098;31227.063188104392;22849.63033687049;22883.77116228883;23023.769762302163;23294.184703535295;23589.764102358757 11:25:48 INFO - PID 5864 | |2;jquery.html;555.6194007105133;557.3089369182215;569.7493103034667;571.1775043936731;579.6029719642045;22314.553708925832;23031.078756849725;23066.19268325609;23092.65361019586;23098.884505577447;23119.653205201892;23961.520769584597;24198.758012419872;24444.38889027775;24567.385815354624;6385.425311721944;6452.548321617489;6485.902711459308;6486.059521369399;6490;6196.504279657616;6376.872462550747;6465.644389558573;6472.029195620671;6484.870302593945;6454.031895215709;6461.06314584385;6464.806055818333;6469.644169570672;6471.676416179196;6307.747690092391;6477.546571739957;6481.967590162066;6483.967580162116;6485.513586481009;6026.9095963560585;6028.577999540034;6034.818955431344;6062.030075187993;6073.635581865102;27237.455250894873;27730;27731.306717332027;27737.167884963485;27805.582916256273;1967.6064787042505;1982.960340793176;1986.5927484865567;1987.5528006198633;1992.402279316214;18723;19136.61726765457;19432.611347773105;19505.414837554898;19634.410967670992;2479.3429741118616;2504.4490212153296;2519.4205332773563;2519.60946053362;2534.4424226670103;115809;121408;127056;133693;136237.999999999;13870.583882483541;13974.231417272147;14354.210518421587;14445.277736113363;14602.707945841024;22115.33653990383;22181.55636887253;22201.888990554944;22208;22232.888835555717;9608.13526782593;9916.157126644172;10008.49957502122;10016.298859079794;10092;9138.725838224864;9154.86267705985;9234.261259099256;9280.675176368795;9307.953460232655;8887.200151986352;8943.686970955985;8974.775630609156;8994.775130621787;9166.08339166078;2716.415970566338;2729.7543221110195;2730.631364765731;2753.6833264174475;2771;941.9764505887408;949.3259785552198;967.7241986033946;970.96601618943;974.7027156717128;18343.082845857654;18875.81124188768;19082.904585476983;19153.329633462763;19366.61266774685;991.712403403005;1014.4623349624711;1021.4637315409469;1026.5688410867454;1029.4183786160795;10320.587176513005;10475.371477711362;10489.842652360221;10527.210459215436;10859.34843909368;413464;419723;422296.8885155555;427362;432268;110226.44886775514;113857;114156.42921785338;114196;115283;1018.9337693050077;1063.4470075560664;1123.4719681749727;1160.158884808524;1176.1943068997764;19636.312729054414;19766.50583735418;19798.40604781859;19905.60188796245;20134.89932550328;50776.74611626918;52301.47698523118;52371.73814130905;52753;53481.465185347646;61502.38497615146;61537;61901;62307;64154.67922660357;13786.586402407944;13911.165330080228;14138.434462621792;14145.222012788983;14149;21806.34580962574;22140;22236.221732239293;22248.221312253994;22280.77719222787;17988.100594969936;18190.818091818914;18282;18318.72521912199;18477.53806154857;15981.520554383387;16465;16465.91767041157;16796.66406671884;17121.914390428465;18265.543361416072;18447.354342597944;18452;18721.15754791065;18802.717959230347;13917.164970101827;13988.860111399163;14011.08927919682;14052.508162214273;14064;18093.185806638998;18098;18102.45692629223;18111.818881811014;18171.54571135732 11:25:48 INFO - PID 5864 | |3;mootools.html;1282.0576875996144;1322.629663694166;1337.6856438736895;1337.732453509298;1352.2022007015871;15048.097114173157;15572.61068473286;15706.842931570682;15718.842811571882;15720.449784257553;15245;15446.768298475532;15494.61263468414;15557.29992150353;15571.766423503628;2719.428919926808;2729.42682036772;2788.9163325100176;2790.1629511146675;2790.8465034423098;2633.1442281258574;2705.9594106088425;2746.5193591121574;2768.2664094015004;2782.9721702783017;2744.917652470429;2782.290515918438;2783.6659600847825;2785.874635641401;2786.4287820996647;2613.425046489769;2617.7382261773764;2636.064197209982;2637.406583518712;2638.4063585693066;2581.0579138614457;2587.3531617095728;2588.831725937827;2595.5976823592373;2602.921912342633;14590.927045364706;14948.62628434287;14975.400983960628;14983.02610330336;15010.849891501055;7776.105747839014;8068;8074.1925807419375;8075.919240807575;8076.798080047987;5010.699358038493;5108.897822043538;5302.443243459458;5321.255024296563;5352.545033672103;1941.8543609229364;1953.804619538049;1974.2793880233755;1985.9503512412161;2012.6578481658153;26164.607530887053;26370.999999999807;26421.471570568672;26451;26468.60297095545;6656.36764507371;6704.7988560343265;6726.327367263332;6836.914741004041;6933.722651094001;17261.741073883903;17355.65288694219;17358.739618905725;17393.304267829146;17412.912935435495;7473.252674732484;7653.6938522459595;7687.654055567513;7689.807754806175;7703.422243331661;6878.828029299308;7055.788326350218;7067.6112813795735;7108.715651373887;7128.714851405989;4867.805287788519;5032.194848824171;5032.748362581856;5071.39143302806;5120.359955005624;1264.563725514696;1300.8682446271614;1404.6769243073945;1441.3081720774087;1473.8305094914008;871.8561437362764;883.969061082859;891.7146513115871;899.7435730816686;901.4636291406603;8577.442466239674;8640.255622956089;8678.826423471495;8719.60761765722;8749.1250874912;998.7852611688377;1000.3397757480028;1001.3441196016621;1011.4740335025746;1016.9745756356002;4734;4861.29511220871;4879.097366987119;5304.946950530522;5334.3865455473115;20573.48566285825;21704.457388565097;21978.560428791334;21984.780152198593;21989.560208796054;20789;21345.89327053386;21460.356189314345;21473.67789483159;21628.243011494837;9899.554520046615;10088.74778130538;10099.242556808269;10140.492975351202;10147.797044059078;8414.410991230556;8446.746597602081;8463;8483.194096560817;8499.8725019126;18262.817371826644;18603.627927441645;18842.246310147442;18996.24015039383;19123.71314430257;18534.536636584195;19068.618627627646;19330.4200873974;19369.159929806647;19879.403617891487;10799.298045627009;11029.44852757343;11142;11143.609973650884;11159.497822598165;13531;13678.179309241477;13678.31608419555;13690.726185476435;13730.794038089636;10446.947765261126;10506.947465262625;10543.367397956146;10543.78912421732;10644.520996555018;10669.35983840972;10737.624183153552;10770.030697237285;10793.568257269935;10925;9285.071492850931;9320.906790932004;9444.85832712496;9466.668666596635;9557.90442095598;7012.509124361246;7196.604186769778;7199.604021778852;7201.13586369618;7201.675924583511;6797;6797.796066118024;6799.93200067993;6931.202911665021;6984 11:25:48 INFO - PID 5864 | |4;prototype.html;498.9166948259755;499.7456827800083;517.8058228164439;524.7271418862192;529.2431822493835;6278.4035516625845;6302.65335406553;6332.683365831707;6341.63654814216;6366.395192456721;6142.723577439015;6209.689515524228;6230.968845155768;6254.718537665804;6258.249010118792;5032.5470707636305;5069.543741063304;5106.31064806252;5118.820841270556;5140.280360749498;4962.131626965267;5047.394312682483;5061.253867415736;5083.068433995077;5104.719240441793;4664.97667511662;4786.832460863853;4819.566239038486;4834.685745426554;4841.298011788289;4781.641376896747;4789.377380940456;4792.017636384533;4857.198562237262;4864.683795553277;4289.356596510517;4342.826286948518;4345.956540434587;4355.629771469397;4363.516404422511;5985.371535988702;6007.128966299906;6064.272287325549;6077.604955677911;6105.542084343692;5489.972550137264;5535.335759708861;5608.523275521586;5613.326400831927;5639.210510528529;6455.644939528324;6504.349565043505;6543.280239173687;6554;6562.606243625398;4523.140603285398;4756.310335001405;4775.641826862964;4814.277858321245;4817.783199755984;6512.479001679902;6647.734090636369;6675.065490831287;6762.391384775345;6776.05135281061;4824.131656301899;4834.7824347904425;4869.415670119608;4876.658633895593;4889.704228379483;4883.902321953612;4899.191633380452;4900.2894580286375;4909.7790599423115;4958.454569997298;5493.786135110925;5513.3108361454815;5513.58648101386;5521.69630670317;5605.579581531401;6601.33986601336;6630.668466576652;6636.7013484392355;6647.368499992493;6662.0340050692375;1713.477389396246;1723.8448539631493;1726.8791184616957;1744.0930716027594;1755.4207111653125;1143.2276728932306;1197.3354788092518;1198.8801119887942;1211.733418647896;1217.6773155113901;5679.545636349082;5688.11834165705;5698.943010569924;5702;5713.22871412354;6606.7026983785845;6641.66791660415;6696.799096027127;6705.564138330993;6714;5665.971670141623;5680.573956953162;5681.375048744635;5687.687177205211;5717.371089180187;3497.527833742463;3505.3339865425487;3517.595476520182;3527.7177825773874;3548.769329993542;6323.52573556985;6397.552171348054;6422.298091005887;6433.613983161025;6445.45213656835;6735.989601559707;6782.559133656297;6793.354631310018;6800.387965083166;6826.965865170642;6363.172787537683;6389.680515974275;6392.424681778569;6394.968025159845;6408.51936104794;6152.723127459186;6539.215294164731;6568.671566421755;6569.080328754074;6687.726173100974;6388.68056597159;6425.903611445926;6546.631761955151;6589.901151482636;6623.039659249285;6256.499480041494;6314.1160237565855;6432.9678351607945;6436.16329877113;6446.194225721785;5259.500347466985;5304.628675992643;5339.46605339463;5345.251664767014;5371.5702743781185;6418.358164183544;6534.4772418205475;6574.638394888327;6668.199816021915;6762;6469.191351081115;6489.3510648934725;6493.318201588954;6522.28254891971;6557.2131344239;6455.806325810233;6468.967655161694;6469.482441404771;6497.480201583768;6510;6434.935650643433;6436.517261205335;6449.419552240321;6487.156669632917;6511.869762604816;6565.770198043046;6587.209534855848;6593.571417857824;6594.373534514213;6625.966870165618;6349.746010159727;6361.93638063632;6366.458850997532;6386.584871983307;6386.840328991812 11:25:48 INFO - PID 5864 | |5;yui.html;903.7650210945154;905.587957479347;907.9954600227002;923.672096405776;934.8177105464435;17603.119844007797;17999.100044997747;18002.09989500523;18059.097045147755;18192.636147277048;16665.66668666629;16858.662826743457;16874.83125168748;17357.21892514837;19263.133159007844;966.3960024984367;981.4749109226565;983.9163671087966;985.374287327545;987.2694206287332;946.8437707778209;958.5638534466835;965.227817745804;972.2805124208106;972.6352617768337;1049.18163832211;1059.179136169467;1059.2691043180182;1059.8569193158903;1061.161682271005;993.92545559083;1014.5992333028413;1016.4409574733867;1056.7622284985855;1059.3326204491198;741.6143605325254;742.1873049011324;744.5309455043342;745.057502259642;746.8095635612938;18235.72646410305;18315.175817088264;18341;18383.540411489685;18398.264069437206;18451.44645660632;18755.718664220047;18811.62376752471;19068.5232869178;20557.177712891615;16554.337826486924;16697.33210671584;16747;17077.7438338425;17090.401835935805;3785.0348161218712;3812.866549670776;3813.2564149990762;3813.5423749150004;3814.4469051987585;133689.33155334162;133860.33069834588;135005;135654.32172839172;139645;16585.17074146312;16627.833721662628;16869.32522699103;16929.661406771796;16957.321707131825;30853.074407767803;31020.53469197964;31100.68899311023;31674.524882126785;31815.522767158513;7538.283863033003;7650.693972241048;7674.232576742281;7683.346915512132;7687;3906.7851268179957;4019.598040195957;4043.1913617276664;4059.65492933104;4065.4714887064492;5274.709890955957;5445.455454454523;5455.863603409867;5478.315210598676;5482.5888058394985;962.153305091529;993.1756641987133;1002.2783595811004;1003.0170432975725;1003.8644782954208;685.9725610975505;709.1029847243242;715.4097869257884;718.0450001497995;725.0465637686531;11701.239419437708;11993.520259189534;12488.937555312346;13143.277119758504;13339.866601334057;685.7771224352106;694.121935751275;694.2814187316204;700.1807884774826;704.9154101507852;5527.889442211133;5564.4991950724625;5583.664980101207;5652.18043383707;5683.488486036276;118857;119352;122362;123151;123994;102837;105161;105755;106399.46800265949;107528.46235768928;87803.56098219595;88456.557717211;88556.5572172135;90578;91149;10095.89904100979;10106.140978016656;10352.53413596375;10429.53067111997;10606.628767993083;42477.36283955805;42663.7866810664;42878.49925252601;43330.350044748724;43338.56661433345;55449.44550554443;55466.44533554613;55675.443245567025;56394;56445.71777141088;13636.93181534086;13942.233177175352;14089.295535223402;14106.435742570182;14126.43494260218;16115.113668747863;16340.101294428921;16384.83615163833;16492.917535412245;16504.917475412545;14341.92829035848;14400.927995359956;14413.351399186851;14470.493532726305;14566.781498277322;14051.789223161864;14088;14098.224597647228;14260.215688136837;14309.284535773379;13375.732485350043;13670;13752.449902004208;13803.654908626962;13814.37835297394;11043;11121;11123.221374503708;11133.944330278297;11315.207935444769;12068.456919438471;12092.637220883387;12225;12401.441935113122;12518.624441266777 11:25:48 INFO - PID 5864 | __end_tp_report 11:25:48 INFO - PID 5864 | __start_cc_report 11:25:48 INFO - PID 5864 | _x_x_mozilla_cycle_collect,377 11:25:48 INFO - PID 5864 | __end_cc_report 11:25:48 INFO - PID 5864 | __startTimestamp1505067948172__endTimestamp 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | ------- Summary: start ------- 11:25:48 INFO - PID 5864 | Number of tests: 6 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#0] dojo.html Cycles:165 Average:6145.70 Median:6405.39 stddev:882.67 (13.8%) stddev-sans-first:853.26 11:25:48 INFO - PID 5864 | Values: 3137.9 3144.1 3152.6 3157.6 3170.4 6110.3 6227.2 6244.3 6281.0 6356.6 6225.1 6232.0 6234.5 6266.3 6284.9 5816.7 5869.7 5894.9 5897.8 5920.1 128.2 5725.1 5772.5 5784.7 5806.1 5264.6 5594.9 5600.6 5797.8 5809.8 5701.9 5710.6 5773.5 5787.2 5790.6 5705.7 5739.6 5804.9 5810.4 5818.5 6051.3 6184.3 6252.3 6264.9 6334.6 6497.5 6633.6 6647.4 6680.2 6749.9 6718.9 6719.1 6742.5 6743.2 6749.1 6210.7 6238.4 6279.7 6314.4 6320.6 6903.3 6926.3 6983.5 6991.0 7014.4 6485.3 6579.5 6602.9 6677.8 6682.6 6618.6 6720.5 6800.8 6802.4 6814.2 6696.8 6780.6 6783.0 6804.2 6819.2 6765.6 6775.0 6846.7 6857.2 6863.5 5190.2 5273.6 5323.3 5331.4 5339.2 4559.2 4568.0 4600.7 4664.0 4675.8 5762.9 5810.2 5822.1 5833.1 5834.2 6727.1 6733.1 6749.3 6754.3 6821.1 5766.4 5812.9 5817.8 5822.8 5829.3 5797.7 5845.7 5849.9 5850.0 5855.0 6277.3 6394.7 6424.3 6446.4 6535.8 6768.4 6813.6 6854.5 6856.7 6878.6 6355.8 6405.4 6442.3 6443.3 6538.1 6559.2 6567.2 6597.9 6599.1 6616.0 6789.2 6832.5 6846.2 6860.3 6863.9 6533.3 6536.8 6597.3 6625.0 6642.4 6479.2 6497.3 6510.1 6587.7 6590.6 6406.8 6463.7 6466.3 6468.5 6492.6 6513.9 6533.7 6619.5 6622.0 6633.0 6176.3 6281.5 6310.5 6380.8 6406.0 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#1] ext.html Cycles:180 Average:36881.29 Median:19009.26 stddev:51874.31 (272.9%) stddev-sans-first:51949.20 11:25:48 INFO - PID 5864 | Values: 829.7 863.2 887.4 896.8 897.5 39194.8 40107.8 40876.6 40898.0 40941.6 41284.8 41767.8 41783.0 41795.0 41876.8 7675.0 7792.7 7793.3 7802.6 7812.8 7707.8 7776.1 7778.9 7801.1 7810.5 7768.6 7776.1 7843.8 7854.4 7859.3 7754.8 7796.3 7805.2 7829.5 7835.2 7630.4 7662.0 7687.1 7687.7 7689.3 37209.0 37394.0 37406.4 37459.0 37534.0 3453.3 3481.9 3486.3 3486.8 3489.8 31239.2 31329.8 31369.2 31386.8 31388.8 5018.3 5140.3 5215.2 5215.4 5217.9 170758.0 171348.0 171768.0 172597.0 173582.0 44050.6 44173.8 44376.6 48262.3 48763.3 50296.2 50723.5 50737.2 50752.0 50808.5 14610.6 14697.3 14746.5 15738.1 16043.4 12689.4 12763.1 12774.7 12781.7 12822.9 14929.2 14972.3 15035.5 15060.7 15212.5 5812.2 5922.9 5954.9 6035.2 6040.0 1004.7 1005.0 1007.1 1009.4 1011.4 22394.3 22429.3 22838.3 22865.7 23311.3 1092.9 1094.9 1109.1 1116.0 1118.2 12071.8 12309.9 12345.9 12353.1 12419.0 222755.0 226351.0 228981.0 229644.0 229900.0 53633.0 54234.2 54319.5 54414.2 54470.5 1434.4 1455.2 1458.5 1459.9 1461.4 26069.7 26777.3 26821.9 27012.2 27443.3 36761.8 36809.4 36956.0 37177.4 37230.0 197453.0 197473.0 197605.0 197903.0 198204.0 34215.7 34452.5 34487.0 34488.5 34536.7 41064.6 43116.4 43577.8 43582.6 43772.6 30778.0 31369.5 31406.2 31423.2 31505.7 30744.7 31032.0 31375.8 31786.2 32085.8 34911.1 35048.0 35068.6 35130.6 35253.5 30341.7 30385.2 30457.0 31098.0 31227.1 22849.6 22883.8 23023.8 23294.2 23589.8 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#2] jquery.html Cycles:180 Average:31950.49 Median:22264.50 stddev:71760.19 (322.3%) stddev-sans-first:71922.78 11:25:48 INFO - PID 5864 | Values: 555.6 557.3 569.7 571.2 579.6 22314.6 23031.1 23066.2 23092.7 23098.9 23119.7 23961.5 24198.8 24444.4 24567.4 6385.4 6452.5 6485.9 6486.1 6490.0 6196.5 6376.9 6465.6 6472.0 6484.9 6454.0 6461.1 6464.8 6469.6 6471.7 6307.7 6477.5 6482.0 6484.0 6485.5 6026.9 6028.6 6034.8 6062.0 6073.6 27237.5 27730.0 27731.3 27737.2 27805.6 1967.6 1983.0 1986.6 1987.6 1992.4 18723.0 19136.6 19432.6 19505.4 19634.4 2479.3 2504.4 2519.4 2519.6 2534.4 115809.0 121408.0 127056.0 133693.0 136238.0 13870.6 13974.2 14354.2 14445.3 14602.7 22115.3 22181.6 22201.9 22208.0 22232.9 9608.1 9916.2 10008.5 10016.3 10092.0 9138.7 9154.9 9234.3 9280.7 9308.0 8887.2 8943.7 8974.8 8994.8 9166.1 2716.4 2729.8 2730.6 2753.7 2771.0 942.0 949.3 967.7 971.0 974.7 18343.1 18875.8 19082.9 19153.3 19366.6 991.7 1014.5 1021.5 1026.6 1029.4 10320.6 10475.4 10489.8 10527.2 10859.3 413464.0 419723.0 422296.9 427362.0 432268.0 110226.4 113857.0 114156.4 114196.0 115283.0 1018.9 1063.4 1123.5 1160.2 1176.2 19636.3 19766.5 19798.4 19905.6 20134.9 50776.7 52301.5 52371.7 52753.0 53481.5 61502.4 61537.0 61901.0 62307.0 64154.7 13786.6 13911.2 14138.4 14145.2 14149.0 21806.3 22140.0 22236.2 22248.2 22280.8 17988.1 18190.8 18282.0 18318.7 18477.5 15981.5 16465.0 16465.9 16796.7 17121.9 18265.5 18447.4 18452.0 18721.2 18802.7 13917.2 13988.9 14011.1 14052.5 14064.0 18093.2 18098.0 18102.5 18111.8 18171.5 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#3] mootools.html Cycles:180 Average:9225.61 Median:2625.44 stddev:6677.17 (254.3%) stddev-sans-first:6669.23 11:25:48 INFO - PID 5864 | Values: 1282.1 1322.6 1337.7 1337.7 1352.2 15048.1 15572.6 15706.8 15718.8 15720.4 15245.0 15446.8 15494.6 15557.3 15571.8 2719.4 2729.4 2788.9 2790.2 2790.8 2633.1 2706.0 2746.5 2768.3 2783.0 2744.9 2782.3 2783.7 2785.9 2786.4 2613.4 2617.7 2636.1 2637.4 2638.4 2581.1 2587.4 2588.8 2595.6 2602.9 14590.9 14948.6 14975.4 14983.0 15010.8 7776.1 8068.0 8074.2 8075.9 8076.8 5010.7 5108.9 5302.4 5321.3 5352.5 1941.9 1953.8 1974.3 1986.0 2012.7 26164.6 26371.0 26421.5 26451.0 26468.6 6656.4 6704.8 6726.3 6836.9 6933.7 17261.7 17355.7 17358.7 17393.3 17412.9 7473.3 7653.7 7687.7 7689.8 7703.4 6878.8 7055.8 7067.6 7108.7 7128.7 4867.8 5032.2 5032.7 5071.4 5120.4 1264.6 1300.9 1404.7 1441.3 1473.8 871.9 884.0 891.7 899.7 901.5 8577.4 8640.3 8678.8 8719.6 8749.1 998.8 1000.3 1001.3 1011.5 1017.0 4734.0 4861.3 4879.1 5304.9 5334.4 20573.5 21704.5 21978.6 21984.8 21989.6 20789.0 21345.9 21460.4 21473.7 21628.2 9899.6 10088.7 10099.2 10140.5 10147.8 8414.4 8446.7 8463.0 8483.2 8499.9 18262.8 18603.6 18842.2 18996.2 19123.7 18534.5 19068.6 19330.4 19369.2 19879.4 10799.3 11029.4 11142.0 11143.6 11159.5 13531.0 13678.2 13678.3 13690.7 13730.8 10446.9 10506.9 10543.4 10543.8 10644.5 10669.4 10737.6 10770.0 10793.6 10925.0 9285.1 9320.9 9444.9 9466.7 9557.9 7012.5 7196.6 7199.6 7201.1 7201.7 6797.0 6797.8 6799.9 6931.2 6984.0 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#4] prototype.html Cycles:180 Average:5457.06 Median:6147.72 stddev:1535.58 (25.0%) stddev-sans-first:1494.11 11:25:48 INFO - PID 5864 | Values: 498.9 499.7 517.8 524.7 529.2 6278.4 6302.7 6332.7 6341.6 6366.4 6142.7 6209.7 6231.0 6254.7 6258.2 5032.5 5069.5 5106.3 5118.8 5140.3 4962.1 5047.4 5061.3 5083.1 5104.7 4665.0 4786.8 4819.6 4834.7 4841.3 4781.6 4789.4 4792.0 4857.2 4864.7 4289.4 4342.8 4346.0 4355.6 4363.5 5985.4 6007.1 6064.3 6077.6 6105.5 5490.0 5535.3 5608.5 5613.3 5639.2 6455.6 6504.3 6543.3 6554.0 6562.6 4523.1 4756.3 4775.6 4814.3 4817.8 6512.5 6647.7 6675.1 6762.4 6776.1 4824.1 4834.8 4869.4 4876.7 4889.7 4883.9 4899.2 4900.3 4909.8 4958.5 5493.8 5513.3 5513.6 5521.7 5605.6 6601.3 6630.7 6636.7 6647.4 6662.0 1713.5 1723.8 1726.9 1744.1 1755.4 1143.2 1197.3 1198.9 1211.7 1217.7 5679.5 5688.1 5698.9 5702.0 5713.2 6606.7 6641.7 6696.8 6705.6 6714.0 5666.0 5680.6 5681.4 5687.7 5717.4 3497.5 3505.3 3517.6 3527.7 3548.8 6323.5 6397.6 6422.3 6433.6 6445.5 6736.0 6782.6 6793.4 6800.4 6827.0 6363.2 6389.7 6392.4 6395.0 6408.5 6152.7 6539.2 6568.7 6569.1 6687.7 6388.7 6425.9 6546.6 6589.9 6623.0 6256.5 6314.1 6433.0 6436.2 6446.2 5259.5 5304.6 5339.5 5345.3 5371.6 6418.4 6534.5 6574.6 6668.2 6762.0 6469.2 6489.4 6493.3 6522.3 6557.2 6455.8 6469.0 6469.5 6497.5 6510.0 6434.9 6436.5 6449.4 6487.2 6511.9 6565.8 6587.2 6593.6 6594.4 6626.0 6349.7 6361.9 6366.5 6386.6 6386.8 11:25:48 INFO - PID 5864 | 11:25:48 INFO - PID 5864 | [#5] yui.html Cycles:180 Average:23389.58 Median:18214.18 stddev:34325.86 (188.5%) stddev-sans-first:34380.63 11:25:48 INFO - PID 5864 | Values: 903.8 905.6 908.0 923.7 934.8 17603.1 17999.1 18002.1 18059.1 18192.6 16665.7 16858.7 16874.8 17357.2 19263.1 966.4 981.5 983.9 985.4 987.3 946.8 958.6 965.2 972.3 972.6 1049.2 1059.2 1059.3 1059.9 1061.2 993.9 1014.6 1016.4 1056.8 1059.3 741.6 742.2 744.5 745.1 746.8 18235.7 18315.2 18341.0 18383.5 18398.3 18451.4 18755.7 18811.6 19068.5 20557.2 16554.3 16697.3 16747.0 17077.7 17090.4 3785.0 3812.9 3813.3 3813.5 3814.4 133689.3 133860.3 135005.0 135654.3 139645.0 16585.2 16627.8 16869.3 16929.7 16957.3 30853.1 31020.5 31100.7 31674.5 31815.5 7538.3 7650.7 7674.2 7683.3 7687.0 3906.8 4019.6 4043.2 4059.7 4065.5 5274.7 5445.5 5455.9 5478.3 5482.6 962.2 993.2 1002.3 1003.0 1003.9 686.0 709.1 715.4 718.0 725.0 11701.2 11993.5 12488.9 13143.3 13339.9 685.8 694.1 694.3 700.2 704.9 5527.9 5564.5 5583.7 5652.2 5683.5 118857.0 119352.0 122362.0 123151.0 123994.0 102837.0 105161.0 105755.0 106399.5 107528.5 87803.6 88456.6 88556.6 90578.0 91149.0 10095.9 10106.1 10352.5 10429.5 10606.6 42477.4 42663.8 42878.5 43330.4 43338.6 55449.4 55466.4 55675.4 56394.0 56445.7 13636.9 13942.2 14089.3 14106.4 14126.4 16115.1 16340.1 16384.8 16492.9 16504.9 14341.9 14400.9 14413.4 14470.5 14566.8 14051.8 14088.0 14098.2 14260.2 14309.3 13375.7 13670.0 13752.4 13803.7 13814.4 11043.0 11121.0 11123.2 11133.9 11315.2 12068.5 12092.6 12225.0 12401.4 12518.6 11:25:48 INFO - PID 5864 | -------- Summary: end -------- 11:25:48 INFO - PID 5864 | 11:25:48 INFO - TEST-INFO | 5864: exit 0 11:25:48 INFO - TEST-OK | dromaeo_css | took 1107897ms 11:25:48 INFO - TEST-START | kraken 11:25:48 INFO - Initialising browser for kraken test... 11:25:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39487/getInfo.html -profile /tmp/tmp0SVqSb/profile 11:25:48 INFO - TEST-INFO | started process 6245 (/builds/slave/test/build/application/firefox/firefox http://localhost:39487/getInfo.html) 11:25:53 INFO - TEST-INFO | 6245: exit 0 11:25:54 INFO - Browser initialized. 11:25:54 INFO - Running cycle 1/1 for kraken test... 11:25:54 INFO - Using env: {'DISPLAY': ':0', 11:25:54 INFO - 'HOME': '/home/cltbld', 11:25:54 INFO - 'JSGC_DISABLE_POISONING': '1', 11:25:54 INFO - 'LANG': 'en_US.UTF-8', 11:25:54 INFO - 'LANGUAGE': 'en_US:en', 11:25:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:25:54 INFO - 'LOGNAME': 'cltbld', 11:25:54 INFO - 'MAIL': '/var/mail/cltbld', 11:25:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:54 INFO - 'MOZ_CRASHREPORTER': '1', 11:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:25:54 INFO - 'MOZ_NO_REMOTE': '1', 11:25:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:54 INFO - 'NO_EM_RESTART': '1', 11:25:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:54 INFO - 'PWD': '/builds/slave/test', 11:25:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:54 INFO - 'RUST_BACKTRACE': 'full', 11:25:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:54 INFO - 'SHELL': '/bin/bash', 11:25:54 INFO - 'SHLVL': '1', 11:25:54 INFO - 'STYLO_FORCE_DISABLED': '1', 11:25:54 INFO - 'TERM': 'linux', 11:25:54 INFO - 'TMOUT': '86400', 11:25:54 INFO - 'USER': 'cltbld', 11:25:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1505056341.814380-748463436', 11:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:54 INFO - '_': '/tools/buildbot/bin/python'} 11:25:54 INFO - TEST-INFO | started process 6440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0SVqSb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:54 INFO - PID 6440 | 11:25:54 INFO - PID 6440 | (/builds/slave/test/build/application/firefox/firefox:6491): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:54 INFO - PID 6440 | 11:26:05 INFO - PID 6440 | RSS: Main: 170156032 11:26:05 INFO - PID 6440 | 11:26:07 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39487/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:08 INFO - PID 6440 | RSS: Main: 175472640 11:26:08 INFO - PID 6440 | 11:26:11 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39487/tests/kraken/driver.html?testName=audio-dft) 11:26:12 INFO - PID 6440 | RSS: Main: 175968256 11:26:12 INFO - PID 6440 | 11:26:15 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39487/tests/kraken/driver.html?testName=audio-fft) 11:26:15 INFO - PID 6440 | RSS: Main: 171233280 11:26:15 INFO - PID 6440 | 11:26:17 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39487/tests/kraken/driver.html?testName=audio-oscillator) 11:26:18 INFO - PID 6440 | RSS: Main: 171761664 11:26:18 INFO - PID 6440 | 11:26:20 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:21 INFO - PID 6440 | RSS: Main: 171999232 11:26:21 INFO - PID 6440 | 11:26:24 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39487/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:25 INFO - PID 6440 | RSS: Main: 174895104 11:26:25 INFO - PID 6440 | 11:26:28 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39487/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:29 INFO - PID 6440 | RSS: Main: 174813184 11:26:29 INFO - PID 6440 | 11:26:32 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39487/tests/kraken/driver.html?testName=json-parse-financial) 11:26:32 INFO - PID 6440 | RSS: Main: 175276032 11:26:32 INFO - PID 6440 | 11:26:34 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:35 INFO - PID 6440 | RSS: Main: 174993408 11:26:35 INFO - PID 6440 | 11:26:36 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:37 INFO - PID 6440 | RSS: Main: 175620096 11:26:37 INFO - PID 6440 | 11:26:39 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:40 INFO - PID 6440 | RSS: Main: 172531712 11:26:40 INFO - PID 6440 | 11:26:42 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:43 INFO - PID 6440 | RSS: Main: 173121536 11:26:43 INFO - PID 6440 | 11:26:46 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:47 INFO - PID 6440 | RSS: Main: 172802048 11:26:47 INFO - PID 6440 | 11:26:48 INFO - PID 6440 | Cycle 1(1): loaded http://localhost:39487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39487/tests/kraken/driver.html?testName=ai-astar) 11:26:49 INFO - PID 6440 | RSS: Main: 174477312 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | __start_tp_report 11:26:49 INFO - PID 6440 | _x_x_mozilla_page_load 11:26:49 INFO - PID 6440 | _x_x_mozilla_page_load_details 11:26:49 INFO - PID 6440 | |i|pagename|runs| 11:26:49 INFO - PID 6440 | |0;ai-astar;108;108;108;108;107;103;110;108;109;111 11:26:49 INFO - PID 6440 | |1;audio-beat-detection;115;116;119;117;115;115;119;119;124;146 11:26:49 INFO - PID 6440 | |2;audio-dft;165;162;162;163;162;162;167;163;176;163 11:26:49 INFO - PID 6440 | |3;audio-fft;73;75;76;76;77;75;73;74;73;74 11:26:49 INFO - PID 6440 | |4;audio-oscillator;80;79;79;78;78;91;79;80;79;79 11:26:49 INFO - PID 6440 | |5;imaging-gaussian-blur;114;114;114;114;114;110;114;117;114;111 11:26:49 INFO - PID 6440 | |6;imaging-darkroom;147;147;149;149;148;152;147;147;148;147 11:26:49 INFO - PID 6440 | |7;imaging-desaturate;94;94;94;94;98;95;97;95;93;94 11:26:49 INFO - PID 6440 | |8;json-parse-financial;54;53;53;54;54;52;52;54;54;51 11:26:49 INFO - PID 6440 | |9;json-stringify-tinderbox;38;40;38;38;38;38;38;38;41;38 11:26:49 INFO - PID 6440 | |10;stanford-crypto-aes;75;76;74;77;74;74;76;75;77;76 11:26:49 INFO - PID 6440 | |11;stanford-crypto-ccm;116;120;120;116;119;116;123;119;115;122 11:26:49 INFO - PID 6440 | |12;stanford-crypto-pbkdf2;169;187;178;169;172;174;172;168;176;174 11:26:49 INFO - PID 6440 | |13;stanford-crypto-sha256-iterative;71;64;64;64;71;66;69;71;62;67 11:26:49 INFO - PID 6440 | __end_tp_report 11:26:49 INFO - PID 6440 | __start_cc_report 11:26:49 INFO - PID 6440 | _x_x_mozilla_cycle_collect,929 11:26:49 INFO - PID 6440 | __end_cc_report 11:26:49 INFO - PID 6440 | __startTimestamp1505068009164__endTimestamp 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | ------- Summary: start ------- 11:26:49 INFO - PID 6440 | Number of tests: 14 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:2.11 (2.0%) stddev-sans-first:2.24 11:26:49 INFO - PID 6440 | Values: 108.0 108.0 108.0 108.0 107.0 103.0 110.0 108.0 109.0 111.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:119.00 stddev:9.38 (7.9%) stddev-sans-first:9.74 11:26:49 INFO - PID 6440 | Values: 115.0 116.0 119.0 117.0 115.0 115.0 119.0 119.0 124.0 146.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:4.35 (2.7%) stddev-sans-first:4.61 11:26:49 INFO - PID 6440 | Values: 165.0 162.0 162.0 163.0 162.0 162.0 167.0 163.0 176.0 163.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:1.43 (1.9%) stddev-sans-first:1.39 11:26:49 INFO - PID 6440 | Values: 73.0 75.0 76.0 76.0 77.0 75.0 73.0 74.0 73.0 74.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:79.00 stddev:3.85 (4.9%) stddev-sans-first:4.09 11:26:49 INFO - PID 6440 | Values: 80.0 79.0 79.0 78.0 78.0 91.0 79.0 80.0 79.0 79.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.90 (1.7%) stddev-sans-first:2.01 11:26:49 INFO - PID 6440 | Values: 114.0 114.0 114.0 114.0 114.0 110.0 114.0 117.0 114.0 111.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:1.64 11:26:49 INFO - PID 6440 | Values: 147.0 147.0 149.0 149.0 148.0 152.0 147.0 147.0 148.0 147.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.62 11:26:49 INFO - PID 6440 | Values: 94.0 94.0 94.0 94.0 98.0 95.0 97.0 95.0 93.0 94.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.12 11:26:49 INFO - PID 6440 | Values: 54.0 53.0 53.0 54.0 54.0 52.0 52.0 54.0 54.0 51.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:38.00 stddev:1.08 (2.8%) stddev-sans-first:1.13 11:26:49 INFO - PID 6440 | Values: 38.0 40.0 38.0 38.0 38.0 38.0 38.0 38.0 41.0 38.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:1.17 (1.5%) stddev-sans-first:1.24 11:26:49 INFO - PID 6440 | Values: 75.0 76.0 74.0 77.0 74.0 74.0 76.0 75.0 77.0 76.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:119.50 stddev:2.76 (2.3%) stddev-sans-first:2.76 11:26:49 INFO - PID 6440 | Values: 116.0 120.0 120.0 116.0 119.0 116.0 123.0 119.0 115.0 122.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:5.61 (3.2%) stddev-sans-first:5.66 11:26:49 INFO - PID 6440 | Values: 169.0 187.0 178.0 169.0 172.0 174.0 172.0 168.0 176.0 174.0 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:68.00 stddev:3.41 (5.0%) stddev-sans-first:3.28 11:26:49 INFO - PID 6440 | Values: 71.0 64.0 64.0 64.0 71.0 66.0 69.0 71.0 62.0 67.0 11:26:49 INFO - PID 6440 | -------- Summary: end -------- 11:26:49 INFO - PID 6440 | 11:26:49 INFO - PID 6440 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:26:49 INFO - TEST-INFO | 6440: exit 0 11:26:49 INFO - TEST-OK | kraken | took 61006ms 11:26:49 INFO - SUITE-END | took 1168s 11:26:50 INFO - Completed test suite (00:19:29) 11:26:50 INFO - javascript benchmark 11:26:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8370.967243360978, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.9372412551747, 3144.1353627752364, 3152.55864179015, 3157.6368717597484, 3170.4134735074, 6110.266767987837, 6227.159333489977, 6244.344343843899, 6280.968595157024, 6356.618602883825, 6225.128482012522, 6232.034034724614, 6234.5324100692515, 6266.342034086424, 6284.937150628492, 5816.651000939936, 5869.706514674271, 5894.88210235795, 5897.764089436418, 5920.111983202511, 128.16729448388787, 5725.112607545837, 5772.451617096369, 5784.652920824743, 5806.129080637896, 5264.552513036397, 5594.888102237953, 5600.5799565032585, 5797.797077102281, 5809.767609295644, 5701.942980570183, 5710.628809127435, 5773.509251713609, 5787.189793428924, 5790.565707571949, 5705.65766054034, 5739.626924249952, 5804.8839023219725, 5810.360860305363, 5818.505427038707, 6051.273847138327, 6184.257889053342, 6252.2809876864285, 6264.87470250597, 6334.588251763666, 6497.545171837974, 6633.568818026861, 6647.401733843977, 6680.231773346079, 6749.898751518682, 6718.932810671929, 6719.0593316935665, 6742.52802303839, 6743.15710536183, 6749.0551322814845, 6210.72051757672, 6238.376162383725, 6279.717412716439, 6314.368563143695, 6320.557560970734, 6903.275156108536, 6926.341997510229, 6983.511154219156, 6990.965045174741, 7014.438844892396, 6485.286618471964, 6579.539432239697, 6602.900956485657, 6677.799666010027, 6682.63245521501, 6618.569792963442, 6720.495962802809, 6800.8299792504595, 6802.4217941474535, 6814.2163651180745, 6696.83257918556, 6780.559263647847, 6783.0, 6804.21751498584, 6819.24988251292, 6765.560238584476, 6775.0, 6846.726130954806, 6857.177138743383, 6863.485238607124, 5190.169572868398, 5273.604479664041, 5323.334583177103, 5331.44019877915, 5339.172428273624, 4559.202139625552, 4568.0, 4600.6549508786975, 4664.043871006435, 4675.76621168947, 5762.855928601818, 5810.157527158538, 5822.126680997884, 5833.066709326487, 5834.183214349994, 6727.058211850345, 6733.091032710521, 6749.291324410866, 6754.3245675433045, 6821.113255276782, 5766.365699773021, 5812.883742325214, 5817.825465236049, 5822.82531524055, 5829.300483941955, 5797.652140871562, 5845.707714614252, 5849.853753656107, 5850.034744267148, 5854.970725146347, 6277.2781130170615, 6394.712237949303, 6424.26120996082, 6446.419822215929, 6535.803925882231, 6768.390844823891, 6813.625250611264, 6854.5201835873, 6856.725730970706, 6878.621675807879, 6355.809325720235, 6405.391487808651, 6442.2591401989375, 6443.2590252119735, 6538.084668146368, 6559.245686746085, 6567.211934567882, 6597.901031484627, 6599.142111525471, 6616.0, 6789.15135608049, 6832.453403727591, 6846.178458585002, 6860.348266914635, 6863.897041544481, 6533.346665333429, 6536.803895883131, 6597.2742998271115, 6624.966875165594, 6642.43539299165, 6479.157709497735, 6497.317781632861, 6510.056041873996, 6587.703553340207, 6590.5716128451495, 6406.775762848278, 6463.741450341934, 6466.256380516301, 6468.547201696025, 6492.610443373413, 6513.902291465726, 6533.738650453929, 6619.503537234823, 6622.0, 6633.0, 6176.320604733386, 6281.497480201664, 6310.495160387066, 6380.840478988062, 6406.0], "value": 6082.529626044692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.7386323308158, 863.1584205399735, 887.3699673232003, 896.8116695493947, 897.4704924094783, 39194.804025979865, 40107.79946100265, 40876.59123408765, 40898.0, 40941.59058409415, 41284.793576032156, 41767.79116104423, 41783.0, 41795.0, 41876.79061604695, 7675.002249707544, 7792.688292468294, 7793.298603125718, 7802.648880800378, 7812.843743125162, 7707.807304817368, 7776.066871975371, 7778.922210777905, 7801.1028731696015, 7810.531368117931, 7768.611569421535, 7776.105747838986, 7843.764687059369, 7854.3716502679645, 7859.331956783652, 7754.806129846743, 7796.298333150044, 7805.180456052118, 7829.530228186299, 7835.177306382805, 7630.351420129296, 7661.961690191513, 7687.115981662125, 7687.654055567513, 7689.269519395649, 37209.0, 37394.0, 37406.43890341647, 37459.0, 37534.0, 3453.2920751245933, 3481.860725570974, 3486.3027394520946, 3486.843092060838, 3489.8080605566684, 31239.219019524466, 31329.84335078333, 31369.215769605944, 31386.843065784753, 31388.843055784575, 5018.2974383586325, 5140.254663073871, 5215.217717342391, 5215.3741551013745, 5217.921731174036, 170758.0, 171348.0, 171768.0, 172597.0, 173582.0, 44050.559494404646, 44173.77913110414, 44376.556234437245, 48262.27606585904, 48763.26855097176, 50296.24555631669, 50723.49276507262, 50737.23894141591, 50752.0, 50808.49191508112, 14610.561683149523, 14697.26513674312, 14746.483873064606, 15738.134402607737, 16043.358265669476, 12689.365531723377, 12763.106582539318, 12774.68063298425, 12781.68045798844, 12822.871771282167, 14929.178895160654, 14972.326245318987, 15035.54893353201, 15060.698786024219, 15212.46756363522, 5812.244408226988, 5922.851928701731, 5954.910676339859, 6035.245594300713, 6039.973204555148, 1004.7287232447198, 1004.9748756281151, 1007.0533698323552, 1009.3943633819796, 1011.3577878047346, 22394.32817015492, 22429.32712018642, 22838.31485055451, 22865.657015144454, 23311.300660980196, 1092.945352732376, 1094.9124070074374, 1109.1459576126338, 1115.9888401116048, 1118.2060736876747, 12071.758564828655, 12309.93845030787, 12345.876541234473, 12353.135280530456, 12419.0, 222755.0, 226351.0, 228981.0, 229644.0, 229900.0, 53633.0, 54234.18648720272, 54319.45680543144, 54414.18378724322, 54470.45529544733, 1434.411891124634, 1455.1850963460283, 1458.4968185975822, 1459.88320934325, 1461.4081297074702, 26069.73930260673, 26777.33056673599, 26821.865890670422, 27012.189634311002, 27443.31391715223, 36761.81619091887, 36809.447858282685, 36956.0, 37177.44233836549, 37230.0, 197453.0, 197473.0, 197605.0, 197903.01048494666, 198204.0, 34215.65784342225, 34452.48321275233, 34487.0, 34488.482672759426, 34536.654633454345, 41064.58935410727, 43116.353254700574, 43577.78211108924, 43582.56417435912, 43772.56227437685, 30778.0, 31369.52945705862, 31406.214844628154, 31423.21441963969, 31505.684943150274, 30744.692553074183, 31032.0, 31375.84312078425, 31786.205344866565, 32085.83957080293, 34911.12722181966, 35048.0, 35068.64931350654, 35130.64869351274, 35253.47119793154, 30341.69658303389, 30385.24036899095, 30457.0, 31098.0, 31227.063188104392, 22849.63033687049, 22883.77116228883, 23023.769762302163, 23294.184703535295, 23589.764102358757], "value": 17098.91553676927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6194007105133, 557.3089369182215, 569.7493103034667, 571.1775043936731, 579.6029719642045, 22314.553708925832, 23031.078756849725, 23066.19268325609, 23092.65361019586, 23098.884505577447, 23119.653205201892, 23961.520769584597, 24198.758012419872, 24444.38889027775, 24567.385815354624, 6385.425311721944, 6452.548321617489, 6485.902711459308, 6486.059521369399, 6490.0, 6196.504279657616, 6376.872462550747, 6465.644389558573, 6472.029195620671, 6484.870302593945, 6454.031895215709, 6461.06314584385, 6464.806055818333, 6469.644169570672, 6471.676416179196, 6307.747690092391, 6477.546571739957, 6481.967590162066, 6483.967580162116, 6485.513586481009, 6026.9095963560585, 6028.577999540034, 6034.818955431344, 6062.030075187993, 6073.635581865102, 27237.455250894873, 27730.0, 27731.306717332027, 27737.167884963485, 27805.582916256273, 1967.6064787042505, 1982.960340793176, 1986.5927484865567, 1987.5528006198633, 1992.402279316214, 18723.0, 19136.61726765457, 19432.611347773105, 19505.414837554898, 19634.410967670992, 2479.3429741118616, 2504.4490212153296, 2519.4205332773563, 2519.60946053362, 2534.4424226670103, 115809.0, 121408.0, 127056.0, 133693.0, 136237.999999999, 13870.583882483541, 13974.231417272147, 14354.210518421587, 14445.277736113363, 14602.707945841024, 22115.33653990383, 22181.55636887253, 22201.888990554944, 22208.0, 22232.888835555717, 9608.13526782593, 9916.157126644172, 10008.49957502122, 10016.298859079794, 10092.0, 9138.725838224864, 9154.86267705985, 9234.261259099256, 9280.675176368795, 9307.953460232655, 8887.200151986352, 8943.686970955985, 8974.775630609156, 8994.775130621787, 9166.08339166078, 2716.415970566338, 2729.7543221110195, 2730.631364765731, 2753.6833264174475, 2771.0, 941.9764505887408, 949.3259785552198, 967.7241986033946, 970.96601618943, 974.7027156717128, 18343.082845857654, 18875.81124188768, 19082.904585476983, 19153.329633462763, 19366.61266774685, 991.712403403005, 1014.4623349624711, 1021.4637315409469, 1026.5688410867454, 1029.4183786160795, 10320.587176513005, 10475.371477711362, 10489.842652360221, 10527.210459215436, 10859.34843909368, 413464.0, 419723.0, 422296.8885155555, 427362.0, 432268.0, 110226.44886775514, 113857.0, 114156.42921785338, 114196.0, 115283.0, 1018.9337693050077, 1063.4470075560664, 1123.4719681749727, 1160.158884808524, 1176.1943068997764, 19636.312729054414, 19766.50583735418, 19798.40604781859, 19905.60188796245, 20134.89932550328, 50776.74611626918, 52301.47698523118, 52371.73814130905, 52753.0, 53481.465185347646, 61502.38497615146, 61537.0, 61901.0, 62307.0, 64154.67922660357, 13786.586402407944, 13911.165330080228, 14138.434462621792, 14145.222012788983, 14149.0, 21806.34580962574, 22140.0, 22236.221732239293, 22248.221312253994, 22280.77719222787, 17988.100594969936, 18190.818091818914, 18282.0, 18318.72521912199, 18477.53806154857, 15981.520554383387, 16465.0, 16465.91767041157, 16796.66406671884, 17121.914390428465, 18265.543361416072, 18447.354342597944, 18452.0, 18721.15754791065, 18802.717959230347, 13917.164970101827, 13988.860111399163, 14011.08927919682, 14052.508162214273, 14064.0, 18093.185806638998, 18098.0, 18102.45692629223, 18111.818881811014, 18171.54571135732], "value": 11635.486695176547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.0576875996144, 1322.629663694166, 1337.6856438736895, 1337.732453509298, 1352.2022007015871, 15048.097114173157, 15572.61068473286, 15706.842931570682, 15718.842811571882, 15720.449784257553, 15245.0, 15446.768298475532, 15494.61263468414, 15557.29992150353, 15571.766423503628, 2719.428919926808, 2729.42682036772, 2788.9163325100176, 2790.1629511146675, 2790.8465034423098, 2633.1442281258574, 2705.9594106088425, 2746.5193591121574, 2768.2664094015004, 2782.9721702783017, 2744.917652470429, 2782.290515918438, 2783.6659600847825, 2785.874635641401, 2786.4287820996647, 2613.425046489769, 2617.7382261773764, 2636.064197209982, 2637.406583518712, 2638.4063585693066, 2581.0579138614457, 2587.3531617095728, 2588.831725937827, 2595.5976823592373, 2602.921912342633, 14590.927045364706, 14948.62628434287, 14975.400983960628, 14983.02610330336, 15010.849891501055, 7776.105747839014, 8068.0, 8074.1925807419375, 8075.919240807575, 8076.798080047987, 5010.699358038493, 5108.897822043538, 5302.443243459458, 5321.255024296563, 5352.545033672103, 1941.8543609229364, 1953.804619538049, 1974.2793880233755, 1985.9503512412161, 2012.6578481658153, 26164.607530887053, 26370.999999999807, 26421.471570568672, 26451.0, 26468.60297095545, 6656.36764507371, 6704.7988560343265, 6726.327367263332, 6836.914741004041, 6933.722651094001, 17261.741073883903, 17355.65288694219, 17358.739618905725, 17393.304267829146, 17412.912935435495, 7473.252674732484, 7653.6938522459595, 7687.654055567513, 7689.807754806175, 7703.422243331661, 6878.828029299308, 7055.788326350218, 7067.6112813795735, 7108.715651373887, 7128.714851405989, 4867.805287788519, 5032.194848824171, 5032.748362581856, 5071.39143302806, 5120.359955005624, 1264.563725514696, 1300.8682446271614, 1404.6769243073945, 1441.3081720774087, 1473.8305094914008, 871.8561437362764, 883.969061082859, 891.7146513115871, 899.7435730816686, 901.4636291406603, 8577.442466239674, 8640.255622956089, 8678.826423471495, 8719.60761765722, 8749.1250874912, 998.7852611688377, 1000.3397757480028, 1001.3441196016621, 1011.4740335025746, 1016.9745756356002, 4734.0, 4861.29511220871, 4879.097366987119, 5304.946950530522, 5334.3865455473115, 20573.48566285825, 21704.457388565097, 21978.560428791334, 21984.780152198593, 21989.560208796054, 20789.0, 21345.89327053386, 21460.356189314345, 21473.67789483159, 21628.243011494837, 9899.554520046615, 10088.74778130538, 10099.242556808269, 10140.492975351202, 10147.797044059078, 8414.410991230556, 8446.746597602081, 8463.0, 8483.194096560817, 8499.8725019126, 18262.817371826644, 18603.627927441645, 18842.246310147442, 18996.24015039383, 19123.71314430257, 18534.536636584195, 19068.618627627646, 19330.4200873974, 19369.159929806647, 19879.403617891487, 10799.298045627009, 11029.44852757343, 11142.0, 11143.609973650884, 11159.497822598165, 13531.0, 13678.179309241477, 13678.31608419555, 13690.726185476435, 13730.794038089636, 10446.947765261126, 10506.947465262625, 10543.367397956146, 10543.78912421732, 10644.520996555018, 10669.35983840972, 10737.624183153552, 10770.030697237285, 10793.568257269935, 10925.0, 9285.071492850931, 9320.906790932004, 9444.85832712496, 9466.668666596635, 9557.90442095598, 7012.509124361246, 7196.604186769778, 7199.604021778852, 7201.13586369618, 7201.675924583511, 6797.0, 6797.796066118024, 6799.93200067993, 6931.202911665021, 6984.0], "value": 6579.591987910776, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.9166948259755, 499.7456827800083, 517.8058228164439, 524.7271418862192, 529.2431822493835, 6278.4035516625845, 6302.65335406553, 6332.683365831707, 6341.63654814216, 6366.395192456721, 6142.723577439015, 6209.689515524228, 6230.968845155768, 6254.718537665804, 6258.249010118792, 5032.5470707636305, 5069.543741063304, 5106.31064806252, 5118.820841270556, 5140.280360749498, 4962.131626965267, 5047.394312682483, 5061.253867415736, 5083.068433995077, 5104.719240441793, 4664.97667511662, 4786.832460863853, 4819.566239038486, 4834.685745426554, 4841.298011788289, 4781.641376896747, 4789.377380940456, 4792.017636384533, 4857.198562237262, 4864.683795553277, 4289.356596510517, 4342.826286948518, 4345.956540434587, 4355.629771469397, 4363.516404422511, 5985.371535988702, 6007.128966299906, 6064.272287325549, 6077.604955677911, 6105.542084343692, 5489.972550137264, 5535.335759708861, 5608.523275521586, 5613.326400831927, 5639.210510528529, 6455.644939528324, 6504.349565043505, 6543.280239173687, 6554.0, 6562.606243625398, 4523.140603285398, 4756.310335001405, 4775.641826862964, 4814.277858321245, 4817.783199755984, 6512.479001679902, 6647.734090636369, 6675.065490831287, 6762.391384775345, 6776.05135281061, 4824.131656301899, 4834.7824347904425, 4869.415670119608, 4876.658633895593, 4889.704228379483, 4883.902321953612, 4899.191633380452, 4900.2894580286375, 4909.7790599423115, 4958.454569997298, 5493.786135110925, 5513.3108361454815, 5513.58648101386, 5521.69630670317, 5605.579581531401, 6601.33986601336, 6630.668466576652, 6636.7013484392355, 6647.368499992493, 6662.0340050692375, 1713.477389396246, 1723.8448539631493, 1726.8791184616957, 1744.0930716027594, 1755.4207111653125, 1143.2276728932306, 1197.3354788092518, 1198.8801119887942, 1211.733418647896, 1217.6773155113901, 5679.545636349082, 5688.11834165705, 5698.943010569924, 5702.0, 5713.22871412354, 6606.7026983785845, 6641.66791660415, 6696.799096027127, 6705.564138330993, 6714.0, 5665.971670141623, 5680.573956953162, 5681.375048744635, 5687.687177205211, 5717.371089180187, 3497.527833742463, 3505.3339865425487, 3517.595476520182, 3527.7177825773874, 3548.769329993542, 6323.52573556985, 6397.552171348054, 6422.298091005887, 6433.613983161025, 6445.45213656835, 6735.989601559707, 6782.559133656297, 6793.354631310018, 6800.387965083166, 6826.965865170642, 6363.172787537683, 6389.680515974275, 6392.424681778569, 6394.968025159845, 6408.51936104794, 6152.723127459186, 6539.215294164731, 6568.671566421755, 6569.080328754074, 6687.726173100974, 6388.68056597159, 6425.903611445926, 6546.631761955151, 6589.901151482636, 6623.039659249285, 6256.499480041494, 6314.1160237565855, 6432.9678351607945, 6436.16329877113, 6446.194225721785, 5259.500347466985, 5304.628675992643, 5339.46605339463, 5345.251664767014, 5371.5702743781185, 6418.358164183544, 6534.4772418205475, 6574.638394888327, 6668.199816021915, 6762.0, 6469.191351081115, 6489.3510648934725, 6493.318201588954, 6522.28254891971, 6557.2131344239, 6455.806325810233, 6468.967655161694, 6469.482441404771, 6497.480201583768, 6510.0, 6434.935650643433, 6436.517261205335, 6449.419552240321, 6487.156669632917, 6511.869762604816, 6565.770198043046, 6587.209534855848, 6593.571417857824, 6594.373534514213, 6625.966870165618, 6349.746010159727, 6361.93638063632, 6366.458850997532, 6386.584871983307, 6386.840328991812], "value": 5004.9977269748715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.7650210945154, 905.587957479347, 907.9954600227002, 923.672096405776, 934.8177105464435, 17603.119844007797, 17999.100044997747, 18002.09989500523, 18059.097045147755, 18192.636147277048, 16665.66668666629, 16858.662826743457, 16874.83125168748, 17357.21892514837, 19263.133159007844, 966.3960024984367, 981.4749109226565, 983.9163671087966, 985.374287327545, 987.2694206287332, 946.8437707778209, 958.5638534466835, 965.227817745804, 972.2805124208106, 972.6352617768337, 1049.18163832211, 1059.179136169467, 1059.2691043180182, 1059.8569193158903, 1061.161682271005, 993.92545559083, 1014.5992333028413, 1016.4409574733867, 1056.7622284985855, 1059.3326204491198, 741.6143605325254, 742.1873049011324, 744.5309455043342, 745.057502259642, 746.8095635612938, 18235.72646410305, 18315.175817088264, 18341.0, 18383.540411489685, 18398.264069437206, 18451.44645660632, 18755.718664220047, 18811.62376752471, 19068.5232869178, 20557.177712891615, 16554.337826486924, 16697.33210671584, 16747.0, 17077.7438338425, 17090.401835935805, 3785.0348161218712, 3812.866549670776, 3813.2564149990762, 3813.5423749150004, 3814.4469051987585, 133689.33155334162, 133860.33069834588, 135005.0, 135654.32172839172, 139645.0, 16585.17074146312, 16627.833721662628, 16869.32522699103, 16929.661406771796, 16957.321707131825, 30853.074407767803, 31020.53469197964, 31100.68899311023, 31674.524882126785, 31815.522767158513, 7538.283863033003, 7650.693972241048, 7674.232576742281, 7683.346915512132, 7687.0, 3906.7851268179957, 4019.598040195957, 4043.1913617276664, 4059.65492933104, 4065.4714887064492, 5274.709890955957, 5445.455454454523, 5455.863603409867, 5478.315210598676, 5482.5888058394985, 962.153305091529, 993.1756641987133, 1002.2783595811004, 1003.0170432975725, 1003.8644782954208, 685.9725610975505, 709.1029847243242, 715.4097869257884, 718.0450001497995, 725.0465637686531, 11701.239419437708, 11993.520259189534, 12488.937555312346, 13143.277119758504, 13339.866601334057, 685.7771224352106, 694.121935751275, 694.2814187316204, 700.1807884774826, 704.9154101507852, 5527.889442211133, 5564.4991950724625, 5583.664980101207, 5652.18043383707, 5683.488486036276, 118857.0, 119352.0, 122362.0, 123151.0, 123994.0, 102837.0, 105161.0, 105755.0, 106399.46800265949, 107528.46235768928, 87803.56098219595, 88456.557717211, 88556.5572172135, 90578.0, 91149.0, 10095.89904100979, 10106.140978016656, 10352.53413596375, 10429.53067111997, 10606.628767993083, 42477.36283955805, 42663.7866810664, 42878.49925252601, 43330.350044748724, 43338.56661433345, 55449.44550554443, 55466.44533554613, 55675.443245567025, 56394.0, 56445.71777141088, 13636.93181534086, 13942.233177175352, 14089.295535223402, 14106.435742570182, 14126.43494260218, 16115.113668747863, 16340.101294428921, 16384.83615163833, 16492.917535412245, 16504.917475412545, 14341.92829035848, 14400.927995359956, 14413.351399186851, 14470.493532726305, 14566.781498277322, 14051.789223161864, 14088.0, 14098.224597647228, 14260.215688136837, 14309.284535773379, 13375.732485350043, 13670.0, 13752.449902004208, 13803.654908626962, 13814.37835297394, 11043.0, 11121.0, 11123.221374503708, 11133.944330278297, 11315.207935444769, 12068.456919438471, 12092.637220883387, 12225.0, 12401.441935113122, 12518.624441266777], "value": 8633.516827460886, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1430.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 108.0, 108.0, 107.0, 103.0, 110.0, 108.0, 109.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 119.0, 117.0, 115.0, 115.0, 119.0, 119.0, 124.0, 146.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 163.0, 162.0, 162.0, 167.0, 163.0, 176.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 76.0, 77.0, 75.0, 73.0, 74.0, 73.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 78.0, 91.0, 79.0, 80.0, 79.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 110.0, 114.0, 117.0, 114.0, 111.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 149.0, 148.0, 152.0, 147.0, 147.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 98.0, 95.0, 97.0, 95.0, 93.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 52.0, 52.0, 54.0, 54.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 40.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 41.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 77.0, 74.0, 74.0, 76.0, 75.0, 77.0, 76.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 120.0, 116.0, 119.0, 116.0, 123.0, 119.0, 115.0, 122.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 187.0, 178.0, 169.0, 172.0, 174.0, 172.0, 168.0, 176.0, 174.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 64.0, 64.0, 71.0, 66.0, 69.0, 71.0, 62.0, 67.0], "value": 66.9, "unit": "score"}]}]} 11:26:50 INFO - Return code: 0 11:26:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:50 INFO - # TBPL SUCCESS # 11:26:50 INFO - Running post-action listener: _package_coverage_data 11:26:50 INFO - Running post-action listener: _resource_record_post_action 11:26:50 INFO - [mozharness: 2017-09-10 18:26:50.438817Z] Finished run-tests step (success) 11:26:50 INFO - Running post-run listener: _resource_record_post_run 11:26:50 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 729088; Write bytes: 311832576; Read time: 68; Write time: 157900 11:26:50 INFO - TinderboxPrint: CPU usage
13.1% 11:26:50 INFO - TinderboxPrint: I/O read bytes / time
729,088 / 68 11:26:50 INFO - TinderboxPrint: I/O write bytes / time
311,832,576 / 157,900 11:26:50 INFO - TinderboxPrint: CPU idle
8,217.1 (86.9%) 11:26:50 INFO - TinderboxPrint: CPU user
1,191.0 (12.6%) 11:26:50 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15052800; Read time: 0; Write time: 4592 11:26:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:26:50 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 729088; Write bytes: 288137216; Read time: 68; Write time: 152524 11:26:51 INFO - Running post-run listener: _upload_blobber_files 11:26:51 INFO - Blob upload gear active. 11:26:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:51 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 11:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:52 INFO - (blobuploader) - INFO - Done attempting. 11:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:53 INFO - (blobuploader) - INFO - Done attempting. 11:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:54 INFO - (blobuploader) - INFO - Done attempting. 11:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:00 INFO - (blobuploader) - INFO - Done attempting. 11:27:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:00 INFO - Return code: 0 11:27:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e43bc311cdef55398928f12a4310f6cabe6dd313e7b98842776b88ea250d3bd95b61500ceb7d82f98de243c0254eee5e042830dd3f9cafb38d34221313f75cf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/325e5a1c06a5f249a8c12c2109de7b21b8a7383f03ea13ca3036914c2742636b86b2c717fd469e7d09c199ba6a58ea34b34cc4dfbbfea1edd8a6c61c49b1ea50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f31be2d908fd9f9a92b4fd03d746a85309fbe01df1aac9e1e8179254f42e0d14ede018c73ad8d3f45d3510217633585e37d0d4ef331e865c258170e4ebfef3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee7cba52853f9c3fbbc48e5eaea7489f6917e590a61157690ad59ba8adea4d776ae10d1b632b89198fadb50759e2024853bff471afcb97000e07521750a3350"} 11:27:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:00 INFO - Contents: 11:27:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e43bc311cdef55398928f12a4310f6cabe6dd313e7b98842776b88ea250d3bd95b61500ceb7d82f98de243c0254eee5e042830dd3f9cafb38d34221313f75cf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/325e5a1c06a5f249a8c12c2109de7b21b8a7383f03ea13ca3036914c2742636b86b2c717fd469e7d09c199ba6a58ea34b34cc4dfbbfea1edd8a6c61c49b1ea50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f31be2d908fd9f9a92b4fd03d746a85309fbe01df1aac9e1e8179254f42e0d14ede018c73ad8d3f45d3510217633585e37d0d4ef331e865c258170e4ebfef3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee7cba52853f9c3fbbc48e5eaea7489f6917e590a61157690ad59ba8adea4d776ae10d1b632b89198fadb50759e2024853bff471afcb97000e07521750a3350"} 11:27:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:00 INFO - Copying logs to upload dir... 11:27:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.077270 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-10 11:27:00.942162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:00.945953) ========= 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=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e43bc311cdef55398928f12a4310f6cabe6dd313e7b98842776b88ea250d3bd95b61500ceb7d82f98de243c0254eee5e042830dd3f9cafb38d34221313f75cf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/325e5a1c06a5f249a8c12c2109de7b21b8a7383f03ea13ca3036914c2742636b86b2c717fd469e7d09c199ba6a58ea34b34cc4dfbbfea1edd8a6c61c49b1ea50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f31be2d908fd9f9a92b4fd03d746a85309fbe01df1aac9e1e8179254f42e0d14ede018c73ad8d3f45d3510217633585e37d0d4ef331e865c258170e4ebfef3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee7cba52853f9c3fbbc48e5eaea7489f6917e590a61157690ad59ba8adea4d776ae10d1b632b89198fadb50759e2024853bff471afcb97000e07521750a3350"} build_url:https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011735 build_url: 'https://queue.taskcluster.net/v1/task/UZWMEdQaTLGG8H3YMvQkdw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e43bc311cdef55398928f12a4310f6cabe6dd313e7b98842776b88ea250d3bd95b61500ceb7d82f98de243c0254eee5e042830dd3f9cafb38d34221313f75cf", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/325e5a1c06a5f249a8c12c2109de7b21b8a7383f03ea13ca3036914c2742636b86b2c717fd469e7d09c199ba6a58ea34b34cc4dfbbfea1edd8a6c61c49b1ea50", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f31be2d908fd9f9a92b4fd03d746a85309fbe01df1aac9e1e8179254f42e0d14ede018c73ad8d3f45d3510217633585e37d0d4ef331e865c258170e4ebfef3fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee7cba52853f9c3fbbc48e5eaea7489f6917e590a61157690ad59ba8adea4d776ae10d1b632b89198fadb50759e2024853bff471afcb97000e07521750a3350"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:00.974989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:00.975336) ========= 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=00204705a9daa57ed339a427000001b9-1505056341.814380-748463436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-10 11:27:01.060622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:27:01.060935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-10 11:27:01.061265) ========= ========= Total master_lag: 0.19 =========