builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-027 starttime: 1506687926.56 results: success (0) revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.564195) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.565156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.565566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.935385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:26.935754) ========= 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=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 05:25:26-- 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% 211M=0s 2017-09-29 05:25:27 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138289 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.127233) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.127653) ========= 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=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017044 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.200068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.200506) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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 cd9c8c48e4b3ded47a776f757008f3dcf570c59c --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=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 05:25:27,240 truncating revision to first 12 chars 2017-09-29 05:25:27,240 Setting DEBUG logging. 2017-09-29 05:25:27,241 attempt 1/10 2017-09-29 05:25:27,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cd9c8c48e4b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 05:25:27,502 unpacking tar archive at: mozilla-central-cd9c8c48e4b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563293 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.834659) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.839268) ========= script_repo_revision: cd9c8c48e4b3ded47a776f757008f3dcf570c59c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 05:25:27.840012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-09-29 05:25:27.865814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-09-29 05:25:29.061497) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 05:25:29.062133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:29 INFO - MultiFileLogger online at 20170929 05:25:29 in /builds/slave/test 05:25:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:25:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:29 INFO - {'append_to_log': False, 05:25:29 INFO - 'base_work_dir': '/builds/slave/test', 05:25:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:25:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:29 INFO - 'branch': 'Firefox-Non-PGO', 05:25:29 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:29 INFO - 'code_coverage': False, 05:25:29 INFO - 'config_files': ('talos/linux_config.py',), 05:25:29 INFO - 'default_actions': ('clobber', 05:25:29 INFO - 'read-buildbot-config', 05:25:29 INFO - 'download-and-extract', 05:25:29 INFO - 'populate-webroot', 05:25:29 INFO - 'create-virtualenv', 05:25:29 INFO - 'install', 05:25:29 INFO - 'setup-mitmproxy', 05:25:29 INFO - 'run-tests'), 05:25:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:29 INFO - 'disable_ccov_upload': False, 05:25:29 INFO - 'disable_stylo': False, 05:25:29 INFO - 'download_minidump_stackwalk': True, 05:25:29 INFO - 'download_symbols': 'ondemand', 05:25:29 INFO - 'enable_stylo': False, 05:25:29 INFO - 'enable_webrender': False, 05:25:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:25:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:29 INFO - 'gecko_profile': False, 05:25:29 INFO - 'gecko_profile_interval': 0, 05:25:29 INFO - 'installer_path': 'installer.exe', 05:25:29 INFO - 'log_level': 'info', 05:25:29 INFO - 'log_name': 'talos', 05:25:29 INFO - 'log_to_console': True, 05:25:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:29 INFO - 'opt_config_files': (), 05:25:29 INFO - 'pip_index': False, 05:25:29 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:25:29 INFO - 'system_bits': '32', 05:25:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:29 INFO - 'title': 'talos-linux64-ix-027', 05:25:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:29 INFO - 'use_talos_json': True, 05:25:29 INFO - 'verify': 'False', 05:25:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:29 INFO - 'work_dir': 'build'} 05:25:29 INFO - [mozharness: 2017-09-29 12:25:29.400345Z] Running clobber step. 05:25:29 INFO - Running pre-action listener: _resource_record_pre_action 05:25:29 INFO - Running main action method: clobber 05:25:29 INFO - rmtree: /builds/slave/test/build 05:25:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:30 INFO - Running post-action listener: _resource_record_post_action 05:25:30 INFO - [mozharness: 2017-09-29 12:25:30.384980Z] Finished clobber step (success) 05:25:30 INFO - [mozharness: 2017-09-29 12:25:30.385078Z] Running read-buildbot-config step. 05:25:30 INFO - Running pre-action listener: _resource_record_pre_action 05:25:30 INFO - Running main action method: read_buildbot_config 05:25:30 INFO - Using buildbot properties: 05:25:30 INFO - { 05:25:30 INFO - "project": "", 05:25:30 INFO - "product": "firefox", 05:25:30 INFO - "who": "archaeopteryx@coole-files.de", 05:25:30 INFO - "installer_path": "public/build/target.tar.bz2", 05:25:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:25:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:25:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 05:25:30 INFO - "stage_platform": "linux64", 05:25:30 INFO - "basedir": "/builds/slave/test", 05:25:30 INFO - "buildnumber": 79, 05:25:30 INFO - "platform": "ubuntu64_hw", 05:25:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:25:30 INFO - "slavebuilddir": "test", 05:25:30 INFO - "taskId": "aW9c26ghRl-0Qs_NP_W0yA", 05:25:30 INFO - "branch": "mozilla-central", 05:25:30 INFO - "script_repo_revision": "production", 05:25:30 INFO - "revision": "cd9c8c48e4b3ded47a776f757008f3dcf570c59c", 05:25:30 INFO - "slavename": "talos-linux64-ix-027", 05:25:30 INFO - "repo_path": "mozilla-central" 05:25:30 INFO - } 05:25:30 INFO - Finding installer, test and symbols from parent task. 05:25:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aW9c26ghRl-0Qs_NP_W0yA'}, attempt #1 05:25:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aW9c26ghRl-0Qs_NP_W0yA'}, attempt #1 05:25:31 INFO - Task dependencies: IH85rkEeSoiGVybgA5cHLA 05:25:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA'}, attempt #1 05:25:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json 05:25:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip 05:25:31 INFO - Running post-action listener: _resource_record_post_action 05:25:31 INFO - [mozharness: 2017-09-29 12:25:31.844299Z] Finished read-buildbot-config step (success) 05:25:31 INFO - [mozharness: 2017-09-29 12:25:31.844521Z] Running download-and-extract step. 05:25:31 INFO - Running pre-action listener: _resource_record_pre_action 05:25:31 INFO - Running main action method: download_and_extract 05:25:31 INFO - mkdir: /builds/slave/test/build/tests 05:25:31 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')]} 05:25:31 INFO - trying https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json 05:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:25:32 INFO - Downloaded 989 bytes. 05:25:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:25:32 INFO - Using the following test package requirements: 05:25:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:25:32 INFO - u'common': [u'target.common.tests.zip'], 05:25:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:25:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:25:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:25:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:25:32 INFO - u'mozbase': [u'target.common.tests.zip'], 05:25:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:25:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:25:32 INFO - u'web-platform': [u'target.common.tests.zip', 05:25:32 INFO - u'target.web-platform.tests.tar.gz'], 05:25:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:25:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:25:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip 05:25:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:25:32 INFO - Fetch https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.common.tests.zip into memory 05:25:33 INFO - Content-Length response header: 55366218 05:25:33 INFO - Bytes received: 55366218 05:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip 05:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.talos.tests.zip into memory 05:25:45 INFO - Content-Length response header: 14521355 05:25:45 INFO - Bytes received: 14521355 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - trying https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:45 INFO - Downloading https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:25:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:25:46 INFO - Downloaded 61539289 bytes. 05:25:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:46 INFO - mkdir: /builds/slave/test/properties 05:25:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:46 INFO - Contents: 05:25:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - Running post-action listener: find_tests_for_verification 05:25:46 INFO - Running post-action listener: set_extra_try_arguments 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.682411Z] Finished download-and-extract step (success) 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.682533Z] Running populate-webroot step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: populate_webroot 05:25:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tresize', 05:25:46 INFO - 'tcanvasmark']}, 05:25:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['dromaeo_css', 05:25:46 INFO - 'kraken']}, 05:25:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['damp', 'tps']}, 05:25:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['damp', 'tps']}, 05:25:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['dromaeo_dom']}, 05:25:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:25:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['basic_compositor_video', 05:25:46 INFO - 'glvideo']}, 05:25:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:25:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['ts_paint_webext', 05:25:46 INFO - 'tp5o_webext']}, 05:25:46 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:46 INFO - 'ts_paint', 05:25:46 INFO - 'tpaint', 05:25:46 INFO - 'sessionrestore', 05:25:46 INFO - 'sessionrestore_many_windows', 05:25:46 INFO - 'sessionrestore_no_auto_restore', 05:25:46 INFO - 'tabpaint', 05:25:46 INFO - 'cpstartup']}, 05:25:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['a11yr', 05:25:46 INFO - 'ts_paint', 05:25:46 INFO - 'tpaint', 05:25:46 INFO - 'sessionrestore', 05:25:46 INFO - 'sessionrestore_many_windows', 05:25:46 INFO - 'sessionrestore_no_auto_restore', 05:25:46 INFO - 'tabpaint', 05:25:46 INFO - 'cpstartup']}, 05:25:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 05:25:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:25:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['perf_reftest_singletons']}, 05:25:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['perf_reftest']}, 05:25:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:46 INFO - 'tsvgr_opacity', 05:25:46 INFO - 'tart', 05:25:46 INFO - 'tscrollx', 05:25:46 INFO - 'tsvg_static']}, 05:25:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tsvgx', 05:25:46 INFO - 'tsvgr_opacity', 05:25:46 INFO - 'tart', 05:25:46 INFO - 'tscrollx', 05:25:46 INFO - 'tsvg_static']}, 05:25:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:25:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo'], 05:25:46 INFO - 'tests': ['tp5o']}, 05:25:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--disable-stylo', 05:25:46 INFO - '--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:25:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:25:46 INFO - 'talos_options': ['--stylo-threads=1', 05:25:46 INFO - '--mitmproxy', 05:25:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:25:46 INFO - '--firstNonBlankPaint'], 05:25:46 INFO - 'tests': ['tp6_google', 05:25:46 INFO - 'tp6_youtube', 05:25:46 INFO - 'tp6_amazon', 05:25:46 INFO - 'tp6_facebook']}, 05:25:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--xperf_path', 05:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:46 INFO - 'tests': ['tp5n']}, 05:25:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:25:46 INFO - 'talos_options': ['--disable-stylo', 05:25:46 INFO - '--xperf_path', 05:25:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:46 INFO - 'tests': ['tp5n']}}} 05:25:46 INFO - Running post-action listener: _resource_record_post_action 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.699980Z] Finished populate-webroot step (success) 05:25:46 INFO - [mozharness: 2017-09-29 12:25:46.700069Z] Running create-virtualenv step. 05:25:46 INFO - Running pre-action listener: _resource_record_pre_action 05:25:46 INFO - Running main action method: create_virtualenv 05:25:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:25:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:25:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:48 INFO - Installing pip...............done. 05:25:48 INFO - Return code: 0 05:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:25:48 INFO - Reading from file tmpfile_stdout 05:25:48 INFO - Output received: 05:25:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:25:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:25:48 INFO - Using env: {'DISPLAY': ':0', 05:25:48 INFO - 'HOME': '/home/cltbld', 05:25:48 INFO - 'LANG': 'en_US.UTF-8', 05:25:48 INFO - 'LANGUAGE': 'en_US:en', 05:25:48 INFO - 'LOGNAME': 'cltbld', 05:25:48 INFO - 'MAIL': '/var/mail/cltbld', 05:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:48 INFO - 'MOZ_NO_REMOTE': '1', 05:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:48 INFO - 'NO_EM_RESTART': '1', 05:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:48 INFO - 'PWD': '/builds/slave/test', 05:25:48 INFO - 'SHELL': '/bin/bash', 05:25:48 INFO - 'SHLVL': '1', 05:25:48 INFO - 'TERM': 'linux', 05:25:48 INFO - 'TMOUT': '86400', 05:25:48 INFO - 'USER': 'cltbld', 05:25:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:48 INFO - '_': '/tools/buildbot/bin/python'} 05:25:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:25:49 INFO - Downloading/unpacking pip>=1.5 05:25:49 INFO - Running setup.py egg_info for package pip 05:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:25:49 INFO - Installing collected packages: pip 05:25:49 INFO - Found existing installation: pip 1.1 05:25:49 INFO - Uninstalling pip: 05:25:49 INFO - Successfully uninstalled pip 05:25:49 INFO - Running setup.py install for pip 05:25:49 INFO - warning: no files found matching 'pip/cacert.pem' 05:25:49 INFO - warning: no files found matching '*.html' under directory 'docs' 05:25:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:25:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:25:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:25:49 INFO - Successfully installed pip 05:25:49 INFO - Cleaning up... 05:25:49 INFO - Return code: 0 05:25:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:49 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')]} 05:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:49 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')]} 05:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:49 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:49 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 05:25:49 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 05:25:49 INFO - Using env: {'DISPLAY': ':0', 05:25:49 INFO - 'HOME': '/home/cltbld', 05:25:49 INFO - 'LANG': 'en_US.UTF-8', 05:25:49 INFO - 'LANGUAGE': 'en_US:en', 05:25:49 INFO - 'LOGNAME': 'cltbld', 05:25:49 INFO - 'MAIL': '/var/mail/cltbld', 05:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:49 INFO - 'MOZ_NO_REMOTE': '1', 05:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:49 INFO - 'NO_EM_RESTART': '1', 05:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:49 INFO - 'PWD': '/builds/slave/test', 05:25:49 INFO - 'SHELL': '/bin/bash', 05:25:49 INFO - 'SHLVL': '1', 05:25:49 INFO - 'TERM': 'linux', 05:25:49 INFO - 'TMOUT': '86400', 05:25:49 INFO - 'USER': 'cltbld', 05:25:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:49 INFO - '_': '/tools/buildbot/bin/python'} 05:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:50 INFO - Downloading/unpacking psutil>=3.1.1 05:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:51 INFO - Installing collected packages: psutil 05:25:51 INFO - Running setup.py install for psutil 05:25:51 INFO - building 'psutil._psutil_linux' extension 05:25:51 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 05:25:51 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 05:25:51 INFO - building 'psutil._psutil_posix' extension 05:25:51 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 05:25:51 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 05:25:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:51 INFO - Successfully installed psutil 05:25:51 INFO - Cleaning up... 05:25:51 INFO - Return code: 0 05:25:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:25:51 INFO - Using env: {'DISPLAY': ':0', 05:25:51 INFO - 'HOME': '/home/cltbld', 05:25:51 INFO - 'LANG': 'en_US.UTF-8', 05:25:51 INFO - 'LANGUAGE': 'en_US:en', 05:25:51 INFO - 'LOGNAME': 'cltbld', 05:25:51 INFO - 'MAIL': '/var/mail/cltbld', 05:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:51 INFO - 'MOZ_NO_REMOTE': '1', 05:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:51 INFO - 'NO_EM_RESTART': '1', 05:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:51 INFO - 'PWD': '/builds/slave/test', 05:25:51 INFO - 'SHELL': '/bin/bash', 05:25:51 INFO - 'SHLVL': '1', 05:25:51 INFO - 'TERM': 'linux', 05:25:51 INFO - 'TMOUT': '86400', 05:25:51 INFO - 'USER': 'cltbld', 05:25:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:51 INFO - '_': '/tools/buildbot/bin/python'} 05:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:53 INFO - Installing collected packages: mozsystemmonitor 05:25:53 INFO - Running setup.py install for mozsystemmonitor 05:25:53 INFO - Successfully installed mozsystemmonitor 05:25:53 INFO - Cleaning up... 05:25:53 INFO - Return code: 0 05:25:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:25:53 INFO - Using env: {'DISPLAY': ':0', 05:25:53 INFO - 'HOME': '/home/cltbld', 05:25:53 INFO - 'LANG': 'en_US.UTF-8', 05:25:53 INFO - 'LANGUAGE': 'en_US:en', 05:25:53 INFO - 'LOGNAME': 'cltbld', 05:25:53 INFO - 'MAIL': '/var/mail/cltbld', 05:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:53 INFO - 'MOZ_NO_REMOTE': '1', 05:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:53 INFO - 'NO_EM_RESTART': '1', 05:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:53 INFO - 'PWD': '/builds/slave/test', 05:25:53 INFO - 'SHELL': '/bin/bash', 05:25:53 INFO - 'SHLVL': '1', 05:25:53 INFO - 'TERM': 'linux', 05:25:53 INFO - 'TMOUT': '86400', 05:25:53 INFO - 'USER': 'cltbld', 05:25:53 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:53 INFO - '_': '/tools/buildbot/bin/python'} 05:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:55 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 05:25:55 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 05:25:55 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 05:25:55 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 05:25:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:55 INFO - warning: no files found matching '*.txt' 05:25:55 INFO - no previously-included directories found matching 'build' 05:25:55 INFO - no previously-included directories found matching 'dist' 05:25:55 INFO - no previously-included directories found matching '.git*' 05:25:55 INFO - Installing collected packages: jsonschema, functools32 05:25:55 INFO - Running setup.py install for functools32 05:25:55 INFO - warning: no files found matching '*.txt' 05:25:55 INFO - no previously-included directories found matching 'build' 05:25:55 INFO - no previously-included directories found matching 'dist' 05:25:55 INFO - no previously-included directories found matching '.git*' 05:25:55 INFO - Successfully installed jsonschema functools32 05:25:55 INFO - Cleaning up... 05:25:55 INFO - Return code: 0 05:25:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:25:55 INFO - Using env: {'DISPLAY': ':0', 05:25:55 INFO - 'HOME': '/home/cltbld', 05:25:55 INFO - 'LANG': 'en_US.UTF-8', 05:25:55 INFO - 'LANGUAGE': 'en_US:en', 05:25:55 INFO - 'LOGNAME': 'cltbld', 05:25:55 INFO - 'MAIL': '/var/mail/cltbld', 05:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:55 INFO - 'MOZ_NO_REMOTE': '1', 05:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:55 INFO - 'NO_EM_RESTART': '1', 05:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:55 INFO - 'PWD': '/builds/slave/test', 05:25:55 INFO - 'SHELL': '/bin/bash', 05:25:55 INFO - 'SHLVL': '1', 05:25:55 INFO - 'TERM': 'linux', 05:25:55 INFO - 'TMOUT': '86400', 05:25:55 INFO - 'USER': 'cltbld', 05:25:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:55 INFO - '_': '/tools/buildbot/bin/python'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:25:56 INFO - Cleaning up... 05:25:56 INFO - Return code: 0 05:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:56 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:56 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 05:25:56 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 05:25:56 INFO - Using env: {'DISPLAY': ':0', 05:25:56 INFO - 'HOME': '/home/cltbld', 05:25:56 INFO - 'LANG': 'en_US.UTF-8', 05:25:56 INFO - 'LANGUAGE': 'en_US:en', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MAIL': '/var/mail/cltbld', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SHLVL': '1', 05:25:56 INFO - 'TERM': 'linux', 05:25:56 INFO - 'TMOUT': '86400', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - '_': '/tools/buildbot/bin/python'} 05:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - Downloading docopt-0.6.1.tar.gz 05:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:58 INFO - Running setup.py install for blobuploader 05:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:58 INFO - Running setup.py install for requests 05:25:58 INFO - Running setup.py install for docopt 05:25:58 INFO - Successfully installed blobuploader requests docopt 05:25:58 INFO - Cleaning up... 05:25:58 INFO - Return code: 0 05:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25: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')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:25:58 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 05:25:58 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 05:25:58 INFO - Using env: {'DISPLAY': ':0', 05:25:58 INFO - 'HOME': '/home/cltbld', 05:25:58 INFO - 'LANG': 'en_US.UTF-8', 05:25:58 INFO - 'LANGUAGE': 'en_US:en', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MAIL': '/var/mail/cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SHLVL': '1', 05:25:58 INFO - 'TERM': 'linux', 05:25:58 INFO - 'TMOUT': '86400', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - '_': '/tools/buildbot/bin/python'} 05:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:58 INFO - Running setup.py (path:/tmp/pip-KkhzNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:58 INFO - Running setup.py (path:/tmp/pip-K2BBrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Running setup.py (path:/tmp/pip-pclTpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Running setup.py (path:/tmp/pip-k2tizh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Running setup.py (path:/tmp/pip-PVVqVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Running setup.py (path:/tmp/pip-0BhW92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:59 INFO - Running setup.py (path:/tmp/pip-IpLbrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:59 INFO - Running setup.py (path:/tmp/pip-nS3ngS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:59 INFO - Running setup.py (path:/tmp/pip-AMGfFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:59 INFO - Running setup.py (path:/tmp/pip-aSlEEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:59 INFO - Running setup.py (path:/tmp/pip-6ukH0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:59 INFO - Running setup.py (path:/tmp/pip-hdlfjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:59 INFO - Running setup.py (path:/tmp/pip-z7XInn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:59 INFO - Running setup.py (path:/tmp/pip-MqTSnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:59 INFO - Running setup.py (path:/tmp/pip-3mI4oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:59 INFO - Running setup.py (path:/tmp/pip-xngvTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:00 INFO - Running setup.py (path:/tmp/pip-l7V4lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:00 INFO - Running setup.py install for manifestparser 05:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozcrash 05:26:00 INFO - Running setup.py install for mozdebug 05:26:00 INFO - Running setup.py install for mozdevice 05:26:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozfile 05:26:00 INFO - Running setup.py install for mozhttpd 05:26:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozinfo 05:26:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozInstall 05:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozleak 05:26:00 INFO - Running setup.py install for mozlog 05:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for moznetwork 05:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozprocess 05:26:01 INFO - Running setup.py install for mozprofile 05:26:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozrunner 05:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozscreenshot 05:26:01 INFO - Running setup.py install for moztest 05:26:01 INFO - Running setup.py install for mozversion 05:26:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:01 INFO - Cleaning up... 05:26:01 INFO - Return code: 0 05:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:01 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:26:01 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 05:26:01 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 05:26:01 INFO - Using env: {'DISPLAY': ':0', 05:26:01 INFO - 'HOME': '/home/cltbld', 05:26:01 INFO - 'LANG': 'en_US.UTF-8', 05:26:01 INFO - 'LANGUAGE': 'en_US:en', 05:26:01 INFO - 'LOGNAME': 'cltbld', 05:26:01 INFO - 'MAIL': '/var/mail/cltbld', 05:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:01 INFO - 'MOZ_NO_REMOTE': '1', 05:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:01 INFO - 'NO_EM_RESTART': '1', 05:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:01 INFO - 'PWD': '/builds/slave/test', 05:26:01 INFO - 'SHELL': '/bin/bash', 05:26:01 INFO - 'SHLVL': '1', 05:26:01 INFO - 'TERM': 'linux', 05:26:01 INFO - 'TMOUT': '86400', 05:26:01 INFO - 'USER': 'cltbld', 05:26:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:01 INFO - '_': '/tools/buildbot/bin/python'} 05:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:02 INFO - Running setup.py (path:/tmp/pip-gmWU4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:02 INFO - Running setup.py (path:/tmp/pip-fqOmte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:02 INFO - Running setup.py (path:/tmp/pip-sscIDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 INFO - Running setup.py (path:/tmp/pip-I6nQKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:02 INFO - Running setup.py (path:/tmp/pip-d6UR7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 INFO - Running setup.py (path:/tmp/pip-NDyKLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 INFO - Running setup.py (path:/tmp/pip-ZK1Uxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 INFO - Running setup.py (path:/tmp/pip-9PwuMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:02 INFO - Running setup.py (path:/tmp/pip-Hr6k8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:02 INFO - Running setup.py (path:/tmp/pip-TdHxdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:02 INFO - Running setup.py (path:/tmp/pip-Xu5mv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:02 INFO - Running setup.py (path:/tmp/pip-vkZcsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:02 INFO - Running setup.py (path:/tmp/pip-odMrXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 INFO - Running setup.py (path:/tmp/pip-KiJWe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 INFO - Running setup.py (path:/tmp/pip-BnYvew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:03 INFO - Running setup.py (path:/tmp/pip-eKPp5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:03 INFO - Running setup.py (path:/tmp/pip-4g2PPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 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)) 05:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:04 INFO - Downloading blessings-1.6.tar.gz 05:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:04 INFO - Installing collected packages: blessings 05:26:04 INFO - Running setup.py install for blessings 05:26:04 INFO - Successfully installed blessings 05:26:04 INFO - Cleaning up... 05:26:04 INFO - Return code: 0 05:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:04 INFO - Reading from file tmpfile_stdout 05:26:04 INFO - Current package versions: 05:26:04 INFO - argparse == 1.2.1 05:26:04 INFO - blessings == 1.6 05:26:04 INFO - blobuploader == 1.2.4 05:26:04 INFO - docopt == 0.6.1 05:26:04 INFO - functools32 == 3.2.3-2 05:26:04 INFO - jsonschema == 2.5.1 05:26:04 INFO - manifestparser == 1.1 05:26:04 INFO - mozInstall == 1.13 05:26:04 INFO - mozcrash == 1.0 05:26:04 INFO - mozdebug == 0.1 05:26:04 INFO - mozdevice == 0.51 05:26:04 INFO - mozfile == 1.2 05:26:04 INFO - mozhttpd == 0.7 05:26:04 INFO - mozinfo == 0.10 05:26:04 INFO - mozleak == 0.1 05:26:04 INFO - mozlog == 3.5 05:26:04 INFO - moznetwork == 0.27 05:26:04 INFO - mozprocess == 0.25 05:26:04 INFO - mozprofile == 0.28 05:26:04 INFO - mozrunner == 6.13 05:26:04 INFO - mozscreenshot == 0.1 05:26:04 INFO - mozsystemmonitor == 0.3 05:26:04 INFO - moztest == 0.8 05:26:04 INFO - mozversion == 1.4 05:26:04 INFO - psutil == 3.1.1 05:26:04 INFO - requests == 1.2.3 05:26:04 INFO - wsgiref == 0.1.2 05:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:04 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:26:04 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 05:26:04 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 05:26:04 INFO - Using env: {'DISPLAY': ':0', 05:26:04 INFO - 'HOME': '/home/cltbld', 05:26:04 INFO - 'LANG': 'en_US.UTF-8', 05:26:04 INFO - 'LANGUAGE': 'en_US:en', 05:26:04 INFO - 'LOGNAME': 'cltbld', 05:26:04 INFO - 'MAIL': '/var/mail/cltbld', 05:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:04 INFO - 'MOZ_NO_REMOTE': '1', 05:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:04 INFO - 'NO_EM_RESTART': '1', 05:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:04 INFO - 'PWD': '/builds/slave/test', 05:26:04 INFO - 'SHELL': '/bin/bash', 05:26:04 INFO - 'SHLVL': '1', 05:26:04 INFO - 'TERM': 'linux', 05:26:04 INFO - 'TMOUT': '86400', 05:26:04 INFO - 'USER': 'cltbld', 05:26:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:04 INFO - '_': '/tools/buildbot/bin/python'} 05:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 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)) 05:26:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:26:06 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)) 05:26:06 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)) 05:26:06 INFO - Installing collected packages: simplejson 05:26:06 INFO - Running setup.py install for simplejson 05:26:06 INFO - building 'simplejson._speedups' extension 05:26:06 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 05:26:07 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 05:26:07 INFO - Successfully installed simplejson 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:07 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 0x13851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x154db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, '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': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', '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 05:26:07 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 05:26:07 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 05:26:07 INFO - Using env: {'DISPLAY': ':0', 05:26:07 INFO - 'HOME': '/home/cltbld', 05:26:07 INFO - 'LANG': 'en_US.UTF-8', 05:26:07 INFO - 'LANGUAGE': 'en_US:en', 05:26:07 INFO - 'LOGNAME': 'cltbld', 05:26:07 INFO - 'MAIL': '/var/mail/cltbld', 05:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:07 INFO - 'MOZ_NO_REMOTE': '1', 05:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:07 INFO - 'NO_EM_RESTART': '1', 05:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:07 INFO - 'PWD': '/builds/slave/test', 05:26:07 INFO - 'SHELL': '/bin/bash', 05:26:07 INFO - 'SHLVL': '1', 05:26:07 INFO - 'TERM': 'linux', 05:26:07 INFO - 'TMOUT': '86400', 05:26:07 INFO - 'USER': 'cltbld', 05:26:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:07 INFO - '_': '/tools/buildbot/bin/python'} 05:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Running post-action listener: _resource_record_post_action 05:26:07 INFO - Running post-action listener: _start_resource_monitoring 05:26:07 INFO - Starting resource monitoring. 05:26:07 INFO - [mozharness: 2017-09-29 12:26:07.599933Z] Finished create-virtualenv step (success) 05:26:07 INFO - [mozharness: 2017-09-29 12:26:07.600405Z] Running install step. 05:26:07 INFO - Running pre-action listener: _resource_record_pre_action 05:26:07 INFO - Running main action method: install 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:07 INFO - Reading from file tmpfile_stdout 05:26:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:07 INFO - Reading from file tmpfile_stdout 05:26:07 INFO - Output received: 05:26:07 INFO - Usage: mozinstall [options] installer 05:26:07 INFO - Options: 05:26:07 INFO - -h, --help show this help message and exit 05:26:07 INFO - -d DEST, --destination=DEST 05:26:07 INFO - Directory to install application into. [default: 05:26:07 INFO - "/builds/slave/test"] 05:26:07 INFO - --app=APP Application being installed. [default: firefox] 05:26:07 INFO - mkdir: /builds/slave/test/build/application 05:26:07 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'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:26:25 INFO - Reading from file tmpfile_stdout 05:26:25 INFO - Output received: 05:26:25 INFO - /builds/slave/test/build/application/firefox/firefox 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.754077Z] Finished install step (success) 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.754426Z] Running setup-mitmproxy step. 05:26:25 INFO - Running pre-action listener: _resource_record_pre_action 05:26:25 INFO - Running main action method: setup_mitmproxy 05:26:25 INFO - Skipping: mitmproxy is not required 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.756057Z] Finished setup-mitmproxy step (success) 05:26:25 INFO - [mozharness: 2017-09-29 12:26:25.756370Z] Running run-tests step. 05:26:25 INFO - Running pre-action listener: _resource_record_pre_action 05:26:25 INFO - Running pre-action listener: _set_gcov_prefix 05:26:25 INFO - Running main action method: run_tests 05:26:25 WARNING - Try message not found. 05:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:25 INFO - Python 2.7.3 05:26:25 INFO - Return code: 0 05:26:25 INFO - grabbing minidump binary from tooltool 05:26:25 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')]} 05:26:25 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 0x16efd60>, '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 0x16f0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f0ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:25 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 05:26:25 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 05:26:25 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 05:26:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:25 INFO - Return code: 0 05:26:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:26:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:25 INFO - ENV: RUST_BACKTRACE is now full 05:26:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:26:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 05:26:25 INFO - Using env: {'DISPLAY': ':0', 05:26:25 INFO - 'HOME': '/home/cltbld', 05:26:25 INFO - 'LANG': 'en_US.UTF-8', 05:26:25 INFO - 'LANGUAGE': 'en_US:en', 05:26:25 INFO - 'LOGNAME': 'cltbld', 05:26:25 INFO - 'MAIL': '/var/mail/cltbld', 05:26:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:25 INFO - 'MOZ_NO_REMOTE': '1', 05:26:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:25 INFO - 'NO_EM_RESTART': '1', 05:26:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:25 INFO - 'PWD': '/builds/slave/test', 05:26:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:25 INFO - 'RUST_BACKTRACE': 'full', 05:26:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:26:25 INFO - 'SHELL': '/bin/bash', 05:26:25 INFO - 'SHLVL': '1', 05:26:25 INFO - 'TERM': 'linux', 05:26:25 INFO - 'TMOUT': '86400', 05:26:25 INFO - 'USER': 'cltbld', 05:26:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:25 INFO - '_': '/tools/buildbot/bin/python'} 05:26:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 05:26:26 INFO - mozversion application_buildid: 20170929113110 05:26:26 INFO - mozversion application_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:26:26 INFO - mozversion application_display_name: Nightly 05:26:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:26 INFO - mozversion application_name: Firefox 05:26:26 INFO - mozversion application_remotingname: firefox 05:26:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:26 INFO - mozversion application_vendor: Mozilla 05:26:26 INFO - mozversion application_version: 58.0a1 05:26:26 INFO - mozversion platform_buildid: 20170929113110 05:26:26 INFO - mozversion platform_changeset: cd9c8c48e4b3ded47a776f757008f3dcf570c59c 05:26:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:26 INFO - mozversion platform_version: 58.0a1 05:26:26 INFO - using testdate: 1506687986 05:26:26 INFO - actual date: 1506687986 05:26:26 INFO - starting webserver on 'localhost:47613' 05:26:26 INFO - SUITE-START | Running 2 tests 05:26:26 INFO - TEST-START | dromaeo_css 05:26:26 INFO - Initialising browser for dromaeo_css test... 05:26:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47613/getInfo.html -profile /tmp/tmpp1OtFJ/profile 05:26:26 INFO - TEST-INFO | started process 5873 (/builds/slave/test/build/application/firefox/firefox http://localhost:47613/getInfo.html) 05:26:31 INFO - TEST-INFO | 5873: exit 0 05:26:32 INFO - Browser initialized. 05:26:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:32 INFO - Using env: {'DISPLAY': ':0', 05:26:32 INFO - 'HOME': '/home/cltbld', 05:26:32 INFO - 'JSGC_DISABLE_POISONING': '1', 05:26:32 INFO - 'LANG': 'en_US.UTF-8', 05:26:32 INFO - 'LANGUAGE': 'en_US:en', 05:26:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:26:32 INFO - 'LOGNAME': 'cltbld', 05:26:32 INFO - 'MAIL': '/var/mail/cltbld', 05:26:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:26:32 INFO - 'MOZ_CRASHREPORTER': '1', 05:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:26:32 INFO - 'MOZ_NO_REMOTE': '1', 05:26:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:32 INFO - 'NO_EM_RESTART': '1', 05:26:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:32 INFO - 'PWD': '/builds/slave/test', 05:26:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:32 INFO - 'RUST_BACKTRACE': 'full', 05:26:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:26:32 INFO - 'SHELL': '/bin/bash', 05:26:32 INFO - 'SHLVL': '1', 05:26:32 INFO - 'STYLO_FORCE_DISABLED': '1', 05:26:32 INFO - 'TERM': 'linux', 05:26:32 INFO - 'TMOUT': '86400', 05:26:32 INFO - 'USER': 'cltbld', 05:26:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:32 INFO - '_': '/tools/buildbot/bin/python'} 05:26:32 INFO - TEST-INFO | started process 6114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp1OtFJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:32 INFO - PID 6114 | 05:26:32 INFO - PID 6114 | (/builds/slave/test/build/application/firefox/firefox:6163): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:26:32 INFO - PID 6114 | 05:26:43 INFO - PID 6114 | RSS: Main: 152330240 05:26:43 INFO - PID 6114 | 05:29:40 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47613/tests/dromaeo/cssquery-ext.html) 05:29:42 INFO - PID 6114 | RSS: Main: 149716992 05:29:42 INFO - PID 6114 | 05:32:44 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-ext.html (next: http://localhost:47613/tests/dromaeo/cssquery-jquery.html) 05:32:44 INFO - PID 6114 | RSS: Main: 150188032 05:32:44 INFO - PID 6114 | 05:35:46 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47613/tests/dromaeo/cssquery-mootools.html) 05:35:47 INFO - PID 6114 | RSS: Main: 151764992 05:35:47 INFO - PID 6114 | 05:38:48 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47613/tests/dromaeo/cssquery-prototype.html) 05:38:49 INFO - PID 6114 | RSS: Main: 151494656 05:38:49 INFO - PID 6114 | 05:41:52 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47613/tests/dromaeo/cssquery-yui.html) 05:41:53 INFO - PID 6114 | RSS: Main: 154791936 05:41:53 INFO - PID 6114 | 05:44:54 INFO - PID 6114 | Cycle 1(1): loaded http://localhost:47613/tests/dromaeo/cssquery-yui.html (next: http://localhost:47613/tests/dromaeo/cssquery-dojo.html) 05:44:55 INFO - PID 6114 | RSS: Main: 155353088 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | __start_tp_report 05:44:55 INFO - PID 6114 | _x_x_mozilla_page_load 05:44:55 INFO - PID 6114 | _x_x_mozilla_page_load_details 05:44:55 INFO - PID 6114 | |i|pagename|runs| 05:44:55 INFO - PID 6114 | |0;dojo.html;3214.549963005179;3220.5974253218346;3229;3241.1086951088464;3261.249912520121;6182;6275.466585340251;6302.527310451717;6329.651869147195;6410.679466026698;6216.378362163781;6246.187995560582;6280.905786413207;6284.245890493147;6292.653904035276;5824.009918313886;5891.440313170242;5917.792877249297;5919.082542205965;5936.554758393117;5882.499987501046;5929.644221346733;5933.525317974551;5963.522918166536;5964.910526342108;1247.7933570666412;5740.024195886688;5765.423457654243;5887.058070708709;5914.201582786355;5796.768129274824;5845.066250666458;5900.97049514754;5925.2889653241455;5927.8221653350465;5810.273715785527;5817.331006934172;5887.1463637772285;5895.115732640095;5904.822855314347;6208.565400421972;6224.315325314212;6367.108604795332;6389.4568961638315;6394.296627370985;6614.371634694697;6785.59286442815;6804.6257455839905;6880.552764070369;6902.137232845895;6753.324667533257;6756.189257289107;6759.5606285591275;6761.729530818761;6769.458443324522;6177.3822617738315;6259.467945224661;6262.5929314594405;6306.716197771111;6400.199975003125;7048.577085374894;7095.113110861143;7099.396551293198;7125.35871771543;7144.1784194818265;6699.095622091053;6707.128073350434;6744.966275168691;6770.458363330922;6773;6552.934470655233;6703.798886033427;6713.630750308682;6719.697613607399;6775.322467753185;6599.373059559334;6600.240972288152;6664.666766661648;6685.699143538553;6795.490338224653;6811.182658081062;6817.488688348294;6825.69284382204;6833.658317084126;6837.213720422115;5281.366236051622;5282.286891269706;5356.276902618175;5360.276362691065;5390.865228369322;4539.500654927955;4611.008633143891;4612.400387949545;4654.743989080565;4681.836135735233;5701.059325211377;5711.057675483582;5726.427357264323;5726.685032323262;5741.62679425836;6651.43462805667;6747.932520674829;6750.1224840771365;6757.054012438262;6771.424428923498;5812.331581868055;5821.330546987066;5828.475437210672;5838.474537291664;5849.268841394825;5821.301443826683;5824.825255242349;5906.8818623627285;5912.231409916683;5926.8814623707285;6268.811935641938;6345.365463453618;6556.442702370352;6630.038644396535;6647.933520664731;6651.33486651331;6684.598924064571;6771.62756048422;6852.828679283058;6867.381935625817;6511.837204069747;6587;6620.040094186413;6626.635535045619;6633.170853643294;6707.631080290631;6767.89848152288;6770.187577490733;6777.796666100025;6785.1518560179975;6828.897566536605;6831.316868313129;6854.691538880663;6925.065116209449;6946.479014073863;6358.713857876314;6474.805755827333;6500.934990650033;6595.1096601958125;6597.571157874723;6523.380278873499;6606.141201643755;6616.867662646817;6624.370684784938;6649.767258145942;6488.091667166695;6513.120728701565;6581.638009909309;6603.174603174603;6608;6665.100211471389;6675.632840193836;6716.899246511209;6742.9662851685425;6749.932500675127;6219.906701399392;6341;6356.872862542816;6438.130852334875;6456.54804163704 05:44:55 INFO - PID 6114 | |1;ext.html;810.2221867007672;834.9332053435726;836.686242659003;838.0404436919727;839.2866063845736;38588.421173682385;38725.80637096814;41656.58343416565;41696.374554381706;41967.790161049226;38751.418728719094;39252.21495570087;39357.409638855366;39386;39412;7165.9283407165785;7267.7819665410125;7276.381507571863;7546.584937828417;8157.102718700939;8006.719764808233;8073.11195768465;8085.3127484163915;8103.3922455815755;8107.675692972303;8074.475159114668;8092.028956525225;8137.918620813805;8142.267195952363;8144.837103257932;8002.119766825645;8033.437659363847;8050.15473375293;8051.758447246592;8082;7937.404694647925;7997.880031799527;8017;8024.719134830311;8029.076656184555;39275.803620981715;39635;39751;39755.403668944986;39820.60179398198;3522.876699315512;3526.9294614107575;3538.080099174233;3539.50446937429;3556.1643013891717;32106.678933210602;32340.353192936243;32359.83820080908;32534.674653253638;32576.83711581427;5074.949250507485;5227.451117632631;5238.5023422774775;5278.445763194848;5352.304200453955;195081;195113;195797;195991;197068.01465992723;48388.27417588739;48698.75650621724;49464.50535494671;50030.24954625683;50139.74930125326;51986;51993.7400312996;52027.47972520302;52087.21869171965;52153.73923130436;16446;16568.502944911674;16593.087380194203;16600.086995215137;16604.335826566803;13577.932110339385;13582.932085339708;13605.047646664638;13605.659858503419;13745.312734363242;14133.78799318011;14265.857341426661;14292.21392823384;14392.496262630757;14418.279086045655;5557.221988921554;5571.637843540238;5634.352049514277;5662.716864156858;5716.828495145069;1009.0968583118215;1020.7754294055296;1024.0936770957608;1032.6127702111708;1037.4501514197486;23159.53680926372;23390.298291051295;23406.297811065695;23486.530269394516;23693.7630623695;1128.7121783945042;1129.757102223026;1130.6438471881331;1136.1478890831877;1136.63059505661;12371.13402061865;12388.194767340094;12405.379731013414;12433.875661243272;12484.875151248552;248501;249530;249822;249866;251421;53722.73138634282;53941.46058539443;54035;54082.729586351816;54303.72848135734;1300.90243231758;1444.4366696988184;1462.6928345047659;1483.7329280729573;1491.4630732936134;21376.465588360414;27578;27584.138220648725;28072.85963570169;28108.71891281061;49437.75281123571;49852;50109;50131.49868501268;50212.246816297054;201419;203569;203988;205068;207331;34058.82970585131;34089.82955085209;34151.31697366088;34316.31367372689;34462.13844653904;41822.163556729305;42769;43301.56698432975;43797.34303985379;44349.55650443583;31582;31582.210444738146;31658.683413166495;31860;32568.674313256564;31039.689603104584;31557.211069723442;31594.526082109245;31685.36629267448;31754;35220.823895880356;35272.47091293684;35474.82262588774;35557.82221088878;35692.28615427729;30594.847025764728;30727;30807.2298192547;30870.69129308678;31413.528797067604;23095.6535651962;23229;23331.416714582272;23403;23476.882615586812 05:44:55 INFO - PID 6114 | |2;jquery.html;583.8803045375698;585.3960149191217;593.8657164815204;602.7619090459268;605.9060845568938;22066.779332206672;22912.198073067448;22930.082796688155;22980.1956931507;22980.88509557452;23641.763582364172;24107;24431.144909928156;24679.629805552886;24754.628680569807;6583.210014798219;6781.186257649089;6800.897986530206;6809.761658341959;6811.557248778813;6462.450691691189;6556.213254409454;6756.2568117507035;6761.763338283161;6768.458523318147;6733.8316542086595;6739.966300168492;6740.359665831738;6762.594244345355;6764.729410823561;6457.547971641987;6731.697073631673;6742.426893714065;6758;6770.627615481147;6252.843678908018;6257.499400047986;6291.276503202144;6298.2442106947;6310.9368906311265;28407.715922840714;28948.710512894813;28956.42087158266;29023.854880725674;29076.418471630448;2021.5451523407262;2028.4320390290595;2037.5415531505441;2042.948926276855;2051.271798511522;18894.716579251322;19023.904880475646;19355.516112097168;19741.605167896563;19890.80109198904;2332.661764044221;2384.9046038158626;2386.4033991502124;2390.378501589599;2493.7880280176205;124297;130741;137776;145226;145483;14564.199152437446;14622.488212912709;14908.701825963637;14942.103473791607;15081.245937703072;23408.297751067494;23423.882880585486;23510.29469115929;23585.7641423587;23604.29187124389;10333.328333658288;10490;10533.473326333653;10621.362718236931;10637.627683031056;9733.805323893483;9771.853422198672;9815.263855210746;9844.261680373857;9854.950725246328;8653.524056176971;9140;9141.588628511732;9291.95354023239;9323.067693230623;2607.478504299148;2618.5155746187015;2770.1827960751225;2779.4163225722823;2789.2887313735273;955.8136163448061;961.6201600367815;963.9733683626915;966.8356379415517;981.906718861707;19159.904200478908;19323.51691207731;19348.516287092654;19491.12289946956;19857.404277871687;993.3543196922059;1010.8880231745021;1018.0786388318584;1038.2991480750463;1052.1057101463696;10647.041766241075;10704.791221091904;10825.188110891715;10857.294275872044;10947.56209751617;421993;428173;436412;445107;448757;115840;116432.83567164389;119446.40276798561;121030;121042;1159.1306520109918;1178.4932479034098;1179.280638810325;1182.3615247766281;1183.1599564309436;17169.91415042917;17384.913075434542;17400.303987840853;17506.562335941195;17635.55911102233;54921.626959326335;55645;55772.442275578345;55801.88396231971;57195.14207286977;68996.6550167246;69358;69700.30299697141;69769.30230697629;70301.64849175926;14108.788368174692;14509.637259068608;14620.268986550842;14620.342084606005;14625.0493717908;22240.44398889976;22316.10735570559;22362.552748945254;22367.65794052362;22430.775692243522;17610.29558817633;17864;18229.45311640653;18267.817321826613;18313.3590324338;14674.63313417173;14758.926205369335;15529.068255904682;15931.601709957344;16955.406560770312;17304.221310040826;18233.726494102335;18489.260429582668;18508.81491185071;18563;14293.213873237071;14304.642383940485;14423.855761442252;14424.350904209126;14454.855451445352;17531.737023944905;17665.116744163;17815.198316075548;17947;18003.18985645623 05:44:55 INFO - PID 6114 | |3;mootools.html;1344.2606566388488;1383.5295999360221;1405.0445696926085;1410.471073347494;1413.7949997250396;15031.699366012686;15445;16532;16551.337946482156;16614.169291535436;15983.041017538955;16148;16244.75632865505;16245.51263462095;16290.26693798779;2692.3538350795866;2778.8054836161427;2820.2667306500357;2827.886884524627;2909.0690978886764;2865.627468429101;2897.203269100993;2897.290163909845;2897.4929387357233;2898.7536059434974;2678.34380576758;2693.0843513205505;2734.0567504211117;2775.1258353618546;2826.1521543536855;2551.617257411385;2600.3759097816483;2698.932526686829;2757.9586306205224;2761.240658818821;2676.330917270682;2694.6362241097595;2696.083331667223;2696.8516731579757;2699.838009719423;15117.924410377987;15143.848561514464;15331.310091045929;15341.232938353149;15353.769693454607;8042.115367309591;8340.249377555989;8345.41582089254;8376.455530390565;8379.45533540318;5382;5499.477549632778;5546.4453554644615;5666.773329066832;5682.318121825408;1940.2723978508059;1997.530580313625;2006.518435575466;2068.700038494425;2078.418042947977;24990.875045624838;25241.87379063093;27551.44897102067;28244.293892652644;28248.435031299465;6917.619530925746;7089.645517724093;7104.822379440452;7210.747623833246;7286.870535067073;17672.823271767375;17683;17717.645647086985;17771.911140444216;17809.910950445166;8011.639476223584;8244.093149753522;8245.711400100967;8252.793680158044;8256.050554186226;7584.089909210819;7584.658690358947;7603.46775725705;7656.272654097852;7670;5222.1383471727495;5292.44429334922;5331.813386531453;5375.838724838261;5411.540019098342;1603.5670369000538;1605.2615796733633;1614.6124930016947;1619.7084524785653;1630.2582325042076;875.2866413872673;892.8571428571397;902.7788191893028;912.2838571721167;914.9542522873829;7374.668139933716;7409.629518524052;7440.85118297631;7457.627118644046;7464.141623713343;733.7211859493465;737.4469148138896;741.2402287655088;750.4446709434978;760.6843160088612;5191.273221748958;5226.712530810842;5274.92087618686;5289.100852855024;5416.8104116355735;21815.454613634785;22578.322650320188;22708.545829083658;22916.083356665546;22953.7704622955;21514.56970860574;21997.890010550163;22086.668699969512;22626.886865565568;22937.19719809832;11117.27737697047;11250.437478126061;11295.491702873554;11305.773884522428;11382.94308528452;8474.74575762728;8541.572921354033;8606.569671516525;8640.179182977607;8678.088800675838;18886.20820289917;19207.32774352891;19211.423657290303;19482.051794820403;19499.8050019498;19720.21119155275;20012.199512019357;20019.29932452357;20040;20108.59782804365;10988.670339889815;11090.390028548507;11188.944055279671;11192.216544841784;11196.048335891215;13840.169589824643;13840.653983650489;13912;13998.58004259833;14012;11568;11791;11902.107341949562;11946.76106477883;12106.515739370327;11223.270487418291;11261.549538018387;11521.193516453768;11711.180217385043;11869.52521899149;9999.20006399501;10004.699859004242;10022.799544009225;10045.799084018132;10051.49742512886;7038.436925046087;7062.540934839219;7116.893246601202;7186;7292.088488938883;7190.784276471505;7204.819879503054;7208.135023796968;7225.458090643117;7273.9636301818155 05:44:55 INFO - PID 6114 | |4;prototype.html;510.6782726882064;526.2579762534826;537.3685919045121;541.1422894711882;545.7489554804789;6299.590526615767;6348.873022539547;6361.459275961543;6407.622361192342;6425.357464253572;6295.622262664243;6330.145430366899;6339.5245356598325;6340.651264180468;6371.4584260337815;5226.738663066851;5248.186531087687;5251.527362537371;5285.127953887613;5289.497497737709;4898.951010489903;5069.797208111671;5199.454057323983;5258.342707161605;5258.368995720519;5017.673851199678;5037.143685573461;5058.49415058493;5059.772310246048;5071.239314102877;5056.671316364443;5062.367204099488;5072.847814565569;5089.46560611136;5095.566876815438;4396.89007774805;4521;4550.476695180064;4552.590266875997;4562.794674239667;6180.732949745291;6204.193454850885;6208.906866397007;6212.627242365427;6227.1282020517165;5757.884842303172;5788.479036886658;5799.36207017232;5811.535077193815;5813.883722325572;6538.103949854536;6591.35216195951;6628.701708423133;6651.66741662915;6656.207530577976;4760.5001474844985;4962.528559786814;4998.375203099613;5001.44984051754;5030.874228144289;6748.392644661955;6821.624810635413;6941.861162776716;6951.16586009677;6992.930070699279;5050.1667224908215;5107.514786095315;5112.463191364853;5112.897742045138;5124.333836601218;5104.3364362633365;5105.412877519133;5119.360079990001;5161.509656582619;5172.793088276427;5680.630759000652;5699.487046165865;5750.942490575125;5788.88422231553;5803.564732645069;6588.604683718992;6643.966780166165;6667.6666166691475;6680.5323627345615;6680.5991640501725;1770.849477794376;1775.2277759174801;1786.5265704588294;1797.8763272954404;1805.972910406345;1162.4304090995352;1226;1246.8067449545335;1250.4685508658965;1251.3993283224104;5641.407652196543;5726.627769194989;5756.625819321731;5773.509251713567;5786.88426231473;6648.96675516629;6713.462922966151;6761.763338283235;6836.760713375008;6863.347981941708;5550.196186239488;5602.330473539838;5747.913781293284;5777.595568310262;5786.739596718074;3619.1314084619503;3625.7672391387055;3633.8909832705062;3654.7624404413627;3656.2504686539196;6429.678516074177;6457.967710161419;6484.610923344614;6527.06282173024;6585.934140658628;6897.241303456716;7042.823929401806;7053.813317871476;7056.976738372907;7066.222715501291;6549.052926183142;6593;6602.240742314695;6627.801165965029;6653.534252602271;6615.735370585123;6716.29478904708;6747.865042699021;6753.797386078426;6800.251972282946;6685.966570167118;6731.697073631796;6750.1562304711915;6798.139330378803;6804.863902722017;6506.674666266573;6507.73969041252;6583.80248592543;6595.769148079794;6595.97762346837;5043.193089105725;5061.4432412435335;5095.974520127375;5106.2595923590125;5134.922976155286;6523.6738163092605;6533.216014078341;6677.3656502632175;6916.930830691628;6976.895346569907;6543.149390579194;6604.900926486011;6612.768553100618;6629.138212032405;6721.697523611351;6503.041116291981;6544.5418820684;6574.967125164344;6579.243387010363;6661.634364955075;6299.842503937438;6406.13517175194;6431.678416079084;6444.613323200623;6472.255690595642;6657.633830139389;6671.099401580725;6683.899741503784;6743.258241593323;6773;6308.243010838729;6384.87230255383;6450.967745161244;6460.806175814733;6519.7392104315295 05:44:55 INFO - PID 6114 | |5;yui.html;888.6223355074096;901.3960646366934;908.9227415669668;923.473620036579;924.7688077980503;18060.63878722425;19350.516237094078;20282;20323;20353.185872565096;16509.91745041273;16949.406770763027;17093.743593846102;17449.040302783374;21957;974.6393834281325;976.5605477535103;983.3952119446525;985.7141428985585;985.8521221816749;953.3803028031765;964.03114869556;965;965.0253244223314;967.274544091931;982.8181786369545;1028.4497793680382;1032.3960483117385;1036.4144258493964;1037.6627596031283;1024.533837104116;1029.3360782295415;1029.552144817007;1030.0317701360734;1030.0780801182975;744.9217832127657;748.8914107454443;749.0487081406637;754.2871985973258;754.336184157943;19779.703304450446;20054.997250137436;20135.697964530544;20433.69349459759;20443.38669839907;21780;21874.89062554677;22490.55018899629;22501.54996900069;22511.54976900469;17931.820681793146;17953.461396158134;17963.101844907702;18004.54988625282;18073.909630451762;3776.433534969749;3782.7730336179916;3803.6576708096127;3823.9044023899346;3839.4816699745456;135636;140329;140414.29792851073;143084;143181.28409357992;16915.407960721317;17228.224729886933;17299.048552329492;17304.480865574053;17626.91186544059;30738.38523229523;31272.843635781675;31280.84359578233;31345.843270783957;31378.372432551678;8044.557549334842;8114.350851931831;8291.626876790559;8350.66597336112;8370.958145209235;4201.537830838605;4268.487781466244;4269.829206831692;4273.059926816096;4277.315629499265;5454.781808727606;5534;5566.777328906879;5570.41510641385;5592.217089607459;1003.8795344558554;1010.3180353261666;1024.5235965276183;1025.4462590201356;1025.661531694539;682.0451368084721;692.4771797293012;698.8218004408843;713.3472872321871;714.3071220915704;11893.691693913663;12201.633950981484;12336.444859981322;13289.66775830612;13435.731285374433;688.3151264491762;692.8475735338218;697.3723648716197;709.4076446167405;710.5168485429854;5787.39232380594;5885.61743486672;5934.732937017845;5963.642181469126;5981.790637327673;121868;126061;126170;127045;128301;112526;112544.99999999836;114316;114889.42555287338;115488;95485;96980;98052.50973745086;100326.49836750915;100857.49571252096;10881.292715973437;10940.452977350942;11374.260673056226;11530.769384612093;11667.183297169457;44853.9999999987;45173.54826451693;45635.77182114068;46550.767246164905;46853.53146468628;57187;57457.42542574688;58332.70833645974;59064.70467647806;59705.701471492364;16135.75796363079;16394.426195083113;16430.67138657244;16554.58613534671;16608.501744947673;18287.725684114484;18470.168842401854;18471.353502627342;18587.34944276944;18710.53223669419;15714.764278535602;15768.448104316294;15810.68378632398;16016.439424620083;16052.598685032968;15882.444114455939;15961.600959976093;16105.597360066093;16265.756013659568;16290.67418651644;14580.562583122522;14900;14935.775963360342;15057;15063.472778452702;10988.780224395307;11176.832347514957;11263.605773797877;11325.037371823159;11351.432428378714;11948.701282468008;12083.456244469196;12127.272363657856;12568;12732.745345093232 05:44:55 INFO - PID 6114 | __end_tp_report 05:44:55 INFO - PID 6114 | __start_cc_report 05:44:55 INFO - PID 6114 | _x_x_mozilla_cycle_collect,282 05:44:55 INFO - PID 6114 | __end_cc_report 05:44:55 INFO - PID 6114 | __startTimestamp1506689095032__endTimestamp 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | ------- Summary: start ------- 05:44:55 INFO - PID 6114 | Number of tests: 6 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#0] dojo.html Cycles:165 Average:6206.60 Median:6456.55 stddev:837.13 (13.0%) stddev-sans-first:806.12 05:44:55 INFO - PID 6114 | Values: 3214.5 3220.6 3229.0 3241.1 3261.2 6182.0 6275.5 6302.5 6329.7 6410.7 6216.4 6246.2 6280.9 6284.2 6292.7 5824.0 5891.4 5917.8 5919.1 5936.6 5882.5 5929.6 5933.5 5963.5 5964.9 1247.8 5740.0 5765.4 5887.1 5914.2 5796.8 5845.1 5901.0 5925.3 5927.8 5810.3 5817.3 5887.1 5895.1 5904.8 6208.6 6224.3 6367.1 6389.5 6394.3 6614.4 6785.6 6804.6 6880.6 6902.1 6753.3 6756.2 6759.6 6761.7 6769.5 6177.4 6259.5 6262.6 6306.7 6400.2 7048.6 7095.1 7099.4 7125.4 7144.2 6699.1 6707.1 6745.0 6770.5 6773.0 6552.9 6703.8 6713.6 6719.7 6775.3 6599.4 6600.2 6664.7 6685.7 6795.5 6811.2 6817.5 6825.7 6833.7 6837.2 5281.4 5282.3 5356.3 5360.3 5390.9 4539.5 4611.0 4612.4 4654.7 4681.8 5701.1 5711.1 5726.4 5726.7 5741.6 6651.4 6747.9 6750.1 6757.1 6771.4 5812.3 5821.3 5828.5 5838.5 5849.3 5821.3 5824.8 5906.9 5912.2 5926.9 6268.8 6345.4 6556.4 6630.0 6647.9 6651.3 6684.6 6771.6 6852.8 6867.4 6511.8 6587.0 6620.0 6626.6 6633.2 6707.6 6767.9 6770.2 6777.8 6785.2 6828.9 6831.3 6854.7 6925.1 6946.5 6358.7 6474.8 6500.9 6595.1 6597.6 6523.4 6606.1 6616.9 6624.4 6649.8 6488.1 6513.1 6581.6 6603.2 6608.0 6665.1 6675.6 6716.9 6743.0 6749.9 6219.9 6341.0 6356.9 6438.1 6456.5 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#1] ext.html Cycles:180 Average:38969.92 Median:19371.85 stddev:56541.67 (291.9%) stddev-sans-first:56627.69 05:44:55 INFO - PID 6114 | Values: 810.2 834.9 836.7 838.0 839.3 38588.4 38725.8 41656.6 41696.4 41967.8 38751.4 39252.2 39357.4 39386.0 39412.0 7165.9 7267.8 7276.4 7546.6 8157.1 8006.7 8073.1 8085.3 8103.4 8107.7 8074.5 8092.0 8137.9 8142.3 8144.8 8002.1 8033.4 8050.2 8051.8 8082.0 7937.4 7997.9 8017.0 8024.7 8029.1 39275.8 39635.0 39751.0 39755.4 39820.6 3522.9 3526.9 3538.1 3539.5 3556.2 32106.7 32340.4 32359.8 32534.7 32576.8 5074.9 5227.5 5238.5 5278.4 5352.3 195081.0 195113.0 195797.0 195991.0 197068.0 48388.3 48698.8 49464.5 50030.2 50139.7 51986.0 51993.7 52027.5 52087.2 52153.7 16446.0 16568.5 16593.1 16600.1 16604.3 13577.9 13582.9 13605.0 13605.7 13745.3 14133.8 14265.9 14292.2 14392.5 14418.3 5557.2 5571.6 5634.4 5662.7 5716.8 1009.1 1020.8 1024.1 1032.6 1037.5 23159.5 23390.3 23406.3 23486.5 23693.8 1128.7 1129.8 1130.6 1136.1 1136.6 12371.1 12388.2 12405.4 12433.9 12484.9 248501.0 249530.0 249822.0 249866.0 251421.0 53722.7 53941.5 54035.0 54082.7 54303.7 1300.9 1444.4 1462.7 1483.7 1491.5 21376.5 27578.0 27584.1 28072.9 28108.7 49437.8 49852.0 50109.0 50131.5 50212.2 201419.0 203569.0 203988.0 205068.0 207331.0 34058.8 34089.8 34151.3 34316.3 34462.1 41822.2 42769.0 43301.6 43797.3 44349.6 31582.0 31582.2 31658.7 31860.0 32568.7 31039.7 31557.2 31594.5 31685.4 31754.0 35220.8 35272.5 35474.8 35557.8 35692.3 30594.8 30727.0 30807.2 30870.7 31413.5 23095.7 23229.0 23331.4 23403.0 23476.9 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#2] jquery.html Cycles:180 Average:33131.41 Median:22921.14 stddev:74396.45 (324.6%) stddev-sans-first:74565.01 05:44:55 INFO - PID 6114 | Values: 583.9 585.4 593.9 602.8 605.9 22066.8 22912.2 22930.1 22980.2 22980.9 23641.8 24107.0 24431.1 24679.6 24754.6 6583.2 6781.2 6800.9 6809.8 6811.6 6462.5 6556.2 6756.3 6761.8 6768.5 6733.8 6740.0 6740.4 6762.6 6764.7 6457.5 6731.7 6742.4 6758.0 6770.6 6252.8 6257.5 6291.3 6298.2 6310.9 28407.7 28948.7 28956.4 29023.9 29076.4 2021.5 2028.4 2037.5 2042.9 2051.3 18894.7 19023.9 19355.5 19741.6 19890.8 2332.7 2384.9 2386.4 2390.4 2493.8 124297.0 130741.0 137776.0 145226.0 145483.0 14564.2 14622.5 14908.7 14942.1 15081.2 23408.3 23423.9 23510.3 23585.8 23604.3 10333.3 10490.0 10533.5 10621.4 10637.6 9733.8 9771.9 9815.3 9844.3 9855.0 8653.5 9140.0 9141.6 9292.0 9323.1 2607.5 2618.5 2770.2 2779.4 2789.3 955.8 961.6 964.0 966.8 981.9 19159.9 19323.5 19348.5 19491.1 19857.4 993.4 1010.9 1018.1 1038.3 1052.1 10647.0 10704.8 10825.2 10857.3 10947.6 421993.0 428173.0 436412.0 445107.0 448757.0 115840.0 116432.8 119446.4 121030.0 121042.0 1159.1 1178.5 1179.3 1182.4 1183.2 17169.9 17384.9 17400.3 17506.6 17635.6 54921.6 55645.0 55772.4 55801.9 57195.1 68996.7 69358.0 69700.3 69769.3 70301.6 14108.8 14509.6 14620.3 14620.3 14625.0 22240.4 22316.1 22362.6 22367.7 22430.8 17610.3 17864.0 18229.5 18267.8 18313.4 14674.6 14758.9 15529.1 15931.6 16955.4 17304.2 18233.7 18489.3 18508.8 18563.0 14293.2 14304.6 14423.9 14424.4 14454.9 17531.7 17665.1 17815.2 17947.0 18003.2 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#3] mootools.html Cycles:180 Average:9558.52 Median:2692.72 stddev:6905.41 (256.4%) stddev-sans-first:6897.20 05:44:55 INFO - PID 6114 | Values: 1344.3 1383.5 1405.0 1410.5 1413.8 15031.7 15445.0 16532.0 16551.3 16614.2 15983.0 16148.0 16244.8 16245.5 16290.3 2692.4 2778.8 2820.3 2827.9 2909.1 2865.6 2897.2 2897.3 2897.5 2898.8 2678.3 2693.1 2734.1 2775.1 2826.2 2551.6 2600.4 2698.9 2758.0 2761.2 2676.3 2694.6 2696.1 2696.9 2699.8 15117.9 15143.8 15331.3 15341.2 15353.8 8042.1 8340.2 8345.4 8376.5 8379.5 5382.0 5499.5 5546.4 5666.8 5682.3 1940.3 1997.5 2006.5 2068.7 2078.4 24990.9 25241.9 27551.4 28244.3 28248.4 6917.6 7089.6 7104.8 7210.7 7286.9 17672.8 17683.0 17717.6 17771.9 17809.9 8011.6 8244.1 8245.7 8252.8 8256.1 7584.1 7584.7 7603.5 7656.3 7670.0 5222.1 5292.4 5331.8 5375.8 5411.5 1603.6 1605.3 1614.6 1619.7 1630.3 875.3 892.9 902.8 912.3 915.0 7374.7 7409.6 7440.9 7457.6 7464.1 733.7 737.4 741.2 750.4 760.7 5191.3 5226.7 5274.9 5289.1 5416.8 21815.5 22578.3 22708.5 22916.1 22953.8 21514.6 21997.9 22086.7 22626.9 22937.2 11117.3 11250.4 11295.5 11305.8 11382.9 8474.7 8541.6 8606.6 8640.2 8678.1 18886.2 19207.3 19211.4 19482.1 19499.8 19720.2 20012.2 20019.3 20040.0 20108.6 10988.7 11090.4 11188.9 11192.2 11196.0 13840.2 13840.7 13912.0 13998.6 14012.0 11568.0 11791.0 11902.1 11946.8 12106.5 11223.3 11261.5 11521.2 11711.2 11869.5 9999.2 10004.7 10022.8 10045.8 10051.5 7038.4 7062.5 7116.9 7186.0 7292.1 7190.8 7204.8 7208.1 7225.5 7274.0 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#4] prototype.html Cycles:180 Average:5581.23 Median:6297.61 stddev:1554.17 (24.7%) stddev-sans-first:1511.21 05:44:55 INFO - PID 6114 | Values: 510.7 526.3 537.4 541.1 545.7 6299.6 6348.9 6361.5 6407.6 6425.4 6295.6 6330.1 6339.5 6340.7 6371.5 5226.7 5248.2 5251.5 5285.1 5289.5 4899.0 5069.8 5199.5 5258.3 5258.4 5017.7 5037.1 5058.5 5059.8 5071.2 5056.7 5062.4 5072.8 5089.5 5095.6 4396.9 4521.0 4550.5 4552.6 4562.8 6180.7 6204.2 6208.9 6212.6 6227.1 5757.9 5788.5 5799.4 5811.5 5813.9 6538.1 6591.4 6628.7 6651.7 6656.2 4760.5 4962.5 4998.4 5001.4 5030.9 6748.4 6821.6 6941.9 6951.2 6992.9 5050.2 5107.5 5112.5 5112.9 5124.3 5104.3 5105.4 5119.4 5161.5 5172.8 5680.6 5699.5 5750.9 5788.9 5803.6 6588.6 6644.0 6667.7 6680.5 6680.6 1770.8 1775.2 1786.5 1797.9 1806.0 1162.4 1226.0 1246.8 1250.5 1251.4 5641.4 5726.6 5756.6 5773.5 5786.9 6649.0 6713.5 6761.8 6836.8 6863.3 5550.2 5602.3 5747.9 5777.6 5786.7 3619.1 3625.8 3633.9 3654.8 3656.3 6429.7 6458.0 6484.6 6527.1 6585.9 6897.2 7042.8 7053.8 7057.0 7066.2 6549.1 6593.0 6602.2 6627.8 6653.5 6615.7 6716.3 6747.9 6753.8 6800.3 6686.0 6731.7 6750.2 6798.1 6804.9 6506.7 6507.7 6583.8 6595.8 6596.0 5043.2 5061.4 5096.0 5106.3 5134.9 6523.7 6533.2 6677.4 6916.9 6976.9 6543.1 6604.9 6612.8 6629.1 6721.7 6503.0 6544.5 6575.0 6579.2 6661.6 6299.8 6406.1 6431.7 6444.6 6472.3 6657.6 6671.1 6683.9 6743.3 6773.0 6308.2 6384.9 6451.0 6460.8 6519.7 05:44:55 INFO - PID 6114 | 05:44:55 INFO - PID 6114 | [#5] yui.html Cycles:180 Average:24846.26 Median:19030.52 stddev:36174.34 (190.1%) stddev-sans-first:36231.09 05:44:55 INFO - PID 6114 | Values: 888.6 901.4 908.9 923.5 924.8 18060.6 19350.5 20282.0 20323.0 20353.2 16509.9 16949.4 17093.7 17449.0 21957.0 974.6 976.6 983.4 985.7 985.9 953.4 964.0 965.0 965.0 967.3 982.8 1028.4 1032.4 1036.4 1037.7 1024.5 1029.3 1029.6 1030.0 1030.1 744.9 748.9 749.0 754.3 754.3 19779.7 20055.0 20135.7 20433.7 20443.4 21780.0 21874.9 22490.6 22501.5 22511.5 17931.8 17953.5 17963.1 18004.5 18073.9 3776.4 3782.8 3803.7 3823.9 3839.5 135636.0 140329.0 140414.3 143084.0 143181.3 16915.4 17228.2 17299.0 17304.5 17626.9 30738.4 31272.8 31280.8 31345.8 31378.4 8044.6 8114.4 8291.6 8350.7 8371.0 4201.5 4268.5 4269.8 4273.1 4277.3 5454.8 5534.0 5566.8 5570.4 5592.2 1003.9 1010.3 1024.5 1025.4 1025.7 682.0 692.5 698.8 713.3 714.3 11893.7 12201.6 12336.4 13289.7 13435.7 688.3 692.8 697.4 709.4 710.5 5787.4 5885.6 5934.7 5963.6 5981.8 121868.0 126061.0 126170.0 127045.0 128301.0 112526.0 112545.0 114316.0 114889.4 115488.0 95485.0 96980.0 98052.5 100326.5 100857.5 10881.3 10940.5 11374.3 11530.8 11667.2 44854.0 45173.5 45635.8 46550.8 46853.5 57187.0 57457.4 58332.7 59064.7 59705.7 16135.8 16394.4 16430.7 16554.6 16608.5 18287.7 18470.2 18471.4 18587.3 18710.5 15714.8 15768.4 15810.7 16016.4 16052.6 15882.4 15961.6 16105.6 16265.8 16290.7 14580.6 14900.0 14935.8 15057.0 15063.5 10988.8 11176.8 11263.6 11325.0 11351.4 11948.7 12083.5 12127.3 12568.0 12732.7 05:44:55 INFO - PID 6114 | -------- Summary: end -------- 05:44:55 INFO - PID 6114 | 05:44:55 INFO - TEST-INFO | 6114: exit 0 05:44:55 INFO - TEST-OK | dromaeo_css | took 1109600ms 05:44:55 INFO - TEST-START | kraken 05:44:55 INFO - Initialising browser for kraken test... 05:44:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47613/getInfo.html -profile /tmp/tmpFXb9e7/profile 05:44:55 INFO - TEST-INFO | started process 6475 (/builds/slave/test/build/application/firefox/firefox http://localhost:47613/getInfo.html) 05:45:00 INFO - TEST-INFO | 6475: exit 0 05:45:00 INFO - Browser initialized. 05:45:00 INFO - Running cycle 1/1 for kraken test... 05:45:00 INFO - Using env: {'DISPLAY': ':0', 05:45:00 INFO - 'HOME': '/home/cltbld', 05:45:00 INFO - 'JSGC_DISABLE_POISONING': '1', 05:45:00 INFO - 'LANG': 'en_US.UTF-8', 05:45:00 INFO - 'LANGUAGE': 'en_US:en', 05:45:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:45:00 INFO - 'LOGNAME': 'cltbld', 05:45:00 INFO - 'MAIL': '/var/mail/cltbld', 05:45:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:00 INFO - 'MOZ_CRASHREPORTER': '1', 05:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:45:00 INFO - 'MOZ_NO_REMOTE': '1', 05:45:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:00 INFO - 'NO_EM_RESTART': '1', 05:45:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:00 INFO - 'PWD': '/builds/slave/test', 05:45:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:00 INFO - 'RUST_BACKTRACE': 'full', 05:45:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:45:00 INFO - 'SHELL': '/bin/bash', 05:45:00 INFO - 'SHLVL': '1', 05:45:00 INFO - 'STYLO_FORCE_DISABLED': '1', 05:45:00 INFO - 'TERM': 'linux', 05:45:00 INFO - 'TMOUT': '86400', 05:45:00 INFO - 'USER': 'cltbld', 05:45:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188', 05:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:00 INFO - '_': '/tools/buildbot/bin/python'} 05:45:00 INFO - TEST-INFO | started process 6710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFXb9e7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:01 INFO - PID 6710 | 05:45:01 INFO - PID 6710 | (/builds/slave/test/build/application/firefox/firefox:6759): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:45:01 INFO - PID 6710 | 05:45:12 INFO - PID 6710 | RSS: Main: 153243648 05:45:12 INFO - PID 6710 | 05:45:14 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47613/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:15 INFO - PID 6710 | RSS: Main: 160305152 05:45:15 INFO - PID 6710 | 05:45:18 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47613/tests/kraken/driver.html?testName=audio-dft) 05:45:18 INFO - PID 6710 | RSS: Main: 160514048 05:45:18 INFO - PID 6710 | 05:45:21 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47613/tests/kraken/driver.html?testName=audio-fft) 05:45:22 INFO - PID 6710 | RSS: Main: 156344320 05:45:22 INFO - PID 6710 | 05:45:24 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47613/tests/kraken/driver.html?testName=audio-oscillator) 05:45:25 INFO - PID 6710 | RSS: Main: 156499968 05:45:25 INFO - PID 6710 | 05:45:27 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:27 INFO - PID 6710 | RSS: Main: 156676096 05:45:27 INFO - PID 6710 | 05:45:31 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47613/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:31 INFO - PID 6710 | RSS: Main: 158965760 05:45:31 INFO - PID 6710 | 05:45:35 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47613/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:36 INFO - PID 6710 | RSS: Main: 159580160 05:45:36 INFO - PID 6710 | 05:45:39 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47613/tests/kraken/driver.html?testName=json-parse-financial) 05:45:39 INFO - PID 6710 | RSS: Main: 159477760 05:45:39 INFO - PID 6710 | 05:45:41 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:41 INFO - PID 6710 | RSS: Main: 159633408 05:45:41 INFO - PID 6710 | 05:45:43 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:44 INFO - PID 6710 | RSS: Main: 159645696 05:45:44 INFO - PID 6710 | 05:45:46 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:46 INFO - PID 6710 | RSS: Main: 156225536 05:45:46 INFO - PID 6710 | 05:45:49 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:50 INFO - PID 6710 | RSS: Main: 156749824 05:45:50 INFO - PID 6710 | 05:45:52 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:53 INFO - PID 6710 | RSS: Main: 156979200 05:45:53 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | Cycle 1(1): loaded http://localhost:47613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47613/tests/kraken/driver.html?testName=ai-astar) 05:45:55 INFO - PID 6710 | RSS: Main: 158216192 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | __start_tp_report 05:45:55 INFO - PID 6710 | _x_x_mozilla_page_load 05:45:55 INFO - PID 6710 | _x_x_mozilla_page_load_details 05:45:55 INFO - PID 6710 | |i|pagename|runs| 05:45:55 INFO - PID 6710 | |0;ai-astar;108;108;109;107;109;107;108;108;107;109 05:45:55 INFO - PID 6710 | |1;audio-beat-detection;117;114;116;116;115;116;115;119;119;116 05:45:55 INFO - PID 6710 | |2;audio-dft;165;163;164;163;161;163;166;167;164;165 05:45:55 INFO - PID 6710 | |3;audio-fft;74;75;75;73;73;73;81;73;73;73 05:45:55 INFO - PID 6710 | |4;audio-oscillator;80;78;79;78;79;79;82;78;78;78 05:45:55 INFO - PID 6710 | |5;imaging-gaussian-blur;117;112;112;111;111;117;111;111;112;112 05:45:55 INFO - PID 6710 | |6;imaging-darkroom;153;148;147;149;148;150;148;150;148;147 05:45:55 INFO - PID 6710 | |7;imaging-desaturate;95;94;94;94;95;94;94;96;94;94 05:45:55 INFO - PID 6710 | |8;json-parse-financial;52;50;51;52;51;54;53;52;54;52 05:45:55 INFO - PID 6710 | |9;json-stringify-tinderbox;36;37;37;36;37;37;36;37;38;37 05:45:55 INFO - PID 6710 | |10;stanford-crypto-aes;78;74;73;73;75;73;78;83;78;73 05:45:55 INFO - PID 6710 | |11;stanford-crypto-ccm;112;108;108;124;119;109;117;108;117;111 05:45:55 INFO - PID 6710 | |12;stanford-crypto-pbkdf2;171;160;157;165;158;161;168;164;162;165 05:45:55 INFO - PID 6710 | |13;stanford-crypto-sha256-iterative;63;66;66;73;65;65;64;62;63;64 05:45:55 INFO - PID 6710 | __end_tp_report 05:45:55 INFO - PID 6710 | __start_cc_report 05:45:55 INFO - PID 6710 | _x_x_mozilla_cycle_collect,783 05:45:55 INFO - PID 6710 | __end_cc_report 05:45:55 INFO - PID 6710 | __startTimestamp1506689155566__endTimestamp 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | ------- Summary: start ------- 05:45:55 INFO - PID 6710 | Number of tests: 14 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 05:45:55 INFO - PID 6710 | Values: 108.0 108.0 109.0 107.0 109.0 107.0 108.0 108.0 107.0 109.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:116.00 stddev:1.64 (1.4%) stddev-sans-first:1.72 05:45:55 INFO - PID 6710 | Values: 117.0 114.0 116.0 116.0 115.0 116.0 115.0 119.0 119.0 116.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.73 (1.1%) stddev-sans-first:1.80 05:45:55 INFO - PID 6710 | Values: 165.0 163.0 164.0 163.0 161.0 163.0 166.0 167.0 164.0 165.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#3] audio-fft Cycles:10 Average:74.30 Median:73.50 stddev:2.50 (3.4%) stddev-sans-first:2.65 05:45:55 INFO - PID 6710 | Values: 74.0 75.0 75.0 73.0 73.0 73.0 81.0 73.0 73.0 73.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:1.29 (1.6%) stddev-sans-first:1.30 05:45:55 INFO - PID 6710 | Values: 80.0 78.0 79.0 78.0 79.0 79.0 82.0 78.0 78.0 78.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#5] imaging-gaussian-blur Cycles:10 Average:112.60 Median:112.00 stddev:2.37 (2.1%) stddev-sans-first:1.90 05:45:55 INFO - PID 6710 | Values: 117.0 112.0 112.0 111.0 111.0 117.0 111.0 111.0 112.0 112.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.81 (1.2%) stddev-sans-first:1.12 05:45:55 INFO - PID 6710 | Values: 153.0 148.0 147.0 149.0 148.0 150.0 148.0 150.0 148.0 147.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:45:55 INFO - PID 6710 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 94.0 96.0 94.0 94.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.29 (2.5%) stddev-sans-first:1.36 05:45:55 INFO - PID 6710 | Values: 52.0 50.0 51.0 52.0 51.0 54.0 53.0 52.0 54.0 52.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.63 (1.7%) stddev-sans-first:0.60 05:45:55 INFO - PID 6710 | Values: 36.0 37.0 37.0 36.0 37.0 37.0 36.0 37.0 38.0 37.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.50 stddev:3.36 (4.4%) stddev-sans-first:3.47 05:45:55 INFO - PID 6710 | Values: 78.0 74.0 73.0 73.0 75.0 73.0 78.0 83.0 78.0 73.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:114.50 stddev:5.62 (4.9%) stddev-sans-first:5.94 05:45:55 INFO - PID 6710 | Values: 112.0 108.0 108.0 124.0 119.0 109.0 117.0 108.0 117.0 111.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.50 stddev:4.38 (2.7%) stddev-sans-first:3.60 05:45:55 INFO - PID 6710 | Values: 171.0 160.0 157.0 165.0 158.0 161.0 168.0 164.0 162.0 165.0 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:3.07 (4.7%) stddev-sans-first:3.16 05:45:55 INFO - PID 6710 | Values: 63.0 66.0 66.0 73.0 65.0 65.0 64.0 62.0 63.0 64.0 05:45:55 INFO - PID 6710 | -------- Summary: end -------- 05:45:55 INFO - PID 6710 | 05:45:55 INFO - PID 6710 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:45:56 INFO - TEST-INFO | 6710: exit 0 05:45:56 INFO - TEST-OK | kraken | took 60479ms 05:45:56 INFO - SUITE-END | took 1170s 05:45:56 INFO - Completed test suite (00:19:30) 05:45:56 INFO - javascript benchmark 05:45:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8593.977895688826, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.549963005179, 3220.5974253218346, 3229.0, 3241.1086951088464, 3261.249912520121, 6182.0, 6275.466585340251, 6302.527310451717, 6329.651869147195, 6410.679466026698, 6216.378362163781, 6246.187995560582, 6280.905786413207, 6284.245890493147, 6292.653904035276, 5824.009918313886, 5891.440313170242, 5917.792877249297, 5919.082542205965, 5936.554758393117, 5882.499987501046, 5929.644221346733, 5933.525317974551, 5963.522918166536, 5964.910526342108, 1247.7933570666412, 5740.024195886688, 5765.423457654243, 5887.058070708709, 5914.201582786355, 5796.768129274824, 5845.066250666458, 5900.97049514754, 5925.2889653241455, 5927.8221653350465, 5810.273715785527, 5817.331006934172, 5887.1463637772285, 5895.115732640095, 5904.822855314347, 6208.565400421972, 6224.315325314212, 6367.108604795332, 6389.4568961638315, 6394.296627370985, 6614.371634694697, 6785.59286442815, 6804.6257455839905, 6880.552764070369, 6902.137232845895, 6753.324667533257, 6756.189257289107, 6759.5606285591275, 6761.729530818761, 6769.458443324522, 6177.3822617738315, 6259.467945224661, 6262.5929314594405, 6306.716197771111, 6400.199975003125, 7048.577085374894, 7095.113110861143, 7099.396551293198, 7125.35871771543, 7144.1784194818265, 6699.095622091053, 6707.128073350434, 6744.966275168691, 6770.458363330922, 6773.0, 6552.934470655233, 6703.798886033427, 6713.630750308682, 6719.697613607399, 6775.322467753185, 6599.373059559334, 6600.240972288152, 6664.666766661648, 6685.699143538553, 6795.490338224653, 6811.182658081062, 6817.488688348294, 6825.69284382204, 6833.658317084126, 6837.213720422115, 5281.366236051622, 5282.286891269706, 5356.276902618175, 5360.276362691065, 5390.865228369322, 4539.500654927955, 4611.008633143891, 4612.400387949545, 4654.743989080565, 4681.836135735233, 5701.059325211377, 5711.057675483582, 5726.427357264323, 5726.685032323262, 5741.62679425836, 6651.43462805667, 6747.932520674829, 6750.1224840771365, 6757.054012438262, 6771.424428923498, 5812.331581868055, 5821.330546987066, 5828.475437210672, 5838.474537291664, 5849.268841394825, 5821.301443826683, 5824.825255242349, 5906.8818623627285, 5912.231409916683, 5926.8814623707285, 6268.811935641938, 6345.365463453618, 6556.442702370352, 6630.038644396535, 6647.933520664731, 6651.33486651331, 6684.598924064571, 6771.62756048422, 6852.828679283058, 6867.381935625817, 6511.837204069747, 6587.0, 6620.040094186413, 6626.635535045619, 6633.170853643294, 6707.631080290631, 6767.89848152288, 6770.187577490733, 6777.796666100025, 6785.1518560179975, 6828.897566536605, 6831.316868313129, 6854.691538880663, 6925.065116209449, 6946.479014073863, 6358.713857876314, 6474.805755827333, 6500.934990650033, 6595.1096601958125, 6597.571157874723, 6523.380278873499, 6606.141201643755, 6616.867662646817, 6624.370684784938, 6649.767258145942, 6488.091667166695, 6513.120728701565, 6581.638009909309, 6603.174603174603, 6608.0, 6665.100211471389, 6675.632840193836, 6716.899246511209, 6742.9662851685425, 6749.932500675127, 6219.906701399392, 6341.0, 6356.872862542816, 6438.130852334875, 6456.54804163704], "value": 6146.728201257006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.2221867007672, 834.9332053435726, 836.686242659003, 838.0404436919727, 839.2866063845736, 38588.421173682385, 38725.80637096814, 41656.58343416565, 41696.374554381706, 41967.790161049226, 38751.418728719094, 39252.21495570087, 39357.409638855366, 39386.0, 39412.0, 7165.9283407165785, 7267.7819665410125, 7276.381507571863, 7546.584937828417, 8157.102718700939, 8006.719764808233, 8073.11195768465, 8085.3127484163915, 8103.3922455815755, 8107.675692972303, 8074.475159114668, 8092.028956525225, 8137.918620813805, 8142.267195952363, 8144.837103257932, 8002.119766825645, 8033.437659363847, 8050.15473375293, 8051.758447246592, 8082.0, 7937.404694647925, 7997.880031799527, 8017.0, 8024.719134830311, 8029.076656184555, 39275.803620981715, 39635.0, 39751.0, 39755.403668944986, 39820.60179398198, 3522.876699315512, 3526.9294614107575, 3538.080099174233, 3539.50446937429, 3556.1643013891717, 32106.678933210602, 32340.353192936243, 32359.83820080908, 32534.674653253638, 32576.83711581427, 5074.949250507485, 5227.451117632631, 5238.5023422774775, 5278.445763194848, 5352.304200453955, 195081.0, 195113.0, 195797.0, 195991.0, 197068.01465992723, 48388.27417588739, 48698.75650621724, 49464.50535494671, 50030.24954625683, 50139.74930125326, 51986.0, 51993.7400312996, 52027.47972520302, 52087.21869171965, 52153.73923130436, 16446.0, 16568.502944911674, 16593.087380194203, 16600.086995215137, 16604.335826566803, 13577.932110339385, 13582.932085339708, 13605.047646664638, 13605.659858503419, 13745.312734363242, 14133.78799318011, 14265.857341426661, 14292.21392823384, 14392.496262630757, 14418.279086045655, 5557.221988921554, 5571.637843540238, 5634.352049514277, 5662.716864156858, 5716.828495145069, 1009.0968583118215, 1020.7754294055296, 1024.0936770957608, 1032.6127702111708, 1037.4501514197486, 23159.53680926372, 23390.298291051295, 23406.297811065695, 23486.530269394516, 23693.7630623695, 1128.7121783945042, 1129.757102223026, 1130.6438471881331, 1136.1478890831877, 1136.63059505661, 12371.13402061865, 12388.194767340094, 12405.379731013414, 12433.875661243272, 12484.875151248552, 248501.0, 249530.0, 249822.0, 249866.0, 251421.0, 53722.73138634282, 53941.46058539443, 54035.0, 54082.729586351816, 54303.72848135734, 1300.90243231758, 1444.4366696988184, 1462.6928345047659, 1483.7329280729573, 1491.4630732936134, 21376.465588360414, 27578.0, 27584.138220648725, 28072.85963570169, 28108.71891281061, 49437.75281123571, 49852.0, 50109.0, 50131.49868501268, 50212.246816297054, 201419.0, 203569.0, 203988.0, 205068.0, 207331.0, 34058.82970585131, 34089.82955085209, 34151.31697366088, 34316.31367372689, 34462.13844653904, 41822.163556729305, 42769.0, 43301.56698432975, 43797.34303985379, 44349.55650443583, 31582.0, 31582.210444738146, 31658.683413166495, 31860.0, 32568.674313256564, 31039.689603104584, 31557.211069723442, 31594.526082109245, 31685.36629267448, 31754.0, 35220.823895880356, 35272.47091293684, 35474.82262588774, 35557.82221088878, 35692.28615427729, 30594.847025764728, 30727.0, 30807.2298192547, 30870.69129308678, 31413.528797067604, 23095.6535651962, 23229.0, 23331.416714582272, 23403.0, 23476.882615586812], "value": 17540.952090177234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8803045375698, 585.3960149191217, 593.8657164815204, 602.7619090459268, 605.9060845568938, 22066.779332206672, 22912.198073067448, 22930.082796688155, 22980.1956931507, 22980.88509557452, 23641.763582364172, 24107.0, 24431.144909928156, 24679.629805552886, 24754.628680569807, 6583.210014798219, 6781.186257649089, 6800.897986530206, 6809.761658341959, 6811.557248778813, 6462.450691691189, 6556.213254409454, 6756.2568117507035, 6761.763338283161, 6768.458523318147, 6733.8316542086595, 6739.966300168492, 6740.359665831738, 6762.594244345355, 6764.729410823561, 6457.547971641987, 6731.697073631673, 6742.426893714065, 6758.0, 6770.627615481147, 6252.843678908018, 6257.499400047986, 6291.276503202144, 6298.2442106947, 6310.9368906311265, 28407.715922840714, 28948.710512894813, 28956.42087158266, 29023.854880725674, 29076.418471630448, 2021.5451523407262, 2028.4320390290595, 2037.5415531505441, 2042.948926276855, 2051.271798511522, 18894.716579251322, 19023.904880475646, 19355.516112097168, 19741.605167896563, 19890.80109198904, 2332.661764044221, 2384.9046038158626, 2386.4033991502124, 2390.378501589599, 2493.7880280176205, 124297.0, 130741.0, 137776.0, 145226.0, 145483.0, 14564.199152437446, 14622.488212912709, 14908.701825963637, 14942.103473791607, 15081.245937703072, 23408.297751067494, 23423.882880585486, 23510.29469115929, 23585.7641423587, 23604.29187124389, 10333.328333658288, 10490.0, 10533.473326333653, 10621.362718236931, 10637.627683031056, 9733.805323893483, 9771.853422198672, 9815.263855210746, 9844.261680373857, 9854.950725246328, 8653.524056176971, 9140.0, 9141.588628511732, 9291.95354023239, 9323.067693230623, 2607.478504299148, 2618.5155746187015, 2770.1827960751225, 2779.4163225722823, 2789.2887313735273, 955.8136163448061, 961.6201600367815, 963.9733683626915, 966.8356379415517, 981.906718861707, 19159.904200478908, 19323.51691207731, 19348.516287092654, 19491.12289946956, 19857.404277871687, 993.3543196922059, 1010.8880231745021, 1018.0786388318584, 1038.2991480750463, 1052.1057101463696, 10647.041766241075, 10704.791221091904, 10825.188110891715, 10857.294275872044, 10947.56209751617, 421993.0, 428173.0, 436412.0, 445107.0, 448757.0, 115840.0, 116432.83567164389, 119446.40276798561, 121030.0, 121042.0, 1159.1306520109918, 1178.4932479034098, 1179.280638810325, 1182.3615247766281, 1183.1599564309436, 17169.91415042917, 17384.913075434542, 17400.303987840853, 17506.562335941195, 17635.55911102233, 54921.626959326335, 55645.0, 55772.442275578345, 55801.88396231971, 57195.14207286977, 68996.6550167246, 69358.0, 69700.30299697141, 69769.30230697629, 70301.64849175926, 14108.788368174692, 14509.637259068608, 14620.268986550842, 14620.342084606005, 14625.0493717908, 22240.44398889976, 22316.10735570559, 22362.552748945254, 22367.65794052362, 22430.775692243522, 17610.29558817633, 17864.0, 18229.45311640653, 18267.817321826613, 18313.3590324338, 14674.63313417173, 14758.926205369335, 15529.068255904682, 15931.601709957344, 16955.406560770312, 17304.221310040826, 18233.726494102335, 18489.260429582668, 18508.81491185071, 18563.0, 14293.213873237071, 14304.642383940485, 14423.855761442252, 14424.350904209126, 14454.855451445352, 17531.737023944905, 17665.116744163, 17815.198316075548, 17947.0, 18003.18985645623], "value": 11890.428325751489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.2606566388488, 1383.5295999360221, 1405.0445696926085, 1410.471073347494, 1413.7949997250396, 15031.699366012686, 15445.0, 16532.0, 16551.337946482156, 16614.169291535436, 15983.041017538955, 16148.0, 16244.75632865505, 16245.51263462095, 16290.26693798779, 2692.3538350795866, 2778.8054836161427, 2820.2667306500357, 2827.886884524627, 2909.0690978886764, 2865.627468429101, 2897.203269100993, 2897.290163909845, 2897.4929387357233, 2898.7536059434974, 2678.34380576758, 2693.0843513205505, 2734.0567504211117, 2775.1258353618546, 2826.1521543536855, 2551.617257411385, 2600.3759097816483, 2698.932526686829, 2757.9586306205224, 2761.240658818821, 2676.330917270682, 2694.6362241097595, 2696.083331667223, 2696.8516731579757, 2699.838009719423, 15117.924410377987, 15143.848561514464, 15331.310091045929, 15341.232938353149, 15353.769693454607, 8042.115367309591, 8340.249377555989, 8345.41582089254, 8376.455530390565, 8379.45533540318, 5382.0, 5499.477549632778, 5546.4453554644615, 5666.773329066832, 5682.318121825408, 1940.2723978508059, 1997.530580313625, 2006.518435575466, 2068.700038494425, 2078.418042947977, 24990.875045624838, 25241.87379063093, 27551.44897102067, 28244.293892652644, 28248.435031299465, 6917.619530925746, 7089.645517724093, 7104.822379440452, 7210.747623833246, 7286.870535067073, 17672.823271767375, 17683.0, 17717.645647086985, 17771.911140444216, 17809.910950445166, 8011.639476223584, 8244.093149753522, 8245.711400100967, 8252.793680158044, 8256.050554186226, 7584.089909210819, 7584.658690358947, 7603.46775725705, 7656.272654097852, 7670.0, 5222.1383471727495, 5292.44429334922, 5331.813386531453, 5375.838724838261, 5411.540019098342, 1603.5670369000538, 1605.2615796733633, 1614.6124930016947, 1619.7084524785653, 1630.2582325042076, 875.2866413872673, 892.8571428571397, 902.7788191893028, 912.2838571721167, 914.9542522873829, 7374.668139933716, 7409.629518524052, 7440.85118297631, 7457.627118644046, 7464.141623713343, 733.7211859493465, 737.4469148138896, 741.2402287655088, 750.4446709434978, 760.6843160088612, 5191.273221748958, 5226.712530810842, 5274.92087618686, 5289.100852855024, 5416.8104116355735, 21815.454613634785, 22578.322650320188, 22708.545829083658, 22916.083356665546, 22953.7704622955, 21514.56970860574, 21997.890010550163, 22086.668699969512, 22626.886865565568, 22937.19719809832, 11117.27737697047, 11250.437478126061, 11295.491702873554, 11305.773884522428, 11382.94308528452, 8474.74575762728, 8541.572921354033, 8606.569671516525, 8640.179182977607, 8678.088800675838, 18886.20820289917, 19207.32774352891, 19211.423657290303, 19482.051794820403, 19499.8050019498, 19720.21119155275, 20012.199512019357, 20019.29932452357, 20040.0, 20108.59782804365, 10988.670339889815, 11090.390028548507, 11188.944055279671, 11192.216544841784, 11196.048335891215, 13840.169589824643, 13840.653983650489, 13912.0, 13998.58004259833, 14012.0, 11568.0, 11791.0, 11902.107341949562, 11946.76106477883, 12106.515739370327, 11223.270487418291, 11261.549538018387, 11521.193516453768, 11711.180217385043, 11869.52521899149, 9999.20006399501, 10004.699859004242, 10022.799544009225, 10045.799084018132, 10051.49742512886, 7038.436925046087, 7062.540934839219, 7116.893246601202, 7186.0, 7292.088488938883, 7190.784276471505, 7204.819879503054, 7208.135023796968, 7225.458090643117, 7273.9636301818155], "value": 6772.53481604458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.6782726882064, 526.2579762534826, 537.3685919045121, 541.1422894711882, 545.7489554804789, 6299.590526615767, 6348.873022539547, 6361.459275961543, 6407.622361192342, 6425.357464253572, 6295.622262664243, 6330.145430366899, 6339.5245356598325, 6340.651264180468, 6371.4584260337815, 5226.738663066851, 5248.186531087687, 5251.527362537371, 5285.127953887613, 5289.497497737709, 4898.951010489903, 5069.797208111671, 5199.454057323983, 5258.342707161605, 5258.368995720519, 5017.673851199678, 5037.143685573461, 5058.49415058493, 5059.772310246048, 5071.239314102877, 5056.671316364443, 5062.367204099488, 5072.847814565569, 5089.46560611136, 5095.566876815438, 4396.89007774805, 4521.0, 4550.476695180064, 4552.590266875997, 4562.794674239667, 6180.732949745291, 6204.193454850885, 6208.906866397007, 6212.627242365427, 6227.1282020517165, 5757.884842303172, 5788.479036886658, 5799.36207017232, 5811.535077193815, 5813.883722325572, 6538.103949854536, 6591.35216195951, 6628.701708423133, 6651.66741662915, 6656.207530577976, 4760.5001474844985, 4962.528559786814, 4998.375203099613, 5001.44984051754, 5030.874228144289, 6748.392644661955, 6821.624810635413, 6941.861162776716, 6951.16586009677, 6992.930070699279, 5050.1667224908215, 5107.514786095315, 5112.463191364853, 5112.897742045138, 5124.333836601218, 5104.3364362633365, 5105.412877519133, 5119.360079990001, 5161.509656582619, 5172.793088276427, 5680.630759000652, 5699.487046165865, 5750.942490575125, 5788.88422231553, 5803.564732645069, 6588.604683718992, 6643.966780166165, 6667.6666166691475, 6680.5323627345615, 6680.5991640501725, 1770.849477794376, 1775.2277759174801, 1786.5265704588294, 1797.8763272954404, 1805.972910406345, 1162.4304090995352, 1226.0, 1246.8067449545335, 1250.4685508658965, 1251.3993283224104, 5641.407652196543, 5726.627769194989, 5756.625819321731, 5773.509251713567, 5786.88426231473, 6648.96675516629, 6713.462922966151, 6761.763338283235, 6836.760713375008, 6863.347981941708, 5550.196186239488, 5602.330473539838, 5747.913781293284, 5777.595568310262, 5786.739596718074, 3619.1314084619503, 3625.7672391387055, 3633.8909832705062, 3654.7624404413627, 3656.2504686539196, 6429.678516074177, 6457.967710161419, 6484.610923344614, 6527.06282173024, 6585.934140658628, 6897.241303456716, 7042.823929401806, 7053.813317871476, 7056.976738372907, 7066.222715501291, 6549.052926183142, 6593.0, 6602.240742314695, 6627.801165965029, 6653.534252602271, 6615.735370585123, 6716.29478904708, 6747.865042699021, 6753.797386078426, 6800.251972282946, 6685.966570167118, 6731.697073631796, 6750.1562304711915, 6798.139330378803, 6804.863902722017, 6506.674666266573, 6507.73969041252, 6583.80248592543, 6595.769148079794, 6595.97762346837, 5043.193089105725, 5061.4432412435335, 5095.974520127375, 5106.2595923590125, 5134.922976155286, 6523.6738163092605, 6533.216014078341, 6677.3656502632175, 6916.930830691628, 6976.895346569907, 6543.149390579194, 6604.900926486011, 6612.768553100618, 6629.138212032405, 6721.697523611351, 6503.041116291981, 6544.5418820684, 6574.967125164344, 6579.243387010363, 6661.634364955075, 6299.842503937438, 6406.13517175194, 6431.678416079084, 6444.613323200623, 6472.255690595642, 6657.633830139389, 6671.099401580725, 6683.899741503784, 6743.258241593323, 6773.0, 6308.243010838729, 6384.87230255383, 6450.967745161244, 6460.806175814733, 6519.7392104315295], "value": 5125.786803609919, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.6223355074096, 901.3960646366934, 908.9227415669668, 923.473620036579, 924.7688077980503, 18060.63878722425, 19350.516237094078, 20282.0, 20323.0, 20353.185872565096, 16509.91745041273, 16949.406770763027, 17093.743593846102, 17449.040302783374, 21957.0, 974.6393834281325, 976.5605477535103, 983.3952119446525, 985.7141428985585, 985.8521221816749, 953.3803028031765, 964.03114869556, 965.0, 965.0253244223314, 967.274544091931, 982.8181786369545, 1028.4497793680382, 1032.3960483117385, 1036.4144258493964, 1037.6627596031283, 1024.533837104116, 1029.3360782295415, 1029.552144817007, 1030.0317701360734, 1030.0780801182975, 744.9217832127657, 748.8914107454443, 749.0487081406637, 754.2871985973258, 754.336184157943, 19779.703304450446, 20054.997250137436, 20135.697964530544, 20433.69349459759, 20443.38669839907, 21780.0, 21874.89062554677, 22490.55018899629, 22501.54996900069, 22511.54976900469, 17931.820681793146, 17953.461396158134, 17963.101844907702, 18004.54988625282, 18073.909630451762, 3776.433534969749, 3782.7730336179916, 3803.6576708096127, 3823.9044023899346, 3839.4816699745456, 135636.0, 140329.0, 140414.29792851073, 143084.0, 143181.28409357992, 16915.407960721317, 17228.224729886933, 17299.048552329492, 17304.480865574053, 17626.91186544059, 30738.38523229523, 31272.843635781675, 31280.84359578233, 31345.843270783957, 31378.372432551678, 8044.557549334842, 8114.350851931831, 8291.626876790559, 8350.66597336112, 8370.958145209235, 4201.537830838605, 4268.487781466244, 4269.829206831692, 4273.059926816096, 4277.315629499265, 5454.781808727606, 5534.0, 5566.777328906879, 5570.41510641385, 5592.217089607459, 1003.8795344558554, 1010.3180353261666, 1024.5235965276183, 1025.4462590201356, 1025.661531694539, 682.0451368084721, 692.4771797293012, 698.8218004408843, 713.3472872321871, 714.3071220915704, 11893.691693913663, 12201.633950981484, 12336.444859981322, 13289.66775830612, 13435.731285374433, 688.3151264491762, 692.8475735338218, 697.3723648716197, 709.4076446167405, 710.5168485429854, 5787.39232380594, 5885.61743486672, 5934.732937017845, 5963.642181469126, 5981.790637327673, 121868.0, 126061.0, 126170.0, 127045.0, 128301.0, 112526.0, 112544.99999999836, 114316.0, 114889.42555287338, 115488.0, 95485.0, 96980.0, 98052.50973745086, 100326.49836750915, 100857.49571252096, 10881.292715973437, 10940.452977350942, 11374.260673056226, 11530.769384612093, 11667.183297169457, 44853.9999999987, 45173.54826451693, 45635.77182114068, 46550.767246164905, 46853.53146468628, 57187.0, 57457.42542574688, 58332.70833645974, 59064.70467647806, 59705.701471492364, 16135.75796363079, 16394.426195083113, 16430.67138657244, 16554.58613534671, 16608.501744947673, 18287.725684114484, 18470.168842401854, 18471.353502627342, 18587.34944276944, 18710.53223669419, 15714.764278535602, 15768.448104316294, 15810.68378632398, 16016.439424620083, 16052.598685032968, 15882.444114455939, 15961.600959976093, 16105.597360066093, 16265.756013659568, 16290.67418651644, 14580.562583122522, 14900.0, 14935.775963360342, 15057.0, 15063.472778452702, 10988.780224395307, 11176.832347514957, 11263.605773797877, 11325.037371823159, 11351.432428378714, 11948.701282468008, 12083.456244469196, 12127.272363657856, 12568.0, 12732.745345093232], "value": 9051.767317256787, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1403.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 109.0, 107.0, 109.0, 107.0, 108.0, 108.0, 107.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 116.0, 116.0, 115.0, 116.0, 115.0, 119.0, 119.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 163.0, 161.0, 163.0, 166.0, 167.0, 164.0, 165.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 73.0, 73.0, 73.0, 81.0, 73.0, 73.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 78.0, 79.0, 79.0, 82.0, 78.0, 78.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 112.0, 111.0, 111.0, 117.0, 111.0, 111.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 147.0, 149.0, 148.0, 150.0, 148.0, 150.0, 148.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 52.0, 51.0, 54.0, 53.0, 52.0, 54.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 36.0, 37.0, 37.0, 36.0, 37.0, 38.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 73.0, 73.0, 75.0, 73.0, 78.0, 83.0, 78.0, 73.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 108.0, 124.0, 119.0, 109.0, 117.0, 108.0, 117.0, 111.0], "value": 113.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 160.0, 157.0, 165.0, 158.0, 161.0, 168.0, 164.0, 162.0, 165.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 66.0, 73.0, 65.0, 65.0, 64.0, 62.0, 63.0, 64.0], "value": 65.1, "unit": "score"}]}]} 05:45:56 INFO - Return code: 0 05:45:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:45:56 INFO - # TBPL SUCCESS # 05:45:56 INFO - Running post-action listener: _package_coverage_data 05:45:56 INFO - Running post-action listener: _resource_record_post_action 05:45:56 INFO - [mozharness: 2017-09-29 12:45:56.348617Z] Finished run-tests step (success) 05:45:56 INFO - Running post-run listener: _resource_record_post_run 05:45:56 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 430080; Write bytes: 335626240; Read time: 216; Write time: 214888 05:45:56 INFO - TinderboxPrint: CPU usage
13.1% 05:45:56 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 216 05:45:56 INFO - TinderboxPrint: I/O write bytes / time
335,626,240 / 214,888 05:45:56 INFO - TinderboxPrint: CPU idle
8,230.5 (86.9%) 05:45:56 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 05:45:56 INFO - TinderboxPrint: Swap in / out
0 / 0 05:45:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13062144; Read time: 0; Write time: 1920 05:45:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:45:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 425984; Write bytes: 322564096; Read time: 200; Write time: 212968 05:45:57 INFO - Running post-run listener: _upload_blobber_files 05:45:57 INFO - Blob upload gear active. 05:45:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:57 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 05:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:45:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:58 INFO - (blobuploader) - INFO - Done attempting. 05:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:06 INFO - (blobuploader) - INFO - Done attempting. 05:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 05:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 05:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:07 INFO - (blobuploader) - INFO - Done attempting. 05:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 05:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 05:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:08 INFO - (blobuploader) - INFO - Done attempting. 05:46:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:08 INFO - Return code: 0 05:46:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d143d8eaba0d4f20d300b3ce91a29204ee7423485bc3a2871bef7fb474d8e14f5bbb7bc132eb111dad0bae732ea7e5191f5f880c8df8501a89e57681e109e740", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d82deab3d82ccc6652b3fe584f8622733dd3eec65ddd092ecdafae065c440de1c5ad92526e5ecd704a087f23165c632ee0c46606310f54d9bea1578b1ddf1d6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3fd8890dd6e95d056a3fd706abb1c7bf2425806bda192a31c1ac36a15349c1f6d24ef9d0e66b9015b3267952934aec71d30b9a201fb0b477d3a1a78cbd6a749", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8c53c643f91af414c37954f09aacf6626e54dea4b86f3ed1a6ef71701648a27415d6b0cef1d25afc9a8497b551c692f725d521569fc495f4d25094eb44a9bcb"} 05:46:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:08 INFO - Contents: 05:46:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d143d8eaba0d4f20d300b3ce91a29204ee7423485bc3a2871bef7fb474d8e14f5bbb7bc132eb111dad0bae732ea7e5191f5f880c8df8501a89e57681e109e740", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d82deab3d82ccc6652b3fe584f8622733dd3eec65ddd092ecdafae065c440de1c5ad92526e5ecd704a087f23165c632ee0c46606310f54d9bea1578b1ddf1d6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3fd8890dd6e95d056a3fd706abb1c7bf2425806bda192a31c1ac36a15349c1f6d24ef9d0e66b9015b3267952934aec71d30b9a201fb0b477d3a1a78cbd6a749", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8c53c643f91af414c37954f09aacf6626e54dea4b86f3ed1a6ef71701648a27415d6b0cef1d25afc9a8497b551c692f725d521569fc495f4d25094eb44a9bcb"} 05:46:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:08 INFO - Copying logs to upload dir... 05:46:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.719323 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-29 05:46:08.891403) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:08.899211) ========= 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=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d143d8eaba0d4f20d300b3ce91a29204ee7423485bc3a2871bef7fb474d8e14f5bbb7bc132eb111dad0bae732ea7e5191f5f880c8df8501a89e57681e109e740", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d82deab3d82ccc6652b3fe584f8622733dd3eec65ddd092ecdafae065c440de1c5ad92526e5ecd704a087f23165c632ee0c46606310f54d9bea1578b1ddf1d6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3fd8890dd6e95d056a3fd706abb1c7bf2425806bda192a31c1ac36a15349c1f6d24ef9d0e66b9015b3267952934aec71d30b9a201fb0b477d3a1a78cbd6a749", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8c53c643f91af414c37954f09aacf6626e54dea4b86f3ed1a6ef71701648a27415d6b0cef1d25afc9a8497b551c692f725d521569fc495f4d25094eb44a9bcb"} build_url:https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/IH85rkEeSoiGVybgA5cHLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d143d8eaba0d4f20d300b3ce91a29204ee7423485bc3a2871bef7fb474d8e14f5bbb7bc132eb111dad0bae732ea7e5191f5f880c8df8501a89e57681e109e740", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d82deab3d82ccc6652b3fe584f8622733dd3eec65ddd092ecdafae065c440de1c5ad92526e5ecd704a087f23165c632ee0c46606310f54d9bea1578b1ddf1d6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3fd8890dd6e95d056a3fd706abb1c7bf2425806bda192a31c1ac36a15349c1f6d24ef9d0e66b9015b3267952934aec71d30b9a201fb0b477d3a1a78cbd6a749", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8c53c643f91af414c37954f09aacf6626e54dea4b86f3ed1a6ef71701648a27415d6b0cef1d25afc9a8497b551c692f725d521569fc495f4d25094eb44a9bcb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:08.928304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:08.928652) ========= 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=1f5564757af27664ca02d71f000001b0-1506683838.778638-1629260188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.80 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 05:46:09.728534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 05:46:09.728934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 05:46:09.729311) ========= ========= Total master_lag: 1.10 =========