builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-083 starttime: 1506387294.11 results: success (0) revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.112047) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.112480) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.112802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.125105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.125462) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:54:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-09-25 17:54:54 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136769 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.363727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.364046) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025261 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:54.404791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:54:54.405159) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 641bfddb87113b45ee3df9849345dbcf821ef3da --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 641bfddb87113b45ee3df9849345dbcf821ef3da --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=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:54:54,466 truncating revision to first 12 chars 2017-09-25 17:54:54,466 Setting DEBUG logging. 2017-09-25 17:54:54,466 attempt 1/10 2017-09-25 17:54:54,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/641bfddb8711?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:54:55,165 unpacking tar archive at: mozilla-central-641bfddb8711/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051243 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-25 17:54:55.503694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:55.504071) ========= script_repo_revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:55.504449) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:55.504710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:54:55.520762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-25 17:54:55.521156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:54:55 INFO - MultiFileLogger online at 20170925 17:54:55 in /builds/slave/test 17:54:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:54:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:54:55 INFO - {'append_to_log': False, 17:54:55 INFO - 'base_work_dir': '/builds/slave/test', 17:54:55 INFO - 'blob_upload_branch': 'Firefox', 17:54:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:54:55 INFO - 'branch': 'Firefox', 17:54:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:54:55 INFO - 'code_coverage': False, 17:54:55 INFO - 'config_files': ('talos/linux_config.py',), 17:54:55 INFO - 'default_actions': ('clobber', 17:54:55 INFO - 'read-buildbot-config', 17:54:55 INFO - 'download-and-extract', 17:54:55 INFO - 'populate-webroot', 17:54:55 INFO - 'create-virtualenv', 17:54:55 INFO - 'install', 17:54:55 INFO - 'setup-mitmproxy', 17:54:55 INFO - 'run-tests'), 17:54:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:54:55 INFO - 'disable_ccov_upload': False, 17:54:55 INFO - 'disable_stylo': False, 17:54:55 INFO - 'download_minidump_stackwalk': True, 17:54:55 INFO - 'download_symbols': 'ondemand', 17:54:55 INFO - 'enable_stylo': False, 17:54:55 INFO - 'enable_webrender': False, 17:54:55 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:54:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:54:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:54:55 INFO - 'gecko_profile': False, 17:54:55 INFO - 'gecko_profile_interval': 0, 17:54:55 INFO - 'installer_path': 'installer.exe', 17:54:55 INFO - 'log_level': 'info', 17:54:55 INFO - 'log_name': 'talos', 17:54:55 INFO - 'log_to_console': True, 17:54:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:54:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:54:55 INFO - 'opt_config_files': (), 17:54:55 INFO - 'pip_index': False, 17:54:55 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:54:55 INFO - 'system_bits': '32', 17:54:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:54:55 INFO - 'title': 'talos-linux64-ix-083', 17:54:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:54:55 INFO - 'use_talos_json': True, 17:54:55 INFO - 'verify': 'False', 17:54:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:54:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:54:55 INFO - 'work_dir': 'build'} 17:54:55 INFO - [mozharness: 2017-09-26 00:54:55.697040Z] Running clobber step. 17:54:55 INFO - Running pre-action listener: _resource_record_pre_action 17:54:55 INFO - Running main action method: clobber 17:54:55 INFO - rmtree: /builds/slave/test/build 17:54:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:54:57 INFO - Running post-action listener: _resource_record_post_action 17:54:57 INFO - [mozharness: 2017-09-26 00:54:57.279336Z] Finished clobber step (success) 17:54:57 INFO - [mozharness: 2017-09-26 00:54:57.279432Z] Running read-buildbot-config step. 17:54:57 INFO - Running pre-action listener: _resource_record_pre_action 17:54:57 INFO - Running main action method: read_buildbot_config 17:54:57 INFO - Using buildbot properties: 17:54:57 INFO - { 17:54:57 INFO - "project": "", 17:54:57 INFO - "product": "firefox", 17:54:57 INFO - "who": "kwierso@gmail.com", 17:54:57 INFO - "installer_path": "public/build/target.tar.bz2", 17:54:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:54:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:54:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:54:57 INFO - "stage_platform": "linux64-pgo", 17:54:57 INFO - "basedir": "/builds/slave/test", 17:54:57 INFO - "buildnumber": 40, 17:54:57 INFO - "platform": "ubuntu64_hw", 17:54:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:54:57 INFO - "slavebuilddir": "test", 17:54:57 INFO - "taskId": "FvexGruQStK0u66AHTy8Nw", 17:54:57 INFO - "branch": "mozilla-central", 17:54:57 INFO - "script_repo_revision": "production", 17:54:57 INFO - "revision": "641bfddb87113b45ee3df9849345dbcf821ef3da", 17:54:57 INFO - "slavename": "talos-linux64-ix-083", 17:54:57 INFO - "repo_path": "mozilla-central" 17:54:57 INFO - } 17:54:57 INFO - Finding installer, test and symbols from parent task. 17:54:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FvexGruQStK0u66AHTy8Nw'}, attempt #1 17:54:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FvexGruQStK0u66AHTy8Nw'}, attempt #1 17:54:58 INFO - Task dependencies: NrQ6614BRL-Ibp7ZFNvHoA 17:54:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA'}, attempt #1 17:54:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:54:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json 17:54:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip 17:54:58 INFO - Running post-action listener: _resource_record_post_action 17:54:58 INFO - [mozharness: 2017-09-26 00:54:58.612226Z] Finished read-buildbot-config step (success) 17:54:58 INFO - [mozharness: 2017-09-26 00:54:58.612423Z] Running download-and-extract step. 17:54:58 INFO - Running pre-action listener: _resource_record_pre_action 17:54:58 INFO - Running main action method: download_and_extract 17:54:58 INFO - mkdir: /builds/slave/test/build/tests 17:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:54:58 INFO - trying https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json 17:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:54:59 INFO - Downloaded 989 bytes. 17:54:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:54:59 INFO - Using the following test package requirements: 17:54:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:54:59 INFO - u'common': [u'target.common.tests.zip'], 17:54:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:54:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:54:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:54:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:54:59 INFO - u'mozbase': [u'target.common.tests.zip'], 17:54:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:54:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:54:59 INFO - u'web-platform': [u'target.common.tests.zip', 17:54:59 INFO - u'target.web-platform.tests.tar.gz'], 17:54:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:54:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:54:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip 17:54:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:54:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.common.tests.zip into memory 17:55:00 INFO - Content-Length response header: 55342467 17:55:00 INFO - Bytes received: 55342467 17:55:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip 17:55:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:55:11 INFO - Fetch https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.talos.tests.zip into memory 17:55:12 INFO - Content-Length response header: 14513823 17:55:12 INFO - Bytes received: 14513823 17:55: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')]} 17:55:12 INFO - trying https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:55:12 INFO - Downloading https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:55:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:55:13 INFO - Downloaded 62422160 bytes. 17:55:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:55:13 INFO - mkdir: /builds/slave/test/properties 17:55:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:55:13 INFO - Writing to file /builds/slave/test/properties/build_url 17:55:13 INFO - Contents: 17:55:13 INFO - build_url:https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 17:55:13 INFO - Running post-action listener: _resource_record_post_action 17:55:13 INFO - Running post-action listener: find_tests_for_verification 17:55:13 INFO - Running post-action listener: set_extra_try_arguments 17:55:13 INFO - [mozharness: 2017-09-26 00:55:13.414329Z] Finished download-and-extract step (success) 17:55:13 INFO - [mozharness: 2017-09-26 00:55:13.414428Z] Running populate-webroot step. 17:55:13 INFO - Running pre-action listener: _resource_record_pre_action 17:55:13 INFO - Running main action method: populate_webroot 17:55:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:55:13 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['tresize', 17:55:13 INFO - 'tcanvasmark']}, 17:55:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:55:13 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['dromaeo_css', 17:55:13 INFO - 'kraken']}, 17:55:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:13 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:55:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'tests': ['damp', 'tps']}, 17:55:13 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['damp', 'tps']}, 17:55:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:55:13 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['dromaeo_dom']}, 17:55:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:55:13 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['basic_compositor_video', 17:55:13 INFO - 'glvideo']}, 17:55:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:55:13 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['ts_paint_webext', 17:55:13 INFO - 'tp5o_webext']}, 17:55:13 INFO - 'other-e10s': {'tests': ['a11yr', 17:55:13 INFO - 'ts_paint', 17:55:13 INFO - 'tpaint', 17:55:13 INFO - 'sessionrestore', 17:55:13 INFO - 'sessionrestore_many_windows', 17:55:13 INFO - 'sessionrestore_no_auto_restore', 17:55:13 INFO - 'tabpaint']}, 17:55:13 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['a11yr', 17:55:13 INFO - 'ts_paint', 17:55:13 INFO - 'tpaint', 17:55:13 INFO - 'sessionrestore', 17:55:13 INFO - 'sessionrestore_many_windows', 17:55:13 INFO - 'sessionrestore_no_auto_restore', 17:55:13 INFO - 'tabpaint']}, 17:55:13 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:55:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:55:13 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['perf_reftest_singletons']}, 17:55:13 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['perf_reftest']}, 17:55:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:55:13 INFO - 'tsvgr_opacity', 17:55:13 INFO - 'tart', 17:55:13 INFO - 'tscrollx', 17:55:13 INFO - 'tsvg_static']}, 17:55:13 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['tsvgx', 17:55:13 INFO - 'tsvgr_opacity', 17:55:13 INFO - 'tart', 17:55:13 INFO - 'tscrollx', 17:55:13 INFO - 'tsvg_static']}, 17:55:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:55:13 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--disable-stylo'], 17:55:13 INFO - 'tests': ['tp5o']}, 17:55:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:13 INFO - 'talos_options': ['--mitmproxy', 17:55:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:13 INFO - '--firstNonBlankPaint'], 17:55:13 INFO - 'tests': ['tp6_google', 17:55:13 INFO - 'tp6_youtube', 17:55:13 INFO - 'tp6_amazon', 17:55:13 INFO - 'tp6_facebook']}, 17:55:13 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:13 INFO - 'talos_options': ['--disable-stylo', 17:55:13 INFO - '--mitmproxy', 17:55:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:13 INFO - '--firstNonBlankPaint'], 17:55:13 INFO - 'tests': ['tp6_google', 17:55:13 INFO - 'tp6_youtube', 17:55:13 INFO - 'tp6_amazon', 17:55:13 INFO - 'tp6_facebook']}, 17:55:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:55:13 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:55:13 INFO - 'talos_options': ['--stylo-threads=1', 17:55:13 INFO - '--mitmproxy', 17:55:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:55:13 INFO - '--firstNonBlankPaint'], 17:55:13 INFO - 'tests': ['tp6_google', 17:55:13 INFO - 'tp6_youtube', 17:55:13 INFO - 'tp6_amazon', 17:55:13 INFO - 'tp6_facebook']}, 17:55:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--xperf_path', 17:55:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:13 INFO - 'tests': ['tp5n']}, 17:55:13 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:55:13 INFO - 'talos_options': ['--disable-stylo', 17:55:13 INFO - '--xperf_path', 17:55:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:55:13 INFO - 'tests': ['tp5n']}}} 17:55:13 INFO - Running post-action listener: _resource_record_post_action 17:55:13 INFO - [mozharness: 2017-09-26 00:55:13.429983Z] Finished populate-webroot step (success) 17:55:13 INFO - [mozharness: 2017-09-26 00:55:13.430072Z] Running create-virtualenv step. 17:55:13 INFO - Running pre-action listener: _resource_record_pre_action 17:55:13 INFO - Running main action method: create_virtualenv 17:55:13 INFO - Creating virtualenv /builds/slave/test/build/venv 17:55:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:55:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:55:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:55:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:55:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:55:14 INFO - Installing distribute.............................................................................................................................................................................................done. 17:55:14 INFO - Installing pip...............done. 17:55:14 INFO - Return code: 0 17:55:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:55:14 INFO - Reading from file tmpfile_stdout 17:55:14 INFO - Output received: 17:55:14 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:55:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:55:14 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')]} 17:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:14 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')]} 17:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:14 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:14 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 17:55:14 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 17:55:14 INFO - Using env: {'DISPLAY': ':0', 17:55:14 INFO - 'HOME': '/home/cltbld', 17:55:14 INFO - 'LANG': 'en_US.UTF-8', 17:55:14 INFO - 'LANGUAGE': 'en_US:en', 17:55:14 INFO - 'LOGNAME': 'cltbld', 17:55:14 INFO - 'MAIL': '/var/mail/cltbld', 17:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:14 INFO - 'MOZ_NO_REMOTE': '1', 17:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:14 INFO - 'NO_EM_RESTART': '1', 17:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:14 INFO - 'PWD': '/builds/slave/test', 17:55:14 INFO - 'SHELL': '/bin/bash', 17:55:14 INFO - 'SHLVL': '1', 17:55:14 INFO - 'TERM': 'linux', 17:55:14 INFO - 'TMOUT': '86400', 17:55:14 INFO - 'USER': 'cltbld', 17:55:14 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:14 INFO - '_': '/tools/buildbot/bin/python'} 17:55:15 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:55:15 INFO - Downloading/unpacking pip>=1.5 17:55:15 INFO - Running setup.py egg_info for package pip 17:55:15 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:15 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:15 INFO - Installing collected packages: pip 17:55:15 INFO - Found existing installation: pip 1.1 17:55:15 INFO - Uninstalling pip: 17:55:15 INFO - Successfully uninstalled pip 17:55:15 INFO - Running setup.py install for pip 17:55:15 INFO - warning: no files found matching 'pip/cacert.pem' 17:55:15 INFO - warning: no files found matching '*.html' under directory 'docs' 17:55:15 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:55:15 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:55:15 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:55:15 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:55:15 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:55:15 INFO - Successfully installed pip 17:55:15 INFO - Cleaning up... 17:55:15 INFO - Return code: 0 17:55:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:55: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')]} 17:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55: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')]} 17:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55: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', '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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:55: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 psutil>=3.1.1 17:55:15 INFO - Using env: {'DISPLAY': ':0', 17:55:15 INFO - 'HOME': '/home/cltbld', 17:55:15 INFO - 'LANG': 'en_US.UTF-8', 17:55:15 INFO - 'LANGUAGE': 'en_US:en', 17:55:15 INFO - 'LOGNAME': 'cltbld', 17:55:15 INFO - 'MAIL': '/var/mail/cltbld', 17:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:15 INFO - 'MOZ_NO_REMOTE': '1', 17:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:15 INFO - 'NO_EM_RESTART': '1', 17:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:15 INFO - 'PWD': '/builds/slave/test', 17:55:15 INFO - 'SHELL': '/bin/bash', 17:55:15 INFO - 'SHLVL': '1', 17:55:15 INFO - 'TERM': 'linux', 17:55:15 INFO - 'TMOUT': '86400', 17:55:15 INFO - 'USER': 'cltbld', 17:55:15 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:15 INFO - '_': '/tools/buildbot/bin/python'} 17:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:15 INFO - Downloading/unpacking psutil>=3.1.1 17:55:15 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 17:55:15 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 17:55:15 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 17:55:15 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 17:55:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:55:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:17 INFO - Installing collected packages: psutil 17:55:17 INFO - Running setup.py install for psutil 17:55:17 INFO - building 'psutil._psutil_linux' extension 17:55:17 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 17:55:17 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 17:55:17 INFO - building 'psutil._psutil_posix' extension 17:55:17 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 17:55:17 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 17:55:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:55:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:55:17 INFO - Successfully installed psutil 17:55:17 INFO - Cleaning up... 17:55:17 INFO - Return code: 0 17:55:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:55:17 INFO - Using env: {'DISPLAY': ':0', 17:55:17 INFO - 'HOME': '/home/cltbld', 17:55:17 INFO - 'LANG': 'en_US.UTF-8', 17:55:17 INFO - 'LANGUAGE': 'en_US:en', 17:55:17 INFO - 'LOGNAME': 'cltbld', 17:55:17 INFO - 'MAIL': '/var/mail/cltbld', 17:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:17 INFO - 'MOZ_NO_REMOTE': '1', 17:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:17 INFO - 'NO_EM_RESTART': '1', 17:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:17 INFO - 'PWD': '/builds/slave/test', 17:55:17 INFO - 'SHELL': '/bin/bash', 17:55:17 INFO - 'SHLVL': '1', 17:55:17 INFO - 'TERM': 'linux', 17:55:17 INFO - 'TMOUT': '86400', 17:55:17 INFO - 'USER': 'cltbld', 17:55:17 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:17 INFO - '_': '/tools/buildbot/bin/python'} 17:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:55:17 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 17:55:17 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 17:55:17 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 17:55:17 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 17:55:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:55:19 INFO - Installing collected packages: mozsystemmonitor 17:55:19 INFO - Running setup.py install for mozsystemmonitor 17:55:19 INFO - Successfully installed mozsystemmonitor 17:55:19 INFO - Cleaning up... 17:55:19 INFO - Return code: 0 17:55:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:55:19 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')]} 17:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:19 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')]} 17:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:19 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:19 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 17:55:19 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 17:55:19 INFO - Using env: {'DISPLAY': ':0', 17:55:19 INFO - 'HOME': '/home/cltbld', 17:55:19 INFO - 'LANG': 'en_US.UTF-8', 17:55:19 INFO - 'LANGUAGE': 'en_US:en', 17:55:19 INFO - 'LOGNAME': 'cltbld', 17:55:19 INFO - 'MAIL': '/var/mail/cltbld', 17:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:19 INFO - 'MOZ_NO_REMOTE': '1', 17:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:19 INFO - 'NO_EM_RESTART': '1', 17:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:19 INFO - 'PWD': '/builds/slave/test', 17:55:19 INFO - 'SHELL': '/bin/bash', 17:55:19 INFO - 'SHLVL': '1', 17:55:19 INFO - 'TERM': 'linux', 17:55:19 INFO - 'TMOUT': '86400', 17:55:19 INFO - 'USER': 'cltbld', 17:55:19 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:19 INFO - '_': '/tools/buildbot/bin/python'} 17:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:55:19 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 17:55:19 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 17:55:19 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 17:55:19 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 17:55:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:55:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:55:20 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 17:55:20 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 17:55:20 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 17:55:20 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 17:55:20 INFO - Downloading functools32-3.2.3-2.tar.gz 17:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:55:20 INFO - warning: no files found matching '*.txt' 17:55:20 INFO - no previously-included directories found matching 'build' 17:55:20 INFO - no previously-included directories found matching 'dist' 17:55:20 INFO - no previously-included directories found matching '.git*' 17:55:20 INFO - Installing collected packages: jsonschema, functools32 17:55:20 INFO - Running setup.py install for functools32 17:55:21 INFO - warning: no files found matching '*.txt' 17:55:21 INFO - no previously-included directories found matching 'build' 17:55:21 INFO - no previously-included directories found matching 'dist' 17:55:21 INFO - no previously-included directories found matching '.git*' 17:55:21 INFO - Successfully installed jsonschema functools32 17:55:21 INFO - Cleaning up... 17:55:21 INFO - Return code: 0 17:55:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:55:21 INFO - Using env: {'DISPLAY': ':0', 17:55:21 INFO - 'HOME': '/home/cltbld', 17:55:21 INFO - 'LANG': 'en_US.UTF-8', 17:55:21 INFO - 'LANGUAGE': 'en_US:en', 17:55:21 INFO - 'LOGNAME': 'cltbld', 17:55:21 INFO - 'MAIL': '/var/mail/cltbld', 17:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:21 INFO - 'MOZ_NO_REMOTE': '1', 17:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:21 INFO - 'NO_EM_RESTART': '1', 17:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:21 INFO - 'PWD': '/builds/slave/test', 17:55:21 INFO - 'SHELL': '/bin/bash', 17:55:21 INFO - 'SHLVL': '1', 17:55:21 INFO - 'TERM': 'linux', 17:55:21 INFO - 'TMOUT': '86400', 17:55:21 INFO - 'USER': 'cltbld', 17:55:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:21 INFO - '_': '/tools/buildbot/bin/python'} 17:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:55:21 INFO - Cleaning up... 17:55:21 INFO - Return code: 0 17:55:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:55:21 INFO - Using env: {'DISPLAY': ':0', 17:55:21 INFO - 'HOME': '/home/cltbld', 17:55:21 INFO - 'LANG': 'en_US.UTF-8', 17:55:21 INFO - 'LANGUAGE': 'en_US:en', 17:55:21 INFO - 'LOGNAME': 'cltbld', 17:55:21 INFO - 'MAIL': '/var/mail/cltbld', 17:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:21 INFO - 'MOZ_NO_REMOTE': '1', 17:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:21 INFO - 'NO_EM_RESTART': '1', 17:55:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:21 INFO - 'PWD': '/builds/slave/test', 17:55:21 INFO - 'SHELL': '/bin/bash', 17:55:21 INFO - 'SHLVL': '1', 17:55:21 INFO - 'TERM': 'linux', 17:55:21 INFO - 'TMOUT': '86400', 17:55:21 INFO - 'USER': 'cltbld', 17:55:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:21 INFO - '_': '/tools/buildbot/bin/python'} 17:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:21 INFO - Downloading/unpacking blobuploader==1.2.4 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:55:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:55:22 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 17:55:22 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 17:55:22 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 17:55:22 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 17:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:55:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:55:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:55:23 INFO - Downloading docopt-0.6.1.tar.gz 17:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:55:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:55:23 INFO - Running setup.py install for blobuploader 17:55:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:55:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:55:23 INFO - Running setup.py install for requests 17:55:24 INFO - Running setup.py install for docopt 17:55:24 INFO - Successfully installed blobuploader requests docopt 17:55:24 INFO - Cleaning up... 17:55:24 INFO - Return code: 0 17:55:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:24 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:24 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 17:55:24 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 17:55:24 INFO - Using env: {'DISPLAY': ':0', 17:55:24 INFO - 'HOME': '/home/cltbld', 17:55:24 INFO - 'LANG': 'en_US.UTF-8', 17:55:24 INFO - 'LANGUAGE': 'en_US:en', 17:55:24 INFO - 'LOGNAME': 'cltbld', 17:55:24 INFO - 'MAIL': '/var/mail/cltbld', 17:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:24 INFO - 'MOZ_NO_REMOTE': '1', 17:55:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:24 INFO - 'NO_EM_RESTART': '1', 17:55:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:24 INFO - 'PWD': '/builds/slave/test', 17:55:24 INFO - 'SHELL': '/bin/bash', 17:55:24 INFO - 'SHLVL': '1', 17:55:24 INFO - 'TERM': 'linux', 17:55:24 INFO - 'TMOUT': '86400', 17:55:24 INFO - 'USER': 'cltbld', 17:55:24 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:24 INFO - '_': '/tools/buildbot/bin/python'} 17:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:24 INFO - Running setup.py (path:/tmp/pip-1t9T7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:24 INFO - Running setup.py (path:/tmp/pip-nE_2IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:24 INFO - Running setup.py (path:/tmp/pip-p7_49m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:24 INFO - Running setup.py (path:/tmp/pip-eW3dZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:24 INFO - Running setup.py (path:/tmp/pip-jCt0cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:24 INFO - Running setup.py (path:/tmp/pip-JGNr1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:24 INFO - Running setup.py (path:/tmp/pip-AQ3dTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:24 INFO - Running setup.py (path:/tmp/pip-3QgVw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:24 INFO - Running setup.py (path:/tmp/pip-cpugJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:25 INFO - Running setup.py (path:/tmp/pip-5L9Y1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:25 INFO - Running setup.py (path:/tmp/pip-xqbTNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:25 INFO - Running setup.py (path:/tmp/pip-DnPIQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:25 INFO - Running setup.py (path:/tmp/pip-CSl2mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:25 INFO - Running setup.py (path:/tmp/pip-iE1tZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:25 INFO - Running setup.py (path:/tmp/pip-BxUYgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:25 INFO - Running setup.py (path:/tmp/pip-CEAT4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:25 INFO - Running setup.py (path:/tmp/pip-22zYup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:55:25 INFO - Running setup.py install for manifestparser 17:55:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:55:25 INFO - Running setup.py install for mozcrash 17:55:25 INFO - Running setup.py install for mozdebug 17:55:25 INFO - Running setup.py install for mozdevice 17:55:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozfile 17:55:26 INFO - Running setup.py install for mozhttpd 17:55:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozinfo 17:55:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozInstall 17:55:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozleak 17:55:26 INFO - Running setup.py install for mozlog 17:55:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for moznetwork 17:55:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozprocess 17:55:26 INFO - Running setup.py install for mozprofile 17:55:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:55:26 INFO - Running setup.py install for mozrunner 17:55:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:55:27 INFO - Running setup.py install for mozscreenshot 17:55:27 INFO - Running setup.py install for moztest 17:55:27 INFO - Running setup.py install for mozversion 17:55:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:55:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:55:27 INFO - Cleaning up... 17:55:27 INFO - Return code: 0 17:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:27 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:27 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 17:55:27 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 17:55:27 INFO - Using env: {'DISPLAY': ':0', 17:55:27 INFO - 'HOME': '/home/cltbld', 17:55:27 INFO - 'LANG': 'en_US.UTF-8', 17:55:27 INFO - 'LANGUAGE': 'en_US:en', 17:55:27 INFO - 'LOGNAME': 'cltbld', 17:55:27 INFO - 'MAIL': '/var/mail/cltbld', 17:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:27 INFO - 'MOZ_NO_REMOTE': '1', 17:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:27 INFO - 'NO_EM_RESTART': '1', 17:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:27 INFO - 'PWD': '/builds/slave/test', 17:55:27 INFO - 'SHELL': '/bin/bash', 17:55:27 INFO - 'SHLVL': '1', 17:55:27 INFO - 'TERM': 'linux', 17:55:27 INFO - 'TMOUT': '86400', 17:55:27 INFO - 'USER': 'cltbld', 17:55:27 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:27 INFO - '_': '/tools/buildbot/bin/python'} 17:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:55:27 INFO - Running setup.py (path:/tmp/pip-h7aS8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:55:27 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)) 17:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:55:27 INFO - Running setup.py (path:/tmp/pip-QT5JiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:55:27 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)) 17:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:55:27 INFO - Running setup.py (path:/tmp/pip-65Y96G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:55:27 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)) 17:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:55:27 INFO - Running setup.py (path:/tmp/pip-jmZv7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:55:27 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)) 17:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:55:27 INFO - Running setup.py (path:/tmp/pip-0fOwUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:55:28 INFO - Running setup.py (path:/tmp/pip-NzvbDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:55:28 INFO - Running setup.py (path:/tmp/pip-mkg1gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:55:28 INFO - Running setup.py (path:/tmp/pip-O_Yvjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:55:28 INFO - Running setup.py (path:/tmp/pip-jaE_Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:55:28 INFO - Running setup.py (path:/tmp/pip-JpMNhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:55:28 INFO - Running setup.py (path:/tmp/pip-ZuE2D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:55:28 INFO - Running setup.py (path:/tmp/pip-dTrhUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:55:28 INFO - Running setup.py (path:/tmp/pip-m7yZac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:55:28 INFO - Running setup.py (path:/tmp/pip-hunvh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:28 INFO - Running setup.py (path:/tmp/pip-gbCpZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:55:28 INFO - Running setup.py (path:/tmp/pip-VXs5ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:55:28 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)) 17:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:55:28 INFO - Running setup.py (path:/tmp/pip-36uBo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:55:28 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)) 17:55:28 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)) 17:55:28 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)) 17:55:28 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)) 17:55:28 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)) 17:55:28 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)) 17:55:28 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)) 17:55:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:55:28 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 17:55:28 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 17:55:28 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 17:55:28 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 17:55:29 INFO - Downloading blessings-1.6.tar.gz 17:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:55:30 INFO - Installing collected packages: blessings 17:55:30 INFO - Running setup.py install for blessings 17:55:30 INFO - Successfully installed blessings 17:55:30 INFO - Cleaning up... 17:55:30 INFO - Return code: 0 17:55:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:30 INFO - Reading from file tmpfile_stdout 17:55:30 INFO - Current package versions: 17:55:30 INFO - argparse == 1.2.1 17:55:30 INFO - blessings == 1.6 17:55:30 INFO - blobuploader == 1.2.4 17:55:30 INFO - docopt == 0.6.1 17:55:30 INFO - functools32 == 3.2.3-2 17:55:30 INFO - jsonschema == 2.5.1 17:55:30 INFO - manifestparser == 1.1 17:55:30 INFO - mozInstall == 1.13 17:55:30 INFO - mozcrash == 1.0 17:55:30 INFO - mozdebug == 0.1 17:55:30 INFO - mozdevice == 0.51 17:55:30 INFO - mozfile == 1.2 17:55:30 INFO - mozhttpd == 0.7 17:55:30 INFO - mozinfo == 0.10 17:55:30 INFO - mozleak == 0.1 17:55:30 INFO - mozlog == 3.5 17:55:30 INFO - moznetwork == 0.27 17:55:30 INFO - mozprocess == 0.25 17:55:30 INFO - mozprofile == 0.28 17:55:30 INFO - mozrunner == 6.13 17:55:30 INFO - mozscreenshot == 0.1 17:55:30 INFO - mozsystemmonitor == 0.3 17:55:30 INFO - moztest == 0.8 17:55:30 INFO - mozversion == 1.4 17:55:30 INFO - psutil == 3.1.1 17:55:30 INFO - requests == 1.2.3 17:55:30 INFO - wsgiref == 0.1.2 17:55:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:30 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:30 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 17:55:30 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 17:55:30 INFO - Using env: {'DISPLAY': ':0', 17:55:30 INFO - 'HOME': '/home/cltbld', 17:55:30 INFO - 'LANG': 'en_US.UTF-8', 17:55:30 INFO - 'LANGUAGE': 'en_US:en', 17:55:30 INFO - 'LOGNAME': 'cltbld', 17:55:30 INFO - 'MAIL': '/var/mail/cltbld', 17:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:30 INFO - 'MOZ_NO_REMOTE': '1', 17:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:30 INFO - 'NO_EM_RESTART': '1', 17:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:30 INFO - 'PWD': '/builds/slave/test', 17:55:30 INFO - 'SHELL': '/bin/bash', 17:55:30 INFO - 'SHLVL': '1', 17:55:30 INFO - 'TERM': 'linux', 17:55:30 INFO - 'TMOUT': '86400', 17:55:30 INFO - 'USER': 'cltbld', 17:55:30 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:30 INFO - '_': '/tools/buildbot/bin/python'} 17:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 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)) 17:55:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:55:30 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 17:55:30 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 17:55:30 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 17:55:30 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 17:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:55:31 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)) 17:55:31 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)) 17:55:31 INFO - Installing collected packages: simplejson 17:55:31 INFO - Running setup.py install for simplejson 17:55:31 INFO - building 'simplejson._speedups' extension 17:55:31 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 17:55:32 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 17:55:32 INFO - Successfully installed simplejson 17:55:32 INFO - Cleaning up... 17:55:32 INFO - Return code: 0 17:55:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:55:32 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')]} 17:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:55:32 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')]} 17:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:55:32 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 0x13f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17659c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, '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': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', '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 17:55:32 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 17:55:32 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 17:55:32 INFO - Using env: {'DISPLAY': ':0', 17:55:32 INFO - 'HOME': '/home/cltbld', 17:55:32 INFO - 'LANG': 'en_US.UTF-8', 17:55:32 INFO - 'LANGUAGE': 'en_US:en', 17:55:32 INFO - 'LOGNAME': 'cltbld', 17:55:32 INFO - 'MAIL': '/var/mail/cltbld', 17:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:32 INFO - 'MOZ_NO_REMOTE': '1', 17:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:32 INFO - 'NO_EM_RESTART': '1', 17:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:32 INFO - 'PWD': '/builds/slave/test', 17:55:32 INFO - 'SHELL': '/bin/bash', 17:55:32 INFO - 'SHLVL': '1', 17:55:32 INFO - 'TERM': 'linux', 17:55:32 INFO - 'TMOUT': '86400', 17:55:32 INFO - 'USER': 'cltbld', 17:55:32 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:32 INFO - '_': '/tools/buildbot/bin/python'} 17:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:55:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:55:33 INFO - Cleaning up... 17:55:33 INFO - Return code: 0 17:55:33 INFO - Running post-action listener: _resource_record_post_action 17:55:33 INFO - Running post-action listener: _start_resource_monitoring 17:55:33 INFO - Starting resource monitoring. 17:55:33 INFO - [mozharness: 2017-09-26 00:55:33.181349Z] Finished create-virtualenv step (success) 17:55:33 INFO - [mozharness: 2017-09-26 00:55:33.181824Z] Running install step. 17:55:33 INFO - Running pre-action listener: _resource_record_pre_action 17:55:33 INFO - Running main action method: install 17:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:55:33 INFO - Reading from file tmpfile_stdout 17:55:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:55:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:55:33 INFO - Reading from file tmpfile_stdout 17:55:33 INFO - Output received: 17:55:33 INFO - Usage: mozinstall [options] installer 17:55:33 INFO - Options: 17:55:33 INFO - -h, --help show this help message and exit 17:55:33 INFO - -d DEST, --destination=DEST 17:55:33 INFO - Directory to install application into. [default: 17:55:33 INFO - "/builds/slave/test"] 17:55:33 INFO - --app=APP Application being installed. [default: firefox] 17:55:33 INFO - mkdir: /builds/slave/test/build/application 17:55:33 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'] 17:55:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:55:52 INFO - Reading from file tmpfile_stdout 17:55:52 INFO - Output received: 17:55:52 INFO - /builds/slave/test/build/application/firefox/firefox 17:55:52 INFO - Running post-action listener: _resource_record_post_action 17:55:52 INFO - [mozharness: 2017-09-26 00:55:52.137235Z] Finished install step (success) 17:55:52 INFO - [mozharness: 2017-09-26 00:55:52.137496Z] Running setup-mitmproxy step. 17:55:52 INFO - Running pre-action listener: _resource_record_pre_action 17:55:52 INFO - Running main action method: setup_mitmproxy 17:55:52 INFO - Skipping: mitmproxy is not required 17:55:52 INFO - Running post-action listener: _resource_record_post_action 17:55:52 INFO - [mozharness: 2017-09-26 00:55:52.138636Z] Finished setup-mitmproxy step (success) 17:55:52 INFO - [mozharness: 2017-09-26 00:55:52.138856Z] Running run-tests step. 17:55:52 INFO - Running pre-action listener: _resource_record_pre_action 17:55:52 INFO - Running pre-action listener: _set_gcov_prefix 17:55:52 INFO - Running main action method: run_tests 17:55:52 WARNING - Try message not found. 17:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:55:52 INFO - Python 2.7.3 17:55:52 INFO - Return code: 0 17:55:52 INFO - grabbing minidump binary from tooltool 17:55: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')]} 17:55:52 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 0x1762d60>, '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 0x1763a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:55:52 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 17:55:52 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 17:55:52 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 17:55:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:55:52 INFO - Return code: 0 17:55:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:55:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:55:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:55:52 INFO - ENV: RUST_BACKTRACE is now full 17:55:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:55:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 17:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 17:55:52 INFO - Using env: {'DISPLAY': ':0', 17:55:52 INFO - 'HOME': '/home/cltbld', 17:55:52 INFO - 'LANG': 'en_US.UTF-8', 17:55:52 INFO - 'LANGUAGE': 'en_US:en', 17:55:52 INFO - 'LOGNAME': 'cltbld', 17:55:52 INFO - 'MAIL': '/var/mail/cltbld', 17:55:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:52 INFO - 'MOZ_NO_REMOTE': '1', 17:55:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:52 INFO - 'NO_EM_RESTART': '1', 17:55:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:52 INFO - 'PWD': '/builds/slave/test', 17:55:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:52 INFO - 'RUST_BACKTRACE': 'full', 17:55:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:55:52 INFO - 'SHELL': '/bin/bash', 17:55:52 INFO - 'SHLVL': '1', 17:55:52 INFO - 'TERM': 'linux', 17:55:52 INFO - 'TMOUT': '86400', 17:55:52 INFO - 'USER': 'cltbld', 17:55:52 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:52 INFO - '_': '/tools/buildbot/bin/python'} 17:55:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 17:55:52 INFO - mozversion application_buildid: 20170925232538 17:55:52 INFO - mozversion application_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:55:52 INFO - mozversion application_display_name: Nightly 17:55:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:55:52 INFO - mozversion application_name: Firefox 17:55:52 INFO - mozversion application_remotingname: firefox 17:55:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:55:52 INFO - mozversion application_vendor: Mozilla 17:55:52 INFO - mozversion application_version: 58.0a1 17:55:52 INFO - mozversion platform_buildid: 20170925232538 17:55:52 INFO - mozversion platform_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:55:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:55:52 INFO - mozversion platform_version: 58.0a1 17:55:52 INFO - using testdate: 1506387352 17:55:52 INFO - actual date: 1506387352 17:55:52 INFO - starting webserver on 'localhost:45054' 17:55:52 INFO - SUITE-START | Running 2 tests 17:55:52 INFO - TEST-START | dromaeo_css 17:55:52 INFO - Initialising browser for dromaeo_css test... 17:55:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45054/getInfo.html -profile /tmp/tmpswH3ei/profile 17:55:52 INFO - TEST-INFO | started process 28003 (/builds/slave/test/build/application/firefox/firefox http://localhost:45054/getInfo.html) 17:55:57 INFO - TEST-INFO | 28003: exit 0 17:55:57 INFO - Browser initialized. 17:55:57 INFO - Running cycle 1/1 for dromaeo_css test... 17:55:57 INFO - Using env: {'DISPLAY': ':0', 17:55:57 INFO - 'HOME': '/home/cltbld', 17:55:57 INFO - 'JSGC_DISABLE_POISONING': '1', 17:55:57 INFO - 'LANG': 'en_US.UTF-8', 17:55:57 INFO - 'LANGUAGE': 'en_US:en', 17:55:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:55:57 INFO - 'LOGNAME': 'cltbld', 17:55:57 INFO - 'MAIL': '/var/mail/cltbld', 17:55:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:55:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:55:57 INFO - 'MOZ_CRASHREPORTER': '1', 17:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:55:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:55:57 INFO - 'MOZ_NO_REMOTE': '1', 17:55:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:55:57 INFO - 'NO_EM_RESTART': '1', 17:55:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:55:57 INFO - 'PWD': '/builds/slave/test', 17:55:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:55:57 INFO - 'RUST_BACKTRACE': 'full', 17:55:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:55:57 INFO - 'SHELL': '/bin/bash', 17:55:57 INFO - 'SHLVL': '1', 17:55:57 INFO - 'STYLO_FORCE_DISABLED': '1', 17:55:57 INFO - 'TERM': 'linux', 17:55:57 INFO - 'TMOUT': '86400', 17:55:57 INFO - 'USER': 'cltbld', 17:55:57 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 17:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:55:57 INFO - '_': '/tools/buildbot/bin/python'} 17:55:57 INFO - TEST-INFO | started process 28238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpswH3ei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:58 INFO - PID 28238 | 17:55:58 INFO - PID 28238 | (/builds/slave/test/build/application/firefox/firefox:28287): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:55:58 INFO - PID 28238 | 17:56:08 INFO - PID 28238 | RSS: Main: 146264064 17:56:08 INFO - PID 28238 | 17:59:06 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45054/tests/dromaeo/cssquery-ext.html) 17:59:07 INFO - PID 28238 | RSS: Main: 146833408 17:59:07 INFO - PID 28238 | 18:02:09 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-ext.html (next: http://localhost:45054/tests/dromaeo/cssquery-jquery.html) 18:02:09 INFO - PID 28238 | RSS: Main: 147816448 18:02:09 INFO - PID 28238 | 18:05:11 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45054/tests/dromaeo/cssquery-mootools.html) 18:05:11 INFO - PID 28238 | RSS: Main: 148992000 18:05:11 INFO - PID 28238 | 18:08:13 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45054/tests/dromaeo/cssquery-prototype.html) 18:08:13 INFO - PID 28238 | RSS: Main: 147480576 18:08:13 INFO - PID 28238 | 18:11:17 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45054/tests/dromaeo/cssquery-yui.html) 18:11:17 INFO - PID 28238 | RSS: Main: 148439040 18:11:17 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | Cycle 1(1): loaded http://localhost:45054/tests/dromaeo/cssquery-yui.html (next: http://localhost:45054/tests/dromaeo/cssquery-dojo.html) 18:14:19 INFO - PID 28238 | RSS: Main: 151654400 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | __start_tp_report 18:14:19 INFO - PID 28238 | _x_x_mozilla_page_load 18:14:19 INFO - PID 28238 | _x_x_mozilla_page_load_details 18:14:19 INFO - PID 28238 | |i|pagename|runs| 18:14:19 INFO - PID 28238 | |0;dojo.html;3887.475190849238;3898.6491215790593;3898.8830335089942;3933.311670457671;3946.388309811979;6231.252249730027;6297.811065668037;6334.113224148623;6340.619562826234;6431.035344698297;6373.872522549546;6374.649394283312;6389.233292004954;6390.392912673288;6414.037894315855;5655.0386434306065;5698.601097923126;5703.08750599902;5720.942790572103;5722.399148089464;5745.5690823188215;5807.303123625171;5815.941840581582;5834.183214349994;5837.649741015532;5768.682722450264;5777.1623114648355;5830.008898487267;5865.032269675498;5874.148248503986;5574.191742197399;5607.467290607427;5670.6030577859565;5738.626989245728;5873.0603103503445;5625.971870140664;5694.5159661428825;5697.145428185764;5739.225204597367;5770.13447982806;6325.367463253638;6347.904781428282;6375.10748495211;6375.93624063758;6401.647909364983;6872.656367181621;6881.793546193622;6928.653567321614;6952.54808437455;6956.965215173892;7009.08881845362;7039.331263530008;7042.6830792614455;7044.788656340267;7054.788356349318;6427.2929977702415;6449.9355006449805;6514.804555863332;6530.151080359523;6534.673266336664;7106.111736032996;7122.145342558926;7184.030155928987;7187.245339239409;7197.244289349647;6751;6817.181938167451;6828.112345395067;6830.248672646005;6855.245922948472;6807.115075040312;6910.654467276717;6915.377616014583;7013.649317534103;7026.648667566601;6957.860842783116;6969.686364113627;6979.3020697930815;6998.720051197997;7024.5082844200415;6864.38220560142;6889;6906;6995.510314277952;7009.509334346547;5030.4718004608985;5047.899042019212;5053.0206449444595;5107.284980102789;5133.435322114565;4569.885752856205;4594.793234304464;4652.255639097796;4656.4645065817185;4663.906721865612;6306.211723534559;6389.520785941073;6475.773347932894;6478.4169424752;6504.219493660697;6893.345132212432;6911.6889739961825;6912.377885990285;6967.024616553686;6992.440604751608;6329.651869147149;6335.904961425582;6371.649559274192;6388.425041746265;6445.129907462527;5595.8601034973635;5610.382857885629;5621.409751975983;5624.100143976944;5624.128260119688;7176.96411517939;7215.242399548077;7219.205887352387;7224.855502890018;7331.706731730671;6855.760048398282;6923.238443771081;6981.930180698128;6992.3357281058215;7023.262557431498;7236.023136876454;7280.745173919099;7282.162551306667;7285;7290.270972902667;6839.89740153908;6844.863102738017;6847.041414201916;6925.099737034153;6947.444204463732;6858.691358888962;6902.551334163263;6957.826054348682;6977.476689248225;6999.615021173884;6680.799576012728;6745.3591908768585;6775;6776.322367763184;6780.423663988616;6693.497987651043;6703.932960670526;6778.186617605918;6786.660666966533;6791.04925310447;6434.099226108255;6496.480281577368;6600.768973085919;6611.801645950629;6614.371634694697;6703.698333574904;6756.459483241427;6851.383375496229;6858.0398744176855;6876.106106206161;6566.8358291043105;6567.146270984741;6569.868602627825;6659.833504162435;6673.599584024974 18:14:19 INFO - PID 28238 | |1;ext.html;942.5240253671894;946.3990366117513;975.7755716185277;1001.2440607341451;1003.6888564544992;42794;43323.78338108305;43383.34924976128;43466.130677386434;43531;40597.188056238854;40681.38977915334;40858;40883;41056.38415423771;7739.03262092237;7790.45466817323;7879.684812607489;7883.2510911463605;7884.0144981877265;7416.666250018762;7450.850982980337;7462.813429664247;7475.32722055015;7480.476366654337;7470.626468676572;8353.289970352496;8523.360747943898;8549.444286121383;8554.529500877481;8406.537640429773;8433.873491897626;8460.8730869037;8490.150984901522;8496.83006339876;8219.424640275183;8237.341012718967;8360.665573377119;8405.70580029696;8413.32693384534;39951.20097598032;40337.193256135004;40357.192856143;40532.189356213006;40622.796886015676;3739.6447337502896;3761.0409345616695;3794.582595914447;3796.2597293527774;3802.4106263529197;32750.67249327524;32983.50524742131;33141.83429082839;33146.6685333146;33327;5437.755301011464;5466.098093814516;5475.342958844964;5477.123660214386;5479.53423958964;230825;231223;231504;231641;232135;53100.73449632804;53164.46835531595;53200;53268;53283;55270.44729552734;55560.16659750107;55666.721666392215;55667;55670.16494752582;16914.492565223063;17059.914700426667;17070.40253591143;17072.2317495713;17092.572685682957;14001.789973150411;14010.159390436607;14109.294535273195;14119.082259653089;14119.576412707635;15027.774583381259;15085.54743357701;15192.848071519144;15315.540533784004;15322.00406973543;6249.78125765596;6258.466675664491;6276.968615156895;6295.5907865988565;6341.080543321193;1098.7857367813199;1106.8561087058793;1122.5790328626765;1126.5887950898027;1131.4569006876745;26124.73875261261;26132.608010879852;26165.476690466083;26189.73810261873;26481.867590661925;1210.2980271442543;1216.9087318451152;1236.1717649175075;1240.3240234072452;1243.6704273367566;13587.388567514485;13647.187764658876;13717.245551494563;14040.438382464792;14137.575872723835;272284;273783;273919;274283;274345;57574;57664;61063.38936610666;61448.38551614427;61496;1520.9847901521064;1527.6639139389538;1536.3854458216804;1550.0622123615276;1561.3832536148159;30316.393672126876;30481.23796905095;30549.847250763603;30686.539701904934;30814.229644259074;42266.788666056476;42504.57495425006;42555;42613.57386426096;42672.359914601926;234113;236219;237102;237548;237637;34625.82687086549;34636.48045279373;34671.30657386889;34793.65206347904;35021.64978350184;44511;45895.31157032714;46290.074198516515;46298.768506157256;46314.53685463237;33572.328553428306;33841;34093;34430.48354274638;34506.30987380188;33505.329893402486;33773.66226337705;33806;33818.830905845316;34572;39614.80192599134;40066;40244;40361.79819100886;40450.59549404586;33328.1667958303;33687.4946875802;33786.49320260247;33854.830725846216;33904.66095339114;24746.628800568367;24831.62752558677;25384.238472845846;25533;25766.87116564405 18:14:19 INFO - PID 28238 | |2;jquery.html;619.5043964828136;625.0804877807168;631.1447987976295;632.285517365377;651.4267444648707;21457.67813482795;21818.345449636516;22567.661485077715;22584.096636134556;22625.434364140903;24379.512409751795;25558.233253002392;25585.616215756778;25586.488270234586;25593.36016599581;6644.734210631581;6795.932040679604;6808.489363297747;6818.284080171585;6822.079019332376;6303.684815759217;6544.181977252843;6548.345165483437;6552.246491653474;6569.211694596631;6514.348565143471;6517.250516190651;6517.576357536768;6519.8044058678315;6521.641309727963;6365.777197798055;6499.057636642684;6499.642519661416;6506.837329066764;6639.136912201383;6207.379262073801;6212.813615591494;6218.129461875341;6229.221347331583;6235.127082208494;29464.41071178586;29969.100926972227;29973.400531989457;30078;30094;2308.0883051194683;2320.5706944215376;2331.778481044298;2346.4368551547677;2346.753590872951;19804;20429.897850510803;20680.482987925272;20807.271745488986;20886.5822683547;2575.0987154495965;2576.0983655720534;2625.1599488163797;2646.8941242350284;2660.255128564005;138743;142703.28648356692;145860.2706986469;149054;151593;15740.763888541682;16705.248263828158;16781.58046048834;16867.409640662518;16971.06659133735;25781.226563203134;26003;26016.739832601812;26035.349116272246;26095;10508.474576271155;10639.521221545048;10876;10915.56337746497;10963.780724385468;9872.45701486425;9916.553755081039;9935.80128397428;9940.80118397628;10021.849672254923;9394.117237469061;9855.35940163887;9901.554430050664;9962.306407910673;10048.497575121215;2763.571646394812;2767.9861600691866;2770.667519897625;2792.3437992071845;2842.2894276430893;1026.7330494071596;1041.5417216424748;1054.7099547624464;1057.5928267616869;1076.0100707349256;21272.872712728604;21642.891785541287;21658.35024949254;21740.782592174193;21877.343679689635;1112.4870176559873;1122.421952694363;1124.7694222684493;1130.327455164176;1137.147139645266;11881.643550693492;11962.760744785055;12034.870933557164;12070.45682944252;12131.757364852654;584923;600005;607825;608468;626517;125705.37147314205;126483;127583;129383;129659;1186.833843261944;1203.9291328040874;1227.914046016788;1232.3037483821613;1238.8823061809114;19266.422007339803;19356;19382.4185274442;19439.416817495498;19652.11565479528;60575.69712151411;60772.39227607667;61151.69424152851;61506.38493615186;61680.69159654173;77139.61430192813;77623.61188194023;77715.61142194252;77991;78461.21538784767;15489.690206195588;15615.765763513784;15854.524364269091;15864.92067539655;15868.889177757446;23778.881105595054;23803.880980594986;23924.88037559801;24156.154534591205;24195.75804241935;19345.61308773845;19457;19486.220551177794;19651.70522442193;19747.703784442958;17241.65516689634;17461.38885139014;17550.73673894867;17669.91165044218;17877.910610446863;20095.19619215215;20176.39470815878;20482.487937801674;20529.48676283105;20532;15582.532524024298;15602.765958510405;15641.608959775642;15646.374145034071;15674.764878526603;19405.8059419404;19515.60968780645;19546.804531954498;19725.70411443858;19735.802641973398 18:14:19 INFO - PID 28238 | |3;mootools.html;1387.2578170678685;1444.321169050546;1449.7680371140616;1459.2922432620185;1459.6132025013367;16398.754018689713;17807.82192178078;17821.198046087924;17823.732644010335;17836.821631783678;17537.91231043843;17819.821801781978;17833.197506112225;17844.197011134496;17879.463616091507;2756.3935934094466;2797.496450638884;2851.957220641692;2852.1443566929943;2857.514222582166;2805.607214989893;2814.929626759337;2840.772738180951;2842.3462603601183;2846.3311121886445;2774.6531683539556;2786.916392508218;2801.1876555798794;2804.298925268683;2811.718828117182;2668.319578507468;2675.357914100621;2689.22012616342;2697.2178068360154;2700.351915540266;2692.044324264897;2699.892004319825;2701.6217729517884;2702.067786613615;2702.6486556747695;16210.108444035573;16417.67164656712;16419.343226270936;16511.669766604722;16580.253888575044;8406.789830254293;8640.697575584825;8674.653013879437;8686.39195256326;8693.391462597621;5186.066508028591;5408.4591540845995;5502.422245664187;5523.061079616435;5539.14143307788;1993.6212119697211;2033.9389818305474;2037.6841589553494;2061.5876824635134;2095;29256.41487170266;29388.559171612444;29550.556741648892;29730.554041689607;29748.55377169344;6843.349881761224;7031.261717519586;7055;7207.639618019078;7215.206327303992;19493.51266218356;19612.215511379385;19659.901700491406;19667.311644092388;19678;7647.197044310378;8593.140685931357;8895.110488951053;8907.643694252287;8918.420302680304;6732.360425759545;6783.152105986752;6873.725050998004;7617.542947423172;7644.541327520366;5616.269884914935;5708.914366284509;5770.913436298459;5823.417658234227;5841.32824725162;1691.9238634261487;1693.3819156008215;1705.224123024021;1711.3582406597525;1720.2430930390587;951.1059603972244;966.0918736387773;982.6609819612222;983.2183414185739;983.6311383231289;8330;8365.665373385118;8421.957890210631;8561.315094792402;8656.826863462695;768.6041688530412;802.4022103532789;804.6419343392251;805.20284917932;808.4421748993176;4947.1837146871085;4985.551300382983;5046.990601879639;5632.352279487829;5879.088741245114;23977.640335394983;24356.147534836196;24507.877460612584;25043;25106;24123.396915077265;24202.63696044561;24295.27114186577;24572.754272457045;24606.876965615058;12577.811332830015;12836.101472896995;12861.228326300265;12898.290594017231;12986.545470908663;8998;9628.229741620513;9662.951685241529;9667.806643866943;9672.516374181403;20903.477413064797;21080.78919210788;21232;21261.46846328854;21599.892000539898;21995;22112.557748845255;22242.777572224717;22301.442463938532;22575.77424225737;12466.937665311616;12484.188527745668;12575.748485030432;12675.683107922376;12694;15103;15353.462628807938;15408.229588520753;15414.922925385301;15422.537323880302;12585.119041666996;12633.305168215837;12656.620301390973;12762.68093297675;12929;12308.26150430977;12478.5008599655;12659.303738294113;12714;12747.426365813746;10415.218858585486;10541.051305382553;10549.9472502637;10562.524686388977;10569.207309451667;8344.541050242295;8443.620037098468;8446.396907935487;8453.196946290092;8475.491470511543;8541.487510749375;8622.78443038929;8664.306855451674;8673.262772664395;8723.302135829246 18:14:19 INFO - PID 28238 | |4;prototype.html;564.3030856891738;579.5421616922631;580.9186713860059;587.6474115530682;606.7239406070238;6180.814575562729;6278.215223097113;6293.7272618238485;6311.084892690557;6342.58773179743;6191.907121393183;6228.346023667517;6252.499800015999;6261;6265.71804268809;5099.15863882459;5119.641625086246;5126.154184559543;5137.434882162959;5138.3577052868395;5059.620528460362;5205.063088644042;5224.1119009768245;5260.579643496254;5270.736463176845;5202.791888324481;5215.1655735082395;5218.556422704075;5231.424543300234;5233.450487698794;5172.301739265226;5196.428392876781;5208.791648334062;5213.582913366921;5232.8691782705355;4915.90168196634;4944.851654450372;4966.354373931402;4969.900601987976;4982.725950072744;6235.906461403038;6236.126942228092;6288.748450061992;6293.590916590453;6359;6164.8767024659255;6165.136880836686;6178.7219575119225;6226.283977342573;6238.968805155991;6706.765263215764;6710.382950649251;6757.452337522791;6793.694283757242;6818.352256535622;5258.1849813279005;5541.9168712468945;5558;5572.359178694462;5577.944220557783;6736.393724564813;6914.308569143096;6929.272426395206;6960.651967401711;6972.546784459045;5661.886762264731;5677.17680936262;5723.313202415737;5760.3951585083805;5768.394318596571;5755.050416681201;5789.305283366023;5798.739056742373;5806.82579522615;5850.327212370632;6145.539084568675;6184.443400094013;6225.750969961241;6225.782097626561;6229.4393504584805;6712.295209003082;6750.459963202932;6773.559718618274;6785.219699734594;6786.728530858809;2002.1590931808676;2011.6923999400506;2013.9899300503696;2017.1023894366865;2018.3440381875948;1438.7769895666188;1520.9391624335124;1540.3376548084432;1554.1374537131774;1557.696249231389;6212.9378706213265;6218.378162183836;6237.126802247689;6266.373362663789;6273.1844860167885;6702.463802895757;6800.5718799051765;6800.6599670017295;6822.658867056627;6838.418734407631;6258.812235632939;6289.8742025159245;6292.339304373067;6299.748010079637;6309.14826498426;3572.7141828653644;3591.856325746993;3593;3606.3688854450365;3621.239539696693;7082.575045497287;7086.858262834715;7112.6443677815905;7138.571685698875;7145.178304494945;6994.825129371807;7003.92996070043;7009.509334346649;7011.649417529103;7013.754518591825;7012.368886800111;7073.5755854649915;7095.609741464269;7124.3944264738075;7146.142462904485;6704.161979752531;6742.898856517254;6779.864402712017;6798;6855.245922948571;6488.870222595616;6624.171978502687;6714.227863795726;6748.763793267212;6801;6903.861922761617;6925.437588092438;6941.0629565010095;6995.565908988747;7091.432685385053;5616.69108199053;5670.773169073356;5693.886122277614;5744.540436765133;5750.25246717924;6268.623882567061;6609.537332386879;6663.500237482305;6698.799036028927;6742.393184613212;6349.396807303298;6490.578112422678;6499.025146228104;6520.380563846427;6558;6486.870262594816;6491.642959637265;6541.934580654323;6573.244076931214;6624.436922861611;6231.750729970931;6311.558190926591;6355.841103972252;6369.172007638977;6385.393387628168;6454.225492940877;6497.772577959938;6521.608703477807;6577.572457790228;6597.5381723280825;6340.397662222082;6370.299267080525;6377;6480.53739578957;6493.772717954849 18:14:19 INFO - PID 28238 | |5;yui.html;952.4428209497444;982.5431174503857;988.4267125067457;988.7280997725625;1011.1304278320642;19522.804771952276;19690;19870.503237419052;19904.20383184671;19904.800951990477;19538.609227815436;19547.706784398244;19655.5086122847;20269.695954560695;20446.38660840177;1034.6275340877296;1050.4117694091294;1056.587930707021;1057.2968975631195;1057.8148823955814;1047.1884289675486;1068.0601071057458;1078.811208038594;1079.4872435593109;1082.199172612265;1112.816385296425;1120.590984290736;1121.8149005414098;1121.9270747401392;1124.499597679033;1082.0910435234362;1108.69510884507;1120.0703416164604;1124.775044991005;1126.7239526316105;796.8924195233627;799.8920145780303;800.1958032177624;806.6007326373424;807.1363640904235;18973.146208420654;19042.61914761697;19127.617447651108;19183;19196.80803191964;23038.193663221875;23262.30213093593;23773.762262377502;23804.166854160023;23840.761592384028;18420.447386578424;18568.721469177974;18604.16281267346;18631.068446577618;18651.25394984199;3958.524977002778;3982.900427489336;3985.561588225293;3988.162485877969;3992.161646054332;156399;157002;157705;159415;160740;15513.146776927151;15558.766618500506;15802;15955.122468264357;16336.836631633769;27537.724622753514;27593.58609620857;27594.862025690145;27821.582676259874;27848.303792405353;9174.86237706435;9192.21866141372;9241.537923103819;9308.255339572817;9368.531573421302;4782.0914026334885;4938.481459446778;4949.183384741549;4957.677750946177;4959.454460009396;6260.373962603794;6286.277078135981;6293.433590976834;6387.169667943138;6415.486761059104;1069.417167643636;1078.2398409121552;1089.2701889733896;1092.355510248957;1097.9341239525654;671.214678825775;735.9374453171433;737.4911311195258;749.7863109013905;766.1113108793772;12654.671259517618;12884.226946383247;14045.367958441895;14101.746272226907;14383.856161438252;733.8385555177853;734.3354264390734;738.2174894611621;744.8510297940434;747.1855677311647;6252.499800015988;6254.593451425642;6357.872842543124;6380.7128679209545;6518.967405162944;139068.30465847606;140527;142346;144722;148725;127707;128474;128720.35639821741;129283.35358323336;133392.33303833613;114081;115670;116681.9999999983;116942.41528792301;119598.4020079894;12069.698257543281;12087.093467990111;12143.574974875837;12199.390030498616;12352.876471235531;53866.46133538614;54672;54801;55155.72422137864;55824.72087639536;69339;69485;70455;70533.64733176302;71186.28813712003;16560.420385286456;16740.41408550695;16842;16944.068076255924;17037.403690871255;19906.70139947931;20201.191952321744;20354.491137721674;20387.18451261933;20420.285290015374;17199.484015479557;17357.30570777155;17458.388956386465;17462;17611.911940440215;17663.82336176622;17838.91080544589;17854.642907142043;17929.103544822447;18089;17352.47942561725;17637.559061023578;17739.11304434799;17769;18029.90985045119;13643.590692279247;13968.092074015563;14048.508302209373;14096.577102686935;14260.429582816987;13866.514671986431;13914.443422262995;13917.304134793423;13922.930385348009;14119.576412707635 18:14:19 INFO - PID 28238 | __end_tp_report 18:14:19 INFO - PID 28238 | __start_cc_report 18:14:19 INFO - PID 28238 | _x_x_mozilla_cycle_collect,285 18:14:19 INFO - PID 28238 | __end_cc_report 18:14:19 INFO - PID 28238 | __startTimestamp1506388459487__endTimestamp 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | ------- Summary: start ------- 18:14:19 INFO - PID 28238 | Number of tests: 6 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#0] dojo.html Cycles:165 Average:6388.24 Median:6614.37 stddev:767.93 (11.6%) stddev-sans-first:744.80 18:14:19 INFO - PID 28238 | Values: 3887.5 3898.6 3898.9 3933.3 3946.4 6231.3 6297.8 6334.1 6340.6 6431.0 6373.9 6374.6 6389.2 6390.4 6414.0 5655.0 5698.6 5703.1 5720.9 5722.4 5745.6 5807.3 5815.9 5834.2 5837.6 5768.7 5777.2 5830.0 5865.0 5874.1 5574.2 5607.5 5670.6 5738.6 5873.1 5626.0 5694.5 5697.1 5739.2 5770.1 6325.4 6347.9 6375.1 6375.9 6401.6 6872.7 6881.8 6928.7 6952.5 6957.0 7009.1 7039.3 7042.7 7044.8 7054.8 6427.3 6449.9 6514.8 6530.2 6534.7 7106.1 7122.1 7184.0 7187.2 7197.2 6751.0 6817.2 6828.1 6830.2 6855.2 6807.1 6910.7 6915.4 7013.6 7026.6 6957.9 6969.7 6979.3 6998.7 7024.5 6864.4 6889.0 6906.0 6995.5 7009.5 5030.5 5047.9 5053.0 5107.3 5133.4 4569.9 4594.8 4652.3 4656.5 4663.9 6306.2 6389.5 6475.8 6478.4 6504.2 6893.3 6911.7 6912.4 6967.0 6992.4 6329.7 6335.9 6371.6 6388.4 6445.1 5595.9 5610.4 5621.4 5624.1 5624.1 7177.0 7215.2 7219.2 7224.9 7331.7 6855.8 6923.2 6981.9 6992.3 7023.3 7236.0 7280.7 7282.2 7285.0 7290.3 6839.9 6844.9 6847.0 6925.1 6947.4 6858.7 6902.6 6957.8 6977.5 6999.6 6680.8 6745.4 6775.0 6776.3 6780.4 6693.5 6703.9 6778.2 6786.7 6791.0 6434.1 6496.5 6600.8 6611.8 6614.4 6703.7 6756.5 6851.4 6858.0 6876.1 6566.8 6567.1 6569.9 6659.8 6673.6 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#1] ext.html Cycles:180 Average:42660.60 Median:34907.65 stddev:64397.08 (184.5%) stddev-sans-first:64501.55 18:14:19 INFO - PID 28238 | Values: 942.5 946.4 975.8 1001.2 1003.7 42794.0 43323.8 43383.3 43466.1 43531.0 40597.2 40681.4 40858.0 40883.0 41056.4 7739.0 7790.5 7879.7 7883.3 7884.0 7416.7 7450.9 7462.8 7475.3 7480.5 7470.6 8353.3 8523.4 8549.4 8554.5 8406.5 8433.9 8460.9 8490.2 8496.8 8219.4 8237.3 8360.7 8405.7 8413.3 39951.2 40337.2 40357.2 40532.2 40622.8 3739.6 3761.0 3794.6 3796.3 3802.4 32750.7 32983.5 33141.8 33146.7 33327.0 5437.8 5466.1 5475.3 5477.1 5479.5 230825.0 231223.0 231504.0 231641.0 232135.0 53100.7 53164.5 53200.0 53268.0 53283.0 55270.4 55560.2 55666.7 55667.0 55670.2 16914.5 17059.9 17070.4 17072.2 17092.6 14001.8 14010.2 14109.3 14119.1 14119.6 15027.8 15085.5 15192.8 15315.5 15322.0 6249.8 6258.5 6277.0 6295.6 6341.1 1098.8 1106.9 1122.6 1126.6 1131.5 26124.7 26132.6 26165.5 26189.7 26481.9 1210.3 1216.9 1236.2 1240.3 1243.7 13587.4 13647.2 13717.2 14040.4 14137.6 272284.0 273783.0 273919.0 274283.0 274345.0 57574.0 57664.0 61063.4 61448.4 61496.0 1521.0 1527.7 1536.4 1550.1 1561.4 30316.4 30481.2 30549.8 30686.5 30814.2 42266.8 42504.6 42555.0 42613.6 42672.4 234113.0 236219.0 237102.0 237548.0 237637.0 34625.8 34636.5 34671.3 34793.7 35021.6 44511.0 45895.3 46290.1 46298.8 46314.5 33572.3 33841.0 34093.0 34430.5 34506.3 33505.3 33773.7 33806.0 33818.8 34572.0 39614.8 40066.0 40244.0 40361.8 40450.6 33328.2 33687.5 33786.5 33854.8 33904.7 24746.6 24831.6 25384.2 25533.0 25766.9 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#2] jquery.html Cycles:180 Average:39408.56 Median:22604.77 stddev:101081.98 (447.2%) stddev-sans-first:101323.58 18:14:19 INFO - PID 28238 | Values: 619.5 625.1 631.1 632.3 651.4 21457.7 21818.3 22567.7 22584.1 22625.4 24379.5 25558.2 25585.6 25586.5 25593.4 6644.7 6795.9 6808.5 6818.3 6822.1 6303.7 6544.2 6548.3 6552.2 6569.2 6514.3 6517.3 6517.6 6519.8 6521.6 6365.8 6499.1 6499.6 6506.8 6639.1 6207.4 6212.8 6218.1 6229.2 6235.1 29464.4 29969.1 29973.4 30078.0 30094.0 2308.1 2320.6 2331.8 2346.4 2346.8 19804.0 20429.9 20680.5 20807.3 20886.6 2575.1 2576.1 2625.2 2646.9 2660.3 138743.0 142703.3 145860.3 149054.0 151593.0 15740.8 16705.2 16781.6 16867.4 16971.1 25781.2 26003.0 26016.7 26035.3 26095.0 10508.5 10639.5 10876.0 10915.6 10963.8 9872.5 9916.6 9935.8 9940.8 10021.8 9394.1 9855.4 9901.6 9962.3 10048.5 2763.6 2768.0 2770.7 2792.3 2842.3 1026.7 1041.5 1054.7 1057.6 1076.0 21272.9 21642.9 21658.4 21740.8 21877.3 1112.5 1122.4 1124.8 1130.3 1137.1 11881.6 11962.8 12034.9 12070.5 12131.8 584923.0 600005.0 607825.0 608468.0 626517.0 125705.4 126483.0 127583.0 129383.0 129659.0 1186.8 1203.9 1227.9 1232.3 1238.9 19266.4 19356.0 19382.4 19439.4 19652.1 60575.7 60772.4 61151.7 61506.4 61680.7 77139.6 77623.6 77715.6 77991.0 78461.2 15489.7 15615.8 15854.5 15864.9 15868.9 23778.9 23803.9 23924.9 24156.2 24195.8 19345.6 19457.0 19486.2 19651.7 19747.7 17241.7 17461.4 17550.7 17669.9 17877.9 20095.2 20176.4 20482.5 20529.5 20532.0 15582.5 15602.8 15641.6 15646.4 15674.8 19405.8 19515.6 19546.8 19725.7 19735.8 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#3] mootools.html Cycles:180 Average:10379.45 Median:2700.12 stddev:7665.34 (283.9%) stddev-sans-first:7657.07 18:14:19 INFO - PID 28238 | Values: 1387.3 1444.3 1449.8 1459.3 1459.6 16398.8 17807.8 17821.2 17823.7 17836.8 17537.9 17819.8 17833.2 17844.2 17879.5 2756.4 2797.5 2852.0 2852.1 2857.5 2805.6 2814.9 2840.8 2842.3 2846.3 2774.7 2786.9 2801.2 2804.3 2811.7 2668.3 2675.4 2689.2 2697.2 2700.4 2692.0 2699.9 2701.6 2702.1 2702.6 16210.1 16417.7 16419.3 16511.7 16580.3 8406.8 8640.7 8674.7 8686.4 8693.4 5186.1 5408.5 5502.4 5523.1 5539.1 1993.6 2033.9 2037.7 2061.6 2095.0 29256.4 29388.6 29550.6 29730.6 29748.6 6843.3 7031.3 7055.0 7207.6 7215.2 19493.5 19612.2 19659.9 19667.3 19678.0 7647.2 8593.1 8895.1 8907.6 8918.4 6732.4 6783.2 6873.7 7617.5 7644.5 5616.3 5708.9 5770.9 5823.4 5841.3 1691.9 1693.4 1705.2 1711.4 1720.2 951.1 966.1 982.7 983.2 983.6 8330.0 8365.7 8422.0 8561.3 8656.8 768.6 802.4 804.6 805.2 808.4 4947.2 4985.6 5047.0 5632.4 5879.1 23977.6 24356.1 24507.9 25043.0 25106.0 24123.4 24202.6 24295.3 24572.8 24606.9 12577.8 12836.1 12861.2 12898.3 12986.5 8998.0 9628.2 9663.0 9667.8 9672.5 20903.5 21080.8 21232.0 21261.5 21599.9 21995.0 22112.6 22242.8 22301.4 22575.8 12466.9 12484.2 12575.7 12675.7 12694.0 15103.0 15353.5 15408.2 15414.9 15422.5 12585.1 12633.3 12656.6 12762.7 12929.0 12308.3 12478.5 12659.3 12714.0 12747.4 10415.2 10541.1 10549.9 10562.5 10569.2 8344.5 8443.6 8446.4 8453.2 8475.5 8541.5 8622.8 8664.3 8673.3 8723.3 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#4] prototype.html Cycles:180 Average:5767.14 Median:6275.70 stddev:1525.75 (24.3%) stddev-sans-first:1479.22 18:14:19 INFO - PID 28238 | Values: 564.3 579.5 580.9 587.6 606.7 6180.8 6278.2 6293.7 6311.1 6342.6 6191.9 6228.3 6252.5 6261.0 6265.7 5099.2 5119.6 5126.2 5137.4 5138.4 5059.6 5205.1 5224.1 5260.6 5270.7 5202.8 5215.2 5218.6 5231.4 5233.5 5172.3 5196.4 5208.8 5213.6 5232.9 4915.9 4944.9 4966.4 4969.9 4982.7 6235.9 6236.1 6288.7 6293.6 6359.0 6164.9 6165.1 6178.7 6226.3 6239.0 6706.8 6710.4 6757.5 6793.7 6818.4 5258.2 5541.9 5558.0 5572.4 5577.9 6736.4 6914.3 6929.3 6960.7 6972.5 5661.9 5677.2 5723.3 5760.4 5768.4 5755.1 5789.3 5798.7 5806.8 5850.3 6145.5 6184.4 6225.8 6225.8 6229.4 6712.3 6750.5 6773.6 6785.2 6786.7 2002.2 2011.7 2014.0 2017.1 2018.3 1438.8 1520.9 1540.3 1554.1 1557.7 6212.9 6218.4 6237.1 6266.4 6273.2 6702.5 6800.6 6800.7 6822.7 6838.4 6258.8 6289.9 6292.3 6299.7 6309.1 3572.7 3591.9 3593.0 3606.4 3621.2 7082.6 7086.9 7112.6 7138.6 7145.2 6994.8 7003.9 7009.5 7011.6 7013.8 7012.4 7073.6 7095.6 7124.4 7146.1 6704.2 6742.9 6779.9 6798.0 6855.2 6488.9 6624.2 6714.2 6748.8 6801.0 6903.9 6925.4 6941.1 6995.6 7091.4 5616.7 5670.8 5693.9 5744.5 5750.3 6268.6 6609.5 6663.5 6698.8 6742.4 6349.4 6490.6 6499.0 6520.4 6558.0 6486.9 6491.6 6541.9 6573.2 6624.4 6231.8 6311.6 6355.8 6369.2 6385.4 6454.2 6497.8 6521.6 6577.6 6597.5 6340.4 6370.3 6377.0 6480.5 6493.8 18:14:19 INFO - PID 28238 | 18:14:19 INFO - PID 28238 | [#5] yui.html Cycles:180 Average:27785.00 Median:18254.72 stddev:41511.05 (227.4%) stddev-sans-first:41578.60 18:14:19 INFO - PID 28238 | Values: 952.4 982.5 988.4 988.7 1011.1 19522.8 19690.0 19870.5 19904.2 19904.8 19538.6 19547.7 19655.5 20269.7 20446.4 1034.6 1050.4 1056.6 1057.3 1057.8 1047.2 1068.1 1078.8 1079.5 1082.2 1112.8 1120.6 1121.8 1121.9 1124.5 1082.1 1108.7 1120.1 1124.8 1126.7 796.9 799.9 800.2 806.6 807.1 18973.1 19042.6 19127.6 19183.0 19196.8 23038.2 23262.3 23773.8 23804.2 23840.8 18420.4 18568.7 18604.2 18631.1 18651.3 3958.5 3982.9 3985.6 3988.2 3992.2 156399.0 157002.0 157705.0 159415.0 160740.0 15513.1 15558.8 15802.0 15955.1 16336.8 27537.7 27593.6 27594.9 27821.6 27848.3 9174.9 9192.2 9241.5 9308.3 9368.5 4782.1 4938.5 4949.2 4957.7 4959.5 6260.4 6286.3 6293.4 6387.2 6415.5 1069.4 1078.2 1089.3 1092.4 1097.9 671.2 735.9 737.5 749.8 766.1 12654.7 12884.2 14045.4 14101.7 14383.9 733.8 734.3 738.2 744.9 747.2 6252.5 6254.6 6357.9 6380.7 6519.0 139068.3 140527.0 142346.0 144722.0 148725.0 127707.0 128474.0 128720.4 129283.4 133392.3 114081.0 115670.0 116682.0 116942.4 119598.4 12069.7 12087.1 12143.6 12199.4 12352.9 53866.5 54672.0 54801.0 55155.7 55824.7 69339.0 69485.0 70455.0 70533.6 71186.3 16560.4 16740.4 16842.0 16944.1 17037.4 19906.7 20201.2 20354.5 20387.2 20420.3 17199.5 17357.3 17458.4 17462.0 17611.9 17663.8 17838.9 17854.6 17929.1 18089.0 17352.5 17637.6 17739.1 17769.0 18029.9 13643.6 13968.1 14048.5 14096.6 14260.4 13866.5 13914.4 13917.3 13922.9 14119.6 18:14:19 INFO - PID 28238 | -------- Summary: end -------- 18:14:19 INFO - PID 28238 | 18:14:20 INFO - TEST-INFO | 28238: exit 0 18:14:20 INFO - TEST-OK | dromaeo_css | took 1107673ms 18:14:20 INFO - TEST-START | kraken 18:14:20 INFO - Initialising browser for kraken test... 18:14:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45054/getInfo.html -profile /tmp/tmpx8vSPj/profile 18:14:20 INFO - TEST-INFO | started process 28604 (/builds/slave/test/build/application/firefox/firefox http://localhost:45054/getInfo.html) 18:14:25 INFO - TEST-INFO | 28604: exit 0 18:14:25 INFO - Browser initialized. 18:14:25 INFO - Running cycle 1/1 for kraken test... 18:14:25 INFO - Using env: {'DISPLAY': ':0', 18:14:25 INFO - 'HOME': '/home/cltbld', 18:14:25 INFO - 'JSGC_DISABLE_POISONING': '1', 18:14:25 INFO - 'LANG': 'en_US.UTF-8', 18:14:25 INFO - 'LANGUAGE': 'en_US:en', 18:14:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:14:25 INFO - 'LOGNAME': 'cltbld', 18:14:25 INFO - 'MAIL': '/var/mail/cltbld', 18:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:14:25 INFO - 'MOZ_CRASHREPORTER': '1', 18:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:14:25 INFO - 'MOZ_NO_REMOTE': '1', 18:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:14:25 INFO - 'NO_EM_RESTART': '1', 18:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:25 INFO - 'PWD': '/builds/slave/test', 18:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:25 INFO - 'RUST_BACKTRACE': 'full', 18:14:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:14:25 INFO - 'SHELL': '/bin/bash', 18:14:25 INFO - 'SHLVL': '1', 18:14:25 INFO - 'STYLO_FORCE_DISABLED': '1', 18:14:25 INFO - 'TERM': 'linux', 18:14:25 INFO - 'TMOUT': '86400', 18:14:25 INFO - 'USER': 'cltbld', 18:14:25 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944', 18:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:25 INFO - '_': '/tools/buildbot/bin/python'} 18:14:25 INFO - TEST-INFO | started process 28845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8vSPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:26 INFO - PID 28845 | 18:14:26 INFO - PID 28845 | (/builds/slave/test/build/application/firefox/firefox:28894): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:14:26 INFO - PID 28845 | 18:14:36 INFO - PID 28845 | RSS: Main: 144711680 18:14:36 INFO - PID 28845 | 18:14:39 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45054/tests/kraken/driver.html?testName=audio-beat-detection) 18:14:40 INFO - PID 28845 | RSS: Main: 151248896 18:14:40 INFO - PID 28845 | 18:14:42 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45054/tests/kraken/driver.html?testName=audio-dft) 18:14:43 INFO - PID 28845 | RSS: Main: 151859200 18:14:43 INFO - PID 28845 | 18:14:46 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45054/tests/kraken/driver.html?testName=audio-fft) 18:14:46 INFO - PID 28845 | RSS: Main: 147632128 18:14:46 INFO - PID 28845 | 18:14:48 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45054/tests/kraken/driver.html?testName=audio-oscillator) 18:14:49 INFO - PID 28845 | RSS: Main: 148520960 18:14:49 INFO - PID 28845 | 18:14:51 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45054/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:14:52 INFO - PID 28845 | RSS: Main: 148865024 18:14:52 INFO - PID 28845 | 18:14:55 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45054/tests/kraken/driver.html?testName=imaging-darkroom) 18:14:55 INFO - PID 28845 | RSS: Main: 148824064 18:14:55 INFO - PID 28845 | 18:14:59 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45054/tests/kraken/driver.html?testName=imaging-desaturate) 18:15:00 INFO - PID 28845 | RSS: Main: 149671936 18:15:00 INFO - PID 28845 | 18:15:03 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45054/tests/kraken/driver.html?testName=json-parse-financial) 18:15:03 INFO - PID 28845 | RSS: Main: 150925312 18:15:03 INFO - PID 28845 | 18:15:05 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45054/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:15:05 INFO - PID 28845 | RSS: Main: 151240704 18:15:05 INFO - PID 28845 | 18:15:07 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:15:07 INFO - PID 28845 | RSS: Main: 151384064 18:15:07 INFO - PID 28845 | 18:15:09 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:15:10 INFO - PID 28845 | RSS: Main: 148209664 18:15:10 INFO - PID 28845 | 18:15:12 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:15:13 INFO - PID 28845 | RSS: Main: 148074496 18:15:13 INFO - PID 28845 | 18:15:16 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:15:16 INFO - PID 28845 | RSS: Main: 148443136 18:15:16 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | Cycle 1(1): loaded http://localhost:45054/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45054/tests/kraken/driver.html?testName=ai-astar) 18:15:18 INFO - PID 28845 | RSS: Main: 149790720 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | __start_tp_report 18:15:18 INFO - PID 28845 | _x_x_mozilla_page_load 18:15:18 INFO - PID 28845 | _x_x_mozilla_page_load_details 18:15:18 INFO - PID 28845 | |i|pagename|runs| 18:15:18 INFO - PID 28845 | |0;ai-astar;108;105;106;106;106;117;108;106;108;105 18:15:18 INFO - PID 28845 | |1;audio-beat-detection;118;114;112;112;111;145;116;112;114;114 18:15:18 INFO - PID 28845 | |2;audio-dft;164;164;165;165;163;164;162;163;168;167 18:15:18 INFO - PID 28845 | |3;audio-fft;74;72;73;75;73;74;77;74;73;73 18:15:18 INFO - PID 28845 | |4;audio-oscillator;80;80;79;77;77;79;78;77;78;79 18:15:18 INFO - PID 28845 | |5;imaging-gaussian-blur;110;113;114;117;114;114;114;114;117;114 18:15:18 INFO - PID 28845 | |6;imaging-darkroom;155;150;149;150;149;150;149;150;150;151 18:15:18 INFO - PID 28845 | |7;imaging-desaturate;94;95;94;94;94;95;95;94;94;94 18:15:18 INFO - PID 28845 | |8;json-parse-financial;45;45;45;48;47;45;45;44;44;45 18:15:18 INFO - PID 28845 | |9;json-stringify-tinderbox;39;40;38;39;39;38;42;40;40;39 18:15:18 INFO - PID 28845 | |10;stanford-crypto-aes;73;72;73;70;76;70;73;70;74;73 18:15:18 INFO - PID 28845 | |11;stanford-crypto-ccm;104;103;101;107;108;108;104;116;115;116 18:15:18 INFO - PID 28845 | |12;stanford-crypto-pbkdf2;160;151;149;149;156;157;153;151;156;152 18:15:18 INFO - PID 28845 | |13;stanford-crypto-sha256-iterative;61;59;58;60;60;59;60;59;60;58 18:15:18 INFO - PID 28845 | __end_tp_report 18:15:18 INFO - PID 28845 | __start_cc_report 18:15:18 INFO - PID 28845 | _x_x_mozilla_cycle_collect,662 18:15:18 INFO - PID 28845 | __end_cc_report 18:15:18 INFO - PID 28845 | __startTimestamp1506388518801__endTimestamp 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | ------- Summary: start ------- 18:15:18 INFO - PID 28845 | Number of tests: 14 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#0] ai-astar Cycles:10 Average:107.50 Median:107.00 stddev:3.54 (3.3%) stddev-sans-first:3.75 18:15:18 INFO - PID 28845 | Values: 108.0 105.0 106.0 106.0 106.0 117.0 108.0 106.0 108.0 105.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:114.00 stddev:10.13 (8.9%) stddev-sans-first:10.74 18:15:18 INFO - PID 28845 | Values: 118.0 114.0 112.0 112.0 111.0 145.0 116.0 112.0 114.0 114.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 18:15:18 INFO - PID 28845 | Values: 164.0 164.0 165.0 165.0 163.0 164.0 162.0 163.0 168.0 167.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 18:15:18 INFO - PID 28845 | Values: 74.0 72.0 73.0 75.0 73.0 74.0 77.0 74.0 73.0 73.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.00 stddev:1.17 (1.5%) stddev-sans-first:1.09 18:15:18 INFO - PID 28845 | Values: 80.0 80.0 79.0 77.0 77.0 79.0 78.0 77.0 78.0 79.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.97 (1.7%) stddev-sans-first:1.42 18:15:18 INFO - PID 28845 | Values: 110.0 113.0 114.0 117.0 114.0 114.0 114.0 114.0 117.0 114.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.77 (1.2%) stddev-sans-first:0.67 18:15:18 INFO - PID 28845 | Values: 155.0 150.0 149.0 150.0 149.0 150.0 149.0 150.0 150.0 151.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:15:18 INFO - PID 28845 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:45.00 stddev:1.25 (2.8%) stddev-sans-first:1.32 18:15:18 INFO - PID 28845 | Values: 45.0 45.0 45.0 48.0 47.0 45.0 45.0 44.0 44.0 45.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.50 stddev:1.17 (3.0%) stddev-sans-first:1.24 18:15:18 INFO - PID 28845 | Values: 39.0 40.0 38.0 39.0 39.0 38.0 42.0 40.0 40.0 39.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:1.96 (2.7%) stddev-sans-first:2.06 18:15:18 INFO - PID 28845 | Values: 73.0 72.0 73.0 70.0 76.0 70.0 73.0 70.0 74.0 73.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#11] stanford-crypto-ccm Cycles:10 Average:108.20 Median:108.00 stddev:5.61 (5.2%) stddev-sans-first:5.74 18:15:18 INFO - PID 28845 | Values: 104.0 103.0 101.0 107.0 108.0 108.0 104.0 116.0 115.0 116.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:3.69 (2.4%) stddev-sans-first:3.04 18:15:18 INFO - PID 28845 | Values: 160.0 151.0 149.0 149.0 156.0 157.0 153.0 151.0 156.0 152.0 18:15:18 INFO - PID 28845 | 18:15:18 INFO - PID 28845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:0.83 18:15:18 INFO - PID 28845 | Values: 61.0 59.0 58.0 60.0 60.0 59.0 60.0 59.0 60.0 58.0 18:15:18 INFO - PID 28845 | -------- Summary: end -------- 18:15:18 INFO - PID 28845 | 18:15:19 INFO - PID 28845 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:15:19 INFO - TEST-INFO | 28845: exit 0 18:15:19 INFO - TEST-OK | kraken | took 59289ms 18:15:19 INFO - SUITE-END | took 1166s 18:15:19 INFO - Completed test suite (00:19:27) 18:15:19 INFO - javascript benchmark 18:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9113.842469454645, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3887.475190849238, 3898.6491215790593, 3898.8830335089942, 3933.311670457671, 3946.388309811979, 6231.252249730027, 6297.811065668037, 6334.113224148623, 6340.619562826234, 6431.035344698297, 6373.872522549546, 6374.649394283312, 6389.233292004954, 6390.392912673288, 6414.037894315855, 5655.0386434306065, 5698.601097923126, 5703.08750599902, 5720.942790572103, 5722.399148089464, 5745.5690823188215, 5807.303123625171, 5815.941840581582, 5834.183214349994, 5837.649741015532, 5768.682722450264, 5777.1623114648355, 5830.008898487267, 5865.032269675498, 5874.148248503986, 5574.191742197399, 5607.467290607427, 5670.6030577859565, 5738.626989245728, 5873.0603103503445, 5625.971870140664, 5694.5159661428825, 5697.145428185764, 5739.225204597367, 5770.13447982806, 6325.367463253638, 6347.904781428282, 6375.10748495211, 6375.93624063758, 6401.647909364983, 6872.656367181621, 6881.793546193622, 6928.653567321614, 6952.54808437455, 6956.965215173892, 7009.08881845362, 7039.331263530008, 7042.6830792614455, 7044.788656340267, 7054.788356349318, 6427.2929977702415, 6449.9355006449805, 6514.804555863332, 6530.151080359523, 6534.673266336664, 7106.111736032996, 7122.145342558926, 7184.030155928987, 7187.245339239409, 7197.244289349647, 6751.0, 6817.181938167451, 6828.112345395067, 6830.248672646005, 6855.245922948472, 6807.115075040312, 6910.654467276717, 6915.377616014583, 7013.649317534103, 7026.648667566601, 6957.860842783116, 6969.686364113627, 6979.3020697930815, 6998.720051197997, 7024.5082844200415, 6864.38220560142, 6889.0, 6906.0, 6995.510314277952, 7009.509334346547, 5030.4718004608985, 5047.899042019212, 5053.0206449444595, 5107.284980102789, 5133.435322114565, 4569.885752856205, 4594.793234304464, 4652.255639097796, 4656.4645065817185, 4663.906721865612, 6306.211723534559, 6389.520785941073, 6475.773347932894, 6478.4169424752, 6504.219493660697, 6893.345132212432, 6911.6889739961825, 6912.377885990285, 6967.024616553686, 6992.440604751608, 6329.651869147149, 6335.904961425582, 6371.649559274192, 6388.425041746265, 6445.129907462527, 5595.8601034973635, 5610.382857885629, 5621.409751975983, 5624.100143976944, 5624.128260119688, 7176.96411517939, 7215.242399548077, 7219.205887352387, 7224.855502890018, 7331.706731730671, 6855.760048398282, 6923.238443771081, 6981.930180698128, 6992.3357281058215, 7023.262557431498, 7236.023136876454, 7280.745173919099, 7282.162551306667, 7285.0, 7290.270972902667, 6839.89740153908, 6844.863102738017, 6847.041414201916, 6925.099737034153, 6947.444204463732, 6858.691358888962, 6902.551334163263, 6957.826054348682, 6977.476689248225, 6999.615021173884, 6680.799576012728, 6745.3591908768585, 6775.0, 6776.322367763184, 6780.423663988616, 6693.497987651043, 6703.932960670526, 6778.186617605918, 6786.660666966533, 6791.04925310447, 6434.099226108255, 6496.480281577368, 6600.768973085919, 6611.801645950629, 6614.371634694697, 6703.698333574904, 6756.459483241427, 6851.383375496229, 6858.0398744176855, 6876.106106206161, 6566.8358291043105, 6567.146270984741, 6569.868602627825, 6659.833504162435, 6673.599584024974], "value": 6335.390667990816, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.5240253671894, 946.3990366117513, 975.7755716185277, 1001.2440607341451, 1003.6888564544992, 42794.0, 43323.78338108305, 43383.34924976128, 43466.130677386434, 43531.0, 40597.188056238854, 40681.38977915334, 40858.0, 40883.0, 41056.38415423771, 7739.03262092237, 7790.45466817323, 7879.684812607489, 7883.2510911463605, 7884.0144981877265, 7416.666250018762, 7450.850982980337, 7462.813429664247, 7475.32722055015, 7480.476366654337, 7470.626468676572, 8353.289970352496, 8523.360747943898, 8549.444286121383, 8554.529500877481, 8406.537640429773, 8433.873491897626, 8460.8730869037, 8490.150984901522, 8496.83006339876, 8219.424640275183, 8237.341012718967, 8360.665573377119, 8405.70580029696, 8413.32693384534, 39951.20097598032, 40337.193256135004, 40357.192856143, 40532.189356213006, 40622.796886015676, 3739.6447337502896, 3761.0409345616695, 3794.582595914447, 3796.2597293527774, 3802.4106263529197, 32750.67249327524, 32983.50524742131, 33141.83429082839, 33146.6685333146, 33327.0, 5437.755301011464, 5466.098093814516, 5475.342958844964, 5477.123660214386, 5479.53423958964, 230825.0, 231223.0, 231504.0, 231641.0, 232135.0, 53100.73449632804, 53164.46835531595, 53200.0, 53268.0, 53283.0, 55270.44729552734, 55560.16659750107, 55666.721666392215, 55667.0, 55670.16494752582, 16914.492565223063, 17059.914700426667, 17070.40253591143, 17072.2317495713, 17092.572685682957, 14001.789973150411, 14010.159390436607, 14109.294535273195, 14119.082259653089, 14119.576412707635, 15027.774583381259, 15085.54743357701, 15192.848071519144, 15315.540533784004, 15322.00406973543, 6249.78125765596, 6258.466675664491, 6276.968615156895, 6295.5907865988565, 6341.080543321193, 1098.7857367813199, 1106.8561087058793, 1122.5790328626765, 1126.5887950898027, 1131.4569006876745, 26124.73875261261, 26132.608010879852, 26165.476690466083, 26189.73810261873, 26481.867590661925, 1210.2980271442543, 1216.9087318451152, 1236.1717649175075, 1240.3240234072452, 1243.6704273367566, 13587.388567514485, 13647.187764658876, 13717.245551494563, 14040.438382464792, 14137.575872723835, 272284.0, 273783.0, 273919.0, 274283.0, 274345.0, 57574.0, 57664.0, 61063.38936610666, 61448.38551614427, 61496.0, 1520.9847901521064, 1527.6639139389538, 1536.3854458216804, 1550.0622123615276, 1561.3832536148159, 30316.393672126876, 30481.23796905095, 30549.847250763603, 30686.539701904934, 30814.229644259074, 42266.788666056476, 42504.57495425006, 42555.0, 42613.57386426096, 42672.359914601926, 234113.0, 236219.0, 237102.0, 237548.0, 237637.0, 34625.82687086549, 34636.48045279373, 34671.30657386889, 34793.65206347904, 35021.64978350184, 44511.0, 45895.31157032714, 46290.074198516515, 46298.768506157256, 46314.53685463237, 33572.328553428306, 33841.0, 34093.0, 34430.48354274638, 34506.30987380188, 33505.329893402486, 33773.66226337705, 33806.0, 33818.830905845316, 34572.0, 39614.80192599134, 40066.0, 40244.0, 40361.79819100886, 40450.59549404586, 33328.1667958303, 33687.4946875802, 33786.49320260247, 33854.830725846216, 33904.66095339114, 24746.628800568367, 24831.62752558677, 25384.238472845846, 25533.0, 25766.87116564405], "value": 18705.89886151481, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.5043964828136, 625.0804877807168, 631.1447987976295, 632.285517365377, 651.4267444648707, 21457.67813482795, 21818.345449636516, 22567.661485077715, 22584.096636134556, 22625.434364140903, 24379.512409751795, 25558.233253002392, 25585.616215756778, 25586.488270234586, 25593.36016599581, 6644.734210631581, 6795.932040679604, 6808.489363297747, 6818.284080171585, 6822.079019332376, 6303.684815759217, 6544.181977252843, 6548.345165483437, 6552.246491653474, 6569.211694596631, 6514.348565143471, 6517.250516190651, 6517.576357536768, 6519.8044058678315, 6521.641309727963, 6365.777197798055, 6499.057636642684, 6499.642519661416, 6506.837329066764, 6639.136912201383, 6207.379262073801, 6212.813615591494, 6218.129461875341, 6229.221347331583, 6235.127082208494, 29464.41071178586, 29969.100926972227, 29973.400531989457, 30078.0, 30094.0, 2308.0883051194683, 2320.5706944215376, 2331.778481044298, 2346.4368551547677, 2346.753590872951, 19804.0, 20429.897850510803, 20680.482987925272, 20807.271745488986, 20886.5822683547, 2575.0987154495965, 2576.0983655720534, 2625.1599488163797, 2646.8941242350284, 2660.255128564005, 138743.0, 142703.28648356692, 145860.2706986469, 149054.0, 151593.0, 15740.763888541682, 16705.248263828158, 16781.58046048834, 16867.409640662518, 16971.06659133735, 25781.226563203134, 26003.0, 26016.739832601812, 26035.349116272246, 26095.0, 10508.474576271155, 10639.521221545048, 10876.0, 10915.56337746497, 10963.780724385468, 9872.45701486425, 9916.553755081039, 9935.80128397428, 9940.80118397628, 10021.849672254923, 9394.117237469061, 9855.35940163887, 9901.554430050664, 9962.306407910673, 10048.497575121215, 2763.571646394812, 2767.9861600691866, 2770.667519897625, 2792.3437992071845, 2842.2894276430893, 1026.7330494071596, 1041.5417216424748, 1054.7099547624464, 1057.5928267616869, 1076.0100707349256, 21272.872712728604, 21642.891785541287, 21658.35024949254, 21740.782592174193, 21877.343679689635, 1112.4870176559873, 1122.421952694363, 1124.7694222684493, 1130.327455164176, 1137.147139645266, 11881.643550693492, 11962.760744785055, 12034.870933557164, 12070.45682944252, 12131.757364852654, 584923.0, 600005.0, 607825.0, 608468.0, 626517.0, 125705.37147314205, 126483.0, 127583.0, 129383.0, 129659.0, 1186.833843261944, 1203.9291328040874, 1227.914046016788, 1232.3037483821613, 1238.8823061809114, 19266.422007339803, 19356.0, 19382.4185274442, 19439.416817495498, 19652.11565479528, 60575.69712151411, 60772.39227607667, 61151.69424152851, 61506.38493615186, 61680.69159654173, 77139.61430192813, 77623.61188194023, 77715.61142194252, 77991.0, 78461.21538784767, 15489.690206195588, 15615.765763513784, 15854.524364269091, 15864.92067539655, 15868.889177757446, 23778.881105595054, 23803.880980594986, 23924.88037559801, 24156.154534591205, 24195.75804241935, 19345.61308773845, 19457.0, 19486.220551177794, 19651.70522442193, 19747.703784442958, 17241.65516689634, 17461.38885139014, 17550.73673894867, 17669.91165044218, 17877.910610446863, 20095.19619215215, 20176.39470815878, 20482.487937801674, 20529.48676283105, 20532.0, 15582.532524024298, 15602.765958510405, 15641.608959775642, 15646.374145034071, 15674.764878526603, 19405.8059419404, 19515.60968780645, 19546.804531954498, 19725.70411443858, 19735.802641973398], "value": 12744.964678884548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.2578170678685, 1444.321169050546, 1449.7680371140616, 1459.2922432620185, 1459.6132025013367, 16398.754018689713, 17807.82192178078, 17821.198046087924, 17823.732644010335, 17836.821631783678, 17537.91231043843, 17819.821801781978, 17833.197506112225, 17844.197011134496, 17879.463616091507, 2756.3935934094466, 2797.496450638884, 2851.957220641692, 2852.1443566929943, 2857.514222582166, 2805.607214989893, 2814.929626759337, 2840.772738180951, 2842.3462603601183, 2846.3311121886445, 2774.6531683539556, 2786.916392508218, 2801.1876555798794, 2804.298925268683, 2811.718828117182, 2668.319578507468, 2675.357914100621, 2689.22012616342, 2697.2178068360154, 2700.351915540266, 2692.044324264897, 2699.892004319825, 2701.6217729517884, 2702.067786613615, 2702.6486556747695, 16210.108444035573, 16417.67164656712, 16419.343226270936, 16511.669766604722, 16580.253888575044, 8406.789830254293, 8640.697575584825, 8674.653013879437, 8686.39195256326, 8693.391462597621, 5186.066508028591, 5408.4591540845995, 5502.422245664187, 5523.061079616435, 5539.14143307788, 1993.6212119697211, 2033.9389818305474, 2037.6841589553494, 2061.5876824635134, 2095.0, 29256.41487170266, 29388.559171612444, 29550.556741648892, 29730.554041689607, 29748.55377169344, 6843.349881761224, 7031.261717519586, 7055.0, 7207.639618019078, 7215.206327303992, 19493.51266218356, 19612.215511379385, 19659.901700491406, 19667.311644092388, 19678.0, 7647.197044310378, 8593.140685931357, 8895.110488951053, 8907.643694252287, 8918.420302680304, 6732.360425759545, 6783.152105986752, 6873.725050998004, 7617.542947423172, 7644.541327520366, 5616.269884914935, 5708.914366284509, 5770.913436298459, 5823.417658234227, 5841.32824725162, 1691.9238634261487, 1693.3819156008215, 1705.224123024021, 1711.3582406597525, 1720.2430930390587, 951.1059603972244, 966.0918736387773, 982.6609819612222, 983.2183414185739, 983.6311383231289, 8330.0, 8365.665373385118, 8421.957890210631, 8561.315094792402, 8656.826863462695, 768.6041688530412, 802.4022103532789, 804.6419343392251, 805.20284917932, 808.4421748993176, 4947.1837146871085, 4985.551300382983, 5046.990601879639, 5632.352279487829, 5879.088741245114, 23977.640335394983, 24356.147534836196, 24507.877460612584, 25043.0, 25106.0, 24123.396915077265, 24202.63696044561, 24295.27114186577, 24572.754272457045, 24606.876965615058, 12577.811332830015, 12836.101472896995, 12861.228326300265, 12898.290594017231, 12986.545470908663, 8998.0, 9628.229741620513, 9662.951685241529, 9667.806643866943, 9672.516374181403, 20903.477413064797, 21080.78919210788, 21232.0, 21261.46846328854, 21599.892000539898, 21995.0, 22112.557748845255, 22242.777572224717, 22301.442463938532, 22575.77424225737, 12466.937665311616, 12484.188527745668, 12575.748485030432, 12675.683107922376, 12694.0, 15103.0, 15353.462628807938, 15408.229588520753, 15414.922925385301, 15422.537323880302, 12585.119041666996, 12633.305168215837, 12656.620301390973, 12762.68093297675, 12929.0, 12308.26150430977, 12478.5008599655, 12659.303738294113, 12714.0, 12747.426365813746, 10415.218858585486, 10541.051305382553, 10549.9472502637, 10562.524686388977, 10569.207309451667, 8344.541050242295, 8443.620037098468, 8446.396907935487, 8453.196946290092, 8475.491470511543, 8541.487510749375, 8622.78443038929, 8664.306855451674, 8673.262772664395, 8723.302135829246], "value": 7219.510754822582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3030856891738, 579.5421616922631, 580.9186713860059, 587.6474115530682, 606.7239406070238, 6180.814575562729, 6278.215223097113, 6293.7272618238485, 6311.084892690557, 6342.58773179743, 6191.907121393183, 6228.346023667517, 6252.499800015999, 6261.0, 6265.71804268809, 5099.15863882459, 5119.641625086246, 5126.154184559543, 5137.434882162959, 5138.3577052868395, 5059.620528460362, 5205.063088644042, 5224.1119009768245, 5260.579643496254, 5270.736463176845, 5202.791888324481, 5215.1655735082395, 5218.556422704075, 5231.424543300234, 5233.450487698794, 5172.301739265226, 5196.428392876781, 5208.791648334062, 5213.582913366921, 5232.8691782705355, 4915.90168196634, 4944.851654450372, 4966.354373931402, 4969.900601987976, 4982.725950072744, 6235.906461403038, 6236.126942228092, 6288.748450061992, 6293.590916590453, 6359.0, 6164.8767024659255, 6165.136880836686, 6178.7219575119225, 6226.283977342573, 6238.968805155991, 6706.765263215764, 6710.382950649251, 6757.452337522791, 6793.694283757242, 6818.352256535622, 5258.1849813279005, 5541.9168712468945, 5558.0, 5572.359178694462, 5577.944220557783, 6736.393724564813, 6914.308569143096, 6929.272426395206, 6960.651967401711, 6972.546784459045, 5661.886762264731, 5677.17680936262, 5723.313202415737, 5760.3951585083805, 5768.394318596571, 5755.050416681201, 5789.305283366023, 5798.739056742373, 5806.82579522615, 5850.327212370632, 6145.539084568675, 6184.443400094013, 6225.750969961241, 6225.782097626561, 6229.4393504584805, 6712.295209003082, 6750.459963202932, 6773.559718618274, 6785.219699734594, 6786.728530858809, 2002.1590931808676, 2011.6923999400506, 2013.9899300503696, 2017.1023894366865, 2018.3440381875948, 1438.7769895666188, 1520.9391624335124, 1540.3376548084432, 1554.1374537131774, 1557.696249231389, 6212.9378706213265, 6218.378162183836, 6237.126802247689, 6266.373362663789, 6273.1844860167885, 6702.463802895757, 6800.5718799051765, 6800.6599670017295, 6822.658867056627, 6838.418734407631, 6258.812235632939, 6289.8742025159245, 6292.339304373067, 6299.748010079637, 6309.14826498426, 3572.7141828653644, 3591.856325746993, 3593.0, 3606.3688854450365, 3621.239539696693, 7082.575045497287, 7086.858262834715, 7112.6443677815905, 7138.571685698875, 7145.178304494945, 6994.825129371807, 7003.92996070043, 7009.509334346649, 7011.649417529103, 7013.754518591825, 7012.368886800111, 7073.5755854649915, 7095.609741464269, 7124.3944264738075, 7146.142462904485, 6704.161979752531, 6742.898856517254, 6779.864402712017, 6798.0, 6855.245922948571, 6488.870222595616, 6624.171978502687, 6714.227863795726, 6748.763793267212, 6801.0, 6903.861922761617, 6925.437588092438, 6941.0629565010095, 6995.565908988747, 7091.432685385053, 5616.69108199053, 5670.773169073356, 5693.886122277614, 5744.540436765133, 5750.25246717924, 6268.623882567061, 6609.537332386879, 6663.500237482305, 6698.799036028927, 6742.393184613212, 6349.396807303298, 6490.578112422678, 6499.025146228104, 6520.380563846427, 6558.0, 6486.870262594816, 6491.642959637265, 6541.934580654323, 6573.244076931214, 6624.436922861611, 6231.750729970931, 6311.558190926591, 6355.841103972252, 6369.172007638977, 6385.393387628168, 6454.225492940877, 6497.772577959938, 6521.608703477807, 6577.572457790228, 6597.5381723280825, 6340.397662222082, 6370.299267080525, 6377.0, 6480.53739578957, 6493.772717954849], "value": 5342.644836372647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.4428209497444, 982.5431174503857, 988.4267125067457, 988.7280997725625, 1011.1304278320642, 19522.804771952276, 19690.0, 19870.503237419052, 19904.20383184671, 19904.800951990477, 19538.609227815436, 19547.706784398244, 19655.5086122847, 20269.695954560695, 20446.38660840177, 1034.6275340877296, 1050.4117694091294, 1056.587930707021, 1057.2968975631195, 1057.8148823955814, 1047.1884289675486, 1068.0601071057458, 1078.811208038594, 1079.4872435593109, 1082.199172612265, 1112.816385296425, 1120.590984290736, 1121.8149005414098, 1121.9270747401392, 1124.499597679033, 1082.0910435234362, 1108.69510884507, 1120.0703416164604, 1124.775044991005, 1126.7239526316105, 796.8924195233627, 799.8920145780303, 800.1958032177624, 806.6007326373424, 807.1363640904235, 18973.146208420654, 19042.61914761697, 19127.617447651108, 19183.0, 19196.80803191964, 23038.193663221875, 23262.30213093593, 23773.762262377502, 23804.166854160023, 23840.761592384028, 18420.447386578424, 18568.721469177974, 18604.16281267346, 18631.068446577618, 18651.25394984199, 3958.524977002778, 3982.900427489336, 3985.561588225293, 3988.162485877969, 3992.161646054332, 156399.0, 157002.0, 157705.0, 159415.0, 160740.0, 15513.146776927151, 15558.766618500506, 15802.0, 15955.122468264357, 16336.836631633769, 27537.724622753514, 27593.58609620857, 27594.862025690145, 27821.582676259874, 27848.303792405353, 9174.86237706435, 9192.21866141372, 9241.537923103819, 9308.255339572817, 9368.531573421302, 4782.0914026334885, 4938.481459446778, 4949.183384741549, 4957.677750946177, 4959.454460009396, 6260.373962603794, 6286.277078135981, 6293.433590976834, 6387.169667943138, 6415.486761059104, 1069.417167643636, 1078.2398409121552, 1089.2701889733896, 1092.355510248957, 1097.9341239525654, 671.214678825775, 735.9374453171433, 737.4911311195258, 749.7863109013905, 766.1113108793772, 12654.671259517618, 12884.226946383247, 14045.367958441895, 14101.746272226907, 14383.856161438252, 733.8385555177853, 734.3354264390734, 738.2174894611621, 744.8510297940434, 747.1855677311647, 6252.499800015988, 6254.593451425642, 6357.872842543124, 6380.7128679209545, 6518.967405162944, 139068.30465847606, 140527.0, 142346.0, 144722.0, 148725.0, 127707.0, 128474.0, 128720.35639821741, 129283.35358323336, 133392.33303833613, 114081.0, 115670.0, 116681.9999999983, 116942.41528792301, 119598.4020079894, 12069.698257543281, 12087.093467990111, 12143.574974875837, 12199.390030498616, 12352.876471235531, 53866.46133538614, 54672.0, 54801.0, 55155.72422137864, 55824.72087639536, 69339.0, 69485.0, 70455.0, 70533.64733176302, 71186.28813712003, 16560.420385286456, 16740.41408550695, 16842.0, 16944.068076255924, 17037.403690871255, 19906.70139947931, 20201.191952321744, 20354.491137721674, 20387.18451261933, 20420.285290015374, 17199.484015479557, 17357.30570777155, 17458.388956386465, 17462.0, 17611.911940440215, 17663.82336176622, 17838.91080544589, 17854.642907142043, 17929.103544822447, 18089.0, 17352.47942561725, 17637.559061023578, 17739.11304434799, 17769.0, 18029.90985045119, 13643.590692279247, 13968.092074015563, 14048.508302209373, 14096.577102686935, 14260.429582816987, 13866.514671986431, 13914.443422262995, 13917.304134793423, 13922.930385348009, 14119.576412707635], "value": 9836.234954143154, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1377.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 105.0, 106.0, 106.0, 106.0, 117.0, 108.0, 106.0, 108.0, 105.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 112.0, 112.0, 111.0, 145.0, 116.0, 112.0, 114.0, 114.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 165.0, 163.0, 164.0, 162.0, 163.0, 168.0, 167.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 75.0, 73.0, 74.0, 77.0, 74.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 77.0, 77.0, 79.0, 78.0, 77.0, 78.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 117.0, 114.0, 114.0, 114.0, 114.0, 117.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 149.0, 150.0, 149.0, 150.0, 149.0, 150.0, 150.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 48.0, 47.0, 45.0, 45.0, 44.0, 44.0, 45.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 40.0, 38.0, 39.0, 39.0, 38.0, 42.0, 40.0, 40.0, 39.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 70.0, 76.0, 70.0, 73.0, 70.0, 74.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 103.0, 101.0, 107.0, 108.0, 108.0, 104.0, 116.0, 115.0, 116.0], "value": 108.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 151.0, 149.0, 149.0, 156.0, 157.0, 153.0, 151.0, 156.0, 152.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 58.0], "value": 59.4, "unit": "score"}]}]} 18:15:20 INFO - Return code: 0 18:15:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:15:20 INFO - # TBPL SUCCESS # 18:15:20 INFO - Running post-action listener: _package_coverage_data 18:15:20 INFO - Running post-action listener: _resource_record_post_action 18:15:20 INFO - [mozharness: 2017-09-26 01:15:20.077049Z] Finished run-tests step (success) 18:15:20 INFO - Running post-run listener: _resource_record_post_run 18:15:20 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316518400; Read time: 12; Write time: 177076 18:15:20 INFO - TinderboxPrint: CPU usage
13.1% 18:15:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:15:20 INFO - TinderboxPrint: I/O write bytes / time
316,518,400 / 177,076 18:15:20 INFO - TinderboxPrint: CPU idle
8,218.1 (86.9%) 18:15:20 INFO - TinderboxPrint: CPU user
1,188.7 (12.6%) 18:15:20 INFO - TinderboxPrint: Swap in / out
0 / 0 18:15:20 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 8396800; Read time: 0; Write time: 824 18:15:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:15:20 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308121600; Read time: 12; Write time: 176252 18:15:20 INFO - Running post-run listener: _upload_blobber_files 18:15:20 INFO - Blob upload gear active. 18:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:15:20 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 18:15:20 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'] 18:15:20 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 18:15:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:22 INFO - (blobuploader) - INFO - Done attempting. 18:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:15:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:23 INFO - (blobuploader) - INFO - Done attempting. 18:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:15:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:24 INFO - (blobuploader) - INFO - Done attempting. 18:15:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:15:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:15:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:15:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:15:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:15:31 INFO - (blobuploader) - INFO - Done attempting. 18:15:31 INFO - (blobuploader) - INFO - Iteration through files over. 18:15:31 INFO - Return code: 0 18:15:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:15:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:15:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5b9c33afa2d2e57ea6aeda5a62265b671837607c0bf64d141a00be947534c200cf2ae04b2985eb680ce0f63a3f8fd0791fb211bcad477ea5c16b70219fffd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b62ac41072fa9b4336db79429a1da94550d9e6dfb998884f34dd5cc34c48cb94e358a9ac53b81ef6935d8502920be84aabe8e15025047790001160b60e6decd1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b753f41f4b6971c211c6b21bfb4e4b3d92aea4d67b6618f2d1846a69a9b594e3e63011c8c4af41366598d98a47f33af251608d63744a9e7c89c6c16e889f5aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386951ec0fc1d035b7c7293f48d8c56176e64bfd14f6f411a1afe822dfe80f619eb41e96c8fa234fcc4b6f4c53891e54c4038d545b3a74ca1a1d1d879ccfd65b"} 18:15:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:15:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:15:31 INFO - Contents: 18:15:31 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5b9c33afa2d2e57ea6aeda5a62265b671837607c0bf64d141a00be947534c200cf2ae04b2985eb680ce0f63a3f8fd0791fb211bcad477ea5c16b70219fffd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b62ac41072fa9b4336db79429a1da94550d9e6dfb998884f34dd5cc34c48cb94e358a9ac53b81ef6935d8502920be84aabe8e15025047790001160b60e6decd1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b753f41f4b6971c211c6b21bfb4e4b3d92aea4d67b6618f2d1846a69a9b594e3e63011c8c4af41366598d98a47f33af251608d63744a9e7c89c6c16e889f5aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386951ec0fc1d035b7c7293f48d8c56176e64bfd14f6f411a1afe822dfe80f619eb41e96c8fa234fcc4b6f4c53891e54c4038d545b3a74ca1a1d1d879ccfd65b"} 18:15:31 INFO - Running post-run listener: copy_logs_to_upload_dir 18:15:31 INFO - Copying logs to upload dir... 18:15:31 INFO - mkdir: /builds/slave/test/build/upload/logs 18:15:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.761996 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-25 18:15:31.319316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:31.323611) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 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/bc5b9c33afa2d2e57ea6aeda5a62265b671837607c0bf64d141a00be947534c200cf2ae04b2985eb680ce0f63a3f8fd0791fb211bcad477ea5c16b70219fffd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b62ac41072fa9b4336db79429a1da94550d9e6dfb998884f34dd5cc34c48cb94e358a9ac53b81ef6935d8502920be84aabe8e15025047790001160b60e6decd1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b753f41f4b6971c211c6b21bfb4e4b3d92aea4d67b6618f2d1846a69a9b594e3e63011c8c4af41366598d98a47f33af251608d63744a9e7c89c6c16e889f5aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386951ec0fc1d035b7c7293f48d8c56176e64bfd14f6f411a1afe822dfe80f619eb41e96c8fa234fcc4b6f4c53891e54c4038d545b3a74ca1a1d1d879ccfd65b"} build_url:https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/NrQ6614BRL-Ibp7ZFNvHoA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5b9c33afa2d2e57ea6aeda5a62265b671837607c0bf64d141a00be947534c200cf2ae04b2985eb680ce0f63a3f8fd0791fb211bcad477ea5c16b70219fffd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b62ac41072fa9b4336db79429a1da94550d9e6dfb998884f34dd5cc34c48cb94e358a9ac53b81ef6935d8502920be84aabe8e15025047790001160b60e6decd1", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b753f41f4b6971c211c6b21bfb4e4b3d92aea4d67b6618f2d1846a69a9b594e3e63011c8c4af41366598d98a47f33af251608d63744a9e7c89c6c16e889f5aa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/386951ec0fc1d035b7c7293f48d8c56176e64bfd14f6f411a1afe822dfe80f619eb41e96c8fa234fcc4b6f4c53891e54c4038d545b3a74ca1a1d1d879ccfd65b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:31.354241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:31.354578) ========= 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=3297cc2eebb5444a7688c33f000001b5-1506387293.278562-1995066944 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 18:15:31.438199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:15:31.438525) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 18:15:31.438901) ========= ========= Total master_lag: 0.30 =========