builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-044 starttime: 1506536070.28 results: success (0) revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.282464) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.283121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.283462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.318913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.319264) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 11:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 223M=0s 2017-09-27 11:14:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127532 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.483727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.484082) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015846 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:30.539516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 11:14:30.539845) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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 6100472d3aa833dff22a4edb0934fe600f43ddb8 --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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 11:14:30,776 truncating revision to first 12 chars 2017-09-27 11:14:30,776 Setting DEBUG logging. 2017-09-27 11:14:30,776 attempt 1/10 2017-09-27 11:14:30,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6100472d3aa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 11:14:31,825 unpacking tar archive at: mozilla-central-6100472d3aa8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.378398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-27 11:14:31.935889) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:31.936245) ========= script_repo_revision: 6100472d3aa833dff22a4edb0934fe600f43ddb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:31.936686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:31.937019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 11:14:31.951239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-27 11:14:31.951587) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:32 INFO - MultiFileLogger online at 20170927 11:14:32 in /builds/slave/test 11:14:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:14:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:32 INFO - {'append_to_log': False, 11:14:32 INFO - 'base_work_dir': '/builds/slave/test', 11:14:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:14:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:32 INFO - 'branch': 'Firefox-Non-PGO', 11:14:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:32 INFO - 'code_coverage': False, 11:14:32 INFO - 'config_files': ('talos/linux_config.py',), 11:14:32 INFO - 'default_actions': ('clobber', 11:14:32 INFO - 'read-buildbot-config', 11:14:32 INFO - 'download-and-extract', 11:14:32 INFO - 'populate-webroot', 11:14:32 INFO - 'create-virtualenv', 11:14:32 INFO - 'install', 11:14:32 INFO - 'setup-mitmproxy', 11:14:32 INFO - 'run-tests'), 11:14:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:32 INFO - 'disable_ccov_upload': False, 11:14:32 INFO - 'disable_stylo': False, 11:14:32 INFO - 'download_minidump_stackwalk': True, 11:14:32 INFO - 'download_symbols': 'ondemand', 11:14:32 INFO - 'enable_stylo': False, 11:14:32 INFO - 'enable_webrender': False, 11:14:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:14:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:32 INFO - 'gecko_profile': False, 11:14:32 INFO - 'gecko_profile_interval': 0, 11:14:32 INFO - 'installer_path': 'installer.exe', 11:14:32 INFO - 'log_level': 'info', 11:14:32 INFO - 'log_name': 'talos', 11:14:32 INFO - 'log_to_console': True, 11:14:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:32 INFO - 'opt_config_files': (), 11:14:32 INFO - 'pip_index': False, 11:14:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:14:32 INFO - 'system_bits': '32', 11:14:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:32 INFO - 'title': 'talos-linux64-ix-044', 11:14:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:32 INFO - 'use_talos_json': True, 11:14:32 INFO - 'verify': 'False', 11:14:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:32 INFO - 'work_dir': 'build'} 11:14:32 INFO - [mozharness: 2017-09-27 18:14:32.331345Z] Running clobber step. 11:14:32 INFO - Running pre-action listener: _resource_record_pre_action 11:14:32 INFO - Running main action method: clobber 11:14:32 INFO - rmtree: /builds/slave/test/build 11:14:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:33 INFO - Running post-action listener: _resource_record_post_action 11:14:33 INFO - [mozharness: 2017-09-27 18:14:33.332645Z] Finished clobber step (success) 11:14:33 INFO - [mozharness: 2017-09-27 18:14:33.332747Z] Running read-buildbot-config step. 11:14:33 INFO - Running pre-action listener: _resource_record_pre_action 11:14:33 INFO - Running main action method: read_buildbot_config 11:14:33 INFO - Using buildbot properties: 11:14:33 INFO - { 11:14:33 INFO - "project": "", 11:14:33 INFO - "product": "firefox", 11:14:33 INFO - "who": "ryanvm@gmail.com", 11:14:33 INFO - "installer_path": "public/build/target.tar.bz2", 11:14:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:14:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:14:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:14:33 INFO - "stage_platform": "linux64", 11:14:33 INFO - "basedir": "/builds/slave/test", 11:14:33 INFO - "buildnumber": 48, 11:14:33 INFO - "platform": "ubuntu64_hw", 11:14:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:14:33 INFO - "slavebuilddir": "test", 11:14:33 INFO - "taskId": "JjLXMCsPRyGL_SRRfq7W3Q", 11:14:33 INFO - "branch": "mozilla-central", 11:14:33 INFO - "script_repo_revision": "production", 11:14:33 INFO - "revision": "6100472d3aa833dff22a4edb0934fe600f43ddb8", 11:14:33 INFO - "slavename": "talos-linux64-ix-044", 11:14:33 INFO - "repo_path": "mozilla-central" 11:14:33 INFO - } 11:14:33 INFO - Finding installer, test and symbols from parent task. 11:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjLXMCsPRyGL_SRRfq7W3Q'}, attempt #1 11:14:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JjLXMCsPRyGL_SRRfq7W3Q'}, attempt #1 11:14:34 INFO - Task dependencies: bGmhYXXHRU6bnifb1xql2Q 11:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q'}, attempt #1 11:14:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:14:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json 11:14:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip 11:14:34 INFO - Running post-action listener: _resource_record_post_action 11:14:34 INFO - [mozharness: 2017-09-27 18:14:34.745687Z] Finished read-buildbot-config step (success) 11:14:34 INFO - [mozharness: 2017-09-27 18:14:34.745907Z] Running download-and-extract step. 11:14:34 INFO - Running pre-action listener: _resource_record_pre_action 11:14:34 INFO - Running main action method: download_and_extract 11:14:34 INFO - mkdir: /builds/slave/test/build/tests 11:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:34 INFO - trying https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json 11:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:14:35 INFO - Downloaded 989 bytes. 11:14:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:14:35 INFO - Using the following test package requirements: 11:14:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:14:35 INFO - u'common': [u'target.common.tests.zip'], 11:14:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:14:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:14:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:14:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:14:35 INFO - u'mozbase': [u'target.common.tests.zip'], 11:14:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:14:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:14:35 INFO - u'web-platform': [u'target.common.tests.zip', 11:14:35 INFO - u'target.web-platform.tests.tar.gz'], 11:14:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:14:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:14:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip 11:14:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:14:35 INFO - Fetch https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.common.tests.zip into memory 11:14:38 INFO - Content-Length response header: 54946033 11:14:38 INFO - Bytes received: 54946033 11:14:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip 11:14:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:14:49 INFO - Fetch https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.talos.tests.zip into memory 11:14:50 INFO - Content-Length response header: 14513665 11:14:50 INFO - Bytes received: 14513665 11:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:51 INFO - trying https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:14:51 INFO - Downloading https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:14:53 INFO - Downloaded 61680180 bytes. 11:14:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:14:53 INFO - mkdir: /builds/slave/test/properties 11:14:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:53 INFO - Contents: 11:14:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 11:14:53 INFO - Running post-action listener: _resource_record_post_action 11:14:53 INFO - Running post-action listener: find_tests_for_verification 11:14:53 INFO - Running post-action listener: set_extra_try_arguments 11:14:53 INFO - [mozharness: 2017-09-27 18:14:53.298509Z] Finished download-and-extract step (success) 11:14:53 INFO - [mozharness: 2017-09-27 18:14:53.298606Z] Running populate-webroot step. 11:14:53 INFO - Running pre-action listener: _resource_record_pre_action 11:14:53 INFO - Running main action method: populate_webroot 11:14:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:14:53 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['tresize', 11:14:53 INFO - 'tcanvasmark']}, 11:14:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:14:53 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['dromaeo_css', 11:14:53 INFO - 'kraken']}, 11:14:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:53 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'tests': ['damp', 'tps']}, 11:14:53 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['damp', 'tps']}, 11:14:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:53 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['dromaeo_dom']}, 11:14:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:14:53 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['basic_compositor_video', 11:14:53 INFO - 'glvideo']}, 11:14:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:14:53 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['ts_paint_webext', 11:14:53 INFO - 'tp5o_webext']}, 11:14:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:14:53 INFO - 'ts_paint', 11:14:53 INFO - 'tpaint', 11:14:53 INFO - 'sessionrestore', 11:14:53 INFO - 'sessionrestore_many_windows', 11:14:53 INFO - 'sessionrestore_no_auto_restore', 11:14:53 INFO - 'tabpaint']}, 11:14:53 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['a11yr', 11:14:53 INFO - 'ts_paint', 11:14:53 INFO - 'tpaint', 11:14:53 INFO - 'sessionrestore', 11:14:53 INFO - 'sessionrestore_many_windows', 11:14:53 INFO - 'sessionrestore_no_auto_restore', 11:14:53 INFO - 'tabpaint']}, 11:14:53 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:14:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:14:53 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['perf_reftest_singletons']}, 11:14:53 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['perf_reftest']}, 11:14:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:14:53 INFO - 'tsvgr_opacity', 11:14:53 INFO - 'tart', 11:14:53 INFO - 'tscrollx', 11:14:53 INFO - 'tsvg_static']}, 11:14:53 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['tsvgx', 11:14:53 INFO - 'tsvgr_opacity', 11:14:53 INFO - 'tart', 11:14:53 INFO - 'tscrollx', 11:14:53 INFO - 'tsvg_static']}, 11:14:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:14:53 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--disable-stylo'], 11:14:53 INFO - 'tests': ['tp5o']}, 11:14:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:14:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:14:53 INFO - 'talos_options': ['--mitmproxy', 11:14:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:14:53 INFO - '--firstNonBlankPaint'], 11:14:53 INFO - 'tests': ['tp6_google', 11:14:53 INFO - 'tp6_youtube', 11:14:53 INFO - 'tp6_amazon', 11:14:53 INFO - 'tp6_facebook']}, 11:14:53 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:14:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:14:53 INFO - 'talos_options': ['--disable-stylo', 11:14:53 INFO - '--mitmproxy', 11:14:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:14:53 INFO - '--firstNonBlankPaint'], 11:14:53 INFO - 'tests': ['tp6_google', 11:14:53 INFO - 'tp6_youtube', 11:14:53 INFO - 'tp6_amazon', 11:14:53 INFO - 'tp6_facebook']}, 11:14:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:14:53 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:14:53 INFO - 'talos_options': ['--stylo-threads=1', 11:14:53 INFO - '--mitmproxy', 11:14:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:14:53 INFO - '--firstNonBlankPaint'], 11:14:53 INFO - 'tests': ['tp6_google', 11:14:53 INFO - 'tp6_youtube', 11:14:53 INFO - 'tp6_amazon', 11:14:53 INFO - 'tp6_facebook']}, 11:14:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--xperf_path', 11:14:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:53 INFO - 'tests': ['tp5n']}, 11:14:53 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:14:53 INFO - 'talos_options': ['--disable-stylo', 11:14:53 INFO - '--xperf_path', 11:14:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:53 INFO - 'tests': ['tp5n']}}} 11:14:53 INFO - Running post-action listener: _resource_record_post_action 11:14:53 INFO - [mozharness: 2017-09-27 18:14:53.314027Z] Finished populate-webroot step (success) 11:14:53 INFO - [mozharness: 2017-09-27 18:14:53.314118Z] Running create-virtualenv step. 11:14:53 INFO - Running pre-action listener: _resource_record_pre_action 11:14:53 INFO - Running main action method: create_virtualenv 11:14:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:14:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:14:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:14:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:54 INFO - Installing pip...............done. 11:14:54 INFO - Return code: 0 11:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:14:54 INFO - Reading from file tmpfile_stdout 11:14:54 INFO - Output received: 11:14:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:14:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:54 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:14:54 INFO - Using env: {'DISPLAY': ':0', 11:14:54 INFO - 'HOME': '/home/cltbld', 11:14:54 INFO - 'LANG': 'en_US.UTF-8', 11:14:54 INFO - 'LANGUAGE': 'en_US:en', 11:14:54 INFO - 'LOGNAME': 'cltbld', 11:14:54 INFO - 'MAIL': '/var/mail/cltbld', 11:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:54 INFO - 'MOZ_NO_REMOTE': '1', 11:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:54 INFO - 'NO_EM_RESTART': '1', 11:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:54 INFO - 'PWD': '/builds/slave/test', 11:14:54 INFO - 'SHELL': '/bin/bash', 11:14:54 INFO - 'SHLVL': '1', 11:14:54 INFO - 'TERM': 'linux', 11:14:54 INFO - 'TMOUT': '86400', 11:14:54 INFO - 'USER': 'cltbld', 11:14:54 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:54 INFO - '_': '/tools/buildbot/bin/python'} 11:14:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:14:55 INFO - Downloading/unpacking pip>=1.5 11:14:55 INFO - Running setup.py egg_info for package pip 11:14:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:14:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:14:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:14:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:14:55 INFO - Installing collected packages: pip 11:14:55 INFO - Found existing installation: pip 1.1 11:14:55 INFO - Uninstalling pip: 11:14:55 INFO - Successfully uninstalled pip 11:14:55 INFO - Running setup.py install for pip 11:14:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:14:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:14:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:14:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:14:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:14:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:14:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:14:55 INFO - Successfully installed pip 11:14:55 INFO - Cleaning up... 11:14:55 INFO - Return code: 0 11:14:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14: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', '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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:14: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 psutil>=3.1.1 11:14:55 INFO - Using env: {'DISPLAY': ':0', 11:14:55 INFO - 'HOME': '/home/cltbld', 11:14:55 INFO - 'LANG': 'en_US.UTF-8', 11:14:55 INFO - 'LANGUAGE': 'en_US:en', 11:14:55 INFO - 'LOGNAME': 'cltbld', 11:14:55 INFO - 'MAIL': '/var/mail/cltbld', 11:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:55 INFO - 'MOZ_NO_REMOTE': '1', 11:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:55 INFO - 'NO_EM_RESTART': '1', 11:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:55 INFO - 'PWD': '/builds/slave/test', 11:14:55 INFO - 'SHELL': '/bin/bash', 11:14:55 INFO - 'SHLVL': '1', 11:14:55 INFO - 'TERM': 'linux', 11:14:55 INFO - 'TMOUT': '86400', 11:14:55 INFO - 'USER': 'cltbld', 11:14:55 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:55 INFO - '_': '/tools/buildbot/bin/python'} 11:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:55 INFO - Downloading/unpacking psutil>=3.1.1 11:14: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 11:14: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 11:14: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 11:14: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 11:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:57 INFO - Installing collected packages: psutil 11:14:57 INFO - Running setup.py install for psutil 11:14:57 INFO - building 'psutil._psutil_linux' extension 11:14:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:14:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:14:57 INFO - building 'psutil._psutil_posix' extension 11:14:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:14:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:57 INFO - Successfully installed psutil 11:14:57 INFO - Cleaning up... 11:14:58 INFO - Return code: 0 11:14:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14: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')]} 11:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:58 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:14:58 INFO - Using env: {'DISPLAY': ':0', 11:14:58 INFO - 'HOME': '/home/cltbld', 11:14:58 INFO - 'LANG': 'en_US.UTF-8', 11:14:58 INFO - 'LANGUAGE': 'en_US:en', 11:14:58 INFO - 'LOGNAME': 'cltbld', 11:14:58 INFO - 'MAIL': '/var/mail/cltbld', 11:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:58 INFO - 'MOZ_NO_REMOTE': '1', 11:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:58 INFO - 'NO_EM_RESTART': '1', 11:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:58 INFO - 'PWD': '/builds/slave/test', 11:14:58 INFO - 'SHELL': '/bin/bash', 11:14:58 INFO - 'SHLVL': '1', 11:14:58 INFO - 'TERM': 'linux', 11:14:58 INFO - 'TMOUT': '86400', 11:14:58 INFO - 'USER': 'cltbld', 11:14:58 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:58 INFO - '_': '/tools/buildbot/bin/python'} 11:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:14:59 INFO - Installing collected packages: mozsystemmonitor 11:14:59 INFO - Running setup.py install for mozsystemmonitor 11:14:59 INFO - Successfully installed mozsystemmonitor 11:14:59 INFO - Cleaning up... 11:14:59 INFO - Return code: 0 11:14:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:14:59 INFO - Using env: {'DISPLAY': ':0', 11:14:59 INFO - 'HOME': '/home/cltbld', 11:14:59 INFO - 'LANG': 'en_US.UTF-8', 11:14:59 INFO - 'LANGUAGE': 'en_US:en', 11:14:59 INFO - 'LOGNAME': 'cltbld', 11:14:59 INFO - 'MAIL': '/var/mail/cltbld', 11:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:59 INFO - 'MOZ_NO_REMOTE': '1', 11:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:59 INFO - 'NO_EM_RESTART': '1', 11:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:59 INFO - 'PWD': '/builds/slave/test', 11:14:59 INFO - 'SHELL': '/bin/bash', 11:14:59 INFO - 'SHLVL': '1', 11:14:59 INFO - 'TERM': 'linux', 11:14:59 INFO - 'TMOUT': '86400', 11:14:59 INFO - 'USER': 'cltbld', 11:14:59 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:59 INFO - '_': '/tools/buildbot/bin/python'} 11:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:01 INFO - warning: no files found matching '*.txt' 11:15:01 INFO - no previously-included directories found matching 'build' 11:15:01 INFO - no previously-included directories found matching 'dist' 11:15:01 INFO - no previously-included directories found matching '.git*' 11:15:01 INFO - Installing collected packages: jsonschema, functools32 11:15:01 INFO - Running setup.py install for functools32 11:15:01 INFO - warning: no files found matching '*.txt' 11:15:01 INFO - no previously-included directories found matching 'build' 11:15:01 INFO - no previously-included directories found matching 'dist' 11:15:01 INFO - no previously-included directories found matching '.git*' 11:15:01 INFO - Successfully installed jsonschema functools32 11:15:01 INFO - Cleaning up... 11:15:01 INFO - Return code: 0 11:15:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:15:01 INFO - Using env: {'DISPLAY': ':0', 11:15:01 INFO - 'HOME': '/home/cltbld', 11:15:01 INFO - 'LANG': 'en_US.UTF-8', 11:15:01 INFO - 'LANGUAGE': 'en_US:en', 11:15:01 INFO - 'LOGNAME': 'cltbld', 11:15:01 INFO - 'MAIL': '/var/mail/cltbld', 11:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:01 INFO - 'MOZ_NO_REMOTE': '1', 11:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:01 INFO - 'NO_EM_RESTART': '1', 11:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:01 INFO - 'PWD': '/builds/slave/test', 11:15:01 INFO - 'SHELL': '/bin/bash', 11:15:01 INFO - 'SHLVL': '1', 11:15:01 INFO - 'TERM': 'linux', 11:15:01 INFO - 'TMOUT': '86400', 11:15:01 INFO - 'USER': 'cltbld', 11:15:01 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:01 INFO - '_': '/tools/buildbot/bin/python'} 11:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:01 INFO - Cleaning up... 11:15:01 INFO - Return code: 0 11:15:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:15:01 INFO - Using env: {'DISPLAY': ':0', 11:15:01 INFO - 'HOME': '/home/cltbld', 11:15:01 INFO - 'LANG': 'en_US.UTF-8', 11:15:01 INFO - 'LANGUAGE': 'en_US:en', 11:15:01 INFO - 'LOGNAME': 'cltbld', 11:15:01 INFO - 'MAIL': '/var/mail/cltbld', 11:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:01 INFO - 'MOZ_NO_REMOTE': '1', 11:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:01 INFO - 'NO_EM_RESTART': '1', 11:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:01 INFO - 'PWD': '/builds/slave/test', 11:15:01 INFO - 'SHELL': '/bin/bash', 11:15:01 INFO - 'SHLVL': '1', 11:15:01 INFO - 'TERM': 'linux', 11:15:01 INFO - 'TMOUT': '86400', 11:15:01 INFO - 'USER': 'cltbld', 11:15:01 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:01 INFO - '_': '/tools/buildbot/bin/python'} 11:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:03 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:15:03 INFO - Downloading docopt-0.6.1.tar.gz 11:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:03 INFO - Running setup.py install for blobuploader 11:15:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:03 INFO - Running setup.py install for requests 11:15:04 INFO - Running setup.py install for docopt 11:15:04 INFO - Successfully installed blobuploader requests docopt 11:15:04 INFO - Cleaning up... 11:15:04 INFO - Return code: 0 11:15:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:04 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:04 INFO - Using env: {'DISPLAY': ':0', 11:15:04 INFO - 'HOME': '/home/cltbld', 11:15:04 INFO - 'LANG': 'en_US.UTF-8', 11:15:04 INFO - 'LANGUAGE': 'en_US:en', 11:15:04 INFO - 'LOGNAME': 'cltbld', 11:15:04 INFO - 'MAIL': '/var/mail/cltbld', 11:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:04 INFO - 'MOZ_NO_REMOTE': '1', 11:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:04 INFO - 'NO_EM_RESTART': '1', 11:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:04 INFO - 'PWD': '/builds/slave/test', 11:15:04 INFO - 'SHELL': '/bin/bash', 11:15:04 INFO - 'SHLVL': '1', 11:15:04 INFO - 'TERM': 'linux', 11:15:04 INFO - 'TMOUT': '86400', 11:15:04 INFO - 'USER': 'cltbld', 11:15:04 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:04 INFO - '_': '/tools/buildbot/bin/python'} 11:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:04 INFO - Running setup.py (path:/tmp/pip-069PMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:04 INFO - Running setup.py (path:/tmp/pip-dFXRM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:04 INFO - Running setup.py (path:/tmp/pip-JMmqNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:04 INFO - Running setup.py (path:/tmp/pip-bfHOM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:04 INFO - Running setup.py (path:/tmp/pip-F3A7jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:05 INFO - Running setup.py (path:/tmp/pip-eXsm0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:05 INFO - Running setup.py (path:/tmp/pip-kmUJFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:05 INFO - Running setup.py (path:/tmp/pip-E9kqg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:05 INFO - Running setup.py (path:/tmp/pip-hVzp9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:05 INFO - Running setup.py (path:/tmp/pip-ppWFpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:05 INFO - Running setup.py (path:/tmp/pip-5VBwEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:05 INFO - Running setup.py (path:/tmp/pip-YUEF5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:05 INFO - Running setup.py (path:/tmp/pip-pOC9dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:05 INFO - Running setup.py (path:/tmp/pip-wTg58W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:05 INFO - Running setup.py (path:/tmp/pip-eXMFNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:05 INFO - Running setup.py (path:/tmp/pip-MB9E8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:05 INFO - Running setup.py (path:/tmp/pip-ncVI2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:05 INFO - Running setup.py install for manifestparser 11:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:05 INFO - Running setup.py install for mozcrash 11:15:06 INFO - Running setup.py install for mozdebug 11:15:06 INFO - Running setup.py install for mozdevice 11:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for mozfile 11:15:06 INFO - Running setup.py install for mozhttpd 11:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for mozinfo 11:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for mozInstall 11:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for mozleak 11:15:06 INFO - Running setup.py install for mozlog 11:15:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for moznetwork 11:15:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:06 INFO - Running setup.py install for mozprocess 11:15:07 INFO - Running setup.py install for mozprofile 11:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:07 INFO - Running setup.py install for mozrunner 11:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:07 INFO - Running setup.py install for mozscreenshot 11:15:07 INFO - Running setup.py install for moztest 11:15:07 INFO - Running setup.py install for mozversion 11:15:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:07 INFO - Cleaning up... 11:15:07 INFO - Return code: 0 11:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:07 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:07 INFO - Using env: {'DISPLAY': ':0', 11:15:07 INFO - 'HOME': '/home/cltbld', 11:15:07 INFO - 'LANG': 'en_US.UTF-8', 11:15:07 INFO - 'LANGUAGE': 'en_US:en', 11:15:07 INFO - 'LOGNAME': 'cltbld', 11:15:07 INFO - 'MAIL': '/var/mail/cltbld', 11:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:07 INFO - 'MOZ_NO_REMOTE': '1', 11:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:07 INFO - 'NO_EM_RESTART': '1', 11:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:07 INFO - 'PWD': '/builds/slave/test', 11:15:07 INFO - 'SHELL': '/bin/bash', 11:15:07 INFO - 'SHLVL': '1', 11:15:07 INFO - 'TERM': 'linux', 11:15:07 INFO - 'TMOUT': '86400', 11:15:07 INFO - 'USER': 'cltbld', 11:15:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:07 INFO - '_': '/tools/buildbot/bin/python'} 11:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:07 INFO - Running setup.py (path:/tmp/pip-ZsrnOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:07 INFO - Running setup.py (path:/tmp/pip-CAM0gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:08 INFO - Running setup.py (path:/tmp/pip-anVIwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:08 INFO - Running setup.py (path:/tmp/pip-I3OZG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:08 INFO - Running setup.py (path:/tmp/pip-8mmpPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:08 INFO - Running setup.py (path:/tmp/pip-zOHat5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:08 INFO - Running setup.py (path:/tmp/pip-NQPKlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:08 INFO - Running setup.py (path:/tmp/pip-BgwXOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:08 INFO - Running setup.py (path:/tmp/pip-ZFhaiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:08 INFO - Running setup.py (path:/tmp/pip-cP_Hhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:08 INFO - Running setup.py (path:/tmp/pip-ovCRVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:08 INFO - Running setup.py (path:/tmp/pip-MHKdzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:08 INFO - Running setup.py (path:/tmp/pip-A4Vik6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:08 INFO - Running setup.py (path:/tmp/pip-IGYyhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:08 INFO - Running setup.py (path:/tmp/pip-kseTAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:08 INFO - Running setup.py (path:/tmp/pip-CoKvTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:09 INFO - Running setup.py (path:/tmp/pip-flOfRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:10 INFO - Downloading blessings-1.6.tar.gz 11:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:10 INFO - Installing collected packages: blessings 11:15:10 INFO - Running setup.py install for blessings 11:15:10 INFO - Successfully installed blessings 11:15:10 INFO - Cleaning up... 11:15:10 INFO - Return code: 0 11:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:10 INFO - Reading from file tmpfile_stdout 11:15:10 INFO - Current package versions: 11:15:10 INFO - argparse == 1.2.1 11:15:10 INFO - blessings == 1.6 11:15:10 INFO - blobuploader == 1.2.4 11:15:10 INFO - docopt == 0.6.1 11:15:10 INFO - functools32 == 3.2.3-2 11:15:10 INFO - jsonschema == 2.5.1 11:15:10 INFO - manifestparser == 1.1 11:15:10 INFO - mozInstall == 1.13 11:15:10 INFO - mozcrash == 1.0 11:15:10 INFO - mozdebug == 0.1 11:15:10 INFO - mozdevice == 0.51 11:15:10 INFO - mozfile == 1.2 11:15:10 INFO - mozhttpd == 0.7 11:15:10 INFO - mozinfo == 0.10 11:15:10 INFO - mozleak == 0.1 11:15:10 INFO - mozlog == 3.5 11:15:10 INFO - moznetwork == 0.27 11:15:10 INFO - mozprocess == 0.25 11:15:10 INFO - mozprofile == 0.28 11:15:10 INFO - mozrunner == 6.13 11:15:10 INFO - mozscreenshot == 0.1 11:15:10 INFO - mozsystemmonitor == 0.3 11:15:10 INFO - moztest == 0.8 11:15:10 INFO - mozversion == 1.4 11:15:10 INFO - psutil == 3.1.1 11:15:10 INFO - requests == 1.2.3 11:15:10 INFO - wsgiref == 0.1.2 11:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:10 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:10 INFO - Using env: {'DISPLAY': ':0', 11:15:10 INFO - 'HOME': '/home/cltbld', 11:15:10 INFO - 'LANG': 'en_US.UTF-8', 11:15:10 INFO - 'LANGUAGE': 'en_US:en', 11:15:10 INFO - 'LOGNAME': 'cltbld', 11:15:10 INFO - 'MAIL': '/var/mail/cltbld', 11:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:10 INFO - 'MOZ_NO_REMOTE': '1', 11:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:10 INFO - 'NO_EM_RESTART': '1', 11:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:10 INFO - 'PWD': '/builds/slave/test', 11:15:10 INFO - 'SHELL': '/bin/bash', 11:15:10 INFO - 'SHLVL': '1', 11:15:10 INFO - 'TERM': 'linux', 11:15:10 INFO - 'TMOUT': '86400', 11:15:10 INFO - 'USER': 'cltbld', 11:15:10 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:10 INFO - '_': '/tools/buildbot/bin/python'} 11:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:15:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:15:12 INFO - Installing collected packages: simplejson 11:15:12 INFO - Running setup.py install for simplejson 11:15:12 INFO - building 'simplejson._speedups' extension 11:15:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:15:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:15:13 INFO - Successfully installed simplejson 11:15:13 INFO - Cleaning up... 11:15:13 INFO - Return code: 0 11:15:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:13 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 0xe7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e89c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:15:13 INFO - Using env: {'DISPLAY': ':0', 11:15:13 INFO - 'HOME': '/home/cltbld', 11:15:13 INFO - 'LANG': 'en_US.UTF-8', 11:15:13 INFO - 'LANGUAGE': 'en_US:en', 11:15:13 INFO - 'LOGNAME': 'cltbld', 11:15:13 INFO - 'MAIL': '/var/mail/cltbld', 11:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:13 INFO - 'MOZ_NO_REMOTE': '1', 11:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:13 INFO - 'NO_EM_RESTART': '1', 11:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:13 INFO - 'PWD': '/builds/slave/test', 11:15:13 INFO - 'SHELL': '/bin/bash', 11:15:13 INFO - 'SHLVL': '1', 11:15:13 INFO - 'TERM': 'linux', 11:15:13 INFO - 'TMOUT': '86400', 11:15:13 INFO - 'USER': 'cltbld', 11:15:13 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:13 INFO - '_': '/tools/buildbot/bin/python'} 11:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:13 INFO - Cleaning up... 11:15:13 INFO - Return code: 0 11:15:13 INFO - Running post-action listener: _resource_record_post_action 11:15:13 INFO - Running post-action listener: _start_resource_monitoring 11:15:13 INFO - Starting resource monitoring. 11:15:13 INFO - [mozharness: 2017-09-27 18:15:13.367898Z] Finished create-virtualenv step (success) 11:15:13 INFO - [mozharness: 2017-09-27 18:15:13.368498Z] Running install step. 11:15:13 INFO - Running pre-action listener: _resource_record_pre_action 11:15:13 INFO - Running main action method: install 11:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:13 INFO - Reading from file tmpfile_stdout 11:15:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:13 INFO - Reading from file tmpfile_stdout 11:15:13 INFO - Output received: 11:15:13 INFO - Usage: mozinstall [options] installer 11:15:13 INFO - Options: 11:15:13 INFO - -h, --help show this help message and exit 11:15:13 INFO - -d DEST, --destination=DEST 11:15:13 INFO - Directory to install application into. [default: 11:15:13 INFO - "/builds/slave/test"] 11:15:13 INFO - --app=APP Application being installed. [default: firefox] 11:15:13 INFO - mkdir: /builds/slave/test/build/application 11:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:15:31 INFO - Reading from file tmpfile_stdout 11:15:31 INFO - Output received: 11:15:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:15:31 INFO - Running post-action listener: _resource_record_post_action 11:15:31 INFO - [mozharness: 2017-09-27 18:15:31.542700Z] Finished install step (success) 11:15:31 INFO - [mozharness: 2017-09-27 18:15:31.542954Z] Running setup-mitmproxy step. 11:15:31 INFO - Running pre-action listener: _resource_record_pre_action 11:15:31 INFO - Running main action method: setup_mitmproxy 11:15:31 INFO - Skipping: mitmproxy is not required 11:15:31 INFO - Running post-action listener: _resource_record_post_action 11:15:31 INFO - [mozharness: 2017-09-27 18:15:31.544109Z] Finished setup-mitmproxy step (success) 11:15:31 INFO - [mozharness: 2017-09-27 18:15:31.544400Z] Running run-tests step. 11:15:31 INFO - Running pre-action listener: _resource_record_pre_action 11:15:31 INFO - Running pre-action listener: _set_gcov_prefix 11:15:31 INFO - Running main action method: run_tests 11:15:31 WARNING - Try message not found. 11:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:15:31 INFO - Python 2.7.3 11:15:31 INFO - Return code: 0 11:15:31 INFO - grabbing minidump binary from tooltool 11:15: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')]} 11:15:31 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 0x11e5d60>, '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 0x11e6a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11e6ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:15:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:15:31 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:15:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:15:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:31 INFO - Return code: 0 11:15:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:15:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:15:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:15:31 INFO - ENV: RUST_BACKTRACE is now full 11:15:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:15:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:15:31 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:15:31 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:15:31 INFO - Using env: {'DISPLAY': ':0', 11:15:31 INFO - 'HOME': '/home/cltbld', 11:15:31 INFO - 'LANG': 'en_US.UTF-8', 11:15:31 INFO - 'LANGUAGE': 'en_US:en', 11:15:31 INFO - 'LOGNAME': 'cltbld', 11:15:31 INFO - 'MAIL': '/var/mail/cltbld', 11:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:31 INFO - 'MOZ_NO_REMOTE': '1', 11:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:31 INFO - 'NO_EM_RESTART': '1', 11:15:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:31 INFO - 'PWD': '/builds/slave/test', 11:15:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:31 INFO - 'RUST_BACKTRACE': 'full', 11:15:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:15:31 INFO - 'SHELL': '/bin/bash', 11:15:31 INFO - 'SHLVL': '1', 11:15:31 INFO - 'TERM': 'linux', 11:15:31 INFO - 'TMOUT': '86400', 11:15:31 INFO - 'USER': 'cltbld', 11:15:31 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:31 INFO - '_': '/tools/buildbot/bin/python'} 11:15:31 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/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:15:31 INFO - mozversion application_buildid: 20170927172229 11:15:31 INFO - mozversion application_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:15:31 INFO - mozversion application_display_name: Nightly 11:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:31 INFO - mozversion application_name: Firefox 11:15:31 INFO - mozversion application_remotingname: firefox 11:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:15:31 INFO - mozversion application_vendor: Mozilla 11:15:31 INFO - mozversion application_version: 58.0a1 11:15:31 INFO - mozversion platform_buildid: 20170927172229 11:15:31 INFO - mozversion platform_changeset: 6100472d3aa833dff22a4edb0934fe600f43ddb8 11:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:15:31 INFO - mozversion platform_version: 58.0a1 11:15:31 INFO - using testdate: 1506536131 11:15:31 INFO - actual date: 1506536131 11:15:31 INFO - starting webserver on 'localhost:46596' 11:15:31 INFO - SUITE-START | Running 2 tests 11:15:31 INFO - TEST-START | dromaeo_css 11:15:31 INFO - Initialising browser for dromaeo_css test... 11:15:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html -profile /tmp/tmp_pZLmc/profile 11:15:31 INFO - TEST-INFO | started process 10518 (/builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html) 11:15:37 INFO - TEST-INFO | 10518: exit 0 11:15:37 INFO - Browser initialized. 11:15:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:15:37 INFO - Using env: {'DISPLAY': ':0', 11:15:37 INFO - 'HOME': '/home/cltbld', 11:15:37 INFO - 'JSGC_DISABLE_POISONING': '1', 11:15:37 INFO - 'LANG': 'en_US.UTF-8', 11:15:37 INFO - 'LANGUAGE': 'en_US:en', 11:15:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:15:37 INFO - 'LOGNAME': 'cltbld', 11:15:37 INFO - 'MAIL': '/var/mail/cltbld', 11:15:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:15:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:15:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:15:37 INFO - 'MOZ_NO_REMOTE': '1', 11:15:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:37 INFO - 'NO_EM_RESTART': '1', 11:15:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:37 INFO - 'PWD': '/builds/slave/test', 11:15:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:15:37 INFO - 'RUST_BACKTRACE': 'full', 11:15:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:15:37 INFO - 'SHELL': '/bin/bash', 11:15:37 INFO - 'SHLVL': '1', 11:15:37 INFO - 'STYLO_FORCE_DISABLED': '1', 11:15:37 INFO - 'TERM': 'linux', 11:15:37 INFO - 'TMOUT': '86400', 11:15:37 INFO - 'USER': 'cltbld', 11:15:37 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:37 INFO - '_': '/tools/buildbot/bin/python'} 11:15:37 INFO - TEST-INFO | started process 10750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_pZLmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:37 INFO - PID 10750 | 11:15:37 INFO - PID 10750 | (/builds/slave/test/build/application/firefox/firefox:10798): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:15:37 INFO - PID 10750 | 11:15:48 INFO - PID 10750 | RSS: Main: 153382912 11:15:48 INFO - PID 10750 | 11:18:46 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46596/tests/dromaeo/cssquery-ext.html) 11:18:47 INFO - PID 10750 | RSS: Main: 153751552 11:18:47 INFO - PID 10750 | 11:21:49 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-ext.html (next: http://localhost:46596/tests/dromaeo/cssquery-jquery.html) 11:21:49 INFO - PID 10750 | RSS: Main: 153747456 11:21:49 INFO - PID 10750 | 11:24:51 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46596/tests/dromaeo/cssquery-mootools.html) 11:24:52 INFO - PID 10750 | RSS: Main: 155492352 11:24:52 INFO - PID 10750 | 11:27:53 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46596/tests/dromaeo/cssquery-prototype.html) 11:27:54 INFO - PID 10750 | RSS: Main: 154247168 11:27:54 INFO - PID 10750 | 11:30:57 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46596/tests/dromaeo/cssquery-yui.html) 11:30:58 INFO - PID 10750 | RSS: Main: 155410432 11:30:58 INFO - PID 10750 | 11:33:59 INFO - PID 10750 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-yui.html (next: http://localhost:46596/tests/dromaeo/cssquery-dojo.html) 11:34:00 INFO - PID 10750 | RSS: Main: 157700096 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | __start_tp_report 11:34:00 INFO - PID 10750 | _x_x_mozilla_page_load 11:34:00 INFO - PID 10750 | _x_x_mozilla_page_load_details 11:34:00 INFO - PID 10750 | |i|pagename|runs| 11:34:00 INFO - PID 10750 | |0;dojo.html;3187.2031992002;3211.9839400802994;3227.9354412911744;3248.4315244832164;3251.1059458648883;6152.8461788455315;6282.654454005028;6311.589746666464;6330.113784070234;6453.064305675674;6184.505239580834;6200.10098535712;6281.874362512747;6295.811125666226;6307.810765677025;5734.569907256951;5746.626469279504;5767.192593036968;5769.596128271022;5824.504917082053;5808.767649294024;5849.678267695275;5889.587728858982;5909.645421274738;5955.315138759033;5787.942120578803;5796.913046304308;5799.246098007253;5850.239468869041;5869.9706501467435;5572.58205634575;5600.943990560083;5603.80386686464;5721.427857214287;5797.710114494301;5700.00249956256;5701.401352857932;5777.277840269966;5777.884442311172;5780.0751879699465;6127.387261273881;6217.378262173792;6293.779717709858;6294.3705629437145;6299.118123462719;6645.5680380775575;6690.762208991304;6697.966510167466;6708.060871477997;6708.563943343715;6839.726410943556;6845.589264644137;6850.760223392157;6878.27778083299;6881.346272104142;6215.409536094064;6218;6285.59143655661;6356.9828827387855;6363.140975968231;6787.694553744995;6853.554518956252;6930.06444130036;6954.47841411886;7020.262872398324;6446.323136070739;6517.869642607121;6518.185226846645;6532.608043517404;6534.313897040837;6688.431483323875;6764.0530325754435;6783.932160678429;6793.796186114425;6810.965945170342;6669.233038200669;6682.431993280528;6765.357291057342;6781.796546103625;6787.830304242433;6710.698018589078;6716.227633822173;6774.762883299061;6780.830479238059;6809.114815074008;5124.205748109049;5215.348081489814;5231.241469986907;5291.04761142998;5291.682499050069;4519.638428925678;4543.159515489645;4563.680542362069;4573.153966516205;4622.19111655459;5752.683602401824;5837.503812175928;5845.269341332333;5846.181534585162;5892.351841297454;6747.831304217434;6753.358430949052;6790.93209067903;6869.862602748017;6876.106106206161;5633.239512665819;5721.5708821838525;5792.362840087587;5855.765769369177;5868.09044598088;5694.886102277931;5695.03184458643;5721.971390143022;5724.0841465366175;5770.538356931435;6579.572327798678;6581.012848072732;6586.407223349922;6609.834754131185;6615.503837212228;6652.035454858921;6699.76550820719;6701.095352127498;6711.664416779239;6796;6400.583962042452;6507.544471886922;6593.835154120993;6602.702878370389;6602.7689030883685;6572.507061970276;6595.538312318092;6636.170478690164;6638.701258443285;6649.700763465559;6737.528373013842;6812.693428795816;6820.31796820314;6822.590644561342;6838.5213035089055;6504.902426463512;6507.934920650922;6510.544261901621;6599.472042236705;6604;6350.142730731292;6468.838279043061;6479.611223326427;6506.674666266762;6599.769008084694;6332.778352757816;6354.17395738551;6356.11014457967;6394.4884409246215;6493.642849643315;6504.967475162784;6580.473562115115;6600.141981542369;6615.6030638161865;6651.368120028589;6146.416090471398;6338.8732225354315;6342.365763423621;6437.0666253392055;6444.581102228341 11:34:00 INFO - PID 10750 | |1;ext.html;862.1895418306791;872.664024350625;879.3273146043279;881.4402854187589;882.3382463152635;38256.234875302514;41981.79009104954;42179.36730949038;42271.365929511085;42299.36550951738;38138;38461.23077538447;38466.42300365497;38514;38522.614773852256;7246.166690830556;7293.452991025668;7353.77938661841;7368.705251789922;7372.225916278794;7165.85668286634;7227.819304517403;7240;7255.637218139098;7283.235260297672;7210.7476238331665;7303.087114110736;7320.304571065741;7322.890156647654;7897.486663366892;8033.718819841307;8047.597620119;8060.5566693831815;8072.313853322475;8130.837383252302;7987.960060199662;8083.272505474535;8086.676532938675;8095.311898488636;8132.430729848854;36294.27411451756;37370;37395;37562.43656345157;37691.81154094212;3097.6902309769066;3101.6278046634325;3119.0486901495033;3121.1260846962887;3123.5314702794535;31440.52839207414;31597;31682.841585792154;31708;31789.682103179133;5184.377874655028;5198.714070726109;5206.427292997767;5218.399884013311;5247.47525247476;183860;183988;184587;184707;185109;42408.36387454191;42782.786086069995;47987;48157;49001.5099848997;52177.47822521726;52382.476175238524;52435;52469.737651312265;52501.474985250425;16312.184390780414;16332.265048072864;16368.590785230464;16437.178141092896;16464.259108340153;13270.66823329405;13291.867081329256;13308.600741977756;13339.19964802115;13382.866171338357;14260.35828387725;14452.927735361467;14517.927410362881;14606;14667.706645867023;5714.257146570919;5802.680852553066;5908;6024.186734790835;6038.788642397495;1005.1406047829147;1026.5124066068558;1028.7788125553043;1029.0943969306961;1032.9896701033044;23233.88383058108;23329.533409331718;23347.53304933892;23373.883130584578;23497.412564685677;1110.3615421132881;1118.7370967822555;1118.9104871610252;1120.445379537118;1131.4116659337262;12321.322327271906;12339.50641974311;12372.752544949051;12456.688582785502;12548.623541293775;224757;225715;226029;226501;226757;52655.47344526506;52703;52797.472025280025;52900.206496902574;52994;1422.2746399336413;1434.6915413186216;1453.1644304524941;1455.628814652257;1471.161437980341;22828.885855570617;23089.307320780405;23273.418164546023;23337.299881003597;23573.882130589238;37629.62370376261;37893.24213515769;37947.430788538746;37987.620123798406;38024.42963355607;187516;188585;188692;188982;189210;31287.68712312848;31669.683303166672;31731.682683172872;31736.841315793274;35241.29517409586;44197.11605767931;44755;44848.32727509025;45201.0959780796;45265;32187.51718724174;32286.3856807154;32484.35031299408;32615.836920816193;32857.50713739248;32487.02538923836;32534.674653253165;32561.18597035093;32591.674083258862;33402;36721.26557468782;36736.448953265186;36911.815440922626;36998.44502332414;37093.44359834659;31244.218894527818;31284.37431251408;31411.84294078515;31489.8425507871;31514.054578362688;22966.19618313351;23261.41846453852;23513.41216469602;23567.64648530239;23743.643845342678 11:34:00 INFO - PID 10750 | |2;jquery.html;583.4311546242415;585.2771826793911;591.7958304384987;597.9970100149499;603.8037637767725;21532.38507111967;22328.776712232873;22357.776422235773;22430.55138897223;22504.54990900181;22488.437789055282;23642.290731278044;23779.76220237797;23910.52178956424;23954.640680389766;6398.264199617034;6506.219253689564;6537.934620653804;6543.378379053982;6575.671216439183;6357.936420635804;6398.264199617057;6445.484361251112;6446.838829029289;6682.83292917676;6625.701843417034;6628.867422651544;6633.601983880959;6634.104395906563;6639.269680335159;6290.937090629081;6645.700943457556;6654.2014958204845;6660.200775906922;6662.833429164285;6165.229346331708;6183.319834818167;6185.721642526097;6192.287886892975;6201.658908760016;27363.315917102034;27689.446211075665;27837.721622783916;27852.721472785215;27928;1947.5033866364129;1966.439564724061;1967.1344608372272;1967.9508012299664;1968.5865968146563;18645.53386165343;19031.904840475847;19254.71117933232;19396.612067758564;19506.31727889517;2322.5354929014266;2344.1326709117566;2368.7512811154925;2378.191414918919;2378.9881050594636;107991;115292;126446;132936.34722784656;134942;14314.733175828685;14943.701125977419;14963.027403218974;15053.54909123524;15388.230588470531;22875.28435367354;22943.541129177658;22961.88519057394;22963.311100667008;22964.885175574014;10082.74793130163;10087.546060427298;10146.492675366202;10250.641227557;10358.792824143475;9438.764030899145;9494.715158545254;9507.33448658601;9565;9595.42427454355;8612.363810512043;8708.216260536583;8845.823083538293;9019.601961695947;9207.217386522087;2752.6559180102486;2770.1827960751625;2775.847328396917;2776.88892444304;2902.1583740715378;922.239152699026;933.6172169410509;961.053362437998;967.9032096790264;968.2979839616222;17827;18517.166727497293;18526.907365463358;18591.90704046471;18675.90662046708;985.9901400986042;988.6094992477931;1016.8678071850612;1034.6171916390983;1034.8758149022015;10041.648542300984;10061.446620435947;10127.442990635585;10153.593856245667;10331.741706457398;507010;511714;512062;513785;519389;107853.46073269584;109572;111557.44221278842;111675;112658;1006.5420233793607;1056.6407421476736;1063.106990128296;1102.7077824376547;1128.4245035032193;18626.534336641693;19095.331663391713;19177.94521301342;19295;19540.706889396955;54391.18413223884;54978.725106374215;55487.72256138694;55781.72109139428;57035.429645703014;70287.64856175687;70493;70550;70651;71043.64478177576;13564.593062208149;14006.369713363127;14058.718825623635;14061.086029408056;14079.662432068937;20848.270310539057;21302;21580.352589422342;21840.78159218451;21849.890750546147;17280.827191727923;17553.736693949344;17581.736273956158;17584.38454654081;17818.732719009484;14929.402823887358;15532.68934621324;15616.21918904073;16054.277557510173;16555.66888662244;16664.583385415463;17689.11554422248;17697.292108315523;17970.460886173434;17989.550261243574;13958.790618140532;13980.091294065853;13983.370748316147;14055.367508461939;14100;16995.575110622332;17184.140792960054;17219.3973210937;17407.47777566675;17509.38717144945 11:34:00 INFO - PID 10750 | |3;mootools.html;1324.6158614001938;1406.3460490871737;1410.7108042851203;1410.7954346619738;1422.7367936931669;14915.32881020354;15738.213089345543;15746.685066298667;15749.84250157498;15768.132752698597;15374.07755534666;15477.922610386931;15481.380744770224;15487.84512154878;15508.14705191214;2753.20157154425;2781.8469984150915;2814.0432253033964;2818.2109009477276;2821.379296554765;2567.7560631739957;2573.318070711263;2588.93527661809;2592.481503699258;2596.584546472565;2467.679201703785;2590.922272331833;2593.7665610095087;2596.0524408590823;2753.0777189641494;2711.4034912319357;2724.0465836956905;2740.9588856167175;2746.244782684758;2753.8623068846478;2717.6331195288776;2867.7562407195414;2868.641419822522;2869.9282517937218;2871.5261981772983;15064.096154230781;15132.319045642973;15225.086494810235;15234.847651523454;15258.542243732705;7972.800679982989;8292.58537073144;8302.501849889026;8307.501549907025;8318.45930014547;5292.311999440087;5356.839294821161;5407.729613519347;5486.533644640211;5511.889762204773;1918.8368988635982;1957.618264438435;1964.7740509841408;1977.1399441243104;1999.2802591067205;27528.311792205153;27829;27839.38088048561;27845;27913.860430697718;6725.562838415585;6759.831004224934;7006;7158.92841071593;7384.335409813142;17593.29626814939;17776.55558611045;17811.198496067707;17862.106894655215;17879.642407152045;7834.764957051298;7995.520268783892;8000.599970001476;8048.396370272253;8098.35213182944;7236.276372362721;7337.88993165103;7384.1877393486675;7409;7510.624468776539;5150.27896094547;5266.3943646480375;5273.604479664041;5394.838154855361;5427.3758517770175;1515.2196618741357;1517.3172072567388;1519.8176218853807;1539.3996341426853;1570.701566702323;898.4294972692256;910.4400793511943;910.5492781073411;926.7683079230193;937.8874535055837;8142.389320800964;8236.341092712568;8336.041355244104;8396.664133434717;8405.579721013924;979.1579241852002;992.4839083676447;996.9700908972598;999.3554157568328;1015.7968406318765;5111.693298402108;5255.264263003182;5375.569954403638;5401.4868587484125;5561.193626924073;21626.45933851635;22383.216587419363;22477.10091596318;22594.435139121655;22598.435039124153;19670;21355.57288854214;21368.786312136992;21383.572328553342;21916.342509724735;10893.183011274186;11141.053010494199;11177.552897883994;11222.382768947624;11227;8085.838283234185;8836.204741573289;8907.866382004404;8945.418547794372;9005.774855628662;18581.90709046446;19100.235990560777;19340;19408.70886936669;19470.707939380638;19325.613487730447;19464.513387165433;19663.70504442406;19982.400527984184;20150.69773953421;11451.770964580828;12530.561430349893;12647.747045059232;12658.177218480769;12683.921866641438;14068.859311407165;14090.36593353281;14259.786103208668;14275.857241427453;14285.785713214102;11310.20828542027;11412.828807567726;11446.969772720495;11718.824217636571;11852.762944740884;11109.94445027802;11196.888031119584;11367.772644546898;11395;11421.428928553372;10125.544350504393;10163.89836101659;10178.931212222906;10253.38479691191;10256.38461692301;7167.817310143768;7180.461465390013;7234.89147662796;7362.079740032496;7363.374113200223;7610;7659.463837531319;7758.185390533913;7764.340031097194;7845.5684937329 11:34:00 INFO - PID 10750 | |4;prototype.html;505.4616833072777;518.8910328830946;543.1174341694746;548.2105767694519;549.7526113249039;6206.968965155179;6225.066240063993;6228.906566401508;6275.6548389838545;6318.778842740505;6141.293751218611;6169.938300616993;6175.629462232269;6220.844478888019;6263.7494500220055;4966.751662416883;5008.123578373788;5057.468965758598;5081.390233172025;5085.110105731501;4790.9520904791025;4961.5038496150455;5039.622028347871;5067.74661266937;5085.964894754204;4998.175301075318;5004.949950500503;5012.724300163508;5034.421041580228;5045.167547354682;4928.33467481889;4980.352554167971;4987.351644286256;5029.371328583927;5063.898722025558;4468.664850136221;4493.393391892086;4510.368548403226;4513.932291015637;4530.411046563926;6066.787662431793;6116.92953733095;6133.723982420802;6141.324454310023;6149.954507733652;5735.4551317624755;5741.425857414267;5767.163761254595;5767.471620020698;5781.479666829963;6424.4860411167465;6510.5442619016685;6517.804465866032;6525.64108974011;6545.345465453464;4893.779779909913;4926.531979461945;4964.081644895669;4968.30443737877;4971.651984361096;6912.516123871331;6952.965235173791;6960.999999999949;6980.616066116361;7003.824904377431;4967.7019378837385;5005.772431268124;5025.849224523197;5034.244863270539;5043.722595257223;5071.7971281149075;5079.390473143247;5102.234664800236;5121.103806833789;5142.845714628567;5670.744816483269;5733.226014487991;5736.569757268222;5738.655680659091;5771;6518.478521718251;6519.217693876765;6607.87008119925;6647.966760166265;6661.26726060133;1648.068841104772;1694.534003149144;1708.8974661520099;1751.3695069774872;1772.2645102282409;1147.862256529222;1236.536298887917;1240.2930329712158;1242.975140497185;1257.1011726615332;5592.86017849557;5676.460736230051;5704.800331988444;5714.314282286152;5770.615052387397;6541.252673876983;6587.209534855848;6589;6616.966915165393;6618.966905165444;5705.62913410627;5738.024146436456;5766.855828604318;5796.88406231873;5798.710064496759;3514.947275790865;3541.2740388220354;3542.9645703542633;3563.111550878039;3582.2656355447593;6460.45086167681;6526.543141980016;6567.4417674497245;6570.488787578884;6579.769708060195;6819.965900170567;6916.031755554226;6928.79213623582;6960.617166055814;7005.439564834801;6470.320616335312;6483.481321494269;6528.934710652833;6562.081308616797;6589.505787065989;6356.586821856565;6609;6675.766348177791;6702.865942681022;6719.294474080151;6533.444657204191;6563;6563.523207278324;6571.96714016446;6598.37315455031;6502.934970650233;6571.737130514726;6590.275069742421;6610;6610.603363798187;4948.975255123702;4971.950280497149;4975.378077740283;4998.325226094431;5008.3238762768015;6678.799636010927;6756.527043106936;6778.627175505395;6784.321567843176;6808.455323574201;6338.873222535616;6390.392912673288;6418.422341989243;6424.743010279723;6459.90181669108;6414.888778942302;6454.774082907264;6465.288818230085;6538.476921846146;6564.113844630913;6104.847378815565;6124.418180272867;6350.174477317919;6418.839529011812;6511.413972742476;6415.914827680929;6450.129232553545;6469.159009328945;6481.675916204076;6493.902591461037;6210.223722034746;6272.843178920563;6290.716917738621;6366.949453340332;6400.9039864403 11:34:00 INFO - PID 10750 | |5;yui.html;902.4269588811103;909.8180363927215;929.354098901263;931.0503286647622;931.3247895275925;19354;20045.498862528446;20115.094820733048;20175.697364539526;22295.21966731165;21791;21947;21957.67063494049;21992.230271940487;22075.66886496704;964.9372790768596;980.5783513089368;983.2871168402886;987.0672214757058;989.3766926836083;919.5356345045742;989.7476143583376;993.88073431188;997.1175509673918;999.9600015999351;1053.162735625176;1068.5351871935734;1068.8503609494676;1068.9412082335468;1069.107295408335;1042.9791404171913;1062.5643486170634;1063.3672964586096;1065.03082195202;1065.4832406282947;772.3126417488439;772.3936709682928;773.2460850670608;780.5316809914063;782.8316911863976;20082.89958550198;20232.69650955237;20449.8977505113;20507.077181526867;20667;21726;21840.235591754372;22228.444288892744;22232;22260.22089226869;17647.911760441115;17691.823081769147;17804.91097544517;17816.643667126715;17849.286028558843;3562.7327950403565;3728.7949162796035;3767.6232376762377;3771.585125636178;3775.5469343678933;135183;135343;137105;137665;139169;15459.92270038665;15722.29249683767;15759.68480630381;15790.289436975363;15844.366225351087;31212.531812022837;31899.681003190137;31970.84014579912;32061;32099.67900320967;7603.65783539731;7858.646360913658;7911.564863932539;7911.564863932539;7993.760187194393;3962.5046869141356;4007.438958545806;4031.778252196157;4035.9596404035583;4049.250888585621;4876.536729010738;5082;5762.4525670061275;5968.761249550056;5990.251218597676;1134.659602119361;1147.5065721739566;1165.6153469355093;1172.941352932367;1174.1135442740676;679.7722762874394;699.874022675913;700.4641449291195;703.8627467643863;706.6007705646293;11871.347075910908;12460.190087644456;12897.35513224335;13423.798643020362;13470;654.8133781872239;654.898490733937;654.9934500654932;658.7562601837351;660.6597602234853;5937.168796368512;5946.464818166386;5987.161797348374;5988.461038506555;6126.846828829315;115114;115546;116093;116401;117550.4122479382;103946;105407.4729626347;107329;107502.46248768707;108422.91577084285;88500;89390;92464;92904;95515.9999999986;10911.618093367011;11139.387333696724;11193.608223712132;11279.887201127884;11516.481758320728;41369.586304136574;42280.365794513724;42756;42942.141157177306;44455.555444446436;52845.7357713209;54632;54787.72606136944;55093.44906551044;56135.15797263126;15359.232038397811;15419.460318888785;15439.22803859825;15555.766663500282;15578.9221053894;18345;18392.264309428007;18414.171362289;18475.81524184741;18687.43937681872;16589.917050415155;17019.914900425418;17036.829631703524;17189.828101718824;17255.82744172542;14902.254887255376;15139.54581362561;15445.22773861325;15652;15717.135557544445;16210.108444035692;16262.756058659366;16388.18059097064;16406.589835254214;16531.256093475582;12863.614091577268;13070.673233169247;13155.144915580839;13161.736765264832;13422.865771342162;12710.936445317715;12753.87246127564;12834.679133021376;12838.16551924122;13034.608961731163 11:34:00 INFO - PID 10750 | __end_tp_report 11:34:00 INFO - PID 10750 | __start_cc_report 11:34:00 INFO - PID 10750 | _x_x_mozilla_cycle_collect,275 11:34:00 INFO - PID 10750 | __end_cc_report 11:34:00 INFO - PID 10750 | __startTimestamp1506537240229__endTimestamp 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | ------- Summary: start ------- 11:34:00 INFO - PID 10750 | Number of tests: 6 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#0] dojo.html Cycles:165 Average:6181.25 Median:6400.58 stddev:742.87 (11.6%) stddev-sans-first:707.04 11:34:00 INFO - PID 10750 | Values: 3187.2 3212.0 3227.9 3248.4 3251.1 6152.8 6282.7 6311.6 6330.1 6453.1 6184.5 6200.1 6281.9 6295.8 6307.8 5734.6 5746.6 5767.2 5769.6 5824.5 5808.8 5849.7 5889.6 5909.6 5955.3 5787.9 5796.9 5799.2 5850.2 5870.0 5572.6 5600.9 5603.8 5721.4 5797.7 5700.0 5701.4 5777.3 5777.9 5780.1 6127.4 6217.4 6293.8 6294.4 6299.1 6645.6 6690.8 6698.0 6708.1 6708.6 6839.7 6845.6 6850.8 6878.3 6881.3 6215.4 6218.0 6285.6 6357.0 6363.1 6787.7 6853.6 6930.1 6954.5 7020.3 6446.3 6517.9 6518.2 6532.6 6534.3 6688.4 6764.1 6783.9 6793.8 6811.0 6669.2 6682.4 6765.4 6781.8 6787.8 6710.7 6716.2 6774.8 6780.8 6809.1 5124.2 5215.3 5231.2 5291.0 5291.7 4519.6 4543.2 4563.7 4573.2 4622.2 5752.7 5837.5 5845.3 5846.2 5892.4 6747.8 6753.4 6790.9 6869.9 6876.1 5633.2 5721.6 5792.4 5855.8 5868.1 5694.9 5695.0 5722.0 5724.1 5770.5 6579.6 6581.0 6586.4 6609.8 6615.5 6652.0 6699.8 6701.1 6711.7 6796.0 6400.6 6507.5 6593.8 6602.7 6602.8 6572.5 6595.5 6636.2 6638.7 6649.7 6737.5 6812.7 6820.3 6822.6 6838.5 6504.9 6507.9 6510.5 6599.5 6604.0 6350.1 6468.8 6479.6 6506.7 6599.8 6332.8 6354.2 6356.1 6394.5 6493.6 6505.0 6580.5 6600.1 6615.6 6651.4 6146.4 6338.9 6342.4 6437.1 6444.6 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#1] ext.html Cycles:180 Average:36971.25 Median:32603.76 stddev:51908.92 (159.2%) stddev-sans-first:51983.72 11:34:00 INFO - PID 10750 | Values: 862.2 872.7 879.3 881.4 882.3 38256.2 41981.8 42179.4 42271.4 42299.4 38138.0 38461.2 38466.4 38514.0 38522.6 7246.2 7293.5 7353.8 7368.7 7372.2 7165.9 7227.8 7240.0 7255.6 7283.2 7210.7 7303.1 7320.3 7322.9 7897.5 8033.7 8047.6 8060.6 8072.3 8130.8 7988.0 8083.3 8086.7 8095.3 8132.4 36294.3 37370.0 37395.0 37562.4 37691.8 3097.7 3101.6 3119.0 3121.1 3123.5 31440.5 31597.0 31682.8 31708.0 31789.7 5184.4 5198.7 5206.4 5218.4 5247.5 183860.0 183988.0 184587.0 184707.0 185109.0 42408.4 42782.8 47987.0 48157.0 49001.5 52177.5 52382.5 52435.0 52469.7 52501.5 16312.2 16332.3 16368.6 16437.2 16464.3 13270.7 13291.9 13308.6 13339.2 13382.9 14260.4 14452.9 14517.9 14606.0 14667.7 5714.3 5802.7 5908.0 6024.2 6038.8 1005.1 1026.5 1028.8 1029.1 1033.0 23233.9 23329.5 23347.5 23373.9 23497.4 1110.4 1118.7 1118.9 1120.4 1131.4 12321.3 12339.5 12372.8 12456.7 12548.6 224757.0 225715.0 226029.0 226501.0 226757.0 52655.5 52703.0 52797.5 52900.2 52994.0 1422.3 1434.7 1453.2 1455.6 1471.2 22828.9 23089.3 23273.4 23337.3 23573.9 37629.6 37893.2 37947.4 37987.6 38024.4 187516.0 188585.0 188692.0 188982.0 189210.0 31287.7 31669.7 31731.7 31736.8 35241.3 44197.1 44755.0 44848.3 45201.1 45265.0 32187.5 32286.4 32484.4 32615.8 32857.5 32487.0 32534.7 32561.2 32591.7 33402.0 36721.3 36736.4 36911.8 36998.4 37093.4 31244.2 31284.4 31411.8 31489.8 31514.1 22966.2 23261.4 23513.4 23567.6 23743.6 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#2] jquery.html Cycles:180 Average:34464.58 Median:22394.16 stddev:85574.12 (382.1%) stddev-sans-first:85776.37 11:34:00 INFO - PID 10750 | Values: 583.4 585.3 591.8 598.0 603.8 21532.4 22328.8 22357.8 22430.6 22504.5 22488.4 23642.3 23779.8 23910.5 23954.6 6398.3 6506.2 6537.9 6543.4 6575.7 6357.9 6398.3 6445.5 6446.8 6682.8 6625.7 6628.9 6633.6 6634.1 6639.3 6290.9 6645.7 6654.2 6660.2 6662.8 6165.2 6183.3 6185.7 6192.3 6201.7 27363.3 27689.4 27837.7 27852.7 27928.0 1947.5 1966.4 1967.1 1968.0 1968.6 18645.5 19031.9 19254.7 19396.6 19506.3 2322.5 2344.1 2368.8 2378.2 2379.0 107991.0 115292.0 126446.0 132936.3 134942.0 14314.7 14943.7 14963.0 15053.5 15388.2 22875.3 22943.5 22961.9 22963.3 22964.9 10082.7 10087.5 10146.5 10250.6 10358.8 9438.8 9494.7 9507.3 9565.0 9595.4 8612.4 8708.2 8845.8 9019.6 9207.2 2752.7 2770.2 2775.8 2776.9 2902.2 922.2 933.6 961.1 967.9 968.3 17827.0 18517.2 18526.9 18591.9 18675.9 986.0 988.6 1016.9 1034.6 1034.9 10041.6 10061.4 10127.4 10153.6 10331.7 507010.0 511714.0 512062.0 513785.0 519389.0 107853.5 109572.0 111557.4 111675.0 112658.0 1006.5 1056.6 1063.1 1102.7 1128.4 18626.5 19095.3 19177.9 19295.0 19540.7 54391.2 54978.7 55487.7 55781.7 57035.4 70287.6 70493.0 70550.0 70651.0 71043.6 13564.6 14006.4 14058.7 14061.1 14079.7 20848.3 21302.0 21580.4 21840.8 21849.9 17280.8 17553.7 17581.7 17584.4 17818.7 14929.4 15532.7 15616.2 16054.3 16555.7 16664.6 17689.1 17697.3 17970.5 17989.6 13958.8 13980.1 13983.4 14055.4 14100.0 16995.6 17184.1 17219.4 17407.5 17509.4 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#3] mootools.html Cycles:180 Average:9556.30 Median:2591.70 stddev:6866.18 (264.9%) stddev-sans-first:6857.59 11:34:00 INFO - PID 10750 | Values: 1324.6 1406.3 1410.7 1410.8 1422.7 14915.3 15738.2 15746.7 15749.8 15768.1 15374.1 15477.9 15481.4 15487.8 15508.1 2753.2 2781.8 2814.0 2818.2 2821.4 2567.8 2573.3 2588.9 2592.5 2596.6 2467.7 2590.9 2593.8 2596.1 2753.1 2711.4 2724.0 2741.0 2746.2 2753.9 2717.6 2867.8 2868.6 2869.9 2871.5 15064.1 15132.3 15225.1 15234.8 15258.5 7972.8 8292.6 8302.5 8307.5 8318.5 5292.3 5356.8 5407.7 5486.5 5511.9 1918.8 1957.6 1964.8 1977.1 1999.3 27528.3 27829.0 27839.4 27845.0 27913.9 6725.6 6759.8 7006.0 7158.9 7384.3 17593.3 17776.6 17811.2 17862.1 17879.6 7834.8 7995.5 8000.6 8048.4 8098.4 7236.3 7337.9 7384.2 7409.0 7510.6 5150.3 5266.4 5273.6 5394.8 5427.4 1515.2 1517.3 1519.8 1539.4 1570.7 898.4 910.4 910.5 926.8 937.9 8142.4 8236.3 8336.0 8396.7 8405.6 979.2 992.5 997.0 999.4 1015.8 5111.7 5255.3 5375.6 5401.5 5561.2 21626.5 22383.2 22477.1 22594.4 22598.4 19670.0 21355.6 21368.8 21383.6 21916.3 10893.2 11141.1 11177.6 11222.4 11227.0 8085.8 8836.2 8907.9 8945.4 9005.8 18581.9 19100.2 19340.0 19408.7 19470.7 19325.6 19464.5 19663.7 19982.4 20150.7 11451.8 12530.6 12647.7 12658.2 12683.9 14068.9 14090.4 14259.8 14275.9 14285.8 11310.2 11412.8 11447.0 11718.8 11852.8 11109.9 11196.9 11367.8 11395.0 11421.4 10125.5 10163.9 10178.9 10253.4 10256.4 7167.8 7180.5 7234.9 7362.1 7363.4 7610.0 7659.5 7758.2 7764.3 7845.6 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#4] prototype.html Cycles:180 Average:5506.96 Median:6141.31 stddev:1537.30 (25.0%) stddev-sans-first:1495.07 11:34:00 INFO - PID 10750 | Values: 505.5 518.9 543.1 548.2 549.8 6207.0 6225.1 6228.9 6275.7 6318.8 6141.3 6169.9 6175.6 6220.8 6263.7 4966.8 5008.1 5057.5 5081.4 5085.1 4791.0 4961.5 5039.6 5067.7 5086.0 4998.2 5004.9 5012.7 5034.4 5045.2 4928.3 4980.4 4987.4 5029.4 5063.9 4468.7 4493.4 4510.4 4513.9 4530.4 6066.8 6116.9 6133.7 6141.3 6150.0 5735.5 5741.4 5767.2 5767.5 5781.5 6424.5 6510.5 6517.8 6525.6 6545.3 4893.8 4926.5 4964.1 4968.3 4971.7 6912.5 6953.0 6961.0 6980.6 7003.8 4967.7 5005.8 5025.8 5034.2 5043.7 5071.8 5079.4 5102.2 5121.1 5142.8 5670.7 5733.2 5736.6 5738.7 5771.0 6518.5 6519.2 6607.9 6648.0 6661.3 1648.1 1694.5 1708.9 1751.4 1772.3 1147.9 1236.5 1240.3 1243.0 1257.1 5592.9 5676.5 5704.8 5714.3 5770.6 6541.3 6587.2 6589.0 6617.0 6619.0 5705.6 5738.0 5766.9 5796.9 5798.7 3514.9 3541.3 3543.0 3563.1 3582.3 6460.5 6526.5 6567.4 6570.5 6579.8 6820.0 6916.0 6928.8 6960.6 7005.4 6470.3 6483.5 6528.9 6562.1 6589.5 6356.6 6609.0 6675.8 6702.9 6719.3 6533.4 6563.0 6563.5 6572.0 6598.4 6502.9 6571.7 6590.3 6610.0 6610.6 4949.0 4972.0 4975.4 4998.3 5008.3 6678.8 6756.5 6778.6 6784.3 6808.5 6338.9 6390.4 6418.4 6424.7 6459.9 6414.9 6454.8 6465.3 6538.5 6564.1 6104.8 6124.4 6350.2 6418.8 6511.4 6415.9 6450.1 6469.2 6481.7 6493.9 6210.2 6272.8 6290.7 6366.9 6400.9 11:34:00 INFO - PID 10750 | 11:34:00 INFO - PID 10750 | [#5] yui.html Cycles:180 Average:24083.37 Median:20341.30 stddev:34045.16 (167.4%) stddev-sans-first:34096.17 11:34:00 INFO - PID 10750 | Values: 902.4 909.8 929.4 931.1 931.3 19354.0 20045.5 20115.1 20175.7 22295.2 21791.0 21947.0 21957.7 21992.2 22075.7 964.9 980.6 983.3 987.1 989.4 919.5 989.7 993.9 997.1 1000.0 1053.2 1068.5 1068.9 1068.9 1069.1 1043.0 1062.6 1063.4 1065.0 1065.5 772.3 772.4 773.2 780.5 782.8 20082.9 20232.7 20449.9 20507.1 20667.0 21726.0 21840.2 22228.4 22232.0 22260.2 17647.9 17691.8 17804.9 17816.6 17849.3 3562.7 3728.8 3767.6 3771.6 3775.5 135183.0 135343.0 137105.0 137665.0 139169.0 15459.9 15722.3 15759.7 15790.3 15844.4 31212.5 31899.7 31970.8 32061.0 32099.7 7603.7 7858.6 7911.6 7911.6 7993.8 3962.5 4007.4 4031.8 4036.0 4049.3 4876.5 5082.0 5762.5 5968.8 5990.3 1134.7 1147.5 1165.6 1172.9 1174.1 679.8 699.9 700.5 703.9 706.6 11871.3 12460.2 12897.4 13423.8 13470.0 654.8 654.9 655.0 658.8 660.7 5937.2 5946.5 5987.2 5988.5 6126.8 115114.0 115546.0 116093.0 116401.0 117550.4 103946.0 105407.5 107329.0 107502.5 108422.9 88500.0 89390.0 92464.0 92904.0 95516.0 10911.6 11139.4 11193.6 11279.9 11516.5 41369.6 42280.4 42756.0 42942.1 44455.6 52845.7 54632.0 54787.7 55093.4 56135.2 15359.2 15419.5 15439.2 15555.8 15578.9 18345.0 18392.3 18414.2 18475.8 18687.4 16589.9 17019.9 17036.8 17189.8 17255.8 14902.3 15139.5 15445.2 15652.0 15717.1 16210.1 16262.8 16388.2 16406.6 16531.3 12863.6 13070.7 13155.1 13161.7 13422.9 12710.9 12753.9 12834.7 12838.2 13034.6 11:34:00 INFO - PID 10750 | -------- Summary: end -------- 11:34:00 INFO - PID 10750 | 11:34:00 INFO - TEST-INFO | 10750: exit 0 11:34:00 INFO - TEST-OK | dromaeo_css | took 1109033ms 11:34:00 INFO - TEST-START | kraken 11:34:00 INFO - Initialising browser for kraken test... 11:34:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html -profile /tmp/tmpMJiwYI/profile 11:34:00 INFO - TEST-INFO | started process 11118 (/builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html) 11:34:06 INFO - TEST-INFO | 11118: exit 0 11:34:06 INFO - Browser initialized. 11:34:06 INFO - Running cycle 1/1 for kraken test... 11:34:06 INFO - Using env: {'DISPLAY': ':0', 11:34:06 INFO - 'HOME': '/home/cltbld', 11:34:06 INFO - 'JSGC_DISABLE_POISONING': '1', 11:34:06 INFO - 'LANG': 'en_US.UTF-8', 11:34:06 INFO - 'LANGUAGE': 'en_US:en', 11:34:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:34:06 INFO - 'LOGNAME': 'cltbld', 11:34:06 INFO - 'MAIL': '/var/mail/cltbld', 11:34:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:34:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:34:06 INFO - 'MOZ_CRASHREPORTER': '1', 11:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:34:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:34:06 INFO - 'MOZ_NO_REMOTE': '1', 11:34:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:34:06 INFO - 'NO_EM_RESTART': '1', 11:34:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:34:06 INFO - 'PWD': '/builds/slave/test', 11:34:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:34:06 INFO - 'RUST_BACKTRACE': 'full', 11:34:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:34:06 INFO - 'SHELL': '/bin/bash', 11:34:06 INFO - 'SHLVL': '1', 11:34:06 INFO - 'STYLO_FORCE_DISABLED': '1', 11:34:06 INFO - 'TERM': 'linux', 11:34:06 INFO - 'TMOUT': '86400', 11:34:06 INFO - 'USER': 'cltbld', 11:34:06 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853', 11:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:34:06 INFO - '_': '/tools/buildbot/bin/python'} 11:34:06 INFO - TEST-INFO | started process 11356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJiwYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:34:07 INFO - PID 11356 | 11:34:07 INFO - PID 11356 | (/builds/slave/test/build/application/firefox/firefox:11404): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:34:07 INFO - PID 11356 | 11:34:17 INFO - PID 11356 | RSS: Main: 151351296 11:34:17 INFO - PID 11356 | 11:34:20 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:21 INFO - PID 11356 | RSS: Main: 157253632 11:34:21 INFO - PID 11356 | 11:34:23 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-dft) 11:34:24 INFO - PID 11356 | RSS: Main: 157315072 11:34:24 INFO - PID 11356 | 11:34:27 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-fft) 11:34:28 INFO - PID 11356 | RSS: Main: 154501120 11:34:28 INFO - PID 11356 | 11:34:30 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-oscillator) 11:34:30 INFO - PID 11356 | RSS: Main: 154693632 11:34:30 INFO - PID 11356 | 11:34:32 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:33 INFO - PID 11356 | RSS: Main: 154787840 11:34:33 INFO - PID 11356 | 11:34:36 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:37 INFO - PID 11356 | RSS: Main: 157278208 11:34:37 INFO - PID 11356 | 11:34:41 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:41 INFO - PID 11356 | RSS: Main: 157368320 11:34:41 INFO - PID 11356 | 11:34:44 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46596/tests/kraken/driver.html?testName=json-parse-financial) 11:34:45 INFO - PID 11356 | RSS: Main: 156995584 11:34:45 INFO - PID 11356 | 11:34:46 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:47 INFO - PID 11356 | RSS: Main: 157765632 11:34:47 INFO - PID 11356 | 11:34:49 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:49 INFO - PID 11356 | RSS: Main: 154918912 11:34:49 INFO - PID 11356 | 11:34:51 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:52 INFO - PID 11356 | RSS: Main: 154882048 11:34:52 INFO - PID 11356 | 11:34:55 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:55 INFO - PID 11356 | RSS: Main: 155598848 11:34:55 INFO - PID 11356 | 11:34:58 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:59 INFO - PID 11356 | RSS: Main: 155070464 11:34:59 INFO - PID 11356 | 11:35:00 INFO - PID 11356 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46596/tests/kraken/driver.html?testName=ai-astar) 11:35:01 INFO - PID 11356 | RSS: Main: 156758016 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | __start_tp_report 11:35:01 INFO - PID 11356 | _x_x_mozilla_page_load 11:35:01 INFO - PID 11356 | _x_x_mozilla_page_load_details 11:35:01 INFO - PID 11356 | |i|pagename|runs| 11:35:01 INFO - PID 11356 | |0;ai-astar;109;110;109;107;107;107;108;107;109;107 11:35:01 INFO - PID 11356 | |1;audio-beat-detection;117;119;119;117;119;118;119;155;115;152 11:35:01 INFO - PID 11356 | |2;audio-dft;165;165;164;164;163;162;164;169;167;173 11:35:01 INFO - PID 11356 | |3;audio-fft;74;74;75;74;73;75;74;74;73;75 11:35:01 INFO - PID 11356 | |4;audio-oscillator;81;79;80;79;81;80;78;80;89;79 11:35:01 INFO - PID 11356 | |5;imaging-gaussian-blur;110;114;116;114;114;114;114;114;114;114 11:35:01 INFO - PID 11356 | |6;imaging-darkroom;148;147;147;147;147;148;148;150;150;151 11:35:01 INFO - PID 11356 | |7;imaging-desaturate;95;94;96;95;94;94;93;94;95;95 11:35:01 INFO - PID 11356 | |8;json-parse-financial;54;58;55;56;56;53;57;55;55;54 11:35:01 INFO - PID 11356 | |9;json-stringify-tinderbox;39;39;38;38;38;39;38;39;38;39 11:35:01 INFO - PID 11356 | |10;stanford-crypto-aes;71;73;74;72;74;73;74;76;73;78 11:35:01 INFO - PID 11356 | |11;stanford-crypto-ccm;114;115;115;117;115;110;108;107;111;114 11:35:01 INFO - PID 11356 | |12;stanford-crypto-pbkdf2;172;166;167;165;166;167;165;172;162;166 11:35:01 INFO - PID 11356 | |13;stanford-crypto-sha256-iterative;71;66;68;63;65;70;66;65;66;79 11:35:01 INFO - PID 11356 | __end_tp_report 11:35:01 INFO - PID 11356 | __start_cc_report 11:35:01 INFO - PID 11356 | _x_x_mozilla_cycle_collect,732 11:35:01 INFO - PID 11356 | __end_cc_report 11:35:01 INFO - PID 11356 | __startTimestamp1506537301225__endTimestamp 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | ------- Summary: start ------- 11:35:01 INFO - PID 11356 | Number of tests: 14 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.50 stddev:1.15 (1.1%) stddev-sans-first:1.17 11:35:01 INFO - PID 11356 | Values: 109.0 110.0 109.0 107.0 107.0 107.0 108.0 107.0 109.0 107.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:119.00 stddev:15.09 (12.7%) stddev-sans-first:15.73 11:35:01 INFO - PID 11356 | Values: 117.0 119.0 119.0 117.0 119.0 118.0 119.0 155.0 115.0 152.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 11:35:01 INFO - PID 11356 | Values: 165.0 165.0 164.0 164.0 163.0 162.0 164.0 169.0 167.0 173.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 11:35:01 INFO - PID 11356 | Values: 74.0 74.0 75.0 74.0 73.0 75.0 74.0 74.0 73.0 75.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:80.00 stddev:3.10 (3.9%) stddev-sans-first:3.28 11:35:01 INFO - PID 11356 | Values: 81.0 79.0 80.0 79.0 81.0 80.0 78.0 80.0 89.0 79.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:0.67 11:35:01 INFO - PID 11356 | Values: 110.0 114.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 11:35:01 INFO - PID 11356 | Values: 148.0 147.0 147.0 147.0 147.0 148.0 148.0 150.0 150.0 151.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 11:35:01 INFO - PID 11356 | Values: 95.0 94.0 96.0 95.0 94.0 94.0 93.0 94.0 95.0 95.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.49 (2.7%) stddev-sans-first:1.51 11:35:01 INFO - PID 11356 | Values: 54.0 58.0 55.0 56.0 56.0 53.0 57.0 55.0 55.0 54.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 11:35:01 INFO - PID 11356 | Values: 39.0 39.0 38.0 38.0 38.0 39.0 38.0 39.0 38.0 39.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:1.99 (2.7%) stddev-sans-first:1.83 11:35:01 INFO - PID 11356 | Values: 71.0 73.0 74.0 72.0 74.0 73.0 74.0 76.0 73.0 78.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#11] stanford-crypto-ccm Cycles:10 Average:112.60 Median:114.50 stddev:3.37 (2.9%) stddev-sans-first:3.54 11:35:01 INFO - PID 11356 | Values: 114.0 115.0 115.0 117.0 115.0 110.0 108.0 107.0 111.0 114.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:166.50 stddev:3.08 (1.9%) stddev-sans-first:2.64 11:35:01 INFO - PID 11356 | Values: 172.0 166.0 167.0 165.0 166.0 167.0 165.0 172.0 162.0 166.0 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:4.58 (6.8%) stddev-sans-first:4.72 11:35:01 INFO - PID 11356 | Values: 71.0 66.0 68.0 63.0 65.0 70.0 66.0 65.0 66.0 79.0 11:35:01 INFO - PID 11356 | -------- Summary: end -------- 11:35:01 INFO - PID 11356 | 11:35:01 INFO - PID 11356 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:35:01 INFO - TEST-INFO | 11356: exit 0 11:35:01 INFO - TEST-OK | kraken | took 61005ms 11:35:01 INFO - SUITE-END | took 1170s 11:35:02 INFO - Completed test suite (00:19:30) 11:35:02 INFO - javascript benchmark 11:35:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8517.01884462205, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.2031992002, 3211.9839400802994, 3227.9354412911744, 3248.4315244832164, 3251.1059458648883, 6152.8461788455315, 6282.654454005028, 6311.589746666464, 6330.113784070234, 6453.064305675674, 6184.505239580834, 6200.10098535712, 6281.874362512747, 6295.811125666226, 6307.810765677025, 5734.569907256951, 5746.626469279504, 5767.192593036968, 5769.596128271022, 5824.504917082053, 5808.767649294024, 5849.678267695275, 5889.587728858982, 5909.645421274738, 5955.315138759033, 5787.942120578803, 5796.913046304308, 5799.246098007253, 5850.239468869041, 5869.9706501467435, 5572.58205634575, 5600.943990560083, 5603.80386686464, 5721.427857214287, 5797.710114494301, 5700.00249956256, 5701.401352857932, 5777.277840269966, 5777.884442311172, 5780.0751879699465, 6127.387261273881, 6217.378262173792, 6293.779717709858, 6294.3705629437145, 6299.118123462719, 6645.5680380775575, 6690.762208991304, 6697.966510167466, 6708.060871477997, 6708.563943343715, 6839.726410943556, 6845.589264644137, 6850.760223392157, 6878.27778083299, 6881.346272104142, 6215.409536094064, 6218.0, 6285.59143655661, 6356.9828827387855, 6363.140975968231, 6787.694553744995, 6853.554518956252, 6930.06444130036, 6954.47841411886, 7020.262872398324, 6446.323136070739, 6517.869642607121, 6518.185226846645, 6532.608043517404, 6534.313897040837, 6688.431483323875, 6764.0530325754435, 6783.932160678429, 6793.796186114425, 6810.965945170342, 6669.233038200669, 6682.431993280528, 6765.357291057342, 6781.796546103625, 6787.830304242433, 6710.698018589078, 6716.227633822173, 6774.762883299061, 6780.830479238059, 6809.114815074008, 5124.205748109049, 5215.348081489814, 5231.241469986907, 5291.04761142998, 5291.682499050069, 4519.638428925678, 4543.159515489645, 4563.680542362069, 4573.153966516205, 4622.19111655459, 5752.683602401824, 5837.503812175928, 5845.269341332333, 5846.181534585162, 5892.351841297454, 6747.831304217434, 6753.358430949052, 6790.93209067903, 6869.862602748017, 6876.106106206161, 5633.239512665819, 5721.5708821838525, 5792.362840087587, 5855.765769369177, 5868.09044598088, 5694.886102277931, 5695.03184458643, 5721.971390143022, 5724.0841465366175, 5770.538356931435, 6579.572327798678, 6581.012848072732, 6586.407223349922, 6609.834754131185, 6615.503837212228, 6652.035454858921, 6699.76550820719, 6701.095352127498, 6711.664416779239, 6796.0, 6400.583962042452, 6507.544471886922, 6593.835154120993, 6602.702878370389, 6602.7689030883685, 6572.507061970276, 6595.538312318092, 6636.170478690164, 6638.701258443285, 6649.700763465559, 6737.528373013842, 6812.693428795816, 6820.31796820314, 6822.590644561342, 6838.5213035089055, 6504.902426463512, 6507.934920650922, 6510.544261901621, 6599.472042236705, 6604.0, 6350.142730731292, 6468.838279043061, 6479.611223326427, 6506.674666266762, 6599.769008084694, 6332.778352757816, 6354.17395738551, 6356.11014457967, 6394.4884409246215, 6493.642849643315, 6504.967475162784, 6580.473562115115, 6600.141981542369, 6615.6030638161865, 6651.368120028589, 6146.416090471398, 6338.8732225354315, 6342.365763423621, 6437.0666253392055, 6444.581102228341], "value": 6125.343173448592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.1895418306791, 872.664024350625, 879.3273146043279, 881.4402854187589, 882.3382463152635, 38256.234875302514, 41981.79009104954, 42179.36730949038, 42271.365929511085, 42299.36550951738, 38138.0, 38461.23077538447, 38466.42300365497, 38514.0, 38522.614773852256, 7246.166690830556, 7293.452991025668, 7353.77938661841, 7368.705251789922, 7372.225916278794, 7165.85668286634, 7227.819304517403, 7240.0, 7255.637218139098, 7283.235260297672, 7210.7476238331665, 7303.087114110736, 7320.304571065741, 7322.890156647654, 7897.486663366892, 8033.718819841307, 8047.597620119, 8060.5566693831815, 8072.313853322475, 8130.837383252302, 7987.960060199662, 8083.272505474535, 8086.676532938675, 8095.311898488636, 8132.430729848854, 36294.27411451756, 37370.0, 37395.0, 37562.43656345157, 37691.81154094212, 3097.6902309769066, 3101.6278046634325, 3119.0486901495033, 3121.1260846962887, 3123.5314702794535, 31440.52839207414, 31597.0, 31682.841585792154, 31708.0, 31789.682103179133, 5184.377874655028, 5198.714070726109, 5206.427292997767, 5218.399884013311, 5247.47525247476, 183860.0, 183988.0, 184587.0, 184707.0, 185109.0, 42408.36387454191, 42782.786086069995, 47987.0, 48157.0, 49001.5099848997, 52177.47822521726, 52382.476175238524, 52435.0, 52469.737651312265, 52501.474985250425, 16312.184390780414, 16332.265048072864, 16368.590785230464, 16437.178141092896, 16464.259108340153, 13270.66823329405, 13291.867081329256, 13308.600741977756, 13339.19964802115, 13382.866171338357, 14260.35828387725, 14452.927735361467, 14517.927410362881, 14606.0, 14667.706645867023, 5714.257146570919, 5802.680852553066, 5908.0, 6024.186734790835, 6038.788642397495, 1005.1406047829147, 1026.5124066068558, 1028.7788125553043, 1029.0943969306961, 1032.9896701033044, 23233.88383058108, 23329.533409331718, 23347.53304933892, 23373.883130584578, 23497.412564685677, 1110.3615421132881, 1118.7370967822555, 1118.9104871610252, 1120.445379537118, 1131.4116659337262, 12321.322327271906, 12339.50641974311, 12372.752544949051, 12456.688582785502, 12548.623541293775, 224757.0, 225715.0, 226029.0, 226501.0, 226757.0, 52655.47344526506, 52703.0, 52797.472025280025, 52900.206496902574, 52994.0, 1422.2746399336413, 1434.6915413186216, 1453.1644304524941, 1455.628814652257, 1471.161437980341, 22828.885855570617, 23089.307320780405, 23273.418164546023, 23337.299881003597, 23573.882130589238, 37629.62370376261, 37893.24213515769, 37947.430788538746, 37987.620123798406, 38024.42963355607, 187516.0, 188585.0, 188692.0, 188982.0, 189210.0, 31287.68712312848, 31669.683303166672, 31731.682683172872, 31736.841315793274, 35241.29517409586, 44197.11605767931, 44755.0, 44848.32727509025, 45201.0959780796, 45265.0, 32187.51718724174, 32286.3856807154, 32484.35031299408, 32615.836920816193, 32857.50713739248, 32487.02538923836, 32534.674653253165, 32561.18597035093, 32591.674083258862, 33402.0, 36721.26557468782, 36736.448953265186, 36911.815440922626, 36998.44502332414, 37093.44359834659, 31244.218894527818, 31284.37431251408, 31411.84294078515, 31489.8425507871, 31514.054578362688, 22966.19618313351, 23261.41846453852, 23513.41216469602, 23567.64648530239, 23743.643845342678], "value": 17064.074970564587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4311546242415, 585.2771826793911, 591.7958304384987, 597.9970100149499, 603.8037637767725, 21532.38507111967, 22328.776712232873, 22357.776422235773, 22430.55138897223, 22504.54990900181, 22488.437789055282, 23642.290731278044, 23779.76220237797, 23910.52178956424, 23954.640680389766, 6398.264199617034, 6506.219253689564, 6537.934620653804, 6543.378379053982, 6575.671216439183, 6357.936420635804, 6398.264199617057, 6445.484361251112, 6446.838829029289, 6682.83292917676, 6625.701843417034, 6628.867422651544, 6633.601983880959, 6634.104395906563, 6639.269680335159, 6290.937090629081, 6645.700943457556, 6654.2014958204845, 6660.200775906922, 6662.833429164285, 6165.229346331708, 6183.319834818167, 6185.721642526097, 6192.287886892975, 6201.658908760016, 27363.315917102034, 27689.446211075665, 27837.721622783916, 27852.721472785215, 27928.0, 1947.5033866364129, 1966.439564724061, 1967.1344608372272, 1967.9508012299664, 1968.5865968146563, 18645.53386165343, 19031.904840475847, 19254.71117933232, 19396.612067758564, 19506.31727889517, 2322.5354929014266, 2344.1326709117566, 2368.7512811154925, 2378.191414918919, 2378.9881050594636, 107991.0, 115292.0, 126446.0, 132936.34722784656, 134942.0, 14314.733175828685, 14943.701125977419, 14963.027403218974, 15053.54909123524, 15388.230588470531, 22875.28435367354, 22943.541129177658, 22961.88519057394, 22963.311100667008, 22964.885175574014, 10082.74793130163, 10087.546060427298, 10146.492675366202, 10250.641227557, 10358.792824143475, 9438.764030899145, 9494.715158545254, 9507.33448658601, 9565.0, 9595.42427454355, 8612.363810512043, 8708.216260536583, 8845.823083538293, 9019.601961695947, 9207.217386522087, 2752.6559180102486, 2770.1827960751625, 2775.847328396917, 2776.88892444304, 2902.1583740715378, 922.239152699026, 933.6172169410509, 961.053362437998, 967.9032096790264, 968.2979839616222, 17827.0, 18517.166727497293, 18526.907365463358, 18591.90704046471, 18675.90662046708, 985.9901400986042, 988.6094992477931, 1016.8678071850612, 1034.6171916390983, 1034.8758149022015, 10041.648542300984, 10061.446620435947, 10127.442990635585, 10153.593856245667, 10331.741706457398, 507010.0, 511714.0, 512062.0, 513785.0, 519389.0, 107853.46073269584, 109572.0, 111557.44221278842, 111675.0, 112658.0, 1006.5420233793607, 1056.6407421476736, 1063.106990128296, 1102.7077824376547, 1128.4245035032193, 18626.534336641693, 19095.331663391713, 19177.94521301342, 19295.0, 19540.706889396955, 54391.18413223884, 54978.725106374215, 55487.72256138694, 55781.72109139428, 57035.429645703014, 70287.64856175687, 70493.0, 70550.0, 70651.0, 71043.64478177576, 13564.593062208149, 14006.369713363127, 14058.718825623635, 14061.086029408056, 14079.662432068937, 20848.270310539057, 21302.0, 21580.352589422342, 21840.78159218451, 21849.890750546147, 17280.827191727923, 17553.736693949344, 17581.736273956158, 17584.38454654081, 17818.732719009484, 14929.402823887358, 15532.68934621324, 15616.21918904073, 16054.277557510173, 16555.66888662244, 16664.583385415463, 17689.11554422248, 17697.292108315523, 17970.460886173434, 17989.550261243574, 13958.790618140532, 13980.091294065853, 13983.370748316147, 14055.367508461939, 14100.0, 16995.575110622332, 17184.140792960054, 17219.3973210937, 17407.47777566675, 17509.38717144945], "value": 11667.276977230851, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.6158614001938, 1406.3460490871737, 1410.7108042851203, 1410.7954346619738, 1422.7367936931669, 14915.32881020354, 15738.213089345543, 15746.685066298667, 15749.84250157498, 15768.132752698597, 15374.07755534666, 15477.922610386931, 15481.380744770224, 15487.84512154878, 15508.14705191214, 2753.20157154425, 2781.8469984150915, 2814.0432253033964, 2818.2109009477276, 2821.379296554765, 2567.7560631739957, 2573.318070711263, 2588.93527661809, 2592.481503699258, 2596.584546472565, 2467.679201703785, 2590.922272331833, 2593.7665610095087, 2596.0524408590823, 2753.0777189641494, 2711.4034912319357, 2724.0465836956905, 2740.9588856167175, 2746.244782684758, 2753.8623068846478, 2717.6331195288776, 2867.7562407195414, 2868.641419822522, 2869.9282517937218, 2871.5261981772983, 15064.096154230781, 15132.319045642973, 15225.086494810235, 15234.847651523454, 15258.542243732705, 7972.800679982989, 8292.58537073144, 8302.501849889026, 8307.501549907025, 8318.45930014547, 5292.311999440087, 5356.839294821161, 5407.729613519347, 5486.533644640211, 5511.889762204773, 1918.8368988635982, 1957.618264438435, 1964.7740509841408, 1977.1399441243104, 1999.2802591067205, 27528.311792205153, 27829.0, 27839.38088048561, 27845.0, 27913.860430697718, 6725.562838415585, 6759.831004224934, 7006.0, 7158.92841071593, 7384.335409813142, 17593.29626814939, 17776.55558611045, 17811.198496067707, 17862.106894655215, 17879.642407152045, 7834.764957051298, 7995.520268783892, 8000.599970001476, 8048.396370272253, 8098.35213182944, 7236.276372362721, 7337.88993165103, 7384.1877393486675, 7409.0, 7510.624468776539, 5150.27896094547, 5266.3943646480375, 5273.604479664041, 5394.838154855361, 5427.3758517770175, 1515.2196618741357, 1517.3172072567388, 1519.8176218853807, 1539.3996341426853, 1570.701566702323, 898.4294972692256, 910.4400793511943, 910.5492781073411, 926.7683079230193, 937.8874535055837, 8142.389320800964, 8236.341092712568, 8336.041355244104, 8396.664133434717, 8405.579721013924, 979.1579241852002, 992.4839083676447, 996.9700908972598, 999.3554157568328, 1015.7968406318765, 5111.693298402108, 5255.264263003182, 5375.569954403638, 5401.4868587484125, 5561.193626924073, 21626.45933851635, 22383.216587419363, 22477.10091596318, 22594.435139121655, 22598.435039124153, 19670.0, 21355.57288854214, 21368.786312136992, 21383.572328553342, 21916.342509724735, 10893.183011274186, 11141.053010494199, 11177.552897883994, 11222.382768947624, 11227.0, 8085.838283234185, 8836.204741573289, 8907.866382004404, 8945.418547794372, 9005.774855628662, 18581.90709046446, 19100.235990560777, 19340.0, 19408.70886936669, 19470.707939380638, 19325.613487730447, 19464.513387165433, 19663.70504442406, 19982.400527984184, 20150.69773953421, 11451.770964580828, 12530.561430349893, 12647.747045059232, 12658.177218480769, 12683.921866641438, 14068.859311407165, 14090.36593353281, 14259.786103208668, 14275.857241427453, 14285.785713214102, 11310.20828542027, 11412.828807567726, 11446.969772720495, 11718.824217636571, 11852.762944740884, 11109.94445027802, 11196.888031119584, 11367.772644546898, 11395.0, 11421.428928553372, 10125.544350504393, 10163.89836101659, 10178.931212222906, 10253.38479691191, 10256.38461692301, 7167.817310143768, 7180.461465390013, 7234.89147662796, 7362.079740032496, 7363.374113200223, 7610.0, 7659.463837531319, 7758.185390533913, 7764.340031097194, 7845.5684937329], "value": 6814.079814231436, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.4616833072777, 518.8910328830946, 543.1174341694746, 548.2105767694519, 549.7526113249039, 6206.968965155179, 6225.066240063993, 6228.906566401508, 6275.6548389838545, 6318.778842740505, 6141.293751218611, 6169.938300616993, 6175.629462232269, 6220.844478888019, 6263.7494500220055, 4966.751662416883, 5008.123578373788, 5057.468965758598, 5081.390233172025, 5085.110105731501, 4790.9520904791025, 4961.5038496150455, 5039.622028347871, 5067.74661266937, 5085.964894754204, 4998.175301075318, 5004.949950500503, 5012.724300163508, 5034.421041580228, 5045.167547354682, 4928.33467481889, 4980.352554167971, 4987.351644286256, 5029.371328583927, 5063.898722025558, 4468.664850136221, 4493.393391892086, 4510.368548403226, 4513.932291015637, 4530.411046563926, 6066.787662431793, 6116.92953733095, 6133.723982420802, 6141.324454310023, 6149.954507733652, 5735.4551317624755, 5741.425857414267, 5767.163761254595, 5767.471620020698, 5781.479666829963, 6424.4860411167465, 6510.5442619016685, 6517.804465866032, 6525.64108974011, 6545.345465453464, 4893.779779909913, 4926.531979461945, 4964.081644895669, 4968.30443737877, 4971.651984361096, 6912.516123871331, 6952.965235173791, 6960.999999999949, 6980.616066116361, 7003.824904377431, 4967.7019378837385, 5005.772431268124, 5025.849224523197, 5034.244863270539, 5043.722595257223, 5071.7971281149075, 5079.390473143247, 5102.234664800236, 5121.103806833789, 5142.845714628567, 5670.744816483269, 5733.226014487991, 5736.569757268222, 5738.655680659091, 5771.0, 6518.478521718251, 6519.217693876765, 6607.87008119925, 6647.966760166265, 6661.26726060133, 1648.068841104772, 1694.534003149144, 1708.8974661520099, 1751.3695069774872, 1772.2645102282409, 1147.862256529222, 1236.536298887917, 1240.2930329712158, 1242.975140497185, 1257.1011726615332, 5592.86017849557, 5676.460736230051, 5704.800331988444, 5714.314282286152, 5770.615052387397, 6541.252673876983, 6587.209534855848, 6589.0, 6616.966915165393, 6618.966905165444, 5705.62913410627, 5738.024146436456, 5766.855828604318, 5796.88406231873, 5798.710064496759, 3514.947275790865, 3541.2740388220354, 3542.9645703542633, 3563.111550878039, 3582.2656355447593, 6460.45086167681, 6526.543141980016, 6567.4417674497245, 6570.488787578884, 6579.769708060195, 6819.965900170567, 6916.031755554226, 6928.79213623582, 6960.617166055814, 7005.439564834801, 6470.320616335312, 6483.481321494269, 6528.934710652833, 6562.081308616797, 6589.505787065989, 6356.586821856565, 6609.0, 6675.766348177791, 6702.865942681022, 6719.294474080151, 6533.444657204191, 6563.0, 6563.523207278324, 6571.96714016446, 6598.37315455031, 6502.934970650233, 6571.737130514726, 6590.275069742421, 6610.0, 6610.603363798187, 4948.975255123702, 4971.950280497149, 4975.378077740283, 4998.325226094431, 5008.3238762768015, 6678.799636010927, 6756.527043106936, 6778.627175505395, 6784.321567843176, 6808.455323574201, 6338.873222535616, 6390.392912673288, 6418.422341989243, 6424.743010279723, 6459.90181669108, 6414.888778942302, 6454.774082907264, 6465.288818230085, 6538.476921846146, 6564.113844630913, 6104.847378815565, 6124.418180272867, 6350.174477317919, 6418.839529011812, 6511.413972742476, 6415.914827680929, 6450.129232553545, 6469.159009328945, 6481.675916204076, 6493.902591461037, 6210.223722034746, 6272.843178920563, 6290.716917738621, 6366.949453340332, 6400.9039864403], "value": 5057.296228940614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.4269588811103, 909.8180363927215, 929.354098901263, 931.0503286647622, 931.3247895275925, 19354.0, 20045.498862528446, 20115.094820733048, 20175.697364539526, 22295.21966731165, 21791.0, 21947.0, 21957.67063494049, 21992.230271940487, 22075.66886496704, 964.9372790768596, 980.5783513089368, 983.2871168402886, 987.0672214757058, 989.3766926836083, 919.5356345045742, 989.7476143583376, 993.88073431188, 997.1175509673918, 999.9600015999351, 1053.162735625176, 1068.5351871935734, 1068.8503609494676, 1068.9412082335468, 1069.107295408335, 1042.9791404171913, 1062.5643486170634, 1063.3672964586096, 1065.03082195202, 1065.4832406282947, 772.3126417488439, 772.3936709682928, 773.2460850670608, 780.5316809914063, 782.8316911863976, 20082.89958550198, 20232.69650955237, 20449.8977505113, 20507.077181526867, 20667.0, 21726.0, 21840.235591754372, 22228.444288892744, 22232.0, 22260.22089226869, 17647.911760441115, 17691.823081769147, 17804.91097544517, 17816.643667126715, 17849.286028558843, 3562.7327950403565, 3728.7949162796035, 3767.6232376762377, 3771.585125636178, 3775.5469343678933, 135183.0, 135343.0, 137105.0, 137665.0, 139169.0, 15459.92270038665, 15722.29249683767, 15759.68480630381, 15790.289436975363, 15844.366225351087, 31212.531812022837, 31899.681003190137, 31970.84014579912, 32061.0, 32099.67900320967, 7603.65783539731, 7858.646360913658, 7911.564863932539, 7911.564863932539, 7993.760187194393, 3962.5046869141356, 4007.438958545806, 4031.778252196157, 4035.9596404035583, 4049.250888585621, 4876.536729010738, 5082.0, 5762.4525670061275, 5968.761249550056, 5990.251218597676, 1134.659602119361, 1147.5065721739566, 1165.6153469355093, 1172.941352932367, 1174.1135442740676, 679.7722762874394, 699.874022675913, 700.4641449291195, 703.8627467643863, 706.6007705646293, 11871.347075910908, 12460.190087644456, 12897.35513224335, 13423.798643020362, 13470.0, 654.8133781872239, 654.898490733937, 654.9934500654932, 658.7562601837351, 660.6597602234853, 5937.168796368512, 5946.464818166386, 5987.161797348374, 5988.461038506555, 6126.846828829315, 115114.0, 115546.0, 116093.0, 116401.0, 117550.4122479382, 103946.0, 105407.4729626347, 107329.0, 107502.46248768707, 108422.91577084285, 88500.0, 89390.0, 92464.0, 92904.0, 95515.9999999986, 10911.618093367011, 11139.387333696724, 11193.608223712132, 11279.887201127884, 11516.481758320728, 41369.586304136574, 42280.365794513724, 42756.0, 42942.141157177306, 44455.555444446436, 52845.7357713209, 54632.0, 54787.72606136944, 55093.44906551044, 56135.15797263126, 15359.232038397811, 15419.460318888785, 15439.22803859825, 15555.766663500282, 15578.9221053894, 18345.0, 18392.264309428007, 18414.171362289, 18475.81524184741, 18687.43937681872, 16589.917050415155, 17019.914900425418, 17036.829631703524, 17189.828101718824, 17255.82744172542, 14902.254887255376, 15139.54581362561, 15445.22773861325, 15652.0, 15717.135557544445, 16210.108444035692, 16262.756058659366, 16388.18059097064, 16406.589835254214, 16531.256093475582, 12863.614091577268, 13070.673233169247, 13155.144915580839, 13161.736765264832, 13422.865771342162, 12710.936445317715, 12753.87246127564, 12834.679133021376, 12838.16551924122, 13034.608961731163], "value": 9082.226054615376, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 107.0, 107.0, 107.0, 108.0, 107.0, 109.0, 107.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 119.0, 117.0, 119.0, 118.0, 119.0, 155.0, 115.0, 152.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 164.0, 163.0, 162.0, 164.0, 169.0, 167.0, 173.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 74.0, 73.0, 75.0, 74.0, 74.0, 73.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 79.0, 81.0, 80.0, 78.0, 80.0, 89.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 150.0, 150.0, 151.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 56.0, 56.0, 53.0, 57.0, 55.0, 55.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 74.0, 72.0, 74.0, 73.0, 74.0, 76.0, 73.0, 78.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 117.0, 115.0, 110.0, 108.0, 107.0, 111.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 167.0, 165.0, 166.0, 167.0, 165.0, 172.0, 162.0, 166.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 68.0, 63.0, 65.0, 70.0, 66.0, 65.0, 66.0, 79.0], "value": 67.9, "unit": "score"}]}]} 11:35:02 INFO - Return code: 0 11:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:35:02 INFO - # TBPL SUCCESS # 11:35:02 INFO - Running post-action listener: _package_coverage_data 11:35:02 INFO - Running post-action listener: _resource_record_post_action 11:35:02 INFO - [mozharness: 2017-09-27 18:35:02.479715Z] Finished run-tests step (success) 11:35:02 INFO - Running post-run listener: _resource_record_post_run 11:35:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 430080; Write bytes: 442859520; Read time: 496; Write time: 356076 11:35:02 INFO - TinderboxPrint: CPU usage
13.1% 11:35:02 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 496 11:35:02 INFO - TinderboxPrint: I/O write bytes / time
442,859,520 / 356,076 11:35:02 INFO - TinderboxPrint: CPU idle
8,234.7 (86.9%) 11:35:02 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 11:35:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:35:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106528768; Read time: 220; Write time: 94348 11:35:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:35:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 421888; Write bytes: 336330752; Read time: 260; Write time: 261728 11:35:03 INFO - Running post-run listener: _upload_blobber_files 11:35:03 INFO - Blob upload gear active. 11:35:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:35:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:04 INFO - (blobuploader) - INFO - Done attempting. 11:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:05 INFO - (blobuploader) - INFO - Done attempting. 11:35:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:35:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:12 INFO - (blobuploader) - INFO - Done attempting. 11:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:13 INFO - (blobuploader) - INFO - Done attempting. 11:35:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:13 INFO - Return code: 0 11:35:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d358e71926a73f0ec79bb851adb8cece8463b201a8818a692a4816bd051b1d2ada7dea307bfe09ed7f8b4540493091129ca18db5e19f641c421a7a31af1db0e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffe9e5b5c3fdd3bbde34a529681c0ea3156bc3410ea4e0ef1a5dee82d945a0b3f5e9977ae1452665281d29d9f62dac3906d1463f70ef413ac39b47acef0cda3d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fce9165b55a1419f6042a40af7741d1f9878c63fd7511ed745fa2c5b1425c593be9c6a31b50f62828089017902d17084e1830dba161552bbf9f6950b0c1f9d1d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1bbf7dcea1d060b20a44556f92684b5587572ff4e731ce53fb1b765b5fab0a07e393b2cb9e0146a0359639354d82b96fbf186a48ca22df0063c578d2011415e"} 11:35:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:13 INFO - Contents: 11:35:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d358e71926a73f0ec79bb851adb8cece8463b201a8818a692a4816bd051b1d2ada7dea307bfe09ed7f8b4540493091129ca18db5e19f641c421a7a31af1db0e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffe9e5b5c3fdd3bbde34a529681c0ea3156bc3410ea4e0ef1a5dee82d945a0b3f5e9977ae1452665281d29d9f62dac3906d1463f70ef413ac39b47acef0cda3d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fce9165b55a1419f6042a40af7741d1f9878c63fd7511ed745fa2c5b1425c593be9c6a31b50f62828089017902d17084e1830dba161552bbf9f6950b0c1f9d1d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1bbf7dcea1d060b20a44556f92684b5587572ff4e731ce53fb1b765b5fab0a07e393b2cb9e0146a0359639354d82b96fbf186a48ca22df0063c578d2011415e"} 11:35:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:13 INFO - Copying logs to upload dir... 11:35:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.219905 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-27 11:35:13.371444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:13.375082) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 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/5d358e71926a73f0ec79bb851adb8cece8463b201a8818a692a4816bd051b1d2ada7dea307bfe09ed7f8b4540493091129ca18db5e19f641c421a7a31af1db0e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffe9e5b5c3fdd3bbde34a529681c0ea3156bc3410ea4e0ef1a5dee82d945a0b3f5e9977ae1452665281d29d9f62dac3906d1463f70ef413ac39b47acef0cda3d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fce9165b55a1419f6042a40af7741d1f9878c63fd7511ed745fa2c5b1425c593be9c6a31b50f62828089017902d17084e1830dba161552bbf9f6950b0c1f9d1d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1bbf7dcea1d060b20a44556f92684b5587572ff4e731ce53fb1b765b5fab0a07e393b2cb9e0146a0359639354d82b96fbf186a48ca22df0063c578d2011415e"} build_url:https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/bGmhYXXHRU6bnifb1xql2Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d358e71926a73f0ec79bb851adb8cece8463b201a8818a692a4816bd051b1d2ada7dea307bfe09ed7f8b4540493091129ca18db5e19f641c421a7a31af1db0e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ffe9e5b5c3fdd3bbde34a529681c0ea3156bc3410ea4e0ef1a5dee82d945a0b3f5e9977ae1452665281d29d9f62dac3906d1463f70ef413ac39b47acef0cda3d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fce9165b55a1419f6042a40af7741d1f9878c63fd7511ed745fa2c5b1425c593be9c6a31b50f62828089017902d17084e1830dba161552bbf9f6950b0c1f9d1d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1bbf7dcea1d060b20a44556f92684b5587572ff4e731ce53fb1b765b5fab0a07e393b2cb9e0146a0359639354d82b96fbf186a48ca22df0063c578d2011415e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:13.404381) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:13.404760) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1506530948.992041-982707853 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 11:35:13.489569) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:35:13.489884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 11:35:13.490229) ========= ========= Total master_lag: 0.39 =========