builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1507111410.6 results: success (0) revision: 933b30269777f718a14d2fc379e563a051b14618 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.596254) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.596875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.597152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.674181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.674539) ========= 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=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 03:03:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2017-10-04 03:03:30 (14.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141381 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.858920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.859222) ========= 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=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022426 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.909862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:30.910204) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 933b30269777f718a14d2fc379e563a051b14618 --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 933b30269777f718a14d2fc379e563a051b14618 --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=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 03:03:30,935 truncating revision to first 12 chars 2017-10-04 03:03:30,935 Setting DEBUG logging. 2017-10-04 03:03:30,935 attempt 1/10 2017-10-04 03:03:30,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/933b30269777?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 03:03:31,330 unpacking tar archive at: mozilla-central-933b30269777/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700414 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:31.629109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:31.629609) ========= script_repo_revision: 933b30269777f718a14d2fc379e563a051b14618 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:31.630217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:31.630657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 03:03:31.645558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-10-04 03:03:31.645952) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:03:31 INFO - MultiFileLogger online at 20171004 03:03:31 in /builds/slave/test 03:03:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:03:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:03:31 INFO - {'append_to_log': False, 03:03:31 INFO - 'base_work_dir': '/builds/slave/test', 03:03:31 INFO - 'blob_upload_branch': 'Firefox', 03:03:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:03:31 INFO - 'branch': 'Firefox', 03:03:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:03:31 INFO - 'code_coverage': False, 03:03:31 INFO - 'config_files': ('talos/linux_config.py',), 03:03:31 INFO - 'default_actions': ('clobber', 03:03:31 INFO - 'read-buildbot-config', 03:03:31 INFO - 'download-and-extract', 03:03:31 INFO - 'populate-webroot', 03:03:31 INFO - 'create-virtualenv', 03:03:31 INFO - 'install', 03:03:31 INFO - 'setup-mitmproxy', 03:03:31 INFO - 'run-tests'), 03:03:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:03:31 INFO - 'disable_ccov_upload': False, 03:03:31 INFO - 'disable_stylo': False, 03:03:31 INFO - 'download_minidump_stackwalk': True, 03:03:31 INFO - 'download_symbols': 'ondemand', 03:03:31 INFO - 'enable_stylo': False, 03:03:31 INFO - 'enable_webrender': False, 03:03:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:03:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:03:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:03:31 INFO - 'gecko_profile': False, 03:03:31 INFO - 'gecko_profile_interval': 0, 03:03:31 INFO - 'installer_path': 'installer.exe', 03:03:31 INFO - 'log_level': 'info', 03:03:31 INFO - 'log_name': 'talos', 03:03:31 INFO - 'log_to_console': True, 03:03:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:03:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:03:31 INFO - 'opt_config_files': (), 03:03:31 INFO - 'pip_index': False, 03:03:31 INFO - 'suite': 'dromaeojs-e10s', 03:03:31 INFO - 'system_bits': '32', 03:03:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:03:31 INFO - 'title': 'talos-linux64-ix-003', 03:03:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:03:31 INFO - 'use_talos_json': True, 03:03:31 INFO - 'verify': 'False', 03:03:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:03:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:03:31 INFO - 'work_dir': 'build'} 03:03:31 INFO - [mozharness: 2017-10-04 10:03:31.904547Z] Running clobber step. 03:03:31 INFO - Running pre-action listener: _resource_record_pre_action 03:03:31 INFO - Running main action method: clobber 03:03:31 INFO - rmtree: /builds/slave/test/build 03:03:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:03:32 INFO - Running post-action listener: _resource_record_post_action 03:03:32 INFO - [mozharness: 2017-10-04 10:03:32.854121Z] Finished clobber step (success) 03:03:32 INFO - [mozharness: 2017-10-04 10:03:32.854218Z] Running read-buildbot-config step. 03:03:32 INFO - Running pre-action listener: _resource_record_pre_action 03:03:32 INFO - Running main action method: read_buildbot_config 03:03:32 INFO - Using buildbot properties: 03:03:32 INFO - { 03:03:32 INFO - "project": "", 03:03:32 INFO - "product": "firefox", 03:03:32 INFO - "who": "archaeopteryx@coole-files.de", 03:03:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:03:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:03:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:03:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:03:32 INFO - "stage_platform": "linux64-qr", 03:03:32 INFO - "basedir": "/builds/slave/test", 03:03:32 INFO - "buildnumber": 10, 03:03:32 INFO - "platform": "ubuntu64_hw_qr", 03:03:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:03:32 INFO - "slavebuilddir": "test", 03:03:32 INFO - "taskId": "I_7z3dQaTrK1KHw36cqoeA", 03:03:32 INFO - "branch": "mozilla-central", 03:03:32 INFO - "script_repo_revision": "production", 03:03:32 INFO - "revision": "933b30269777f718a14d2fc379e563a051b14618", 03:03:32 INFO - "slavename": "talos-linux64-ix-003", 03:03:32 INFO - "repo_path": "mozilla-central" 03:03:32 INFO - } 03:03:32 INFO - Finding installer, test and symbols from parent task. 03:03:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_7z3dQaTrK1KHw36cqoeA'}, attempt #1 03:03:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_7z3dQaTrK1KHw36cqoeA'}, attempt #1 03:03:34 INFO - Task dependencies: MyDALZqzQgW4pMnMCbCJUg 03:03:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg'}, attempt #1 03:03:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 03:03:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.test_packages.json 03:03:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.crashreporter-symbols.zip 03:03:34 INFO - Running post-action listener: _resource_record_post_action 03:03:34 INFO - [mozharness: 2017-10-04 10:03:34.443202Z] Finished read-buildbot-config step (success) 03:03:34 INFO - [mozharness: 2017-10-04 10:03:34.443421Z] Running download-and-extract step. 03:03:34 INFO - Running pre-action listener: _resource_record_pre_action 03:03:34 INFO - Running main action method: download_and_extract 03:03:34 INFO - mkdir: /builds/slave/test/build/tests 03:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:34 INFO - trying https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.test_packages.json 03:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:03:35 INFO - Downloaded 989 bytes. 03:03:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:03:35 INFO - Using the following test package requirements: 03:03:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:03:35 INFO - u'common': [u'target.common.tests.zip'], 03:03:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:03:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:03:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:03:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:03:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:03:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:03:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:03:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:03:35 INFO - u'target.web-platform.tests.tar.gz'], 03:03:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:03:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.common.tests.zip 03:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.common.tests.zip into memory 03:03:38 INFO - Content-Length response header: 55307399 03:03:38 INFO - Bytes received: 55307399 03:03:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.talos.tests.zip 03:03:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:03:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.talos.tests.zip into memory 03:03:52 INFO - Content-Length response header: 14533844 03:03:52 INFO - Bytes received: 14533844 03:03: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')]} 03:03:52 INFO - trying https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 03:03:52 INFO - Downloading https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:03:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:03:54 INFO - Downloaded 61673698 bytes. 03:03:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 03:03:54 INFO - mkdir: /builds/slave/test/properties 03:03:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:54 INFO - Contents: 03:03:54 INFO - build_url:https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 03:03:54 INFO - Running post-action listener: _resource_record_post_action 03:03:54 INFO - Running post-action listener: find_tests_for_verification 03:03:54 INFO - Running post-action listener: set_extra_try_arguments 03:03:54 INFO - [mozharness: 2017-10-04 10:03:54.603879Z] Finished download-and-extract step (success) 03:03:54 INFO - [mozharness: 2017-10-04 10:03:54.603978Z] Running populate-webroot step. 03:03:54 INFO - Running pre-action listener: _resource_record_pre_action 03:03:54 INFO - Running main action method: populate_webroot 03:03:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['tresize', 03:03:54 INFO - 'tcanvasmark']}, 03:03:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['dromaeo_css', 03:03:54 INFO - 'kraken']}, 03:03:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'tests': ['damp', 'tps']}, 03:03:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['damp', 'tps']}, 03:03:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['dromaeo_dom']}, 03:03:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:03:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['basic_compositor_video', 03:03:54 INFO - 'glvideo']}, 03:03:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:03:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['ts_paint_webext', 03:03:54 INFO - 'tp5o_webext']}, 03:03:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:54 INFO - 'ts_paint', 03:03:54 INFO - 'tpaint', 03:03:54 INFO - 'sessionrestore', 03:03:54 INFO - 'sessionrestore_many_windows', 03:03:54 INFO - 'sessionrestore_no_auto_restore', 03:03:54 INFO - 'tabpaint', 03:03:54 INFO - 'cpstartup']}, 03:03:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['a11yr', 03:03:54 INFO - 'ts_paint', 03:03:54 INFO - 'tpaint', 03:03:54 INFO - 'sessionrestore', 03:03:54 INFO - 'sessionrestore_many_windows', 03:03:54 INFO - 'sessionrestore_no_auto_restore', 03:03:54 INFO - 'tabpaint', 03:03:54 INFO - 'cpstartup']}, 03:03:54 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:03:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:03:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['perf_reftest_singletons']}, 03:03:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['perf_reftest']}, 03:03:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:54 INFO - 'tsvgr_opacity', 03:03:54 INFO - 'tart', 03:03:54 INFO - 'tscrollx', 03:03:54 INFO - 'tsvg_static']}, 03:03:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['tsvgx', 03:03:54 INFO - 'tsvgr_opacity', 03:03:54 INFO - 'tart', 03:03:54 INFO - 'tscrollx', 03:03:54 INFO - 'tsvg_static']}, 03:03:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:03:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--disable-stylo'], 03:03:54 INFO - 'tests': ['tp5o']}, 03:03:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:03:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:03:54 INFO - 'talos_options': ['--mitmproxy', 03:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:03:54 INFO - '--firstNonBlankPaint'], 03:03:54 INFO - 'tests': ['tp6_google', 03:03:54 INFO - 'tp6_youtube', 03:03:54 INFO - 'tp6_amazon', 03:03:54 INFO - 'tp6_facebook']}, 03:03:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:03:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:03:54 INFO - 'talos_options': ['--disable-stylo', 03:03:54 INFO - '--mitmproxy', 03:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:03:54 INFO - '--firstNonBlankPaint'], 03:03:54 INFO - 'tests': ['tp6_google', 03:03:54 INFO - 'tp6_youtube', 03:03:54 INFO - 'tp6_amazon', 03:03:54 INFO - 'tp6_facebook']}, 03:03:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:03:54 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:03:54 INFO - 'talos_options': ['--stylo-threads=1', 03:03:54 INFO - '--mitmproxy', 03:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:03:54 INFO - '--firstNonBlankPaint'], 03:03:54 INFO - 'tests': ['tp6_google', 03:03:54 INFO - 'tp6_youtube', 03:03:54 INFO - 'tp6_amazon', 03:03:54 INFO - 'tp6_facebook']}, 03:03:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--xperf_path', 03:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:54 INFO - 'tests': ['tp5n']}, 03:03:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:03:54 INFO - 'talos_options': ['--disable-stylo', 03:03:54 INFO - '--xperf_path', 03:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:54 INFO - 'tests': ['tp5n']}}} 03:03:54 INFO - Running post-action listener: _resource_record_post_action 03:03:54 INFO - [mozharness: 2017-10-04 10:03:54.619643Z] Finished populate-webroot step (success) 03:03:54 INFO - [mozharness: 2017-10-04 10:03:54.619733Z] Running create-virtualenv step. 03:03:54 INFO - Running pre-action listener: _resource_record_pre_action 03:03:54 INFO - Running main action method: create_virtualenv 03:03:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:03:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:03:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:03:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:55 INFO - Installing pip...............done. 03:03:55 INFO - Return code: 0 03:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:03:55 INFO - Reading from file tmpfile_stdout 03:03:55 INFO - Output received: 03:03:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:03:55 INFO - Using env: {'DISPLAY': ':0', 03:03:55 INFO - 'HOME': '/home/cltbld', 03:03:55 INFO - 'LANG': 'en_US.UTF-8', 03:03:55 INFO - 'LANGUAGE': 'en_US:en', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MAIL': '/var/mail/cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SHLVL': '1', 03:03:55 INFO - 'TERM': 'linux', 03:03:55 INFO - 'TMOUT': '86400', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - '_': '/tools/buildbot/bin/python'} 03:03:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:03:57 INFO - Downloading/unpacking pip>=1.5 03:03:57 INFO - Running setup.py egg_info for package pip 03:03:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:03:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:03:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:03:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:03:57 INFO - Installing collected packages: pip 03:03:57 INFO - Found existing installation: pip 1.1 03:03:57 INFO - Uninstalling pip: 03:03:57 INFO - Successfully uninstalled pip 03:03:57 INFO - Running setup.py install for pip 03:03:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:03:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:03:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:03:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:03:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:03:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:03:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:03:57 INFO - Successfully installed pip 03:03:57 INFO - Cleaning up... 03:03:57 INFO - Return code: 0 03:03:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03: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')]} 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:57 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:03:57 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 03:03:57 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 03:03:57 INFO - Using env: {'DISPLAY': ':0', 03:03:57 INFO - 'HOME': '/home/cltbld', 03:03:57 INFO - 'LANG': 'en_US.UTF-8', 03:03:57 INFO - 'LANGUAGE': 'en_US:en', 03:03:57 INFO - 'LOGNAME': 'cltbld', 03:03:57 INFO - 'MAIL': '/var/mail/cltbld', 03:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:57 INFO - 'MOZ_NO_REMOTE': '1', 03:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:57 INFO - 'NO_EM_RESTART': '1', 03:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:57 INFO - 'PWD': '/builds/slave/test', 03:03:57 INFO - 'SHELL': '/bin/bash', 03:03:57 INFO - 'SHLVL': '1', 03:03:57 INFO - 'TERM': 'linux', 03:03:57 INFO - 'TMOUT': '86400', 03:03:57 INFO - 'USER': 'cltbld', 03:03:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:57 INFO - '_': '/tools/buildbot/bin/python'} 03:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:57 INFO - Downloading/unpacking psutil>=3.1.1 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:58 INFO - Installing collected packages: psutil 03:03:58 INFO - Running setup.py install for psutil 03:03:58 INFO - building 'psutil._psutil_linux' extension 03:03:58 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 03:03:59 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 03:04:00 INFO - building 'psutil._psutil_posix' extension 03:04:00 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 03:04:00 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 03:04:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:00 INFO - Successfully installed psutil 03:04:00 INFO - Cleaning up... 03:04:00 INFO - Return code: 0 03:04:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04: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')]} 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:00 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:00 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 03:04:00 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 03:04:00 INFO - Using env: {'DISPLAY': ':0', 03:04:00 INFO - 'HOME': '/home/cltbld', 03:04:00 INFO - 'LANG': 'en_US.UTF-8', 03:04:00 INFO - 'LANGUAGE': 'en_US:en', 03:04:00 INFO - 'LOGNAME': 'cltbld', 03:04:00 INFO - 'MAIL': '/var/mail/cltbld', 03:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:00 INFO - 'MOZ_NO_REMOTE': '1', 03:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:00 INFO - 'NO_EM_RESTART': '1', 03:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:00 INFO - 'PWD': '/builds/slave/test', 03:04:00 INFO - 'SHELL': '/bin/bash', 03:04:00 INFO - 'SHLVL': '1', 03:04:00 INFO - 'TERM': 'linux', 03:04:00 INFO - 'TMOUT': '86400', 03:04:00 INFO - 'USER': 'cltbld', 03:04:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:00 INFO - '_': '/tools/buildbot/bin/python'} 03:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:04:01 INFO - Installing collected packages: mozsystemmonitor 03:04:01 INFO - Running setup.py install for mozsystemmonitor 03:04:01 INFO - Successfully installed mozsystemmonitor 03:04:01 INFO - Cleaning up... 03:04:01 INFO - Return code: 0 03:04:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:01 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:01 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 03:04:01 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 03:04:01 INFO - Using env: {'DISPLAY': ':0', 03:04:01 INFO - 'HOME': '/home/cltbld', 03:04:01 INFO - 'LANG': 'en_US.UTF-8', 03:04:01 INFO - 'LANGUAGE': 'en_US:en', 03:04:01 INFO - 'LOGNAME': 'cltbld', 03:04:01 INFO - 'MAIL': '/var/mail/cltbld', 03:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:01 INFO - 'MOZ_NO_REMOTE': '1', 03:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:01 INFO - 'NO_EM_RESTART': '1', 03:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:01 INFO - 'PWD': '/builds/slave/test', 03:04:01 INFO - 'SHELL': '/bin/bash', 03:04:01 INFO - 'SHLVL': '1', 03:04:01 INFO - 'TERM': 'linux', 03:04:01 INFO - 'TMOUT': '86400', 03:04:01 INFO - 'USER': 'cltbld', 03:04:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:01 INFO - '_': '/tools/buildbot/bin/python'} 03:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:03 INFO - warning: no files found matching '*.txt' 03:04:03 INFO - no previously-included directories found matching 'build' 03:04:03 INFO - no previously-included directories found matching 'dist' 03:04:03 INFO - no previously-included directories found matching '.git*' 03:04:03 INFO - Installing collected packages: jsonschema, functools32 03:04:03 INFO - Running setup.py install for functools32 03:04:03 INFO - warning: no files found matching '*.txt' 03:04:03 INFO - no previously-included directories found matching 'build' 03:04:03 INFO - no previously-included directories found matching 'dist' 03:04:03 INFO - no previously-included directories found matching '.git*' 03:04:03 INFO - Successfully installed jsonschema functools32 03:04:03 INFO - Cleaning up... 03:04:03 INFO - Return code: 0 03:04:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04: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')]} 03:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04: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', '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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:04: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 functools32==3.2.3-2 03:04:03 INFO - Using env: {'DISPLAY': ':0', 03:04:03 INFO - 'HOME': '/home/cltbld', 03:04:03 INFO - 'LANG': 'en_US.UTF-8', 03:04:03 INFO - 'LANGUAGE': 'en_US:en', 03:04:03 INFO - 'LOGNAME': 'cltbld', 03:04:03 INFO - 'MAIL': '/var/mail/cltbld', 03:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:03 INFO - 'MOZ_NO_REMOTE': '1', 03:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:03 INFO - 'NO_EM_RESTART': '1', 03:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:03 INFO - 'PWD': '/builds/slave/test', 03:04:03 INFO - 'SHELL': '/bin/bash', 03:04:03 INFO - 'SHLVL': '1', 03:04:03 INFO - 'TERM': 'linux', 03:04:03 INFO - 'TMOUT': '86400', 03:04:03 INFO - 'USER': 'cltbld', 03:04:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:03 INFO - '_': '/tools/buildbot/bin/python'} 03:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:04:03 INFO - Cleaning up... 03:04:03 INFO - Return code: 0 03:04:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04: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')]} 03:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04: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', '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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:04: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 blobuploader==1.2.4 03:04:03 INFO - Using env: {'DISPLAY': ':0', 03:04:03 INFO - 'HOME': '/home/cltbld', 03:04:03 INFO - 'LANG': 'en_US.UTF-8', 03:04:03 INFO - 'LANGUAGE': 'en_US:en', 03:04:03 INFO - 'LOGNAME': 'cltbld', 03:04:03 INFO - 'MAIL': '/var/mail/cltbld', 03:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:03 INFO - 'MOZ_NO_REMOTE': '1', 03:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:03 INFO - 'NO_EM_RESTART': '1', 03:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:03 INFO - 'PWD': '/builds/slave/test', 03:04:03 INFO - 'SHELL': '/bin/bash', 03:04:03 INFO - 'SHLVL': '1', 03:04:03 INFO - 'TERM': 'linux', 03:04:03 INFO - 'TMOUT': '86400', 03:04:03 INFO - 'USER': 'cltbld', 03:04:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:03 INFO - '_': '/tools/buildbot/bin/python'} 03:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:05 INFO - Downloading docopt-0.6.1.tar.gz 03:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:05 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:05 INFO - Running setup.py install for blobuploader 03:04:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:05 INFO - Running setup.py install for requests 03:04:06 INFO - Running setup.py install for docopt 03:04:06 INFO - Successfully installed blobuploader requests docopt 03:04:06 INFO - Cleaning up... 03:04:06 INFO - Return code: 0 03:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:06 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:04:06 INFO - Using env: {'DISPLAY': ':0', 03:04:06 INFO - 'HOME': '/home/cltbld', 03:04:06 INFO - 'LANG': 'en_US.UTF-8', 03:04:06 INFO - 'LANGUAGE': 'en_US:en', 03:04:06 INFO - 'LOGNAME': 'cltbld', 03:04:06 INFO - 'MAIL': '/var/mail/cltbld', 03:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:06 INFO - 'MOZ_NO_REMOTE': '1', 03:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:06 INFO - 'NO_EM_RESTART': '1', 03:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:06 INFO - 'PWD': '/builds/slave/test', 03:04:06 INFO - 'SHELL': '/bin/bash', 03:04:06 INFO - 'SHLVL': '1', 03:04:06 INFO - 'TERM': 'linux', 03:04:06 INFO - 'TMOUT': '86400', 03:04:06 INFO - 'USER': 'cltbld', 03:04:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:06 INFO - '_': '/tools/buildbot/bin/python'} 03:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:06 INFO - Running setup.py (path:/tmp/pip-3feGX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:06 INFO - Running setup.py (path:/tmp/pip-quLJCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:06 INFO - Running setup.py (path:/tmp/pip-kQT4Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:06 INFO - Running setup.py (path:/tmp/pip-Lpj4vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:06 INFO - Running setup.py (path:/tmp/pip-87LyyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:07 INFO - Running setup.py (path:/tmp/pip-odSFUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:07 INFO - Running setup.py (path:/tmp/pip-XHvbbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:07 INFO - Running setup.py (path:/tmp/pip-5F4qjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:07 INFO - Running setup.py (path:/tmp/pip-AHp14w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:07 INFO - Running setup.py (path:/tmp/pip-RheorS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:07 INFO - Running setup.py (path:/tmp/pip-8FkdYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:07 INFO - Running setup.py (path:/tmp/pip-Dd1Rcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:07 INFO - Running setup.py (path:/tmp/pip-f6QzPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:07 INFO - Running setup.py (path:/tmp/pip-TQvTrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:07 INFO - Running setup.py (path:/tmp/pip-_B8ZKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:07 INFO - Running setup.py (path:/tmp/pip-ZMmGeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:07 INFO - Running setup.py (path:/tmp/pip-uaPiTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:07 INFO - Running setup.py install for manifestparser 03:04:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:07 INFO - Running setup.py install for mozcrash 03:04:08 INFO - Running setup.py install for mozdebug 03:04:08 INFO - Running setup.py install for mozdevice 03:04:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for mozfile 03:04:08 INFO - Running setup.py install for mozhttpd 03:04:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for mozinfo 03:04:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for mozInstall 03:04:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for mozleak 03:04:08 INFO - Running setup.py install for mozlog 03:04:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for moznetwork 03:04:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:08 INFO - Running setup.py install for mozprocess 03:04:09 INFO - Running setup.py install for mozprofile 03:04:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Running setup.py install for mozrunner 03:04:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Running setup.py install for mozscreenshot 03:04:09 INFO - Running setup.py install for moztest 03:04:09 INFO - Running setup.py install for mozversion 03:04:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:09 INFO - Cleaning up... 03:04:09 INFO - Return code: 0 03:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:09 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:04:09 INFO - Using env: {'DISPLAY': ':0', 03:04:09 INFO - 'HOME': '/home/cltbld', 03:04:09 INFO - 'LANG': 'en_US.UTF-8', 03:04:09 INFO - 'LANGUAGE': 'en_US:en', 03:04:09 INFO - 'LOGNAME': 'cltbld', 03:04:09 INFO - 'MAIL': '/var/mail/cltbld', 03:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:09 INFO - 'MOZ_NO_REMOTE': '1', 03:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:09 INFO - 'NO_EM_RESTART': '1', 03:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:09 INFO - 'PWD': '/builds/slave/test', 03:04:09 INFO - 'SHELL': '/bin/bash', 03:04:09 INFO - 'SHLVL': '1', 03:04:09 INFO - 'TERM': 'linux', 03:04:09 INFO - 'TMOUT': '86400', 03:04:09 INFO - 'USER': 'cltbld', 03:04:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:09 INFO - '_': '/tools/buildbot/bin/python'} 03:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:09 INFO - Running setup.py (path:/tmp/pip-Q7W4F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:09 INFO - Running setup.py (path:/tmp/pip-AyKLAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:09 INFO - Running setup.py (path:/tmp/pip-Tcs8ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:10 INFO - Running setup.py (path:/tmp/pip-RubTxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:10 INFO - Running setup.py (path:/tmp/pip-OnF2go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:10 INFO - Running setup.py (path:/tmp/pip-LdzlL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:10 INFO - Running setup.py (path:/tmp/pip-Jqb4Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:10 INFO - Running setup.py (path:/tmp/pip-8yx88e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:10 INFO - Running setup.py (path:/tmp/pip-Y4srKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:10 INFO - Running setup.py (path:/tmp/pip-y_JZA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:10 INFO - Running setup.py (path:/tmp/pip-cSTUm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:10 INFO - Running setup.py (path:/tmp/pip-mFylIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:10 INFO - Running setup.py (path:/tmp/pip-XkIRRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:10 INFO - Running setup.py (path:/tmp/pip-F4Olu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:10 INFO - Running setup.py (path:/tmp/pip-S5ZMbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:10 INFO - Running setup.py (path:/tmp/pip-DPHd6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:10 INFO - Running setup.py (path:/tmp/pip-0pRXXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:04:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - Downloading blessings-1.6.tar.gz 03:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:12 INFO - Installing collected packages: blessings 03:04:12 INFO - Running setup.py install for blessings 03:04:12 INFO - Successfully installed blessings 03:04:12 INFO - Cleaning up... 03:04:12 INFO - Return code: 0 03:04:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:12 INFO - Reading from file tmpfile_stdout 03:04:12 INFO - Current package versions: 03:04:12 INFO - argparse == 1.2.1 03:04:12 INFO - blessings == 1.6 03:04:12 INFO - blobuploader == 1.2.4 03:04:12 INFO - docopt == 0.6.1 03:04:12 INFO - functools32 == 3.2.3-2 03:04:12 INFO - jsonschema == 2.5.1 03:04:12 INFO - manifestparser == 1.1 03:04:12 INFO - mozInstall == 1.13 03:04:12 INFO - mozcrash == 1.0 03:04:12 INFO - mozdebug == 0.1 03:04:12 INFO - mozdevice == 0.51 03:04:12 INFO - mozfile == 1.2 03:04:12 INFO - mozhttpd == 0.7 03:04:12 INFO - mozinfo == 0.10 03:04:12 INFO - mozleak == 0.1 03:04:12 INFO - mozlog == 3.5 03:04:12 INFO - moznetwork == 0.27 03:04:12 INFO - mozprocess == 0.25 03:04:12 INFO - mozprofile == 0.28 03:04:12 INFO - mozrunner == 6.13 03:04:12 INFO - mozscreenshot == 0.1 03:04:12 INFO - mozsystemmonitor == 0.3 03:04:12 INFO - moztest == 0.8 03:04:12 INFO - mozversion == 1.4 03:04:12 INFO - psutil == 3.1.1 03:04:12 INFO - requests == 1.2.3 03:04:12 INFO - wsgiref == 0.1.2 03:04:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:12 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:04:12 INFO - Using env: {'DISPLAY': ':0', 03:04:12 INFO - 'HOME': '/home/cltbld', 03:04:12 INFO - 'LANG': 'en_US.UTF-8', 03:04:12 INFO - 'LANGUAGE': 'en_US:en', 03:04:12 INFO - 'LOGNAME': 'cltbld', 03:04:12 INFO - 'MAIL': '/var/mail/cltbld', 03:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:12 INFO - 'MOZ_NO_REMOTE': '1', 03:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:12 INFO - 'NO_EM_RESTART': '1', 03:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:12 INFO - 'PWD': '/builds/slave/test', 03:04:12 INFO - 'SHELL': '/bin/bash', 03:04:12 INFO - 'SHLVL': '1', 03:04:12 INFO - 'TERM': 'linux', 03:04:12 INFO - 'TMOUT': '86400', 03:04:12 INFO - 'USER': 'cltbld', 03:04:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:12 INFO - '_': '/tools/buildbot/bin/python'} 03:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:04:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:04:14 INFO - Installing collected packages: simplejson 03:04:14 INFO - Running setup.py install for simplejson 03:04:14 INFO - building 'simplejson._speedups' extension 03:04:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:04:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:04:15 INFO - Successfully installed simplejson 03:04:15 INFO - Cleaning up... 03:04:15 INFO - Return code: 0 03:04:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:15 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1962b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, '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': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:04:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:04:15 INFO - Using env: {'DISPLAY': ':0', 03:04:15 INFO - 'HOME': '/home/cltbld', 03:04:15 INFO - 'LANG': 'en_US.UTF-8', 03:04:15 INFO - 'LANGUAGE': 'en_US:en', 03:04:15 INFO - 'LOGNAME': 'cltbld', 03:04:15 INFO - 'MAIL': '/var/mail/cltbld', 03:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:15 INFO - 'MOZ_NO_REMOTE': '1', 03:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:15 INFO - 'NO_EM_RESTART': '1', 03:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:15 INFO - 'PWD': '/builds/slave/test', 03:04:15 INFO - 'SHELL': '/bin/bash', 03:04:15 INFO - 'SHLVL': '1', 03:04:15 INFO - 'TERM': 'linux', 03:04:15 INFO - 'TMOUT': '86400', 03:04:15 INFO - 'USER': 'cltbld', 03:04:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:15 INFO - '_': '/tools/buildbot/bin/python'} 03:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:04:15 INFO - Cleaning up... 03:04:15 INFO - Return code: 0 03:04:15 INFO - Running post-action listener: _resource_record_post_action 03:04:15 INFO - Running post-action listener: _start_resource_monitoring 03:04:15 INFO - Starting resource monitoring. 03:04:15 INFO - [mozharness: 2017-10-04 10:04:15.369206Z] Finished create-virtualenv step (success) 03:04:15 INFO - [mozharness: 2017-10-04 10:04:15.370155Z] Running install step. 03:04:15 INFO - Running pre-action listener: _resource_record_pre_action 03:04:15 INFO - Running main action method: install 03:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:15 INFO - Reading from file tmpfile_stdout 03:04:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:15 INFO - Reading from file tmpfile_stdout 03:04:15 INFO - Output received: 03:04:15 INFO - Usage: mozinstall [options] installer 03:04:15 INFO - Options: 03:04:15 INFO - -h, --help show this help message and exit 03:04:15 INFO - -d DEST, --destination=DEST 03:04:15 INFO - Directory to install application into. [default: 03:04:15 INFO - "/builds/slave/test"] 03:04:15 INFO - --app=APP Application being installed. [default: firefox] 03:04:15 INFO - mkdir: /builds/slave/test/build/application 03:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:04:33 INFO - Reading from file tmpfile_stdout 03:04:33 INFO - Output received: 03:04:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:04:33 INFO - Running post-action listener: _resource_record_post_action 03:04:33 INFO - [mozharness: 2017-10-04 10:04:33.502292Z] Finished install step (success) 03:04:33 INFO - [mozharness: 2017-10-04 10:04:33.502521Z] Running setup-mitmproxy step. 03:04:33 INFO - Running pre-action listener: _resource_record_pre_action 03:04:33 INFO - Running main action method: setup_mitmproxy 03:04:33 INFO - Skipping: mitmproxy is not required 03:04:33 INFO - Running post-action listener: _resource_record_post_action 03:04:33 INFO - [mozharness: 2017-10-04 10:04:33.503906Z] Finished setup-mitmproxy step (success) 03:04:33 INFO - [mozharness: 2017-10-04 10:04:33.504143Z] Running run-tests step. 03:04:33 INFO - Running pre-action listener: _resource_record_pre_action 03:04:33 INFO - Running pre-action listener: _set_gcov_prefix 03:04:33 INFO - Running main action method: run_tests 03:04:33 WARNING - Try message not found. 03:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:04:33 INFO - Python 2.7.3 03:04:33 INFO - Return code: 0 03:04:33 INFO - grabbing minidump binary from tooltool 03:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:04:33 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 0x1b04d60>, '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 0x1b05a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b05ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:04:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:04:33 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:04:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:04:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:33 INFO - Return code: 0 03:04:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:04:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - ENV: RUST_BACKTRACE is now full 03:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:04:33 INFO - Using env: {'DISPLAY': ':0', 03:04:33 INFO - 'HOME': '/home/cltbld', 03:04:33 INFO - 'LANG': 'en_US.UTF-8', 03:04:33 INFO - 'LANGUAGE': 'en_US:en', 03:04:33 INFO - 'LOGNAME': 'cltbld', 03:04:33 INFO - 'MAIL': '/var/mail/cltbld', 03:04:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:04:33 INFO - 'MOZ_ACCELERATED': '1', 03:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:33 INFO - 'MOZ_NO_REMOTE': '1', 03:04:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:33 INFO - 'MOZ_WEBRENDER': '1', 03:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:33 INFO - 'NO_EM_RESTART': '1', 03:04:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:33 INFO - 'PWD': '/builds/slave/test', 03:04:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:33 INFO - 'RUST_BACKTRACE': 'full', 03:04:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:04:33 INFO - 'SHELL': '/bin/bash', 03:04:33 INFO - 'SHLVL': '1', 03:04:33 INFO - 'TERM': 'linux', 03:04:33 INFO - 'TMOUT': '86400', 03:04:33 INFO - 'USER': 'cltbld', 03:04:33 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:33 INFO - '_': '/tools/buildbot/bin/python'} 03:04:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:04:33 INFO - mozversion application_buildid: 20171004091107 03:04:33 INFO - mozversion application_changeset: 933b30269777f718a14d2fc379e563a051b14618 03:04:33 INFO - mozversion application_display_name: Nightly 03:04:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:33 INFO - mozversion application_name: Firefox 03:04:33 INFO - mozversion application_remotingname: firefox 03:04:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:04:33 INFO - mozversion application_vendor: Mozilla 03:04:33 INFO - mozversion application_version: 58.0a1 03:04:33 INFO - mozversion platform_buildid: 20171004091107 03:04:33 INFO - mozversion platform_changeset: 933b30269777f718a14d2fc379e563a051b14618 03:04:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:04:33 INFO - mozversion platform_version: 58.0a1 03:04:33 INFO - using testdate: 1507111473 03:04:33 INFO - actual date: 1507111473 03:04:33 INFO - starting webserver on 'localhost:53939' 03:04:33 INFO - SUITE-START | Running 2 tests 03:04:33 INFO - TEST-START | dromaeo_css 03:04:33 INFO - Initialising browser for dromaeo_css test... 03:04:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53939/getInfo.html -profile /tmp/tmpVfMGnR/profile 03:04:33 INFO - TEST-INFO | started process 3885 (/builds/slave/test/build/application/firefox/firefox http://localhost:53939/getInfo.html) 03:04:43 INFO - TEST-INFO | 3885: exit 0 03:04:43 INFO - Browser initialized. 03:04:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:04:43 INFO - Using env: {'DISPLAY': ':0', 03:04:43 INFO - 'HOME': '/home/cltbld', 03:04:43 INFO - 'JSGC_DISABLE_POISONING': '1', 03:04:43 INFO - 'LANG': 'en_US.UTF-8', 03:04:43 INFO - 'LANGUAGE': 'en_US:en', 03:04:43 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:04:43 INFO - 'LOGNAME': 'cltbld', 03:04:43 INFO - 'MAIL': '/var/mail/cltbld', 03:04:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:04:43 INFO - 'MOZ_ACCELERATED': '1', 03:04:43 INFO - 'MOZ_CRASHREPORTER': '1', 03:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:43 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:04:43 INFO - 'MOZ_NO_REMOTE': '1', 03:04:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:43 INFO - 'MOZ_WEBRENDER': '1', 03:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:43 INFO - 'NO_EM_RESTART': '1', 03:04:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:43 INFO - 'PWD': '/builds/slave/test', 03:04:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:43 INFO - 'RUST_BACKTRACE': 'full', 03:04:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:04:43 INFO - 'SHELL': '/bin/bash', 03:04:43 INFO - 'SHLVL': '1', 03:04:43 INFO - 'TERM': 'linux', 03:04:43 INFO - 'TMOUT': '86400', 03:04:43 INFO - 'USER': 'cltbld', 03:04:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:43 INFO - '_': '/tools/buildbot/bin/python'} 03:04:43 INFO - TEST-INFO | started process 4135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVfMGnR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:44 INFO - PID 4135 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:04:44 INFO - PID 4135 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:04:44 INFO - PID 4135 | 03:04:44 INFO - PID 4135 | (/builds/slave/test/build/application/firefox/firefox:4194): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:04:44 INFO - PID 4135 | 03:04:55 INFO - PID 4135 | RSS: Main: 195661824 03:04:55 INFO - PID 4135 | 03:07:53 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53939/tests/dromaeo/cssquery-ext.html) 03:07:54 INFO - PID 4135 | RSS: Main: 194834432 03:07:54 INFO - PID 4135 | 03:10:56 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-ext.html (next: http://localhost:53939/tests/dromaeo/cssquery-jquery.html) 03:10:57 INFO - PID 4135 | RSS: Main: 194863104 03:10:57 INFO - PID 4135 | 03:13:59 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53939/tests/dromaeo/cssquery-mootools.html) 03:13:59 INFO - PID 4135 | RSS: Main: 195563520 03:13:59 INFO - PID 4135 | 03:17:01 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53939/tests/dromaeo/cssquery-prototype.html) 03:17:02 INFO - PID 4135 | RSS: Main: 194973696 03:17:02 INFO - PID 4135 | 03:20:06 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53939/tests/dromaeo/cssquery-yui.html) 03:20:06 INFO - PID 4135 | RSS: Main: 197836800 03:20:06 INFO - PID 4135 | 03:23:08 INFO - PID 4135 | Cycle 1(1): loaded http://localhost:53939/tests/dromaeo/cssquery-yui.html (next: http://localhost:53939/tests/dromaeo/cssquery-dojo.html) 03:23:09 INFO - PID 4135 | RSS: Main: 199151616 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | __start_tp_report 03:23:09 INFO - PID 4135 | _x_x_mozilla_page_load 03:23:09 INFO - PID 4135 | _x_x_mozilla_page_load_details 03:23:09 INFO - PID 4135 | |i|pagename|runs| 03:23:09 INFO - PID 4135 | |0;dojo.html;3120.3291292372137;3146.4493713600123;3148.071318960905;3160.8419579021042;3183.278297056018;6132.724027418766;6280.591761535497;6289.654069026207;6313.305536390999;6376.234851817777;6173.197484327031;6235.657038862861;6393.616383017011;6394.392532709397;6421.068945002972;5626.212330273765;5766.990776614086;5826.679532625704;5847.1521629363715;5925.644461332334;5682.54539636828;5740.397258287882;5811.186433899257;5820.505257053155;5834.824955251349;5632.549396048306;5672.489475947164;5706.9429305707245;5713.800016999385;5772.480476757091;5635.746391412396;5655.604107712462;5670.829875103712;5762.798302059449;5789.334226563957;5740.655560666373;5743.569232307552;5765.4522820332;5805.4194580542035;5825.03886858672;6288.717007734663;6294.402031806971;6352.364763523657;6374.203224596926;6395.808125756234;6463.289038205794;6573.769918052845;6643.136392268974;6687.49843761715;6816.079829223041;6667.499937504706;6715.6977935993;6723.831904202434;6726.394624483771;6727.260001399842;6095.481884039862;6128.908066379008;6168;6169.105479705418;6273.435390814849;7006.614636195059;7052.294770523009;7064.399526040242;7071.858562828715;7078.646067696697;6545.37818907203;6616.768413105518;6648.5346025777735;6707.027481015225;6707.496937729592;6482.481401487869;6577.14497115372;6795.932040679629;6823.420009299166;6879.449644028466;6462.935370646233;6548.214214294315;6565.67171641416;6569.868602628017;6573.408393244631;6570.441512471398;6587.934120658828;6589.439897608661;6591.813473574706;6636.734530618721;5085.74571271435;5128.410232823198;5176.275321454999;5240.973795131;5245.659032162897;4526.751028693454;4623.329617205486;4648.1865673507;4648.767561621906;4660.1145782301255;5687.090065589486;5716;5729.197912292282;5735.483806457439;5779.075347944308;6523.086767852505;6639.269680335159;6648.268690444047;6655.86688266232;6681.432078273401;5635.633683810539;5658.91511627326;5713.800016999385;5720.542356611544;5725.885482290331;5695.259616249944;5793.362730099686;5794.681292528951;5813.157092221604;5816.592838501264;6312.652804095819;6461.095446637474;6465.515086368447;6508.284088750233;6540.771073012422;6505.316941721051;6521.282658907611;6526.24948130971;6533.542652014314;6539.574927629784;6483.09236706852;6566.540342176193;6569.507286953402;6596.8350791230605;6623.701933413105;6648.800535983734;6661.267260601427;6668.399844014062;6684.966575167093;6769.526133170631;6727.058211850443;6757.189137303555;6786.898196526958;6792.490563207878;6868.107146070979;6334.113224148715;6436.806895793134;6467.644279564669;6552.6068435894;6617.07360969455;6518.413342799171;6550.8362290943105;6550.868982620416;6600.768973085919;6604.735810567716;6475.870482590416;6530.575512591667;6542.705578248895;6569.047488114101;6586.736530538917;6584.76953306632;6606.075149479173;6611.801645950629;6698.028785825931;6701.966490167518;6091.42131497507;6136.325004249618;6206.937930620636;6317.557770955989;6398.90401643985 03:23:09 INFO - PID 4135 | |1;ext.html;856.9185927336904;874.5627186406792;875.8686197070434;879.1911441473843;887.613887958738;38015.42976855349;41996.58003419969;42048.57951420485;42180.789096054556;42378.7881060595;37755.433668494996;38156.23687526255;38193.04517387067;38263.80868095662;38416.61583384165;7056.894146587792;7138.286171382846;7151.606661633608;7187.173475050357;7216.314450127229;7099.716011359539;7156.821079473003;7163.426925845946;7217.350438460538;7222.386097181746;7190.820229494252;7204.495685302031;7214.603196824199;7216.422686185093;7794.883076753853;7879.8424031519335;7889.96055019727;7937.920620793776;7943.285104340608;7948.721794737156;7771.494852834604;7772.455928085036;7789.649465774054;7871.960640196762;7876.212378762135;36701.44947825785;37382;39614.60385396138;39901.60098399008;40030.199396012205;3553;3564.928701425983;3605.963940360589;3613.7470377073614;3617.5658920929395;32310.35379292401;32482.837585811918;32735.672643273738;32752.508712369334;32828.835855820806;5096.235564665293;5119.283300337956;5127.230915362688;5137.229415587692;5202.4537423570355;182493;186265;187375;188482;189798.05100974545;42246.78876605597;42839.78580107079;49138;49358.25962610564;49375;52293.47706522962;52350;52835;52993;52996;16066.437674681563;16087.356505739874;16131.032138071754;16213.513594592181;16230.188490575423;12845;12873.549425770054;12936.611901642966;12974.935125324502;12993.545225917047;14041.578752637437;14106.15363078198;14226.928865355607;14336.283185840666;14463.349149288308;5815.76736930518;5870.090136028923;5873.353931067579;5936.9406305937255;5972.283326000907;980.1668581705493;981.3523074770617;999.1058003087196;1009.8232809258351;1019.2915923433143;22646.773532264797;22978.310650680505;23010.19464318741;23025;23113.537729245658;1081.0918232494366;1085.3542142425244;1087.9347239165675;1097.1058587251364;1114.5207560748793;12147.514099435924;12160.45277962476;12343.382830858422;12372.938135309267;12383.62849114528;221942;222342;222919;224010;224519;51817.48182518202;51825;52029.73985130126;52459;52572.21141682878;1415.5399495163906;1463.8536146385277;1471.5144002479155;1475.129673492623;1476.512750792236;22523;22562.210322638628;22717.772822272225;23019.579665888323;23050.538989219785;37316.626833731316;37582;37673;37699.81150094232;37802;189862.05068974567;190244;191085;191633;191653;29317.85341073281;30837.537436938015;31586;31609.36781264316;34218.48672269868;42083.7895810519;43535;43632.345514817935;43851.0602306536;44094;31861.20346991344;31929.521057183698;31978.680213198502;32270.677293226767;32536.51195232026;32030.51954220642;32044.51933220957;32117.197070073435;32229;32450.83774581112;34757.65242347645;36060;36297.27405451929;36377.45433818442;36390.818045909604;31116.844415777778;31490.685093148775;31560.36879262448;31807.363852722352;31809.363812723153;23463.88268058649;23826.761732383147;23995.400114997265;24134.637980429958;24144.517109657358 03:23:09 INFO - PID 4135 | |2;jquery.html;587.198474082877;591.27273453652;596.6151832068314;619.1486705779553;619.7118339971913;22501.54996900061;23363.415914602123;23412.882935585298;23425.414364640892;23435.648465272992;23811.76188238117;24959;25013;25038.874805625946;25071.373215669617;6538.117354157187;6754.324567543255;6758.391744742972;6759.729610815586;6776.017477465764;6641.369069938348;6756.121704178475;6759.121314229168;6761.154855643044;6762.830929226784;6502.414782669559;6703.597784132943;6767.120274364326;6789.626570538619;6790.5246632735725;6658.833529161761;6698.765543206013;6731.697073631698;6741.258461569248;6751.831204219885;6202.069689546604;6233.0338797486465;6240.781572644935;6267.373262673742;6270.247570291549;27466.17601471959;27470.17589472319;28599.142025739053;28653.856730716423;28660;2052.230413594902;2079.563291708743;2081.0219196977396;2083.645780217367;2083.7082808406835;19416.22335106594;19692.70460943087;19723.112459939337;19723.40829775109;19755.20979160832;2326.592846251899;2358.481134150484;2369.2300002499255;2379.559781440439;2483.615039668854;125535;131920;132299.33850330784;134787;142075;14667.926660366844;14673.826093912461;14721.372197622875;14832.851671483148;14907.552773416815;23118.19086332004;23187.7681223189;23303.883480582488;23305.766942330698;23338.416539586306;10062.647807326708;10192.082712555906;10192.694219173436;10249.33379330341;10402.687919362432;9316.254699624014;9341.20599749029;9414.764630884145;9536.28477864163;9595.808083838285;9003.36976411658;9015.791131172904;9183.612260812104;9280.72157835266;9373;2617.5525883298797;2644.7355264473786;2748.738869807405;2774.375765452797;2818.1250780177256;949.6771097826634;962.9744322296732;970.0251247496221;974.5517062151348;987.0721521769514;18693.90653046753;18863.339783107524;19277.132529036226;19428.611427771364;19473.90263048676;1025.2208321675432;1025.4206373399006;1032.2206733915996;1034.9586016559404;1037.574594416301;10308.32995855267;10472.476376181314;10481.580736770597;10637.361758294526;10678;487009;488270;495611;502522;503069;117401;118128.40935795267;119977.40011299888;121266.3936680311;121666;1005.6781829814389;1025.3950169400089;1168.4449886304108;1184.3604453594962;1194.4147367789722;19618.760120749033;19644;19748.802511974696;20080.79515229091;20198.59602807906;55984.44015559792;57962.42037579739;59143.70428147832;59384.40615593789;60037.39962600493;68328;68877.3112268891;71945.6402717983;72223.27776722166;73004;14205.573832785032;14523.927380363031;14616;14661.63345916318;14681.192534410282;22369.77630223742;22428.887855560617;22740.317790466313;22752.431189220402;22792.544149117257;17883.821161788215;18064.72902906431;18195.18121684501;18211.817881821542;18339.26642934321;16182;16222.594435139215;16735.24691388866;16821.91589042047;16894.66210675755;18506.537336566154;18610.813891860907;18642.44072677822;18773;18871;14330.85669143337;14331;14338.928305358406;14475.638109047359;14544;17916.193771280065;18042.1881015352;18099.457016289532;18150;18399 03:23:09 INFO - PID 4135 | |3;mootools.html;1307.4312673986813;1349.0826238158054;1373.1692326142684;1379.7999290102935;1381.792731090337;15109.92445037776;15600.843991560081;15718.449854255103;15811.68376632468;15824.604384890368;15269.312880920357;15477;15569.455069072585;15574.532764017069;15575;2707.7698395636394;2824.3221626809523;2830.1368082734757;2835.957460638092;2842.7299406556344;2795.049683107743;2828.2081017315186;2843.943121137576;2845.971540284602;2853.4293141371704;2728.836269823807;2769.2246171072134;2835.517961946474;2849.3019210293505;2854.1865568313033;2744.519709050908;2748.6151938728594;2754.931126721828;2755.7106503817113;2757.7931655125844;2626.4747050589767;2658.0962472759356;2659.494696007772;2665.746754058361;2677.9598306025423;14407.423703051865;14503.564893053226;14663.92668036653;14680.632984175374;14830.851691483163;8197.139300373434;8375.539345336005;8431.19903609156;8459.027211870653;8478.321734261244;5373.677579345252;5633.023898874193;5728.799492017801;5729.541636669098;5812.099124635688;1884.689026310657;1913.6938089905548;1920.596674698315;1931.1020375525309;1934.0039879462088;26735.73264267352;26898.193054208405;27051.323716907234;27058.999999999804;27101.72898271012;6759.357861003196;6824.761133360308;6908.447324214051;6990.755323563651;7080.36276735086;16637.584060398585;16641.583960401087;16729.079900605582;16746.74879876803;16796.16019199035;7982.760517184493;8247.298979586682;8253.422260441712;8259.628316725762;8260.586970651444;7137;7297.562146271241;7449.180590135081;7525.736599219001;7579.658915348822;5170.586353091744;5341.198820177005;5376.516113549721;5384.6769193848495;5385.7576409061685;1540.5224380442098;1578.8894777365704;1592.570006098347;1596.5689263898682;1598.5763772600271;845.049319515545;860.6084231674573;873.4671850171391;874.1957399192758;876.7282142535835;7404.888926666104;7445.9627701861145;8089.209222818118;8456.238938495564;8520.659173632985;719.133444199738;722.7434260837432;725.7496163823472;739.2939742545856;758.1773775453695;4881.145799485147;4962.950370496249;4967.230079337708;5090.363704536933;5239.842804715865;21711.565768684854;22266.666000010013;22325.77674223237;22682.659760103612;22693.659595106088;21645.56708865814;22135.667964980537;22356.664650030263;22452.438689032904;22471.43821404478;11411.771764564663;11573.479193436315;11815;11874.525018999317;11969.102317326235;8060.31487323584;8082.6362813674705;8190.7133250335955;8195.385346098947;8364.66541338364;18386.724199136755;18954.620907582048;19048.42854714361;19333.419997400102;19462.513437164183;18907.62184756325;19582.11880465411;20069.197232110553;20297.28959486411;20495.795042049387;10952.56189752401;10981.945090274497;10999;11069.944650276697;11070.501827417947;13793.862061379257;13923.23422211788;13952.720945581235;13974.860251397762;14033.649158771112;11528.250663706833;11841.46713397882;11937.94031029874;11945.4027298633;12076.094292928241;10740.83888741685;10795.892041079804;10851.077658398808;11029.669109926715;11121.443927803415;10595.417252051211;10673.039426451656;10677.305975111592;10694.946525267324;10777.46112694378;7661.540307581563;7721.729739459092;7763.456558040883;7797.532148071134;7889.0927543333255;7683.961580192064;7708.691652334068;7709.151993280622;7750.922490775246;7778.338841198562 03:23:09 INFO - PID 4135 | |4;prototype.html;500.32206360381707;517.4566704959791;541.7210136779559;545.5390195284983;548.9862753431164;6135;6213.130161777349;6214.689265536722;6260.686965651722;6284.340144284853;6169.352218017111;6184.319724830265;6193.721282542297;6222.5021998240145;6238.4385405313515;5160.354955630546;5160.741962901859;5175.482451754813;5179.404368497614;5193.376794784631;5144.922826157611;5150.974245128769;5166.819161329354;5193.9740301298625;5207.687538747668;4844.781984810692;4912.656114072016;4936.4076310842565;4964.900701985958;4979.526944940225;4940.876478088041;4954.687007942898;4979.327790748239;4997.375328083989;5040.621953353495;4361.171377438277;4465;4479.7088189267915;4493.865184044484;4531.207038768202;6009.6394216346725;6050.909236361458;6053.970824959767;6098.939010609882;6108.144859719643;5671.9716401418145;5675.489205971482;5715.114157305624;5718.656880587178;5747;6399.136116624242;6485.578437401554;6488.864448721455;6510.576812507172;6516.152900122954;4691.554302341272;4901.289313049623;4928.876778080541;4934.851954441337;4946.307516947631;6599.93400065998;6616.636085015322;6728.519725660347;6759.7972060837765;6806.353396427331;4997.525235102732;5004.524570165829;5007.123753343223;5034.471380505068;5044.8234311798915;5001.349824522788;5122.769475373617;5126.282320475137;5126.512981266774;5140.588752899759;5622.718864056863;5636.210930469738;5675.120356344773;5683.403242659544;5715.570657605486;6493.448056915121;6535.372868058178;6597.30728273534;6612.669366531654;6623.834404139839;1757.4815429448342;1769.9203535840918;1771.7962434320218;1776.6269083492612;1793.1303317890813;1177.7291223018753;1238.7832129377323;1248.1450206608502;1250.4560516175493;1250.8624051354343;5546.667199968015;5548.750306236229;5554.1946417770005;5566.387697353288;5606.411326810708;6608.207015158212;6608.537402381787;6709.765158219537;6712.194536655633;6730.697118629673;5430.782768689208;5560.916586251209;5575.804846830422;5592.636478628876;5667.404922483162;3432.8111953842777;3502.8073455959657;3514.8066856322635;3516.82415879205;3579.83890724918;6310.5898116622275;6339.144215530937;6360.837315312723;6416.615003099736;6471.708773105222;6377.298497165308;6709.597424154566;6739.663016849138;6814.182298124257;6846.349596788297;6313.715882785285;6334.619922804646;6337.366263373718;6346.9682651586445;6387.2335319761;6648.933510664831;6687.699053542505;6738.898916516354;6765.357291057342;6777.830554236183;6560.40956313934;6623.205215374186;6624.370684784938;6665.833354166185;6719.328067193242;6311.558190926591;6387.943655778707;6412.551121421456;6413.4869210463985;6510.153680021567;5033.84898453047;5044.117279476003;5051.570616497639;5051.898962020666;5061.063703214917;6394.1687580614225;6562.967185164043;6598.1422415085735;6603.20761508622;6747.291534388818;6139.3246742857355;6290.402411771058;6300.401461861299;6329.778457753957;6406.551541392244;6406.487481001602;6448.742050318122;6472.838179045373;6495.317991610813;6518.282988871315;6277.5605707600025;6352.269489008639;6358.395952384516;6365.663210725799;6366.29970703213;6377.7130029147875;6430.164078669743;6496.642684652389;6539.542232043711;6552.63960482178;6129.785457508966;6229.470495007794;6237.220347456568;6256.499480041494;6262.436380725757 03:23:09 INFO - PID 4135 | |5;yui.html;877.9517126558045;907.9546022698868;909.8043920557079;911.138973669882;933.5472295936472;19236.807631923675;20191.798082019177;20354.694679579818;20403.795962040374;20404.693929591067;17188;17323.566910827205;17352.47942561722;19281;19400.22399104034;945.4469135555692;968.0706521739139;969.9903000970006;970.1171933540479;970.3595626886256;990.8810942686888;993.1855878179896;1000.6097621927454;1001.6293971230655;1002.293383164867;1004.3772860826261;1017.6896046705751;1039.6413237433073;1042.3745752548487;1046.2101113659214;1025.3079171559204;1036.5024788101678;1038.8441733739962;1039.50103950104;1041.463646222196;728.7449392712562;737.2885165814961;746.0748671647173;746.5259560179271;749.838784661295;20259.493512662302;20383.796162038485;20463;20648.277310294066;20669.793302066937;19331.903340483208;19478.02609869515;19539.609207815905;19745.703814442793;19759.110840012236;17144.657106857794;17550.561235969075;17601.911990440094;17610.38363657266;17714.114294285362;3749.7187710921517;3763.153290509641;3789.3368660484307;3795.2409518096492;3796.506454160969;133651.33174334164;135516.25693100694;138055.30972345173;139866;142242;16559.503214903572;16908.323667053428;16970.660586788443;17162.656746864992;17194.14029298555;30862.228444288623;30884.84557577198;30930.53604195939;31106.377872442423;32666.346673066404;8927.464352138892;9112.8633070504;9114.088591140833;9120.407173533698;9243.815123697488;4393.846215382447;4479.193745125844;4489.6408287336935;4492.528284530077;4494.70784399013;5411.134218525017;5533.142362933751;5555.250041244381;5574.9721251393485;5579.9163012554845;1029.27950434696;1059.2902755154066;1069.5240617924949;1075.306427354352;1076.8815430302661;672.603164133154;690.2752110284182;697.6442014572503;698.5738699393366;704.8097013806243;10716.624918127829;10802.081823044971;11225.494852731646;11409.657710268706;11785.526809148856;660.9008648702733;669.9883176403665;679.4869873245668;683.6547543490506;694.0422217340039;5082;5170.793168273227;5210.166373380241;5291.126964050965;5337.5463085637375;120235.39882300707;120651;121825.39087304506;121886.3905680466;127030;91000;109650.45174774075;110794.44602776934;115450.42274788572;117822.410887945;100014.99985000203;103012;104398.47800760948;105386.47306763417;106480.46759766151;12043.156979011736;12056.914877661053;12094.395280235776;12134.150609457252;12313.815292770794;45976.31035534536;46675;47527.52472475369;47686.523134768206;48249.75875120602;59872.70063649828;60745.69627151836;61309;62119;62957.68521157365;18750.249990000248;18758.812411876253;18764;18903.149358279185;18946.52633684169;20902.895485522477;21082.683759743308;21358.145674172858;21721;21751.564968700855;19918.5020374486;19938.90030549838;20095.899520502306;20170.29403970854;20497.38507844767;19367.418977430698;19579.60840783205;19672.11475483578;19789.30737424183;19892;18735.250589976247;18909.014553471687;19194.520136996685;19202.711959320342;19294.903525482845;12795.42420591057;12888.548900788428;13201.801972970221;13237.933810330887;13361;12925.612231633066;12997.415116319977;13051.086423950612;13059;13129.277889716157 03:23:09 INFO - PID 4135 | __end_tp_report 03:23:09 INFO - PID 4135 | __start_cc_report 03:23:09 INFO - PID 4135 | _x_x_mozilla_cycle_collect,279 03:23:09 INFO - PID 4135 | __end_cc_report 03:23:09 INFO - PID 4135 | __startTimestamp1507112589075__endTimestamp 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | ------- Summary: start ------- 03:23:09 INFO - PID 4135 | Number of tests: 6 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#0] dojo.html Cycles:165 Average:6152.37 Median:6436.81 stddev:743.42 (11.5%) stddev-sans-first:706.62 03:23:09 INFO - PID 4135 | Values: 3120.3 3146.4 3148.1 3160.8 3183.3 6132.7 6280.6 6289.7 6313.3 6376.2 6173.2 6235.7 6393.6 6394.4 6421.1 5626.2 5767.0 5826.7 5847.2 5925.6 5682.5 5740.4 5811.2 5820.5 5834.8 5632.5 5672.5 5706.9 5713.8 5772.5 5635.7 5655.6 5670.8 5762.8 5789.3 5740.7 5743.6 5765.5 5805.4 5825.0 6288.7 6294.4 6352.4 6374.2 6395.8 6463.3 6573.8 6643.1 6687.5 6816.1 6667.5 6715.7 6723.8 6726.4 6727.3 6095.5 6128.9 6168.0 6169.1 6273.4 7006.6 7052.3 7064.4 7071.9 7078.6 6545.4 6616.8 6648.5 6707.0 6707.5 6482.5 6577.1 6795.9 6823.4 6879.4 6462.9 6548.2 6565.7 6569.9 6573.4 6570.4 6587.9 6589.4 6591.8 6636.7 5085.7 5128.4 5176.3 5241.0 5245.7 4526.8 4623.3 4648.2 4648.8 4660.1 5687.1 5716.0 5729.2 5735.5 5779.1 6523.1 6639.3 6648.3 6655.9 6681.4 5635.6 5658.9 5713.8 5720.5 5725.9 5695.3 5793.4 5794.7 5813.2 5816.6 6312.7 6461.1 6465.5 6508.3 6540.8 6505.3 6521.3 6526.2 6533.5 6539.6 6483.1 6566.5 6569.5 6596.8 6623.7 6648.8 6661.3 6668.4 6685.0 6769.5 6727.1 6757.2 6786.9 6792.5 6868.1 6334.1 6436.8 6467.6 6552.6 6617.1 6518.4 6550.8 6550.9 6600.8 6604.7 6475.9 6530.6 6542.7 6569.0 6586.7 6584.8 6606.1 6611.8 6698.0 6702.0 6091.4 6136.3 6206.9 6317.6 6398.9 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#1] ext.html Cycles:180 Average:36923.05 Median:19832.98 stddev:52029.15 (262.3%) stddev-sans-first:52104.63 03:23:09 INFO - PID 4135 | Values: 856.9 874.6 875.9 879.2 887.6 38015.4 41996.6 42048.6 42180.8 42378.8 37755.4 38156.2 38193.0 38263.8 38416.6 7056.9 7138.3 7151.6 7187.2 7216.3 7099.7 7156.8 7163.4 7217.4 7222.4 7190.8 7204.5 7214.6 7216.4 7794.9 7879.8 7890.0 7937.9 7943.3 7948.7 7771.5 7772.5 7789.6 7872.0 7876.2 36701.4 37382.0 39614.6 39901.6 40030.2 3553.0 3564.9 3606.0 3613.7 3617.6 32310.4 32482.8 32735.7 32752.5 32828.8 5096.2 5119.3 5127.2 5137.2 5202.5 182493.0 186265.0 187375.0 188482.0 189798.1 42246.8 42839.8 49138.0 49358.3 49375.0 52293.5 52350.0 52835.0 52993.0 52996.0 16066.4 16087.4 16131.0 16213.5 16230.2 12845.0 12873.5 12936.6 12974.9 12993.5 14041.6 14106.2 14226.9 14336.3 14463.3 5815.8 5870.1 5873.4 5936.9 5972.3 980.2 981.4 999.1 1009.8 1019.3 22646.8 22978.3 23010.2 23025.0 23113.5 1081.1 1085.4 1087.9 1097.1 1114.5 12147.5 12160.5 12343.4 12372.9 12383.6 221942.0 222342.0 222919.0 224010.0 224519.0 51817.5 51825.0 52029.7 52459.0 52572.2 1415.5 1463.9 1471.5 1475.1 1476.5 22523.0 22562.2 22717.8 23019.6 23050.5 37316.6 37582.0 37673.0 37699.8 37802.0 189862.1 190244.0 191085.0 191633.0 191653.0 29317.9 30837.5 31586.0 31609.4 34218.5 42083.8 43535.0 43632.3 43851.1 44094.0 31861.2 31929.5 31978.7 32270.7 32536.5 32030.5 32044.5 32117.2 32229.0 32450.8 34757.7 36060.0 36297.3 36377.5 36390.8 31116.8 31490.7 31560.4 31807.4 31809.4 23463.9 23826.8 23995.4 24134.6 24144.5 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#2] jquery.html Cycles:180 Average:34916.15 Median:22955.37 stddev:83357.14 (363.1%) stddev-sans-first:83551.13 03:23:09 INFO - PID 4135 | Values: 587.2 591.3 596.6 619.1 619.7 22501.5 23363.4 23412.9 23425.4 23435.6 23811.8 24959.0 25013.0 25038.9 25071.4 6538.1 6754.3 6758.4 6759.7 6776.0 6641.4 6756.1 6759.1 6761.2 6762.8 6502.4 6703.6 6767.1 6789.6 6790.5 6658.8 6698.8 6731.7 6741.3 6751.8 6202.1 6233.0 6240.8 6267.4 6270.2 27466.2 27470.2 28599.1 28653.9 28660.0 2052.2 2079.6 2081.0 2083.6 2083.7 19416.2 19692.7 19723.1 19723.4 19755.2 2326.6 2358.5 2369.2 2379.6 2483.6 125535.0 131920.0 132299.3 134787.0 142075.0 14667.9 14673.8 14721.4 14832.9 14907.6 23118.2 23187.8 23303.9 23305.8 23338.4 10062.6 10192.1 10192.7 10249.3 10402.7 9316.3 9341.2 9414.8 9536.3 9595.8 9003.4 9015.8 9183.6 9280.7 9373.0 2617.6 2644.7 2748.7 2774.4 2818.1 949.7 963.0 970.0 974.6 987.1 18693.9 18863.3 19277.1 19428.6 19473.9 1025.2 1025.4 1032.2 1035.0 1037.6 10308.3 10472.5 10481.6 10637.4 10678.0 487009.0 488270.0 495611.0 502522.0 503069.0 117401.0 118128.4 119977.4 121266.4 121666.0 1005.7 1025.4 1168.4 1184.4 1194.4 19618.8 19644.0 19748.8 20080.8 20198.6 55984.4 57962.4 59143.7 59384.4 60037.4 68328.0 68877.3 71945.6 72223.3 73004.0 14205.6 14523.9 14616.0 14661.6 14681.2 22369.8 22428.9 22740.3 22752.4 22792.5 17883.8 18064.7 18195.2 18211.8 18339.3 16182.0 16222.6 16735.2 16821.9 16894.7 18506.5 18610.8 18642.4 18773.0 18871.0 14330.9 14331.0 14338.9 14475.6 14544.0 17916.2 18042.2 18099.5 18150.0 18399.0 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#3] mootools.html Cycles:180 Average:9496.66 Median:14788.08 stddev:6808.15 (46.0%) stddev-sans-first:6799.44 03:23:09 INFO - PID 4135 | Values: 1307.4 1349.1 1373.2 1379.8 1381.8 15109.9 15600.8 15718.4 15811.7 15824.6 15269.3 15477.0 15569.5 15574.5 15575.0 2707.8 2824.3 2830.1 2836.0 2842.7 2795.0 2828.2 2843.9 2846.0 2853.4 2728.8 2769.2 2835.5 2849.3 2854.2 2744.5 2748.6 2754.9 2755.7 2757.8 2626.5 2658.1 2659.5 2665.7 2678.0 14407.4 14503.6 14663.9 14680.6 14830.9 8197.1 8375.5 8431.2 8459.0 8478.3 5373.7 5633.0 5728.8 5729.5 5812.1 1884.7 1913.7 1920.6 1931.1 1934.0 26735.7 26898.2 27051.3 27059.0 27101.7 6759.4 6824.8 6908.4 6990.8 7080.4 16637.6 16641.6 16729.1 16746.7 16796.2 7982.8 8247.3 8253.4 8259.6 8260.6 7137.0 7297.6 7449.2 7525.7 7579.7 5170.6 5341.2 5376.5 5384.7 5385.8 1540.5 1578.9 1592.6 1596.6 1598.6 845.0 860.6 873.5 874.2 876.7 7404.9 7446.0 8089.2 8456.2 8520.7 719.1 722.7 725.7 739.3 758.2 4881.1 4963.0 4967.2 5090.4 5239.8 21711.6 22266.7 22325.8 22682.7 22693.7 21645.6 22135.7 22356.7 22452.4 22471.4 11411.8 11573.5 11815.0 11874.5 11969.1 8060.3 8082.6 8190.7 8195.4 8364.7 18386.7 18954.6 19048.4 19333.4 19462.5 18907.6 19582.1 20069.2 20297.3 20495.8 10952.6 10981.9 10999.0 11069.9 11070.5 13793.9 13923.2 13952.7 13974.9 14033.6 11528.3 11841.5 11937.9 11945.4 12076.1 10740.8 10795.9 10851.1 11029.7 11121.4 10595.4 10673.0 10677.3 10694.9 10777.5 7661.5 7721.7 7763.5 7797.5 7889.1 7684.0 7708.7 7709.2 7750.9 7778.3 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#4] prototype.html Cycles:180 Average:5467.20 Median:6132.39 stddev:1508.76 (24.6%) stddev-sans-first:1466.21 03:23:09 INFO - PID 4135 | Values: 500.3 517.5 541.7 545.5 549.0 6135.0 6213.1 6214.7 6260.7 6284.3 6169.4 6184.3 6193.7 6222.5 6238.4 5160.4 5160.7 5175.5 5179.4 5193.4 5144.9 5151.0 5166.8 5194.0 5207.7 4844.8 4912.7 4936.4 4964.9 4979.5 4940.9 4954.7 4979.3 4997.4 5040.6 4361.2 4465.0 4479.7 4493.9 4531.2 6009.6 6050.9 6054.0 6098.9 6108.1 5672.0 5675.5 5715.1 5718.7 5747.0 6399.1 6485.6 6488.9 6510.6 6516.2 4691.6 4901.3 4928.9 4934.9 4946.3 6599.9 6616.6 6728.5 6759.8 6806.4 4997.5 5004.5 5007.1 5034.5 5044.8 5001.3 5122.8 5126.3 5126.5 5140.6 5622.7 5636.2 5675.1 5683.4 5715.6 6493.4 6535.4 6597.3 6612.7 6623.8 1757.5 1769.9 1771.8 1776.6 1793.1 1177.7 1238.8 1248.1 1250.5 1250.9 5546.7 5548.8 5554.2 5566.4 5606.4 6608.2 6608.5 6709.8 6712.2 6730.7 5430.8 5560.9 5575.8 5592.6 5667.4 3432.8 3502.8 3514.8 3516.8 3579.8 6310.6 6339.1 6360.8 6416.6 6471.7 6377.3 6709.6 6739.7 6814.2 6846.3 6313.7 6334.6 6337.4 6347.0 6387.2 6648.9 6687.7 6738.9 6765.4 6777.8 6560.4 6623.2 6624.4 6665.8 6719.3 6311.6 6387.9 6412.6 6413.5 6510.2 5033.8 5044.1 5051.6 5051.9 5061.1 6394.2 6563.0 6598.1 6603.2 6747.3 6139.3 6290.4 6300.4 6329.8 6406.6 6406.5 6448.7 6472.8 6495.3 6518.3 6277.6 6352.3 6358.4 6365.7 6366.3 6377.7 6430.2 6496.6 6539.5 6552.6 6129.8 6229.5 6237.2 6256.5 6262.4 03:23:09 INFO - PID 4135 | 03:23:09 INFO - PID 4135 | [#5] yui.html Cycles:180 Average:25288.12 Median:19774.21 stddev:35685.31 (180.5%) stddev-sans-first:35738.34 03:23:09 INFO - PID 4135 | Values: 878.0 908.0 909.8 911.1 933.5 19236.8 20191.8 20354.7 20403.8 20404.7 17188.0 17323.6 17352.5 19281.0 19400.2 945.4 968.1 970.0 970.1 970.4 990.9 993.2 1000.6 1001.6 1002.3 1004.4 1017.7 1039.6 1042.4 1046.2 1025.3 1036.5 1038.8 1039.5 1041.5 728.7 737.3 746.1 746.5 749.8 20259.5 20383.8 20463.0 20648.3 20669.8 19331.9 19478.0 19539.6 19745.7 19759.1 17144.7 17550.6 17601.9 17610.4 17714.1 3749.7 3763.2 3789.3 3795.2 3796.5 133651.3 135516.3 138055.3 139866.0 142242.0 16559.5 16908.3 16970.7 17162.7 17194.1 30862.2 30884.8 30930.5 31106.4 32666.3 8927.5 9112.9 9114.1 9120.4 9243.8 4393.8 4479.2 4489.6 4492.5 4494.7 5411.1 5533.1 5555.3 5575.0 5579.9 1029.3 1059.3 1069.5 1075.3 1076.9 672.6 690.3 697.6 698.6 704.8 10716.6 10802.1 11225.5 11409.7 11785.5 660.9 670.0 679.5 683.7 694.0 5082.0 5170.8 5210.2 5291.1 5337.5 120235.4 120651.0 121825.4 121886.4 127030.0 91000.0 109650.5 110794.4 115450.4 117822.4 100015.0 103012.0 104398.5 105386.5 106480.5 12043.2 12056.9 12094.4 12134.2 12313.8 45976.3 46675.0 47527.5 47686.5 48249.8 59872.7 60745.7 61309.0 62119.0 62957.7 18750.2 18758.8 18764.0 18903.1 18946.5 20902.9 21082.7 21358.1 21721.0 21751.6 19918.5 19938.9 20095.9 20170.3 20497.4 19367.4 19579.6 19672.1 19789.3 19892.0 18735.3 18909.0 19194.5 19202.7 19294.9 12795.4 12888.5 13201.8 13237.9 13361.0 12925.6 12997.4 13051.1 13059.0 13129.3 03:23:09 INFO - PID 4135 | -------- Summary: end -------- 03:23:09 INFO - PID 4135 | 03:23:09 INFO - TEST-INFO | 4135: exit 0 03:23:09 INFO - TEST-OK | dromaeo_css | took 1115861ms 03:23:09 INFO - TEST-START | kraken 03:23:09 INFO - Initialising browser for kraken test... 03:23:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53939/getInfo.html -profile /tmp/tmpzazzJH/profile 03:23:09 INFO - TEST-INFO | started process 4574 (/builds/slave/test/build/application/firefox/firefox http://localhost:53939/getInfo.html) 03:23:15 INFO - TEST-INFO | 4574: exit 0 03:23:15 INFO - Browser initialized. 03:23:15 INFO - Running cycle 1/1 for kraken test... 03:23:15 INFO - Using env: {'DISPLAY': ':0', 03:23:15 INFO - 'HOME': '/home/cltbld', 03:23:15 INFO - 'JSGC_DISABLE_POISONING': '1', 03:23:15 INFO - 'LANG': 'en_US.UTF-8', 03:23:15 INFO - 'LANGUAGE': 'en_US:en', 03:23:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:23:15 INFO - 'LOGNAME': 'cltbld', 03:23:15 INFO - 'MAIL': '/var/mail/cltbld', 03:23:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:15 INFO - 'MOZ_ACCELERATED': '1', 03:23:15 INFO - 'MOZ_CRASHREPORTER': '1', 03:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:15 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:23:15 INFO - 'MOZ_NO_REMOTE': '1', 03:23:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:15 INFO - 'MOZ_WEBRENDER': '1', 03:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:15 INFO - 'NO_EM_RESTART': '1', 03:23:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:15 INFO - 'PWD': '/builds/slave/test', 03:23:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:15 INFO - 'RUST_BACKTRACE': 'full', 03:23:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:15 INFO - 'SHELL': '/bin/bash', 03:23:15 INFO - 'SHLVL': '1', 03:23:15 INFO - 'TERM': 'linux', 03:23:15 INFO - 'TMOUT': '86400', 03:23:15 INFO - 'USER': 'cltbld', 03:23:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1507097551.910413-930679622', 03:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:15 INFO - '_': '/tools/buildbot/bin/python'} 03:23:15 INFO - TEST-INFO | started process 4858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzazzJH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:23:16 INFO - PID 4858 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:23:16 INFO - PID 4858 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:23:17 INFO - PID 4858 | 03:23:17 INFO - PID 4858 | (/builds/slave/test/build/application/firefox/firefox:4918): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:23:17 INFO - PID 4858 | 03:23:27 INFO - PID 4858 | RSS: Main: 198950912 03:23:27 INFO - PID 4858 | 03:23:30 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53939/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:30 INFO - PID 4858 | RSS: Main: 199536640 03:23:30 INFO - PID 4858 | 03:23:33 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53939/tests/kraken/driver.html?testName=audio-dft) 03:23:34 INFO - PID 4858 | RSS: Main: 199761920 03:23:34 INFO - PID 4858 | 03:23:37 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53939/tests/kraken/driver.html?testName=audio-fft) 03:23:37 INFO - PID 4858 | RSS: Main: 197124096 03:23:37 INFO - PID 4858 | 03:23:40 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53939/tests/kraken/driver.html?testName=audio-oscillator) 03:23:40 INFO - PID 4858 | RSS: Main: 197419008 03:23:40 INFO - PID 4858 | 03:23:42 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:43 INFO - PID 4858 | RSS: Main: 197812224 03:23:43 INFO - PID 4858 | 03:23:46 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53939/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:47 INFO - PID 4858 | RSS: Main: 199561216 03:23:47 INFO - PID 4858 | 03:23:51 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53939/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:51 INFO - PID 4858 | RSS: Main: 198881280 03:23:51 INFO - PID 4858 | 03:23:54 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53939/tests/kraken/driver.html?testName=json-parse-financial) 03:23:55 INFO - PID 4858 | RSS: Main: 199757824 03:23:55 INFO - PID 4858 | 03:23:56 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:57 INFO - PID 4858 | RSS: Main: 200081408 03:23:57 INFO - PID 4858 | 03:23:59 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:59 INFO - PID 4858 | RSS: Main: 196993024 03:23:59 INFO - PID 4858 | 03:24:02 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:02 INFO - PID 4858 | RSS: Main: 197029888 03:24:02 INFO - PID 4858 | 03:24:05 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:05 INFO - PID 4858 | RSS: Main: 196841472 03:24:05 INFO - PID 4858 | 03:24:08 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:09 INFO - PID 4858 | RSS: Main: 197332992 03:24:09 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | Cycle 1(1): loaded http://localhost:53939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53939/tests/kraken/driver.html?testName=ai-astar) 03:24:11 INFO - PID 4858 | RSS: Main: 198795264 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | __start_tp_report 03:24:11 INFO - PID 4858 | _x_x_mozilla_page_load 03:24:11 INFO - PID 4858 | _x_x_mozilla_page_load_details 03:24:11 INFO - PID 4858 | |i|pagename|runs| 03:24:11 INFO - PID 4858 | |0;ai-astar;108;107;109;118;111;118;107;106;108;107 03:24:11 INFO - PID 4858 | |1;audio-beat-detection;122;114;124;120;133;122;141;118;134;120 03:24:11 INFO - PID 4858 | |2;audio-dft;173;170;170;163;165;175;165;171;179;167 03:24:11 INFO - PID 4858 | |3;audio-fft;78;84;74;75;76;73;78;82;79;83 03:24:11 INFO - PID 4858 | |4;audio-oscillator;79;87;82;81;78;80;141;88;82;79 03:24:11 INFO - PID 4858 | |5;imaging-gaussian-blur;114;114;116;113;113;113;115;119;115;123 03:24:11 INFO - PID 4858 | |6;imaging-darkroom;158;156;152;148;148;147;150;152;153;150 03:24:11 INFO - PID 4858 | |7;imaging-desaturate;95;93;97;94;94;93;97;95;98;97 03:24:11 INFO - PID 4858 | |8;json-parse-financial;54;53;48;50;50;50;49;50;49;51 03:24:11 INFO - PID 4858 | |9;json-stringify-tinderbox;38;39;42;38;37;38;38;45;43;37 03:24:11 INFO - PID 4858 | |10;stanford-crypto-aes;72;82;78;78;75;80;81;82;83;74 03:24:11 INFO - PID 4858 | |11;stanford-crypto-ccm;112;119;110;108;121;109;121;111;107;116 03:24:11 INFO - PID 4858 | |12;stanford-crypto-pbkdf2;160;160;160;168;167;181;158;158;159;162 03:24:11 INFO - PID 4858 | |13;stanford-crypto-sha256-iterative;66;66;72;61;66;61;61;62;64;62 03:24:11 INFO - PID 4858 | __end_tp_report 03:24:11 INFO - PID 4858 | __start_cc_report 03:24:11 INFO - PID 4858 | _x_x_mozilla_cycle_collect,742 03:24:11 INFO - PID 4858 | __end_cc_report 03:24:11 INFO - PID 4858 | __startTimestamp1507112651447__endTimestamp 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | ------- Summary: start ------- 03:24:11 INFO - PID 4858 | Number of tests: 14 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#0] ai-astar Cycles:10 Average:109.90 Median:108.50 stddev:4.48 (4.1%) stddev-sans-first:4.70 03:24:11 INFO - PID 4858 | Values: 108.0 107.0 109.0 118.0 111.0 118.0 107.0 106.0 108.0 107.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:123.00 stddev:8.43 (6.9%) stddev-sans-first:8.88 03:24:11 INFO - PID 4858 | Values: 122.0 114.0 124.0 120.0 133.0 122.0 141.0 118.0 134.0 120.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#2] audio-dft Cycles:10 Average:169.80 Median:170.50 stddev:4.98 (2.9%) stddev-sans-first:5.15 03:24:11 INFO - PID 4858 | Values: 173.0 170.0 170.0 163.0 165.0 175.0 165.0 171.0 179.0 167.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#3] audio-fft Cycles:10 Average:78.20 Median:78.50 stddev:3.82 (4.9%) stddev-sans-first:4.06 03:24:11 INFO - PID 4858 | Values: 78.0 84.0 74.0 75.0 76.0 73.0 78.0 82.0 79.0 83.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:81.50 stddev:19.02 (23.3%) stddev-sans-first:19.91 03:24:11 INFO - PID 4858 | Values: 79.0 87.0 82.0 81.0 78.0 80.0 141.0 88.0 82.0 79.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:3.21 (2.8%) stddev-sans-first:3.35 03:24:11 INFO - PID 4858 | Values: 114.0 114.0 116.0 113.0 113.0 113.0 115.0 119.0 115.0 123.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:3.57 (2.3%) stddev-sans-first:2.87 03:24:11 INFO - PID 4858 | Values: 158.0 156.0 152.0 148.0 148.0 147.0 150.0 152.0 153.0 150.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:1.83 (1.9%) stddev-sans-first:1.94 03:24:11 INFO - PID 4858 | Values: 95.0 93.0 97.0 94.0 94.0 93.0 97.0 95.0 98.0 97.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:50.00 stddev:1.84 (3.7%) stddev-sans-first:1.41 03:24:11 INFO - PID 4858 | Values: 54.0 53.0 48.0 50.0 50.0 50.0 49.0 50.0 49.0 51.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#9] json-stringify-tinderbox Cycles:10 Average:39.50 Median:38.50 stddev:2.80 (7.3%) stddev-sans-first:2.92 03:24:11 INFO - PID 4858 | Values: 38.0 39.0 42.0 38.0 37.0 38.0 38.0 45.0 43.0 37.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:80.50 stddev:3.78 (4.7%) stddev-sans-first:3.19 03:24:11 INFO - PID 4858 | Values: 72.0 82.0 78.0 78.0 75.0 80.0 81.0 82.0 83.0 74.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.00 stddev:5.40 (4.7%) stddev-sans-first:5.70 03:24:11 INFO - PID 4858 | Values: 112.0 119.0 110.0 108.0 121.0 109.0 121.0 111.0 107.0 116.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:161.00 stddev:7.13 (4.4%) stddev-sans-first:7.47 03:24:11 INFO - PID 4858 | Values: 160.0 160.0 160.0 168.0 167.0 181.0 158.0 158.0 159.0 162.0 03:24:11 INFO - PID 4858 | 03:24:11 INFO - PID 4858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:65.00 stddev:3.51 (5.4%) stddev-sans-first:3.66 03:24:11 INFO - PID 4858 | Values: 66.0 66.0 72.0 61.0 66.0 61.0 61.0 62.0 64.0 62.0 03:24:11 INFO - PID 4858 | -------- Summary: end -------- 03:24:11 INFO - PID 4858 | 03:24:12 INFO - PID 4858 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:24:12 INFO - TEST-INFO | 4858: exit 0 03:24:12 INFO - TEST-OK | kraken | took 62720ms 03:24:12 INFO - SUITE-END | took 1178s 03:24:12 INFO - Completed test suite (00:19:38) 03:24:12 INFO - javascript benchmark 03:24:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8558.368954084495, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.3291292372137, 3146.4493713600123, 3148.071318960905, 3160.8419579021042, 3183.278297056018, 6132.724027418766, 6280.591761535497, 6289.654069026207, 6313.305536390999, 6376.234851817777, 6173.197484327031, 6235.657038862861, 6393.616383017011, 6394.392532709397, 6421.068945002972, 5626.212330273765, 5766.990776614086, 5826.679532625704, 5847.1521629363715, 5925.644461332334, 5682.54539636828, 5740.397258287882, 5811.186433899257, 5820.505257053155, 5834.824955251349, 5632.549396048306, 5672.489475947164, 5706.9429305707245, 5713.800016999385, 5772.480476757091, 5635.746391412396, 5655.604107712462, 5670.829875103712, 5762.798302059449, 5789.334226563957, 5740.655560666373, 5743.569232307552, 5765.4522820332, 5805.4194580542035, 5825.03886858672, 6288.717007734663, 6294.402031806971, 6352.364763523657, 6374.203224596926, 6395.808125756234, 6463.289038205794, 6573.769918052845, 6643.136392268974, 6687.49843761715, 6816.079829223041, 6667.499937504706, 6715.6977935993, 6723.831904202434, 6726.394624483771, 6727.260001399842, 6095.481884039862, 6128.908066379008, 6168.0, 6169.105479705418, 6273.435390814849, 7006.614636195059, 7052.294770523009, 7064.399526040242, 7071.858562828715, 7078.646067696697, 6545.37818907203, 6616.768413105518, 6648.5346025777735, 6707.027481015225, 6707.496937729592, 6482.481401487869, 6577.14497115372, 6795.932040679629, 6823.420009299166, 6879.449644028466, 6462.935370646233, 6548.214214294315, 6565.67171641416, 6569.868602628017, 6573.408393244631, 6570.441512471398, 6587.934120658828, 6589.439897608661, 6591.813473574706, 6636.734530618721, 5085.74571271435, 5128.410232823198, 5176.275321454999, 5240.973795131, 5245.659032162897, 4526.751028693454, 4623.329617205486, 4648.1865673507, 4648.767561621906, 4660.1145782301255, 5687.090065589486, 5716.0, 5729.197912292282, 5735.483806457439, 5779.075347944308, 6523.086767852505, 6639.269680335159, 6648.268690444047, 6655.86688266232, 6681.432078273401, 5635.633683810539, 5658.91511627326, 5713.800016999385, 5720.542356611544, 5725.885482290331, 5695.259616249944, 5793.362730099686, 5794.681292528951, 5813.157092221604, 5816.592838501264, 6312.652804095819, 6461.095446637474, 6465.515086368447, 6508.284088750233, 6540.771073012422, 6505.316941721051, 6521.282658907611, 6526.24948130971, 6533.542652014314, 6539.574927629784, 6483.09236706852, 6566.540342176193, 6569.507286953402, 6596.8350791230605, 6623.701933413105, 6648.800535983734, 6661.267260601427, 6668.399844014062, 6684.966575167093, 6769.526133170631, 6727.058211850443, 6757.189137303555, 6786.898196526958, 6792.490563207878, 6868.107146070979, 6334.113224148715, 6436.806895793134, 6467.644279564669, 6552.6068435894, 6617.07360969455, 6518.413342799171, 6550.8362290943105, 6550.868982620416, 6600.768973085919, 6604.735810567716, 6475.870482590416, 6530.575512591667, 6542.705578248895, 6569.047488114101, 6586.736530538917, 6584.76953306632, 6606.075149479173, 6611.801645950629, 6698.028785825931, 6701.966490167518, 6091.42131497507, 6136.325004249618, 6206.937930620636, 6317.557770955989, 6398.90401643985], "value": 6095.729918009536, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.9185927336904, 874.5627186406792, 875.8686197070434, 879.1911441473843, 887.613887958738, 38015.42976855349, 41996.58003419969, 42048.57951420485, 42180.789096054556, 42378.7881060595, 37755.433668494996, 38156.23687526255, 38193.04517387067, 38263.80868095662, 38416.61583384165, 7056.894146587792, 7138.286171382846, 7151.606661633608, 7187.173475050357, 7216.314450127229, 7099.716011359539, 7156.821079473003, 7163.426925845946, 7217.350438460538, 7222.386097181746, 7190.820229494252, 7204.495685302031, 7214.603196824199, 7216.422686185093, 7794.883076753853, 7879.8424031519335, 7889.96055019727, 7937.920620793776, 7943.285104340608, 7948.721794737156, 7771.494852834604, 7772.455928085036, 7789.649465774054, 7871.960640196762, 7876.212378762135, 36701.44947825785, 37382.0, 39614.60385396138, 39901.60098399008, 40030.199396012205, 3553.0, 3564.928701425983, 3605.963940360589, 3613.7470377073614, 3617.5658920929395, 32310.35379292401, 32482.837585811918, 32735.672643273738, 32752.508712369334, 32828.835855820806, 5096.235564665293, 5119.283300337956, 5127.230915362688, 5137.229415587692, 5202.4537423570355, 182493.0, 186265.0, 187375.0, 188482.0, 189798.05100974545, 42246.78876605597, 42839.78580107079, 49138.0, 49358.25962610564, 49375.0, 52293.47706522962, 52350.0, 52835.0, 52993.0, 52996.0, 16066.437674681563, 16087.356505739874, 16131.032138071754, 16213.513594592181, 16230.188490575423, 12845.0, 12873.549425770054, 12936.611901642966, 12974.935125324502, 12993.545225917047, 14041.578752637437, 14106.15363078198, 14226.928865355607, 14336.283185840666, 14463.349149288308, 5815.76736930518, 5870.090136028923, 5873.353931067579, 5936.9406305937255, 5972.283326000907, 980.1668581705493, 981.3523074770617, 999.1058003087196, 1009.8232809258351, 1019.2915923433143, 22646.773532264797, 22978.310650680505, 23010.19464318741, 23025.0, 23113.537729245658, 1081.0918232494366, 1085.3542142425244, 1087.9347239165675, 1097.1058587251364, 1114.5207560748793, 12147.514099435924, 12160.45277962476, 12343.382830858422, 12372.938135309267, 12383.62849114528, 221942.0, 222342.0, 222919.0, 224010.0, 224519.0, 51817.48182518202, 51825.0, 52029.73985130126, 52459.0, 52572.21141682878, 1415.5399495163906, 1463.8536146385277, 1471.5144002479155, 1475.129673492623, 1476.512750792236, 22523.0, 22562.210322638628, 22717.772822272225, 23019.579665888323, 23050.538989219785, 37316.626833731316, 37582.0, 37673.0, 37699.81150094232, 37802.0, 189862.05068974567, 190244.0, 191085.0, 191633.0, 191653.0, 29317.85341073281, 30837.537436938015, 31586.0, 31609.36781264316, 34218.48672269868, 42083.7895810519, 43535.0, 43632.345514817935, 43851.0602306536, 44094.0, 31861.20346991344, 31929.521057183698, 31978.680213198502, 32270.677293226767, 32536.51195232026, 32030.51954220642, 32044.51933220957, 32117.197070073435, 32229.0, 32450.83774581112, 34757.65242347645, 36060.0, 36297.27405451929, 36377.45433818442, 36390.818045909604, 31116.844415777778, 31490.685093148775, 31560.36879262448, 31807.363852722352, 31809.363812723153, 23463.88268058649, 23826.761732383147, 23995.400114997265, 24134.637980429958, 24144.517109657358], "value": 17000.021923633973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.198474082877, 591.27273453652, 596.6151832068314, 619.1486705779553, 619.7118339971913, 22501.54996900061, 23363.415914602123, 23412.882935585298, 23425.414364640892, 23435.648465272992, 23811.76188238117, 24959.0, 25013.0, 25038.874805625946, 25071.373215669617, 6538.117354157187, 6754.324567543255, 6758.391744742972, 6759.729610815586, 6776.017477465764, 6641.369069938348, 6756.121704178475, 6759.121314229168, 6761.154855643044, 6762.830929226784, 6502.414782669559, 6703.597784132943, 6767.120274364326, 6789.626570538619, 6790.5246632735725, 6658.833529161761, 6698.765543206013, 6731.697073631698, 6741.258461569248, 6751.831204219885, 6202.069689546604, 6233.0338797486465, 6240.781572644935, 6267.373262673742, 6270.247570291549, 27466.17601471959, 27470.17589472319, 28599.142025739053, 28653.856730716423, 28660.0, 2052.230413594902, 2079.563291708743, 2081.0219196977396, 2083.645780217367, 2083.7082808406835, 19416.22335106594, 19692.70460943087, 19723.112459939337, 19723.40829775109, 19755.20979160832, 2326.592846251899, 2358.481134150484, 2369.2300002499255, 2379.559781440439, 2483.615039668854, 125535.0, 131920.0, 132299.33850330784, 134787.0, 142075.0, 14667.926660366844, 14673.826093912461, 14721.372197622875, 14832.851671483148, 14907.552773416815, 23118.19086332004, 23187.7681223189, 23303.883480582488, 23305.766942330698, 23338.416539586306, 10062.647807326708, 10192.082712555906, 10192.694219173436, 10249.33379330341, 10402.687919362432, 9316.254699624014, 9341.20599749029, 9414.764630884145, 9536.28477864163, 9595.808083838285, 9003.36976411658, 9015.791131172904, 9183.612260812104, 9280.72157835266, 9373.0, 2617.5525883298797, 2644.7355264473786, 2748.738869807405, 2774.375765452797, 2818.1250780177256, 949.6771097826634, 962.9744322296732, 970.0251247496221, 974.5517062151348, 987.0721521769514, 18693.90653046753, 18863.339783107524, 19277.132529036226, 19428.611427771364, 19473.90263048676, 1025.2208321675432, 1025.4206373399006, 1032.2206733915996, 1034.9586016559404, 1037.574594416301, 10308.32995855267, 10472.476376181314, 10481.580736770597, 10637.361758294526, 10678.0, 487009.0, 488270.0, 495611.0, 502522.0, 503069.0, 117401.0, 118128.40935795267, 119977.40011299888, 121266.3936680311, 121666.0, 1005.6781829814389, 1025.3950169400089, 1168.4449886304108, 1184.3604453594962, 1194.4147367789722, 19618.760120749033, 19644.0, 19748.802511974696, 20080.79515229091, 20198.59602807906, 55984.44015559792, 57962.42037579739, 59143.70428147832, 59384.40615593789, 60037.39962600493, 68328.0, 68877.3112268891, 71945.6402717983, 72223.27776722166, 73004.0, 14205.573832785032, 14523.927380363031, 14616.0, 14661.63345916318, 14681.192534410282, 22369.77630223742, 22428.887855560617, 22740.317790466313, 22752.431189220402, 22792.544149117257, 17883.821161788215, 18064.72902906431, 18195.18121684501, 18211.817881821542, 18339.26642934321, 16182.0, 16222.594435139215, 16735.24691388866, 16821.91589042047, 16894.66210675755, 18506.537336566154, 18610.813891860907, 18642.44072677822, 18773.0, 18871.0, 14330.85669143337, 14331.0, 14338.928305358406, 14475.638109047359, 14544.0, 17916.193771280065, 18042.1881015352, 18099.457016289532, 18150.0, 18399.0], "value": 11999.318226163377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.4312673986813, 1349.0826238158054, 1373.1692326142684, 1379.7999290102935, 1381.792731090337, 15109.92445037776, 15600.843991560081, 15718.449854255103, 15811.68376632468, 15824.604384890368, 15269.312880920357, 15477.0, 15569.455069072585, 15574.532764017069, 15575.0, 2707.7698395636394, 2824.3221626809523, 2830.1368082734757, 2835.957460638092, 2842.7299406556344, 2795.049683107743, 2828.2081017315186, 2843.943121137576, 2845.971540284602, 2853.4293141371704, 2728.836269823807, 2769.2246171072134, 2835.517961946474, 2849.3019210293505, 2854.1865568313033, 2744.519709050908, 2748.6151938728594, 2754.931126721828, 2755.7106503817113, 2757.7931655125844, 2626.4747050589767, 2658.0962472759356, 2659.494696007772, 2665.746754058361, 2677.9598306025423, 14407.423703051865, 14503.564893053226, 14663.92668036653, 14680.632984175374, 14830.851691483163, 8197.139300373434, 8375.539345336005, 8431.19903609156, 8459.027211870653, 8478.321734261244, 5373.677579345252, 5633.023898874193, 5728.799492017801, 5729.541636669098, 5812.099124635688, 1884.689026310657, 1913.6938089905548, 1920.596674698315, 1931.1020375525309, 1934.0039879462088, 26735.73264267352, 26898.193054208405, 27051.323716907234, 27058.999999999804, 27101.72898271012, 6759.357861003196, 6824.761133360308, 6908.447324214051, 6990.755323563651, 7080.36276735086, 16637.584060398585, 16641.583960401087, 16729.079900605582, 16746.74879876803, 16796.16019199035, 7982.760517184493, 8247.298979586682, 8253.422260441712, 8259.628316725762, 8260.586970651444, 7137.0, 7297.562146271241, 7449.180590135081, 7525.736599219001, 7579.658915348822, 5170.586353091744, 5341.198820177005, 5376.516113549721, 5384.6769193848495, 5385.7576409061685, 1540.5224380442098, 1578.8894777365704, 1592.570006098347, 1596.5689263898682, 1598.5763772600271, 845.049319515545, 860.6084231674573, 873.4671850171391, 874.1957399192758, 876.7282142535835, 7404.888926666104, 7445.9627701861145, 8089.209222818118, 8456.238938495564, 8520.659173632985, 719.133444199738, 722.7434260837432, 725.7496163823472, 739.2939742545856, 758.1773775453695, 4881.145799485147, 4962.950370496249, 4967.230079337708, 5090.363704536933, 5239.842804715865, 21711.565768684854, 22266.666000010013, 22325.77674223237, 22682.659760103612, 22693.659595106088, 21645.56708865814, 22135.667964980537, 22356.664650030263, 22452.438689032904, 22471.43821404478, 11411.771764564663, 11573.479193436315, 11815.0, 11874.525018999317, 11969.102317326235, 8060.31487323584, 8082.6362813674705, 8190.7133250335955, 8195.385346098947, 8364.66541338364, 18386.724199136755, 18954.620907582048, 19048.42854714361, 19333.419997400102, 19462.513437164183, 18907.62184756325, 19582.11880465411, 20069.197232110553, 20297.28959486411, 20495.795042049387, 10952.56189752401, 10981.945090274497, 10999.0, 11069.944650276697, 11070.501827417947, 13793.862061379257, 13923.23422211788, 13952.720945581235, 13974.860251397762, 14033.649158771112, 11528.250663706833, 11841.46713397882, 11937.94031029874, 11945.4027298633, 12076.094292928241, 10740.83888741685, 10795.892041079804, 10851.077658398808, 11029.669109926715, 11121.443927803415, 10595.417252051211, 10673.039426451656, 10677.305975111592, 10694.946525267324, 10777.46112694378, 7661.540307581563, 7721.729739459092, 7763.456558040883, 7797.532148071134, 7889.0927543333255, 7683.961580192064, 7708.691652334068, 7709.151993280622, 7750.922490775246, 7778.338841198562], "value": 6736.628880213914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.32206360381707, 517.4566704959791, 541.7210136779559, 545.5390195284983, 548.9862753431164, 6135.0, 6213.130161777349, 6214.689265536722, 6260.686965651722, 6284.340144284853, 6169.352218017111, 6184.319724830265, 6193.721282542297, 6222.5021998240145, 6238.4385405313515, 5160.354955630546, 5160.741962901859, 5175.482451754813, 5179.404368497614, 5193.376794784631, 5144.922826157611, 5150.974245128769, 5166.819161329354, 5193.9740301298625, 5207.687538747668, 4844.781984810692, 4912.656114072016, 4936.4076310842565, 4964.900701985958, 4979.526944940225, 4940.876478088041, 4954.687007942898, 4979.327790748239, 4997.375328083989, 5040.621953353495, 4361.171377438277, 4465.0, 4479.7088189267915, 4493.865184044484, 4531.207038768202, 6009.6394216346725, 6050.909236361458, 6053.970824959767, 6098.939010609882, 6108.144859719643, 5671.9716401418145, 5675.489205971482, 5715.114157305624, 5718.656880587178, 5747.0, 6399.136116624242, 6485.578437401554, 6488.864448721455, 6510.576812507172, 6516.152900122954, 4691.554302341272, 4901.289313049623, 4928.876778080541, 4934.851954441337, 4946.307516947631, 6599.93400065998, 6616.636085015322, 6728.519725660347, 6759.7972060837765, 6806.353396427331, 4997.525235102732, 5004.524570165829, 5007.123753343223, 5034.471380505068, 5044.8234311798915, 5001.349824522788, 5122.769475373617, 5126.282320475137, 5126.512981266774, 5140.588752899759, 5622.718864056863, 5636.210930469738, 5675.120356344773, 5683.403242659544, 5715.570657605486, 6493.448056915121, 6535.372868058178, 6597.30728273534, 6612.669366531654, 6623.834404139839, 1757.4815429448342, 1769.9203535840918, 1771.7962434320218, 1776.6269083492612, 1793.1303317890813, 1177.7291223018753, 1238.7832129377323, 1248.1450206608502, 1250.4560516175493, 1250.8624051354343, 5546.667199968015, 5548.750306236229, 5554.1946417770005, 5566.387697353288, 5606.411326810708, 6608.207015158212, 6608.537402381787, 6709.765158219537, 6712.194536655633, 6730.697118629673, 5430.782768689208, 5560.916586251209, 5575.804846830422, 5592.636478628876, 5667.404922483162, 3432.8111953842777, 3502.8073455959657, 3514.8066856322635, 3516.82415879205, 3579.83890724918, 6310.5898116622275, 6339.144215530937, 6360.837315312723, 6416.615003099736, 6471.708773105222, 6377.298497165308, 6709.597424154566, 6739.663016849138, 6814.182298124257, 6846.349596788297, 6313.715882785285, 6334.619922804646, 6337.366263373718, 6346.9682651586445, 6387.2335319761, 6648.933510664831, 6687.699053542505, 6738.898916516354, 6765.357291057342, 6777.830554236183, 6560.40956313934, 6623.205215374186, 6624.370684784938, 6665.833354166185, 6719.328067193242, 6311.558190926591, 6387.943655778707, 6412.551121421456, 6413.4869210463985, 6510.153680021567, 5033.84898453047, 5044.117279476003, 5051.570616497639, 5051.898962020666, 5061.063703214917, 6394.1687580614225, 6562.967185164043, 6598.1422415085735, 6603.20761508622, 6747.291534388818, 6139.3246742857355, 6290.402411771058, 6300.401461861299, 6329.778457753957, 6406.551541392244, 6406.487481001602, 6448.742050318122, 6472.838179045373, 6495.317991610813, 6518.282988871315, 6277.5605707600025, 6352.269489008639, 6358.395952384516, 6365.663210725799, 6366.29970703213, 6377.7130029147875, 6430.164078669743, 6496.642684652389, 6539.542232043711, 6552.63960482178, 6129.785457508966, 6229.470495007794, 6237.220347456568, 6256.499480041494, 6262.436380725757], "value": 5029.038005320324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.9517126558045, 907.9546022698868, 909.8043920557079, 911.138973669882, 933.5472295936472, 19236.807631923675, 20191.798082019177, 20354.694679579818, 20403.795962040374, 20404.693929591067, 17188.0, 17323.566910827205, 17352.47942561722, 19281.0, 19400.22399104034, 945.4469135555692, 968.0706521739139, 969.9903000970006, 970.1171933540479, 970.3595626886256, 990.8810942686888, 993.1855878179896, 1000.6097621927454, 1001.6293971230655, 1002.293383164867, 1004.3772860826261, 1017.6896046705751, 1039.6413237433073, 1042.3745752548487, 1046.2101113659214, 1025.3079171559204, 1036.5024788101678, 1038.8441733739962, 1039.50103950104, 1041.463646222196, 728.7449392712562, 737.2885165814961, 746.0748671647173, 746.5259560179271, 749.838784661295, 20259.493512662302, 20383.796162038485, 20463.0, 20648.277310294066, 20669.793302066937, 19331.903340483208, 19478.02609869515, 19539.609207815905, 19745.703814442793, 19759.110840012236, 17144.657106857794, 17550.561235969075, 17601.911990440094, 17610.38363657266, 17714.114294285362, 3749.7187710921517, 3763.153290509641, 3789.3368660484307, 3795.2409518096492, 3796.506454160969, 133651.33174334164, 135516.25693100694, 138055.30972345173, 139866.0, 142242.0, 16559.503214903572, 16908.323667053428, 16970.660586788443, 17162.656746864992, 17194.14029298555, 30862.228444288623, 30884.84557577198, 30930.53604195939, 31106.377872442423, 32666.346673066404, 8927.464352138892, 9112.8633070504, 9114.088591140833, 9120.407173533698, 9243.815123697488, 4393.846215382447, 4479.193745125844, 4489.6408287336935, 4492.528284530077, 4494.70784399013, 5411.134218525017, 5533.142362933751, 5555.250041244381, 5574.9721251393485, 5579.9163012554845, 1029.27950434696, 1059.2902755154066, 1069.5240617924949, 1075.306427354352, 1076.8815430302661, 672.603164133154, 690.2752110284182, 697.6442014572503, 698.5738699393366, 704.8097013806243, 10716.624918127829, 10802.081823044971, 11225.494852731646, 11409.657710268706, 11785.526809148856, 660.9008648702733, 669.9883176403665, 679.4869873245668, 683.6547543490506, 694.0422217340039, 5082.0, 5170.793168273227, 5210.166373380241, 5291.126964050965, 5337.5463085637375, 120235.39882300707, 120651.0, 121825.39087304506, 121886.3905680466, 127030.0, 91000.0, 109650.45174774075, 110794.44602776934, 115450.42274788572, 117822.410887945, 100014.99985000203, 103012.0, 104398.47800760948, 105386.47306763417, 106480.46759766151, 12043.156979011736, 12056.914877661053, 12094.395280235776, 12134.150609457252, 12313.815292770794, 45976.31035534536, 46675.0, 47527.52472475369, 47686.523134768206, 48249.75875120602, 59872.70063649828, 60745.69627151836, 61309.0, 62119.0, 62957.68521157365, 18750.249990000248, 18758.812411876253, 18764.0, 18903.149358279185, 18946.52633684169, 20902.895485522477, 21082.683759743308, 21358.145674172858, 21721.0, 21751.564968700855, 19918.5020374486, 19938.90030549838, 20095.899520502306, 20170.29403970854, 20497.38507844767, 19367.418977430698, 19579.60840783205, 19672.11475483578, 19789.30737424183, 19892.0, 18735.250589976247, 18909.014553471687, 19194.520136996685, 19202.711959320342, 19294.903525482845, 12795.42420591057, 12888.548900788428, 13201.801972970221, 13237.933810330887, 13361.0, 12925.612231633066, 12997.415116319977, 13051.086423950612, 13059.0, 13129.277889716157], "value": 9327.404809856047, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 109.0, 118.0, 111.0, 118.0, 107.0, 106.0, 108.0, 107.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 114.0, 124.0, 120.0, 133.0, 122.0, 141.0, 118.0, 134.0, 120.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 170.0, 163.0, 165.0, 175.0, 165.0, 171.0, 179.0, 167.0], "value": 169.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 74.0, 75.0, 76.0, 73.0, 78.0, 82.0, 79.0, 83.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 82.0, 81.0, 78.0, 80.0, 141.0, 88.0, 82.0, 79.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 113.0, 113.0, 113.0, 115.0, 119.0, 115.0, 123.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 152.0, 148.0, 148.0, 147.0, 150.0, 152.0, 153.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 97.0, 94.0, 94.0, 93.0, 97.0, 95.0, 98.0, 97.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 48.0, 50.0, 50.0, 50.0, 49.0, 50.0, 49.0, 51.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 42.0, 38.0, 37.0, 38.0, 38.0, 45.0, 43.0, 37.0], "value": 39.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 78.0, 78.0, 75.0, 80.0, 81.0, 82.0, 83.0, 74.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 119.0, 110.0, 108.0, 121.0, 109.0, 121.0, 111.0, 107.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 168.0, 167.0, 181.0, 158.0, 158.0, 159.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 72.0, 61.0, 66.0, 61.0, 61.0, 62.0, 64.0, 62.0], "value": 64.1, "unit": "score"}]}]} 03:24:12 INFO - Return code: 0 03:24:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:24:12 INFO - # TBPL SUCCESS # 03:24:12 INFO - Running post-action listener: _package_coverage_data 03:24:12 INFO - Running post-action listener: _resource_record_post_action 03:24:12 INFO - [mozharness: 2017-10-04 10:24:12.731742Z] Finished run-tests step (success) 03:24:12 INFO - Running post-run listener: _resource_record_post_run 03:24:12 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 17039360; Write bytes: 324988928; Read time: 6424; Write time: 289788 03:24:12 INFO - TinderboxPrint: CPU usage
13.2% 03:24:12 INFO - TinderboxPrint: I/O read bytes / time
17,039,360 / 6,424 03:24:12 INFO - TinderboxPrint: I/O write bytes / time
324,988,928 / 289,788 03:24:12 INFO - TinderboxPrint: CPU idle
8,273.8 (86.7%) 03:24:12 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 03:24:12 INFO - TinderboxPrint: Swap in / out
0 / 0 03:24:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 73940992; Read time: 0; Write time: 61388 03:24:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:24:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 14802944; Write bytes: 241119232; Read time: 6220; Write time: 206824 03:24:13 INFO - Running post-run listener: _upload_blobber_files 03:24:13 INFO - Blob upload gear active. 03:24:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:24:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:24:13 INFO - (blobuploader) - INFO - Open directory for files ... 03:24:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:24:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:24:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:14 INFO - (blobuploader) - INFO - Done attempting. 03:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:15 INFO - (blobuploader) - INFO - Done attempting. 03:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:16 INFO - (blobuploader) - INFO - Done attempting. 03:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:24:23 INFO - (blobuploader) - INFO - Done attempting. 03:24:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:24:23 INFO - Return code: 0 03:24:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:24:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:24:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45a98fc44fdd3ec3f24fb27df68b964df29d1d3cec11c33986d9d583a6d0caa1d7e73ed71925d23c631794fe42ea13089ef8f06246a1d0c3a699aee299334e72", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0d125adf1d35366ec95e09296973e6ad38953387b4a1a73849534b2eefdd2b24c61b7841b97e4b2d83e0420e1bf8f3f33f2ad5b09c48119aff178598481901f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e407841a6e333311c8b59e3ef6d29951e30bf44afcf79f0bacc3c281fc4236206edbf052d254d0ae52810321109a3b5999a3b120b5aeb83ca76ac0f460ac43ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b31ab6b02b6bc0e6e912752098e8f70eb34a15cce42df7e52eef18a3b38e1fdfb16ae390e65d0dbeaf096be178ff0a772051eeba6ae20a6a8ecddfcb6f92575"} 03:24:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:24:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:24:23 INFO - Contents: 03:24:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45a98fc44fdd3ec3f24fb27df68b964df29d1d3cec11c33986d9d583a6d0caa1d7e73ed71925d23c631794fe42ea13089ef8f06246a1d0c3a699aee299334e72", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0d125adf1d35366ec95e09296973e6ad38953387b4a1a73849534b2eefdd2b24c61b7841b97e4b2d83e0420e1bf8f3f33f2ad5b09c48119aff178598481901f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e407841a6e333311c8b59e3ef6d29951e30bf44afcf79f0bacc3c281fc4236206edbf052d254d0ae52810321109a3b5999a3b120b5aeb83ca76ac0f460ac43ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b31ab6b02b6bc0e6e912752098e8f70eb34a15cce42df7e52eef18a3b38e1fdfb16ae390e65d0dbeaf096be178ff0a772051eeba6ae20a6a8ecddfcb6f92575"} 03:24:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:24:23 INFO - Copying logs to upload dir... 03:24:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:24:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.903626 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-10-04 03:24:23.596548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 03:24:23.602098) ========= 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=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45a98fc44fdd3ec3f24fb27df68b964df29d1d3cec11c33986d9d583a6d0caa1d7e73ed71925d23c631794fe42ea13089ef8f06246a1d0c3a699aee299334e72", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0d125adf1d35366ec95e09296973e6ad38953387b4a1a73849534b2eefdd2b24c61b7841b97e4b2d83e0420e1bf8f3f33f2ad5b09c48119aff178598481901f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e407841a6e333311c8b59e3ef6d29951e30bf44afcf79f0bacc3c281fc4236206edbf052d254d0ae52810321109a3b5999a3b120b5aeb83ca76ac0f460ac43ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b31ab6b02b6bc0e6e912752098e8f70eb34a15cce42df7e52eef18a3b38e1fdfb16ae390e65d0dbeaf096be178ff0a772051eeba6ae20a6a8ecddfcb6f92575"} build_url:https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/MyDALZqzQgW4pMnMCbCJUg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45a98fc44fdd3ec3f24fb27df68b964df29d1d3cec11c33986d9d583a6d0caa1d7e73ed71925d23c631794fe42ea13089ef8f06246a1d0c3a699aee299334e72", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0d125adf1d35366ec95e09296973e6ad38953387b4a1a73849534b2eefdd2b24c61b7841b97e4b2d83e0420e1bf8f3f33f2ad5b09c48119aff178598481901f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e407841a6e333311c8b59e3ef6d29951e30bf44afcf79f0bacc3c281fc4236206edbf052d254d0ae52810321109a3b5999a3b120b5aeb83ca76ac0f460ac43ec", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b31ab6b02b6bc0e6e912752098e8f70eb34a15cce42df7e52eef18a3b38e1fdfb16ae390e65d0dbeaf096be178ff0a772051eeba6ae20a6a8ecddfcb6f92575"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 03:24:23.631898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:24:23.632240) ========= 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=7de08804244eb36560b44971000001c3-1507097551.910413-930679622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 03:24:23.715793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 03:24:23.716111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 03:24:23.716463) ========= ========= Total master_lag: 0.23 =========