builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-022 starttime: 1506725310.7 results: success (0) revision: 57f68296c350469d73d788eb3695a898947b4acb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.698235) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.698666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.698959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.789792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.790080) ========= 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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 15:48:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.4M=0s 2017-09-29 15:48:30 (90.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.909143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.909449) ========= 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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.959692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:30.960033) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 57f68296c350469d73d788eb3695a898947b4acb --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 57f68296c350469d73d788eb3695a898947b4acb --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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 15:48:31,013 truncating revision to first 12 chars 2017-09-29 15:48:31,014 Setting DEBUG logging. 2017-09-29 15:48:31,014 attempt 1/10 2017-09-29 15:48:31,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/57f68296c350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 15:48:31,558 unpacking tar archive at: mozilla-central-57f68296c350/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:31.792518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:31.792835) ========= script_repo_revision: 57f68296c350469d73d788eb3695a898947b4acb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:31.793541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:31.793807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 15:48:31.808077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-29 15:48:31.808517) ========= /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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:31 INFO - MultiFileLogger online at 20170929 15:48:31 in /builds/slave/test 15:48:31 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 15:48:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:31 INFO - {'append_to_log': False, 15:48:31 INFO - 'base_work_dir': '/builds/slave/test', 15:48:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:48:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:31 INFO - 'branch': 'Firefox-Non-PGO', 15:48:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:31 INFO - 'code_coverage': False, 15:48:31 INFO - 'config_files': ('talos/linux_config.py',), 15:48:31 INFO - 'default_actions': ('clobber', 15:48:31 INFO - 'read-buildbot-config', 15:48:31 INFO - 'download-and-extract', 15:48:31 INFO - 'populate-webroot', 15:48:31 INFO - 'create-virtualenv', 15:48:31 INFO - 'install', 15:48:31 INFO - 'setup-mitmproxy', 15:48:31 INFO - 'run-tests'), 15:48:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:31 INFO - 'disable_ccov_upload': False, 15:48:31 INFO - 'disable_stylo': False, 15:48:32 INFO - 'download_minidump_stackwalk': True, 15:48:32 INFO - 'download_symbols': 'ondemand', 15:48:32 INFO - 'enable_stylo': False, 15:48:32 INFO - 'enable_webrender': False, 15:48:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:48:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:32 INFO - 'gecko_profile': False, 15:48:32 INFO - 'gecko_profile_interval': 0, 15:48:32 INFO - 'installer_path': 'installer.exe', 15:48:32 INFO - 'log_level': 'info', 15:48:32 INFO - 'log_name': 'talos', 15:48:32 INFO - 'log_to_console': True, 15:48:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:32 INFO - 'opt_config_files': (), 15:48:32 INFO - 'pip_index': False, 15:48:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:48:32 INFO - 'system_bits': '32', 15:48:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:32 INFO - 'title': 'talos-linux64-ix-022', 15:48:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:32 INFO - 'use_talos_json': True, 15:48:32 INFO - 'verify': 'False', 15:48:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:32 INFO - 'work_dir': 'build'} 15:48:32 INFO - [mozharness: 2017-09-29 22:48:32.004885Z] Running clobber step. 15:48:32 INFO - Running pre-action listener: _resource_record_pre_action 15:48:32 INFO - Running main action method: clobber 15:48:32 INFO - rmtree: /builds/slave/test/build 15:48:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:33 INFO - Running post-action listener: _resource_record_post_action 15:48:33 INFO - [mozharness: 2017-09-29 22:48:33.515961Z] Finished clobber step (success) 15:48:33 INFO - [mozharness: 2017-09-29 22:48:33.516058Z] Running read-buildbot-config step. 15:48:33 INFO - Running pre-action listener: _resource_record_pre_action 15:48:33 INFO - Running main action method: read_buildbot_config 15:48:33 INFO - Using buildbot properties: 15:48:33 INFO - { 15:48:33 INFO - "project": "", 15:48:33 INFO - "product": "firefox", 15:48:33 INFO - "who": "kwierso@gmail.com", 15:48:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:48:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:48:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:48:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:48:33 INFO - "stage_platform": "linux64", 15:48:33 INFO - "basedir": "/builds/slave/test", 15:48:33 INFO - "buildnumber": 53, 15:48:33 INFO - "platform": "ubuntu64_hw", 15:48:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:48:33 INFO - "slavebuilddir": "test", 15:48:33 INFO - "taskId": "Wsvr0uf7Sju3J_TmJDZ3tg", 15:48:33 INFO - "branch": "mozilla-central", 15:48:33 INFO - "script_repo_revision": "production", 15:48:33 INFO - "revision": "57f68296c350469d73d788eb3695a898947b4acb", 15:48:33 INFO - "slavename": "talos-linux64-ix-022", 15:48:33 INFO - "repo_path": "mozilla-central" 15:48:33 INFO - } 15:48:33 INFO - Finding installer, test and symbols from parent task. 15:48:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wsvr0uf7Sju3J_TmJDZ3tg'}, attempt #1 15:48:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wsvr0uf7Sju3J_TmJDZ3tg'}, attempt #1 15:48:34 INFO - Task dependencies: fp7g7_mhRC22F8P10CUW5Q 15:48:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q'}, attempt #1 15:48:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 15:48:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.test_packages.json 15:48:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.crashreporter-symbols.zip 15:48:34 INFO - Running post-action listener: _resource_record_post_action 15:48:34 INFO - [mozharness: 2017-09-29 22:48:34.915169Z] Finished read-buildbot-config step (success) 15:48:34 INFO - [mozharness: 2017-09-29 22:48:34.915389Z] Running download-and-extract step. 15:48:34 INFO - Running pre-action listener: _resource_record_pre_action 15:48:34 INFO - Running main action method: download_and_extract 15:48:34 INFO - mkdir: /builds/slave/test/build/tests 15:48: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')]} 15:48:34 INFO - trying https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.test_packages.json 15:48:34 INFO - Downloading https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:48:35 INFO - Downloaded 989 bytes. 15:48:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:48:35 INFO - Using the following test package requirements: 15:48:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:48:35 INFO - u'common': [u'target.common.tests.zip'], 15:48:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:48:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:48:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:48:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:48:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:48:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:48:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:48:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:48:35 INFO - u'target.web-platform.tests.tar.gz'], 15:48:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:48:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:48:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.common.tests.zip 15:48:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:48:35 INFO - Fetch https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.common.tests.zip into memory 15:48:37 INFO - Content-Length response header: 55366784 15:48:37 INFO - Bytes received: 55366784 15:48:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.talos.tests.zip 15:48:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:48:48 INFO - Fetch https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.talos.tests.zip into memory 15:48:49 INFO - Content-Length response header: 14522385 15:48:49 INFO - Bytes received: 14522385 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:49 INFO - trying https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 15:48:49 INFO - Downloading https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:48:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:48:50 INFO - Downloaded 61665053 bytes. 15:48:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 15:48:50 INFO - mkdir: /builds/slave/test/properties 15:48:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:50 INFO - Contents: 15:48:50 INFO - build_url:https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 15:48:50 INFO - Running post-action listener: _resource_record_post_action 15:48:50 INFO - Running post-action listener: find_tests_for_verification 15:48:50 INFO - Running post-action listener: set_extra_try_arguments 15:48:50 INFO - [mozharness: 2017-09-29 22:48:50.999257Z] Finished download-and-extract step (success) 15:48:50 INFO - [mozharness: 2017-09-29 22:48:50.999487Z] Running populate-webroot step. 15:48:50 INFO - Running pre-action listener: _resource_record_pre_action 15:48:50 INFO - Running main action method: populate_webroot 15:48:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['tresize', 15:48:51 INFO - 'tcanvasmark']}, 15:48:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['dromaeo_css', 15:48:51 INFO - 'kraken']}, 15:48:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'tests': ['damp', 'tps']}, 15:48:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['damp', 'tps']}, 15:48:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['dromaeo_dom']}, 15:48:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:48:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['basic_compositor_video', 15:48:51 INFO - 'glvideo']}, 15:48:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:48:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['ts_paint_webext', 15:48:51 INFO - 'tp5o_webext']}, 15:48:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:51 INFO - 'ts_paint', 15:48:51 INFO - 'tpaint', 15:48:51 INFO - 'sessionrestore', 15:48:51 INFO - 'sessionrestore_many_windows', 15:48:51 INFO - 'sessionrestore_no_auto_restore', 15:48:51 INFO - 'tabpaint', 15:48:51 INFO - 'cpstartup']}, 15:48:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['a11yr', 15:48:51 INFO - 'ts_paint', 15:48:51 INFO - 'tpaint', 15:48:51 INFO - 'sessionrestore', 15:48:51 INFO - 'sessionrestore_many_windows', 15:48:51 INFO - 'sessionrestore_no_auto_restore', 15:48:51 INFO - 'tabpaint', 15:48:51 INFO - 'cpstartup']}, 15:48:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:48:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:48:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['perf_reftest_singletons']}, 15:48:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['perf_reftest']}, 15:48:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:51 INFO - 'tsvgr_opacity', 15:48:51 INFO - 'tart', 15:48:51 INFO - 'tscrollx', 15:48:51 INFO - 'tsvg_static']}, 15:48:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['tsvgx', 15:48:51 INFO - 'tsvgr_opacity', 15:48:51 INFO - 'tart', 15:48:51 INFO - 'tscrollx', 15:48:51 INFO - 'tsvg_static']}, 15:48:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:48:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--disable-stylo'], 15:48:51 INFO - 'tests': ['tp5o']}, 15:48:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:51 INFO - 'talos_options': ['--mitmproxy', 15:48:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:51 INFO - '--firstNonBlankPaint'], 15:48:51 INFO - 'tests': ['tp6_google', 15:48:51 INFO - 'tp6_youtube', 15:48:51 INFO - 'tp6_amazon', 15:48:51 INFO - 'tp6_facebook']}, 15:48:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:51 INFO - 'talos_options': ['--disable-stylo', 15:48:51 INFO - '--mitmproxy', 15:48:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:51 INFO - '--firstNonBlankPaint'], 15:48:51 INFO - 'tests': ['tp6_google', 15:48:51 INFO - 'tp6_youtube', 15:48:51 INFO - 'tp6_amazon', 15:48:51 INFO - 'tp6_facebook']}, 15:48:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:48:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:48:51 INFO - 'talos_options': ['--stylo-threads=1', 15:48:51 INFO - '--mitmproxy', 15:48:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:48:51 INFO - '--firstNonBlankPaint'], 15:48:51 INFO - 'tests': ['tp6_google', 15:48:51 INFO - 'tp6_youtube', 15:48:51 INFO - 'tp6_amazon', 15:48:51 INFO - 'tp6_facebook']}, 15:48:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--xperf_path', 15:48:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:51 INFO - 'tests': ['tp5n']}, 15:48:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:48:51 INFO - 'talos_options': ['--disable-stylo', 15:48:51 INFO - '--xperf_path', 15:48:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:51 INFO - 'tests': ['tp5n']}}} 15:48:51 INFO - Running post-action listener: _resource_record_post_action 15:48:51 INFO - [mozharness: 2017-09-29 22:48:51.020411Z] Finished populate-webroot step (success) 15:48:51 INFO - [mozharness: 2017-09-29 22:48:51.020502Z] Running create-virtualenv step. 15:48:51 INFO - Running pre-action listener: _resource_record_pre_action 15:48:51 INFO - Running main action method: create_virtualenv 15:48:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:48:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:48:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:48:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:51 INFO - Installing pip...............done. 15:48:51 INFO - Return code: 0 15:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:48:51 INFO - Reading from file tmpfile_stdout 15:48:51 INFO - Output received: 15:48:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:48:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48: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')]} 15:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:52 INFO - Using env: {'DISPLAY': ':0', 15:48:52 INFO - 'HOME': '/home/cltbld', 15:48:52 INFO - 'LANG': 'en_US.UTF-8', 15:48:52 INFO - 'LANGUAGE': 'en_US:en', 15:48:52 INFO - 'LOGNAME': 'cltbld', 15:48:52 INFO - 'MAIL': '/var/mail/cltbld', 15:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:52 INFO - 'MOZ_NO_REMOTE': '1', 15:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:52 INFO - 'NO_EM_RESTART': '1', 15:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:52 INFO - 'PWD': '/builds/slave/test', 15:48:52 INFO - 'SHELL': '/bin/bash', 15:48:52 INFO - 'SHLVL': '1', 15:48:52 INFO - 'TERM': 'linux', 15:48:52 INFO - 'TMOUT': '86400', 15:48:52 INFO - 'USER': 'cltbld', 15:48:52 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:52 INFO - '_': '/tools/buildbot/bin/python'} 15:48:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:48:53 INFO - Downloading/unpacking pip>=1.5 15:48:53 INFO - Running setup.py egg_info for package pip 15:48:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:53 INFO - Installing collected packages: pip 15:48:53 INFO - Found existing installation: pip 1.1 15:48:53 INFO - Uninstalling pip: 15:48:53 INFO - Successfully uninstalled pip 15:48:53 INFO - Running setup.py install for pip 15:48:53 INFO - warning: no files found matching 'pip/cacert.pem' 15:48:53 INFO - warning: no files found matching '*.html' under directory 'docs' 15:48:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:48:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:48:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:48:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:48:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:48:53 INFO - Successfully installed pip 15:48:53 INFO - Cleaning up... 15:48:53 INFO - Return code: 0 15:48:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:53 INFO - Using env: {'DISPLAY': ':0', 15:48:53 INFO - 'HOME': '/home/cltbld', 15:48:53 INFO - 'LANG': 'en_US.UTF-8', 15:48:53 INFO - 'LANGUAGE': 'en_US:en', 15:48:53 INFO - 'LOGNAME': 'cltbld', 15:48:53 INFO - 'MAIL': '/var/mail/cltbld', 15:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:53 INFO - 'MOZ_NO_REMOTE': '1', 15:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:53 INFO - 'NO_EM_RESTART': '1', 15:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:53 INFO - 'PWD': '/builds/slave/test', 15:48:53 INFO - 'SHELL': '/bin/bash', 15:48:53 INFO - 'SHLVL': '1', 15:48:53 INFO - 'TERM': 'linux', 15:48:53 INFO - 'TMOUT': '86400', 15:48:53 INFO - 'USER': 'cltbld', 15:48:53 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:53 INFO - '_': '/tools/buildbot/bin/python'} 15:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:53 INFO - Downloading/unpacking psutil>=3.1.1 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:54 INFO - Installing collected packages: psutil 15:48:54 INFO - Running setup.py install for psutil 15:48:54 INFO - building 'psutil._psutil_linux' extension 15:48:54 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 15:48:54 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 15:48:55 INFO - building 'psutil._psutil_posix' extension 15:48:55 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 15:48:55 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 15:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:55 INFO - Successfully installed psutil 15:48:55 INFO - Cleaning up... 15:48:55 INFO - Return code: 0 15:48:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48: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')]} 15:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:48: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 mozsystemmonitor==0.3 15:48:55 INFO - Using env: {'DISPLAY': ':0', 15:48:55 INFO - 'HOME': '/home/cltbld', 15:48:55 INFO - 'LANG': 'en_US.UTF-8', 15:48:55 INFO - 'LANGUAGE': 'en_US:en', 15:48:55 INFO - 'LOGNAME': 'cltbld', 15:48:55 INFO - 'MAIL': '/var/mail/cltbld', 15:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:55 INFO - 'MOZ_NO_REMOTE': '1', 15:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:55 INFO - 'NO_EM_RESTART': '1', 15:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:55 INFO - 'PWD': '/builds/slave/test', 15:48:55 INFO - 'SHELL': '/bin/bash', 15:48:55 INFO - 'SHLVL': '1', 15:48:55 INFO - 'TERM': 'linux', 15:48:55 INFO - 'TMOUT': '86400', 15:48:55 INFO - 'USER': 'cltbld', 15:48:55 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:55 INFO - '_': '/tools/buildbot/bin/python'} 15:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48: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 15:48: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 15:48: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 15:48: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 15:48:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:56 INFO - Installing collected packages: mozsystemmonitor 15:48:56 INFO - Running setup.py install for mozsystemmonitor 15:48:57 INFO - Successfully installed mozsystemmonitor 15:48:57 INFO - Cleaning up... 15:48:57 INFO - Return code: 0 15:48:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:48:57 INFO - Using env: {'DISPLAY': ':0', 15:48:57 INFO - 'HOME': '/home/cltbld', 15:48:57 INFO - 'LANG': 'en_US.UTF-8', 15:48:57 INFO - 'LANGUAGE': 'en_US:en', 15:48:57 INFO - 'LOGNAME': 'cltbld', 15:48:57 INFO - 'MAIL': '/var/mail/cltbld', 15:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:57 INFO - 'MOZ_NO_REMOTE': '1', 15:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:57 INFO - 'NO_EM_RESTART': '1', 15:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:57 INFO - 'PWD': '/builds/slave/test', 15:48:57 INFO - 'SHELL': '/bin/bash', 15:48:57 INFO - 'SHLVL': '1', 15:48:57 INFO - 'TERM': 'linux', 15:48:57 INFO - 'TMOUT': '86400', 15:48:57 INFO - 'USER': 'cltbld', 15:48:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:57 INFO - '_': '/tools/buildbot/bin/python'} 15:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49: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 15:49: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 15:49: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 15:49: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 15:49:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:00 INFO - warning: no files found matching '*.txt' 15:49:00 INFO - no previously-included directories found matching 'build' 15:49:00 INFO - no previously-included directories found matching 'dist' 15:49:00 INFO - no previously-included directories found matching '.git*' 15:49:00 INFO - Installing collected packages: jsonschema, functools32 15:49:00 INFO - Running setup.py install for functools32 15:49:00 INFO - warning: no files found matching '*.txt' 15:49:00 INFO - no previously-included directories found matching 'build' 15:49:00 INFO - no previously-included directories found matching 'dist' 15:49:00 INFO - no previously-included directories found matching '.git*' 15:49:00 INFO - Successfully installed jsonschema functools32 15:49:00 INFO - Cleaning up... 15:49:00 INFO - Return code: 0 15:49:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:49:00 INFO - Using env: {'DISPLAY': ':0', 15:49:00 INFO - 'HOME': '/home/cltbld', 15:49:00 INFO - 'LANG': 'en_US.UTF-8', 15:49:00 INFO - 'LANGUAGE': 'en_US:en', 15:49:00 INFO - 'LOGNAME': 'cltbld', 15:49:00 INFO - 'MAIL': '/var/mail/cltbld', 15:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:00 INFO - 'MOZ_NO_REMOTE': '1', 15:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:00 INFO - 'NO_EM_RESTART': '1', 15:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:00 INFO - 'PWD': '/builds/slave/test', 15:49:00 INFO - 'SHELL': '/bin/bash', 15:49:00 INFO - 'SHLVL': '1', 15:49:00 INFO - 'TERM': 'linux', 15:49:00 INFO - 'TMOUT': '86400', 15:49:00 INFO - 'USER': 'cltbld', 15:49:00 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:00 INFO - '_': '/tools/buildbot/bin/python'} 15:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:00 INFO - Cleaning up... 15:49:00 INFO - Return code: 0 15:49:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:49:00 INFO - Using env: {'DISPLAY': ':0', 15:49:00 INFO - 'HOME': '/home/cltbld', 15:49:00 INFO - 'LANG': 'en_US.UTF-8', 15:49:00 INFO - 'LANGUAGE': 'en_US:en', 15:49:00 INFO - 'LOGNAME': 'cltbld', 15:49:00 INFO - 'MAIL': '/var/mail/cltbld', 15:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:00 INFO - 'MOZ_NO_REMOTE': '1', 15:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:00 INFO - 'NO_EM_RESTART': '1', 15:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:00 INFO - 'PWD': '/builds/slave/test', 15:49:00 INFO - 'SHELL': '/bin/bash', 15:49:00 INFO - 'SHLVL': '1', 15:49:00 INFO - 'TERM': 'linux', 15:49:00 INFO - 'TMOUT': '86400', 15:49:00 INFO - 'USER': 'cltbld', 15:49:00 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:00 INFO - '_': '/tools/buildbot/bin/python'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:49: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 15:49: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 15:49: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 15:49: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 15:49:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:02 INFO - Downloading docopt-0.6.1.tar.gz 15:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:02 INFO - Running setup.py install for blobuploader 15:49:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:02 INFO - Running setup.py install for requests 15:49:03 INFO - Running setup.py install for docopt 15:49:03 INFO - Successfully installed blobuploader requests docopt 15:49:03 INFO - Cleaning up... 15:49:03 INFO - Return code: 0 15:49:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:03 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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:03 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 15:49:03 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 15:49:03 INFO - Using env: {'DISPLAY': ':0', 15:49:03 INFO - 'HOME': '/home/cltbld', 15:49:03 INFO - 'LANG': 'en_US.UTF-8', 15:49:03 INFO - 'LANGUAGE': 'en_US:en', 15:49:03 INFO - 'LOGNAME': 'cltbld', 15:49:03 INFO - 'MAIL': '/var/mail/cltbld', 15:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:03 INFO - 'MOZ_NO_REMOTE': '1', 15:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:03 INFO - 'NO_EM_RESTART': '1', 15:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:03 INFO - 'PWD': '/builds/slave/test', 15:49:03 INFO - 'SHELL': '/bin/bash', 15:49:03 INFO - 'SHLVL': '1', 15:49:03 INFO - 'TERM': 'linux', 15:49:03 INFO - 'TMOUT': '86400', 15:49:03 INFO - 'USER': 'cltbld', 15:49:03 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:03 INFO - '_': '/tools/buildbot/bin/python'} 15:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:03 INFO - Running setup.py (path:/tmp/pip-zivzij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:03 INFO - Running setup.py (path:/tmp/pip-0q7F6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:03 INFO - Running setup.py (path:/tmp/pip-4xmSeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:03 INFO - Running setup.py (path:/tmp/pip-9I2x83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:03 INFO - Running setup.py (path:/tmp/pip-T663qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:04 INFO - Running setup.py (path:/tmp/pip-OGC1zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:04 INFO - Running setup.py (path:/tmp/pip-aYKVk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:04 INFO - Running setup.py (path:/tmp/pip-pKPjhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:04 INFO - Running setup.py (path:/tmp/pip-UHfSW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:04 INFO - Running setup.py (path:/tmp/pip-qMUmOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:04 INFO - Running setup.py (path:/tmp/pip-mUJxrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:04 INFO - Running setup.py (path:/tmp/pip-AzWG7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:04 INFO - Running setup.py (path:/tmp/pip-btqux6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:04 INFO - Running setup.py (path:/tmp/pip-ndBzmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:04 INFO - Running setup.py (path:/tmp/pip-_xUtyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:04 INFO - Running setup.py (path:/tmp/pip-YoqMSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:04 INFO - Running setup.py (path:/tmp/pip-mlpp9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:04 INFO - Running setup.py install for manifestparser 15:49:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:04 INFO - Running setup.py install for mozcrash 15:49:05 INFO - Running setup.py install for mozdebug 15:49:05 INFO - Running setup.py install for mozdevice 15:49:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for mozfile 15:49:05 INFO - Running setup.py install for mozhttpd 15:49:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for mozinfo 15:49:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for mozInstall 15:49:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for mozleak 15:49:05 INFO - Running setup.py install for mozlog 15:49:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for moznetwork 15:49:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:05 INFO - Running setup.py install for mozprocess 15:49:06 INFO - Running setup.py install for mozprofile 15:49:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:06 INFO - Running setup.py install for mozrunner 15:49:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:06 INFO - Running setup.py install for mozscreenshot 15:49:06 INFO - Running setup.py install for moztest 15:49:06 INFO - Running setup.py install for mozversion 15:49:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:06 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 15:49:06 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 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:06 INFO - Running setup.py (path:/tmp/pip-ujl3Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:06 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)) 15:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:06 INFO - Running setup.py (path:/tmp/pip-tFVR0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:06 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)) 15:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:06 INFO - Running setup.py (path:/tmp/pip-pmkiCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:07 INFO - Running setup.py (path:/tmp/pip-7acHZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:07 INFO - Running setup.py (path:/tmp/pip-0KcqCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:07 INFO - Running setup.py (path:/tmp/pip-hbcifZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:07 INFO - Running setup.py (path:/tmp/pip-vsOCIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:07 INFO - Running setup.py (path:/tmp/pip-ACjIHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:07 INFO - Running setup.py (path:/tmp/pip-bxjYzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:07 INFO - Running setup.py (path:/tmp/pip-Cw1vdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:07 INFO - Running setup.py (path:/tmp/pip-Mu7roC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:07 INFO - Running setup.py (path:/tmp/pip-ycMohX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:07 INFO - Running setup.py (path:/tmp/pip-B3qxiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:07 INFO - Running setup.py (path:/tmp/pip-_8YAWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:07 INFO - Running setup.py (path:/tmp/pip-uGwkll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:07 INFO - Running setup.py (path:/tmp/pip-DmLV6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:07 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)) 15:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:07 INFO - Running setup.py (path:/tmp/pip-fAhUVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:08 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)) 15:49:08 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)) 15:49:08 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)) 15:49:08 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)) 15:49:08 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)) 15:49:08 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)) 15:49:08 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)) 15:49:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:08 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 15:49:08 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 15:49:08 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 15:49:08 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 15:49:09 INFO - Downloading blessings-1.6.tar.gz 15:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:09 INFO - Installing collected packages: blessings 15:49:09 INFO - Running setup.py install for blessings 15:49:09 INFO - Successfully installed blessings 15:49:09 INFO - Cleaning up... 15:49:09 INFO - Return code: 0 15:49:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:09 INFO - Reading from file tmpfile_stdout 15:49:09 INFO - Current package versions: 15:49:09 INFO - argparse == 1.2.1 15:49:09 INFO - blessings == 1.6 15:49:09 INFO - blobuploader == 1.2.4 15:49:09 INFO - docopt == 0.6.1 15:49:09 INFO - functools32 == 3.2.3-2 15:49:09 INFO - jsonschema == 2.5.1 15:49:09 INFO - manifestparser == 1.1 15:49:09 INFO - mozInstall == 1.13 15:49:09 INFO - mozcrash == 1.0 15:49:09 INFO - mozdebug == 0.1 15:49:09 INFO - mozdevice == 0.51 15:49:09 INFO - mozfile == 1.2 15:49:09 INFO - mozhttpd == 0.7 15:49:09 INFO - mozinfo == 0.10 15:49:09 INFO - mozleak == 0.1 15:49:09 INFO - mozlog == 3.5 15:49:09 INFO - moznetwork == 0.27 15:49:09 INFO - mozprocess == 0.25 15:49:09 INFO - mozprofile == 0.28 15:49:09 INFO - mozrunner == 6.13 15:49:09 INFO - mozscreenshot == 0.1 15:49:09 INFO - mozsystemmonitor == 0.3 15:49:09 INFO - moztest == 0.8 15:49:09 INFO - mozversion == 1.4 15:49:09 INFO - psutil == 3.1.1 15:49:09 INFO - requests == 1.2.3 15:49:09 INFO - wsgiref == 0.1.2 15:49:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:09 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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:09 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 15:49:09 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 15:49:09 INFO - Using env: {'DISPLAY': ':0', 15:49:09 INFO - 'HOME': '/home/cltbld', 15:49:09 INFO - 'LANG': 'en_US.UTF-8', 15:49:09 INFO - 'LANGUAGE': 'en_US:en', 15:49:09 INFO - 'LOGNAME': 'cltbld', 15:49:09 INFO - 'MAIL': '/var/mail/cltbld', 15:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:09 INFO - 'MOZ_NO_REMOTE': '1', 15:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:09 INFO - 'NO_EM_RESTART': '1', 15:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:09 INFO - 'PWD': '/builds/slave/test', 15:49:09 INFO - 'SHELL': '/bin/bash', 15:49:09 INFO - 'SHLVL': '1', 15:49:09 INFO - 'TERM': 'linux', 15:49:09 INFO - 'TMOUT': '86400', 15:49:09 INFO - 'USER': 'cltbld', 15:49:09 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:09 INFO - '_': '/tools/buildbot/bin/python'} 15:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 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)) 15:49:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:49: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 15:49: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 15:49: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 15:49: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 15:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:49:11 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)) 15:49:11 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)) 15:49:11 INFO - Installing collected packages: simplejson 15:49:11 INFO - Running setup.py install for simplejson 15:49:11 INFO - building 'simplejson._speedups' extension 15:49:11 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 15:49:11 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 15:49:12 INFO - Successfully installed simplejson 15:49:12 INFO - Cleaning up... 15:49:12 INFO - Return code: 0 15:49:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:12 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 0x22521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25bf9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, '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': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', '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 15:49:12 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 15:49:12 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 15:49:12 INFO - Using env: {'DISPLAY': ':0', 15:49:12 INFO - 'HOME': '/home/cltbld', 15:49:12 INFO - 'LANG': 'en_US.UTF-8', 15:49:12 INFO - 'LANGUAGE': 'en_US:en', 15:49:12 INFO - 'LOGNAME': 'cltbld', 15:49:12 INFO - 'MAIL': '/var/mail/cltbld', 15:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:12 INFO - 'MOZ_NO_REMOTE': '1', 15:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:12 INFO - 'NO_EM_RESTART': '1', 15:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:12 INFO - 'PWD': '/builds/slave/test', 15:49:12 INFO - 'SHELL': '/bin/bash', 15:49:12 INFO - 'SHLVL': '1', 15:49:12 INFO - 'TERM': 'linux', 15:49:12 INFO - 'TMOUT': '86400', 15:49:12 INFO - 'USER': 'cltbld', 15:49:12 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:12 INFO - '_': '/tools/buildbot/bin/python'} 15:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:12 INFO - Cleaning up... 15:49:12 INFO - Return code: 0 15:49:12 INFO - Running post-action listener: _resource_record_post_action 15:49:12 INFO - Running post-action listener: _start_resource_monitoring 15:49:12 INFO - Starting resource monitoring. 15:49:12 INFO - [mozharness: 2017-09-29 22:49:12.335458Z] Finished create-virtualenv step (success) 15:49:12 INFO - [mozharness: 2017-09-29 22:49:12.335926Z] Running install step. 15:49:12 INFO - Running pre-action listener: _resource_record_pre_action 15:49:12 INFO - Running main action method: install 15:49:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:12 INFO - Reading from file tmpfile_stdout 15:49:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:12 INFO - Reading from file tmpfile_stdout 15:49:12 INFO - Output received: 15:49:12 INFO - Usage: mozinstall [options] installer 15:49:12 INFO - Options: 15:49:12 INFO - -h, --help show this help message and exit 15:49:12 INFO - -d DEST, --destination=DEST 15:49:12 INFO - Directory to install application into. [default: 15:49:12 INFO - "/builds/slave/test"] 15:49:12 INFO - --app=APP Application being installed. [default: firefox] 15:49:12 INFO - mkdir: /builds/slave/test/build/application 15:49:12 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'] 15:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:49:30 INFO - Reading from file tmpfile_stdout 15:49:30 INFO - Output received: 15:49:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:30 INFO - Running post-action listener: _resource_record_post_action 15:49:30 INFO - [mozharness: 2017-09-29 22:49:30.477546Z] Finished install step (success) 15:49:30 INFO - [mozharness: 2017-09-29 22:49:30.477887Z] Running setup-mitmproxy step. 15:49:30 INFO - Running pre-action listener: _resource_record_pre_action 15:49:30 INFO - Running main action method: setup_mitmproxy 15:49:30 INFO - Skipping: mitmproxy is not required 15:49:30 INFO - Running post-action listener: _resource_record_post_action 15:49:30 INFO - [mozharness: 2017-09-29 22:49:30.479527Z] Finished setup-mitmproxy step (success) 15:49:30 INFO - [mozharness: 2017-09-29 22:49:30.479837Z] Running run-tests step. 15:49:30 INFO - Running pre-action listener: _resource_record_pre_action 15:49:30 INFO - Running pre-action listener: _set_gcov_prefix 15:49:30 INFO - Running main action method: run_tests 15:49:30 WARNING - Try message not found. 15:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:30 INFO - Python 2.7.3 15:49:30 INFO - Return code: 0 15:49:30 INFO - grabbing minidump binary from tooltool 15:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:30 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 0x25bcd60>, '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 0x25bda60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bdef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:30 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 15:49:30 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 15:49:30 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 15:49:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:30 INFO - Return code: 0 15:49:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:30 INFO - ENV: RUST_BACKTRACE is now full 15:49:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:30 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/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:49:30 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/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 15:49:30 INFO - Using env: {'DISPLAY': ':0', 15:49:30 INFO - 'HOME': '/home/cltbld', 15:49:30 INFO - 'LANG': 'en_US.UTF-8', 15:49:30 INFO - 'LANGUAGE': 'en_US:en', 15:49:30 INFO - 'LOGNAME': 'cltbld', 15:49:30 INFO - 'MAIL': '/var/mail/cltbld', 15:49:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:30 INFO - 'MOZ_NO_REMOTE': '1', 15:49:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:30 INFO - 'NO_EM_RESTART': '1', 15:49:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:30 INFO - 'PWD': '/builds/slave/test', 15:49:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:30 INFO - 'RUST_BACKTRACE': 'full', 15:49:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:49:30 INFO - 'SHELL': '/bin/bash', 15:49:30 INFO - 'SHLVL': '1', 15:49:30 INFO - 'TERM': 'linux', 15:49:30 INFO - 'TMOUT': '86400', 15:49:30 INFO - 'USER': 'cltbld', 15:49:30 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:30 INFO - '_': '/tools/buildbot/bin/python'} 15:49:30 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/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:49:30 INFO - mozversion application_buildid: 20170929214740 15:49:30 INFO - mozversion application_changeset: 57f68296c350469d73d788eb3695a898947b4acb 15:49:30 INFO - mozversion application_display_name: Nightly 15:49:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:30 INFO - mozversion application_name: Firefox 15:49:30 INFO - mozversion application_remotingname: firefox 15:49:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:49:30 INFO - mozversion application_vendor: Mozilla 15:49:30 INFO - mozversion application_version: 58.0a1 15:49:30 INFO - mozversion platform_buildid: 20170929214740 15:49:30 INFO - mozversion platform_changeset: 57f68296c350469d73d788eb3695a898947b4acb 15:49:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:49:30 INFO - mozversion platform_version: 58.0a1 15:49:30 INFO - using testdate: 1506725370 15:49:30 INFO - actual date: 1506725370 15:49:30 INFO - starting webserver on 'localhost:48916' 15:49:30 INFO - SUITE-START | Running 2 tests 15:49:30 INFO - TEST-START | dromaeo_css 15:49:30 INFO - Initialising browser for dromaeo_css test... 15:49:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48916/getInfo.html -profile /tmp/tmptwXKK0/profile 15:49:30 INFO - TEST-INFO | started process 14877 (/builds/slave/test/build/application/firefox/firefox http://localhost:48916/getInfo.html) 15:49:36 INFO - TEST-INFO | 14877: exit 0 15:49:36 INFO - Browser initialized. 15:49:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:36 INFO - Using env: {'DISPLAY': ':0', 15:49:36 INFO - 'HOME': '/home/cltbld', 15:49:36 INFO - 'JSGC_DISABLE_POISONING': '1', 15:49:36 INFO - 'LANG': 'en_US.UTF-8', 15:49:36 INFO - 'LANGUAGE': 'en_US:en', 15:49:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:49:36 INFO - 'LOGNAME': 'cltbld', 15:49:36 INFO - 'MAIL': '/var/mail/cltbld', 15:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:36 INFO - 'MOZ_CRASHREPORTER': '1', 15:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:49:36 INFO - 'MOZ_NO_REMOTE': '1', 15:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:36 INFO - 'NO_EM_RESTART': '1', 15:49:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:36 INFO - 'PWD': '/builds/slave/test', 15:49:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:36 INFO - 'RUST_BACKTRACE': 'full', 15:49:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:49:36 INFO - 'SHELL': '/bin/bash', 15:49:36 INFO - 'SHLVL': '1', 15:49:36 INFO - 'STYLO_FORCE_DISABLED': '1', 15:49:36 INFO - 'TERM': 'linux', 15:49:36 INFO - 'TMOUT': '86400', 15:49:36 INFO - 'USER': 'cltbld', 15:49:36 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 15:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:36 INFO - '_': '/tools/buildbot/bin/python'} 15:49:36 INFO - TEST-INFO | started process 15113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptwXKK0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:37 INFO - PID 15113 | 15:49:37 INFO - PID 15113 | (/builds/slave/test/build/application/firefox/firefox:15162): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:49:37 INFO - PID 15113 | 15:49:47 INFO - PID 15113 | RSS: Main: 151789568 15:49:47 INFO - PID 15113 | 15:52:45 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48916/tests/dromaeo/cssquery-ext.html) 15:52:46 INFO - PID 15113 | RSS: Main: 149790720 15:52:46 INFO - PID 15113 | 15:55:48 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-ext.html (next: http://localhost:48916/tests/dromaeo/cssquery-jquery.html) 15:55:48 INFO - PID 15113 | RSS: Main: 151273472 15:55:48 INFO - PID 15113 | 15:58:50 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48916/tests/dromaeo/cssquery-mootools.html) 15:58:51 INFO - PID 15113 | RSS: Main: 150888448 15:58:51 INFO - PID 15113 | 16:01:52 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48916/tests/dromaeo/cssquery-prototype.html) 16:01:53 INFO - PID 15113 | RSS: Main: 151592960 16:01:53 INFO - PID 15113 | 16:04:56 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48916/tests/dromaeo/cssquery-yui.html) 16:04:57 INFO - PID 15113 | RSS: Main: 154750976 16:04:57 INFO - PID 15113 | 16:07:58 INFO - PID 15113 | Cycle 1(1): loaded http://localhost:48916/tests/dromaeo/cssquery-yui.html (next: http://localhost:48916/tests/dromaeo/cssquery-dojo.html) 16:07:59 INFO - PID 15113 | RSS: Main: 155463680 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | __start_tp_report 16:07:59 INFO - PID 15113 | _x_x_mozilla_page_load 16:07:59 INFO - PID 15113 | _x_x_mozilla_page_load_details 16:07:59 INFO - PID 15113 | |i|pagename|runs| 16:07:59 INFO - PID 15113 | |0;dojo.html;3179.984100079499;3180.077777444541;3183.1087295557236;3191.106490182748;3199.232184275773;6071.271447426309;6085.148079268901;6175.629462232269;6314.968425157879;6318.842028949267;6180.660063696495;6254.749810007605;6274.56078074535;6338.366163383671;6348.523860710442;5428.240046393488;5859.853503662422;5872.765089396419;5874.1776151338845;5912.142739302799;5584.832455026356;5758.884822303551;5824.737886795083;5830.7667693292215;5853.707314634273;5691;5696.743646535916;5731.799387021476;5732.111522713986;5744.626599271055;5744;5749.82750517481;5753.539716822645;5756.769729210827;5766.423357664242;5699.031164701969;5770.596058275923;5774.249347584787;5779.393163717833;5827.941720582782;6246;6261.592996455216;6269.655168965705;6325.462335701471;6389.041643753428;6670.7665231716655;6680.5991640501725;6739.595624262511;6771.356721111487;6864.176298844171;6796.966015169942;6868.450523958071;6877.2091209511045;6886.621235832027;6891.655417229169;6200.224971878515;6265.7493700251935;6315.210598675166;6375.681215939231;6400.167978162855;6977.476689248327;7063.223045464994;7080.114985626797;7086.326798954091;7093.864981602918;6631.966840165768;6652.7338906444165;6720.193576770819;6720.697568609425;6738.090357801732;6711.3288671132495;6743.15710536183;6746;6746.966265168643;6749.628770417674;6739.696713647898;6784.559003664746;6787.185537735503;6788.9660551696925;6801.897971530431;6581.605103693793;6681.599104053772;6686.732530698815;6781.389674929182;6782.864342713118;5198.6880787152895;5271.314729085271;5291.126964050965;5376.139817629239;5377.27406800077;4620.330052142421;4688.296755486636;4698.624110071186;4738.668293219442;4748.4539277982785;5804.245448091721;5816.563757718103;5877.147813567009;5911.645301281937;5922.526197904157;6795.52431329812;6799.694013769392;6859.314068593101;6863.622500762506;6892.758753443605;5724.599278050579;5785.247917770663;5793.565482588739;5798.768049278066;5799.5650326225705;5827.388124246893;5862.384449632727;5863;5866.2960444746905;5875.882482350329;6396.5202609804455;6473.352664733583;6491.837704057436;6499.2850786413455;6546.24718157418;6645.534812563074;6649.434798042221;6657.1345725055435;6670.73256081343;6827;6290.654014029089;6378.362163783585;6429.421352078335;6437.195350581177;6444.45222156122;6598.538102332791;6663.466922646274;6665.733370665119;6671.83320416974;6678.49911256648;6791.558548694319;6893.241743408121;6901.102856628606;6907.551009184387;6923.9653801730665;6569.408753212234;6569.868602628017;6580.5064620154635;6666.966665166643;6683.298253683293;6584.275729669636;6585.539012269095;6668.333166683293;6672.266050734513;6677.866442671022;6477;6536.6731663415685;6550.213974323112;6550.312217217314;6566.9014964774615;6648.700808463727;6679.2318883329035;6695.0292207628645;6702.229243637044;6704.564203326768;6400.263969643364;6412.903806443001;6494.545381823416;6496.707648155939;6501.2523559791225 16:07:59 INFO - PID 15113 | |1;ext.html;881.6605606841366;909.2952961454872;910.2808781062959;911.6262332443699;912.8037471943535;40283;44626;44633.77683111588;44682.32976505351;44800.77599612006;40385.39421908674;40698.18603627933;40768.59231407685;40804.795976020156;40820.79589602048;7358.337749602535;8015.278624923756;8188.058373287059;8190.8771368429525;8198.42611017229;8075.313598344148;8200.05699344577;8204.138565450632;8204.917950820474;8211.671533138668;8138.593070346488;8200.671973121069;8208.425410221287;8226.506409615413;8254.215849494318;8156.469829461095;8195.631196596167;8201.548914809682;8217.7123800667;8228.547429891354;7979.760607181735;8099.473534220316;8111.310538604226;8116;8116.431849770518;41153.1769364614;41162.38256426156;41221.175576488604;41525.37711934323;41615.167696646204;3574.195805943668;3637.3270944875285;3637.4725664778457;3637.836297366625;3639.162992511711;33382;33464.83267583671;33501;33567.6643233567;33574.6642533574;5204.8178313758835;5219.5041471060185;5227.503387178212;5233.4243233244315;5363.141897296414;196927;197580;197906.01046994817;198509;200355;44927.326090108676;45783.54216457793;51941.48058519442;52254.47745522572;52806.20790688143;55452.44547554554;55515;55788.44211557833;55872.44127558754;56047.43952560504;16642.75035874463;16717.414890478776;16751;16771.83228167727;16839.494815155565;13611.659708507168;13617.727645447036;13729.725405491834;13739.038267321392;13786.862131378557;14881.925590371979;14964.326605302787;15113.3199006045;15144.242787860783;15268;5922.230110085661;5933.881322373615;5944.7027648617395;6012.699365031731;6084.209052823105;996.5913975270105;1026.9217321812068;1037.6990672704983;1049.7952899184586;1051.6476980211562;24166.7583324168;24200.51598968046;24364.634530482057;24391.878040609685;24420.389490262885;1123.3877536742332;1124.4482613992802;1132.8640563132312;1139.1114930354338;1151.1654050813092;12686.936565317299;12914.41885115172;12952.352382380843;13000.544980925622;13032.478700852049;218178;233356;245568;245837;246489;55217.72391138099;55364.16953745697;55440.72279638576;55473;55550.44449555533;1435.440178330452;1475.7491226491522;1492.1121932450176;1509.8641122298827;1515.6817068415535;23359.53280934406;23422.531549368578;23528.529429411657;23560.410989725395;23590.17434389857;38962.220755585295;39190.608093918694;39203.2159356817;39257;39281.41077883891;195556;196528;197034;197834;198493;37183;39636.60363396329;40118.799406002785;40231.798841005606;40306.79846600748;47310.29034564553;48345.5165448341;48684;48903;48961;33677.831610841786;34050.14874628055;34204.14489637779;34243.183595792696;34462.655373445945;33651.83174084212;33887.15282117967;34010;34010.14974625555;34530.65469345274;38211.23577528489;38645;38671;38677.41983870188;39078.4138237921;33312.666873330956;33458.83270583729;33635.49546756849;33937;34039;24591.754082458945;25009.374765631004;25101.24696259115;25855.22434326898;25867.741322586535 16:07:59 INFO - PID 15113 | |2;jquery.html;593.5933885288576;598.592956789383;603.4146877528796;622.7415622516655;627.8618703885146;22725;22774.089036438563;23485.882570587164;23514.29457116285;23534.64698029531;23627.291181264547;24895.128670496535;24918.875405622948;24939.875300623517;24977.625335619934;6612.107365505655;6750.932490675104;6764.7970560883;6785.558938668995;6822.010808432799;6424.357564243562;6663.4669226461765;6699.062131301622;6711.932880671204;6722.899156512656;6683.899741503881;6687;6688.1305430294;6689.264180940093;6691.464682825363;6669.866602667919;6675.59946403215;6678.131842860445;6680.899786503206;6683.565568238073;6214.65819379934;6215.502759779207;6219.036049412348;6219.40915613016;6224.439800417984;28468.572971405447;29055.56416653752;29157.271068223465;29351.55972660412;29547.704522954926;1967.3999430173935;1985.1662301833264;2019.545602239499;2020.7170996060563;2021.706852506393;19360.128794204295;19403.320883769;19875.30436434718;19878.70181947272;19933.20267189325;2435.719892212383;2490.6762120924163;2569.768720815117;2571.485702859417;2572.446923911349;122699.38650306691;128201;141820;145337.2733136338;145351.2732436331;14736.263186840615;14974;15090.54728358151;15242.771358429633;15406.38374465009;23928.162514311916;24106.51786964286;24182.637260441108;24204.87897560501;24224.636630450557;10056.64801731936;10196.235282353853;10281.845772313422;10292.433916134534;10361.32651377673;9452.763680908032;9593.42439453635;9651.469169195761;9654.662086826927;9935.503224838874;8916.331275154389;9020.323475739346;9113.589888455035;9217.861732074025;9388.765280868032;2656.2296933889343;2761.2682639100653;2766.3775650478883;2813.409184071368;2855.6715977662834;948.6821914658528;956.8086382723483;961.6201600367815;962.167724917955;981.9558119884622;19271.710924336145;19378.031098445023;19585.314513991943;19621.01894905249;19676.70484942727;1019.704285757137;1029.0841151375282;1034.6895931220754;1038.672818062308;1049.3022140276782;10531.315464494783;10681.679549613524;10743.247972641997;10757.193210509244;10968.670939871816;431657;438144;441126;442077;458589;111076;112521;114787;115205.4239728796;116029;1143.8512993310817;1157.0569985461989;1201.3512703140382;1202.963911082669;1204.8554173499235;16863.578410539834;16872.013328411253;17263.82736172622;17477;17610.031448270467;54992.45007549873;56504;56721;56880.71559642341;57531.42468575428;67269;69781.30218697748;70013;70297.29702703112;70993;14105.647358816112;14649.901257405523;14697.632559186106;14744.705105898036;14753.704925901207;22478.438039049153;22620.773792261865;22661.546769064855;22926.19758308451;22975.425614359774;18054.187561560026;18054.5486362842;18333.633327333646;18443.72334414958;18515.537111572317;15934.123623200836;16529.33882644681;16742.995420274336;16843.7473437901;17200.709946754294;17465.21406536734;18506;18513.259469621065;18650;18696.813031869508;14309.928450357682;14326.57020289393;14346.784798228244;14389.568312950629;14494.34775435129;17636.29454821844;18085.095745212424;18162.182701778187;18219.271229150687;18268.81731182671 16:07:59 INFO - PID 15113 | |3;mootools.html;1325.7348530293941;1361.8948796743425;1370.212128026385;1376.4219028008235;1385.494294582477;14220.43118275269;14851.702965940674;14854.48009319674;14865;14866.256687165625;14342.498012569537;14352.354144063516;14482.493112741056;14487.855121448782;14666.560003199895;2665.1737961231984;2790.1629511146675;2817.3520090379225;2819.7180281971846;2821.3510892494737;2773.6671599408;2800.271929298387;2801.5937689035077;2803.3692419205718;2815.6480439945008;2722.6460560127157;2814.577813328007;2815.042885418957;2815.282103063716;2816.0566210319566;2667.6932152802483;2758.0484732767163;2789.0377819652185;2792.511310520661;2799.4960907036725;2771.9445611087667;2804.5652923796843;2805.04628426336;2810.901618443365;2812.2266376746556;14633;14831.184284864328;14919.701605967928;14922.403103875831;14957.775633365509;8081.757547273592;8374.706885259047;8381.832363352698;8384.622691978875;8391.370647201484;5029.497050294978;5205.817796377109;5326.520613144836;5336.813211537617;5342.946570534323;1898.9525261868425;1980.1683293016968;1987.3441764217773;2032.4106009257298;2039.1027947702962;24875.12937047213;24883.253502394957;25158.49683006348;25169.37076573082;25174.874125629438;6614.966925165343;6620.973749068902;6646.368594983469;6792.830179245559;6796.8300792479595;17286;17304.913475432542;17479.300827966737;17481.300747969937;17513.211905464286;7844.646990885424;8056.113827478973;8059.395545334123;8060.476069055492;8085.636146373427;6465.676716164173;6504.317046710122;6517.120188774455;6536.084948107269;7259.673314700851;5160.864609785841;5338.745394832211;5354.571634269249;5374.731263436813;5394.190871369326;1323.371398585664;1356.6133651909158;1431.7351290011381;1457.140287230518;1497.8052853129022;885.751989442957;885.7829831691148;905.4024343932973;907.0249481807084;926.4256161180111;8559;8695;8695.956520217358;8698.652053917773;8720.084391138966;731.1263040666353;733.2154594583744;733.7945375294926;743.5055687967441;814.9877751833727;5315.255864179018;5357.1696387060065;5426.430224826416;5509;5587.161925711176;19497;20568.794312056987;20810.895945520177;21086.789132108788;21207;20589.07349169291;20680.48298792542;20854;21027.15891364328;21051.263205787724;10173.745656358651;10419.94790026045;10483.423411712429;10615.150787936947;10631.893681063091;8513.616887240212;8526.531040792568;8556.229939305493;8575.356848236532;8606;17767;18056.72914906251;18143.727844082612;18375.63248734991;18429.631407372046;18153.18468153174;18318.81681183171;18592.535186620444;18906.243750250385;18923.432297030562;10815.891841081488;10833.349999000086;10986.505607247853;10989.175811814306;10989.780204396027;13630.1140425872;13779.724405511633;13968.930155349564;13986.44054237819;13992.860071399156;11408.828867566826;11445.542178312775;11446.42767861587;11684.532618695497;11804.586839460577;11090.334579925231;11242.213045086766;11457.255278406878;11482.598109066143;11558.364289964133;10099.343542669703;10339.0694837465;10344.637937672145;10354.430506322225;10358.326708763907;6674;7248.927510724825;7317.890231646423;7335.1197856257595;7366.858136988775;7329.450291228072;7337.119545654556;7451.850962980819;7524.398048156244;7536.698532058656 16:07:59 INFO - PID 15113 | |4;prototype.html;506.4606194402963;518.984430467086;536.9221462887881;542.1677724692597;543.7525925703802;6276.340984196657;6283.151774510439;6285.371462853713;6349.1746073010445;6357.682115894198;6250.343713910042;6260.530460215479;6267.717952692128;6267.749290028405;6344.143540622026;5174.482551744814;5207.786690656465;5222.63441559091;5249.107651699221;5285.497877701612;4833.806647734086;5189.273501709764;5221.2429197766305;5241.3710354757295;5316.867078323035;4948.257761335793;4966.304717339575;5008.849734507952;5034.295198672189;5043.319151914481;4958.132326842788;5010.448850626428;5022.522860328263;5029.748512574393;5055.873603159914;4383.232934236496;4471.955280447219;4519.570640789119;4530.411046563926;4538.591526762574;6056.4851987581105;6057.121717351003;6058.27300723916;6075.817725468199;6089.1779609753;5709.514691251248;5719.3136823581435;5733.397993210695;5734.283214598176;5759.769609215668;6343.365663433666;6395.584287021329;6416.48668106555;6428.19647544057;6520.707517245881;4705.200115980291;4909.558139767438;4926.11329960607;4938.999705119432;4963.38689925772;6704.83237919051;6745.156855393076;6860.759873404407;6863.519553631248;6887.311268873123;4988.6009119270375;5019.548240658358;5029.346184996;5043.873903152377;5070.873228169252;5029.698218106925;5099.36257967754;5102.209157580581;5136.101182293084;5137.51193636604;5683.204351390808;5701.116326969326;5705.546614955609;5721;5742.885142297131;6438.645874476949;6483.059956306403;6505.934940650627;6514.771982980573;6539.509536784665;1745.877788554789;1767.6729804986119;1771.6722406354866;1791.0596936608385;1793.9103044847704;1144.7710457908452;1217.1479964025218;1229.7786398448186;1236.1964722929988;1241.4351470081272;5645.294338207724;5714.771409143671;5723.141528770634;5766.913496297559;5769.94230057694;6535.705893234815;6570.638614876228;6571.868562628721;6726.865462690719;6814.216365117975;5703.800366987219;5709.628874123252;5759.85600359986;5764.221830052889;5793.37785420083;3497.4229252173614;3508.9122771930906;3542.5217595624263;3545.6808887200277;3567.9821600892346;6225.408586184305;6298.527610429236;6391.105245265667;6415.133956915756;6416;6224.533160013018;6636.402723754885;6693.2972037935315;6739.5619284746335;6774.8172647924375;6265.4361107499635;6279.96860015697;6305.96847015762;6338.778142764981;6383.744650213939;6500.537379089667;6511.869762604816;6521.869562608626;6589.209294884645;6626.237982632059;6525.771597994048;6538.574992625464;6546.181727283899;6598.571092878948;6629.966850165912;6363.391009686192;6376.776812811529;6397.136386587751;6452.709628066842;6478.5141114415665;5010.847505073781;5077.568406685473;5077.92383114261;5092.796288148433;5094.872628184325;6523.9347606525225;6647.169103862017;6691.631960242234;6733.192016957996;6736.494762892705;6360.681965901779;6424.614523128627;6432.8099301629345;6439.721271760184;6454.806355809334;6395.488360931207;6427.8751218535635;6455.354464553507;6487.3188315226225;6539.193692635814;6347.3652634738;6360.141380913703;6392.20097487814;6455.644939528371;6479.157709497735;6430.971044633024;6519.706613202323;6521.576097553644;6524.380183882524;6574.351235064585;6260.874782504416;6264;6271.717772700331;6336.683165841781;6354.841128971812 16:07:59 INFO - PID 15113 | |5;yui.html;917.6191880369647;926.1664501948246;934.0612684252326;941.5198248893063;945.8202941441124;19843.702344464844;20466.283680071218;20477.590448191026;20481.283155089575;20483.487912802186;18249.908750456263;18477.44567662969;18500.0749962502;18608.441746747587;18619.348322808706;955.9044095590438;972.4214092614883;975.0980343182563;975.9316847820655;975.9658411955583;988.6935050134481;995.372915063509;996.432033740768;996.8155891160122;996.875390576178;943.1982814607597;1027.1218108517223;1029.608748675506;1038.9636362727306;1043.1498328861953;1031.0771859186025;1031.9793604127876;1032.6850310655248;1033.0444338986445;1033.1270076785104;724.0623392706458;743.8995735575683;745.6569977810213;746.4289818289013;750.6659536506257;20554.38336849897;20661.17355305786;20776;20789;20801.06395212204;22107.778922210895;22225;22727.09091636349;22774.430639233986;22851.085956561717;17373.913130434394;17541.912290438595;17598.560035999075;17603.647927041515;17616;3718.5165928429133;3728.440733889911;3735.0849041984616;3738.5139931808963;3745.5879853216125;107641.46179269053;125451.3727431357;150149.9999999989;150872;153435.2328238363;16805.411810586815;17865.285388584573;17888.821111788977;17972.640547189243;18047.729284060748;31039.379212416075;31189.376212475625;31255.531167032514;31303.373932521223;31438.37123257522;8445.113263107409;8468.957655211685;8472;8523.232909038215;8534.829303413897;4101.384792281182;4193.6645068394455;4307.655387568987;4317.7193482423545;4333.609975102256;5332.280142180756;5414.648047876875;5421.132618780976;5426.484483974016;5432.538234250054;1081.7403823082561;1101.11910471624;1117.4915413487006;1120.0143873391364;1125.3641692443744;666.6766618190173;687.3744892148121;700.6146619359332;702.1679310017646;706.1279320039747;11599.826002609967;11745.412729363497;12039.63881083569;12271.38643067843;12430.316332601793;669.9531032827655;671.7816709569312;672.6703915081673;674.2839473539852;685.2941470285614;5346.304980352529;5351.464853514695;5365.812196573179;5369.301990741179;5444.183372494078;129016.35491822481;129149.35425322813;130862;132345;136130.3193484026;116249;116266;116986.41506792411;121631.39184304021;122014.38992804979;94733.52633236928;94802;98993.01006989981;99280;99789.50105249428;9914.454704991294;10092.14216791581;10112.191024718151;10137.036981486746;10162.288639795439;45476;46322.768386157855;46516.06967860692;46885;47543.286850696575;58336.70831645815;58365.70817145887;58696.119558205806;59000.40999589949;60658;16082.115483648511;16491.257893395064;16505.422310219084;16665.3333866644;16720.581985450463;18429.72355414643;18714.812851871306;18823.152958116643;18935.14791834343;18956.620867582296;16488.17559122063;16719.582010449834;16804.411845585346;17008.404705835237;17016.829831701525;16835.91582042131;16841.831581684026;16985.91507042457;17048.829511704724;17144.22850971734;16220.188990550661;16377.590560235612;16406.75389869129;16460;16517.752233716743;10934.961178688012;11086.722831928944;11097.611583594535;11169.497372618414;11584.884151158718;11950.701232469259;12155.149139560499;12214.511419543118;12362.938185309376;12454.688632784253 16:07:59 INFO - PID 15113 | __end_tp_report 16:07:59 INFO - PID 15113 | __start_cc_report 16:07:59 INFO - PID 15113 | _x_x_mozilla_cycle_collect,284 16:07:59 INFO - PID 15113 | __end_cc_report 16:07:59 INFO - PID 15113 | __startTimestamp1506726479026__endTimestamp 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | ------- Summary: start ------- 16:07:59 INFO - PID 15113 | Number of tests: 6 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#0] dojo.html Cycles:165 Average:6213.61 Median:6444.45 stddev:750.52 (11.6%) stddev-sans-first:714.10 16:07:59 INFO - PID 15113 | Values: 3180.0 3180.1 3183.1 3191.1 3199.2 6071.3 6085.1 6175.6 6315.0 6318.8 6180.7 6254.7 6274.6 6338.4 6348.5 5428.2 5859.9 5872.8 5874.2 5912.1 5584.8 5758.9 5824.7 5830.8 5853.7 5691.0 5696.7 5731.8 5732.1 5744.6 5744.0 5749.8 5753.5 5756.8 5766.4 5699.0 5770.6 5774.2 5779.4 5827.9 6246.0 6261.6 6269.7 6325.5 6389.0 6670.8 6680.6 6739.6 6771.4 6864.2 6797.0 6868.5 6877.2 6886.6 6891.7 6200.2 6265.7 6315.2 6375.7 6400.2 6977.5 7063.2 7080.1 7086.3 7093.9 6632.0 6652.7 6720.2 6720.7 6738.1 6711.3 6743.2 6746.0 6747.0 6749.6 6739.7 6784.6 6787.2 6789.0 6801.9 6581.6 6681.6 6686.7 6781.4 6782.9 5198.7 5271.3 5291.1 5376.1 5377.3 4620.3 4688.3 4698.6 4738.7 4748.5 5804.2 5816.6 5877.1 5911.6 5922.5 6795.5 6799.7 6859.3 6863.6 6892.8 5724.6 5785.2 5793.6 5798.8 5799.6 5827.4 5862.4 5863.0 5866.3 5875.9 6396.5 6473.4 6491.8 6499.3 6546.2 6645.5 6649.4 6657.1 6670.7 6827.0 6290.7 6378.4 6429.4 6437.2 6444.5 6598.5 6663.5 6665.7 6671.8 6678.5 6791.6 6893.2 6901.1 6907.6 6924.0 6569.4 6569.9 6580.5 6667.0 6683.3 6584.3 6585.5 6668.3 6672.3 6677.9 6477.0 6536.7 6550.2 6550.3 6566.9 6648.7 6679.2 6695.0 6702.2 6704.6 6400.3 6412.9 6494.5 6496.7 6501.3 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#1] ext.html Cycles:180 Average:39234.34 Median:38428.12 stddev:54912.11 (142.9%) stddev-sans-first:54990.63 16:07:59 INFO - PID 15113 | Values: 881.7 909.3 910.3 911.6 912.8 40283.0 44626.0 44633.8 44682.3 44800.8 40385.4 40698.2 40768.6 40804.8 40820.8 7358.3 8015.3 8188.1 8190.9 8198.4 8075.3 8200.1 8204.1 8204.9 8211.7 8138.6 8200.7 8208.4 8226.5 8254.2 8156.5 8195.6 8201.5 8217.7 8228.5 7979.8 8099.5 8111.3 8116.0 8116.4 41153.2 41162.4 41221.2 41525.4 41615.2 3574.2 3637.3 3637.5 3637.8 3639.2 33382.0 33464.8 33501.0 33567.7 33574.7 5204.8 5219.5 5227.5 5233.4 5363.1 196927.0 197580.0 197906.0 198509.0 200355.0 44927.3 45783.5 51941.5 52254.5 52806.2 55452.4 55515.0 55788.4 55872.4 56047.4 16642.8 16717.4 16751.0 16771.8 16839.5 13611.7 13617.7 13729.7 13739.0 13786.9 14881.9 14964.3 15113.3 15144.2 15268.0 5922.2 5933.9 5944.7 6012.7 6084.2 996.6 1026.9 1037.7 1049.8 1051.6 24166.8 24200.5 24364.6 24391.9 24420.4 1123.4 1124.4 1132.9 1139.1 1151.2 12686.9 12914.4 12952.4 13000.5 13032.5 218178.0 233356.0 245568.0 245837.0 246489.0 55217.7 55364.2 55440.7 55473.0 55550.4 1435.4 1475.7 1492.1 1509.9 1515.7 23359.5 23422.5 23528.5 23560.4 23590.2 38962.2 39190.6 39203.2 39257.0 39281.4 195556.0 196528.0 197034.0 197834.0 198493.0 37183.0 39636.6 40118.8 40231.8 40306.8 47310.3 48345.5 48684.0 48903.0 48961.0 33677.8 34050.1 34204.1 34243.2 34462.7 33651.8 33887.2 34010.0 34010.1 34530.7 38211.2 38645.0 38671.0 38677.4 39078.4 33312.7 33458.8 33635.5 33937.0 34039.0 24591.8 25009.4 25101.2 25855.2 25867.7 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#2] jquery.html Cycles:180 Average:33295.67 Median:22950.81 stddev:75179.24 (327.6%) stddev-sans-first:75350.04 16:07:59 INFO - PID 15113 | Values: 593.6 598.6 603.4 622.7 627.9 22725.0 22774.1 23485.9 23514.3 23534.6 23627.3 24895.1 24918.9 24939.9 24977.6 6612.1 6750.9 6764.8 6785.6 6822.0 6424.4 6663.5 6699.1 6711.9 6722.9 6683.9 6687.0 6688.1 6689.3 6691.5 6669.9 6675.6 6678.1 6680.9 6683.6 6214.7 6215.5 6219.0 6219.4 6224.4 28468.6 29055.6 29157.3 29351.6 29547.7 1967.4 1985.2 2019.5 2020.7 2021.7 19360.1 19403.3 19875.3 19878.7 19933.2 2435.7 2490.7 2569.8 2571.5 2572.4 122699.4 128201.0 141820.0 145337.3 145351.3 14736.3 14974.0 15090.5 15242.8 15406.4 23928.2 24106.5 24182.6 24204.9 24224.6 10056.6 10196.2 10281.8 10292.4 10361.3 9452.8 9593.4 9651.5 9654.7 9935.5 8916.3 9020.3 9113.6 9217.9 9388.8 2656.2 2761.3 2766.4 2813.4 2855.7 948.7 956.8 961.6 962.2 982.0 19271.7 19378.0 19585.3 19621.0 19676.7 1019.7 1029.1 1034.7 1038.7 1049.3 10531.3 10681.7 10743.2 10757.2 10968.7 431657.0 438144.0 441126.0 442077.0 458589.0 111076.0 112521.0 114787.0 115205.4 116029.0 1143.9 1157.1 1201.4 1203.0 1204.9 16863.6 16872.0 17263.8 17477.0 17610.0 54992.5 56504.0 56721.0 56880.7 57531.4 67269.0 69781.3 70013.0 70297.3 70993.0 14105.6 14649.9 14697.6 14744.7 14753.7 22478.4 22620.8 22661.5 22926.2 22975.4 18054.2 18054.5 18333.6 18443.7 18515.5 15934.1 16529.3 16743.0 16843.7 17200.7 17465.2 18506.0 18513.3 18650.0 18696.8 14309.9 14326.6 14346.8 14389.6 14494.3 17636.3 18085.1 18162.2 18219.3 18268.8 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#3] mootools.html Cycles:180 Average:9197.95 Median:2666.43 stddev:6407.28 (240.3%) stddev-sans-first:6397.95 16:07:59 INFO - PID 15113 | Values: 1325.7 1361.9 1370.2 1376.4 1385.5 14220.4 14851.7 14854.5 14865.0 14866.3 14342.5 14352.4 14482.5 14487.9 14666.6 2665.2 2790.2 2817.4 2819.7 2821.4 2773.7 2800.3 2801.6 2803.4 2815.6 2722.6 2814.6 2815.0 2815.3 2816.1 2667.7 2758.0 2789.0 2792.5 2799.5 2771.9 2804.6 2805.0 2810.9 2812.2 14633.0 14831.2 14919.7 14922.4 14957.8 8081.8 8374.7 8381.8 8384.6 8391.4 5029.5 5205.8 5326.5 5336.8 5342.9 1899.0 1980.2 1987.3 2032.4 2039.1 24875.1 24883.3 25158.5 25169.4 25174.9 6615.0 6621.0 6646.4 6792.8 6796.8 17286.0 17304.9 17479.3 17481.3 17513.2 7844.6 8056.1 8059.4 8060.5 8085.6 6465.7 6504.3 6517.1 6536.1 7259.7 5160.9 5338.7 5354.6 5374.7 5394.2 1323.4 1356.6 1431.7 1457.1 1497.8 885.8 885.8 905.4 907.0 926.4 8559.0 8695.0 8696.0 8698.7 8720.1 731.1 733.2 733.8 743.5 815.0 5315.3 5357.2 5426.4 5509.0 5587.2 19497.0 20568.8 20810.9 21086.8 21207.0 20589.1 20680.5 20854.0 21027.2 21051.3 10173.7 10419.9 10483.4 10615.2 10631.9 8513.6 8526.5 8556.2 8575.4 8606.0 17767.0 18056.7 18143.7 18375.6 18429.6 18153.2 18318.8 18592.5 18906.2 18923.4 10815.9 10833.3 10986.5 10989.2 10989.8 13630.1 13779.7 13968.9 13986.4 13992.9 11408.8 11445.5 11446.4 11684.5 11804.6 11090.3 11242.2 11457.3 11482.6 11558.4 10099.3 10339.1 10344.6 10354.4 10358.3 6674.0 7248.9 7317.9 7335.1 7366.9 7329.5 7337.1 7451.9 7524.4 7536.7 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#4] prototype.html Cycles:180 Average:5487.59 Median:6224.97 stddev:1509.70 (24.3%) stddev-sans-first:1466.91 16:07:59 INFO - PID 15113 | Values: 506.5 519.0 536.9 542.2 543.8 6276.3 6283.2 6285.4 6349.2 6357.7 6250.3 6260.5 6267.7 6267.7 6344.1 5174.5 5207.8 5222.6 5249.1 5285.5 4833.8 5189.3 5221.2 5241.4 5316.9 4948.3 4966.3 5008.8 5034.3 5043.3 4958.1 5010.4 5022.5 5029.7 5055.9 4383.2 4472.0 4519.6 4530.4 4538.6 6056.5 6057.1 6058.3 6075.8 6089.2 5709.5 5719.3 5733.4 5734.3 5759.8 6343.4 6395.6 6416.5 6428.2 6520.7 4705.2 4909.6 4926.1 4939.0 4963.4 6704.8 6745.2 6860.8 6863.5 6887.3 4988.6 5019.5 5029.3 5043.9 5070.9 5029.7 5099.4 5102.2 5136.1 5137.5 5683.2 5701.1 5705.5 5721.0 5742.9 6438.6 6483.1 6505.9 6514.8 6539.5 1745.9 1767.7 1771.7 1791.1 1793.9 1144.8 1217.1 1229.8 1236.2 1241.4 5645.3 5714.8 5723.1 5766.9 5769.9 6535.7 6570.6 6571.9 6726.9 6814.2 5703.8 5709.6 5759.9 5764.2 5793.4 3497.4 3508.9 3542.5 3545.7 3568.0 6225.4 6298.5 6391.1 6415.1 6416.0 6224.5 6636.4 6693.3 6739.6 6774.8 6265.4 6280.0 6306.0 6338.8 6383.7 6500.5 6511.9 6521.9 6589.2 6626.2 6525.8 6538.6 6546.2 6598.6 6630.0 6363.4 6376.8 6397.1 6452.7 6478.5 5010.8 5077.6 5077.9 5092.8 5094.9 6523.9 6647.2 6691.6 6733.2 6736.5 6360.7 6424.6 6432.8 6439.7 6454.8 6395.5 6427.9 6455.4 6487.3 6539.2 6347.4 6360.1 6392.2 6455.6 6479.2 6431.0 6519.7 6521.6 6524.4 6574.4 6260.9 6264.0 6271.7 6336.7 6354.8 16:07:59 INFO - PID 15113 | 16:07:59 INFO - PID 15113 | [#5] yui.html Cycles:180 Average:25157.95 Median:20479.44 stddev:36784.23 (179.6%) stddev-sans-first:36842.39 16:07:59 INFO - PID 15113 | Values: 917.6 926.2 934.1 941.5 945.8 19843.7 20466.3 20477.6 20481.3 20483.5 18249.9 18477.4 18500.1 18608.4 18619.3 955.9 972.4 975.1 975.9 976.0 988.7 995.4 996.4 996.8 996.9 943.2 1027.1 1029.6 1039.0 1043.1 1031.1 1032.0 1032.7 1033.0 1033.1 724.1 743.9 745.7 746.4 750.7 20554.4 20661.2 20776.0 20789.0 20801.1 22107.8 22225.0 22727.1 22774.4 22851.1 17373.9 17541.9 17598.6 17603.6 17616.0 3718.5 3728.4 3735.1 3738.5 3745.6 107641.5 125451.4 150150.0 150872.0 153435.2 16805.4 17865.3 17888.8 17972.6 18047.7 31039.4 31189.4 31255.5 31303.4 31438.4 8445.1 8469.0 8472.0 8523.2 8534.8 4101.4 4193.7 4307.7 4317.7 4333.6 5332.3 5414.6 5421.1 5426.5 5432.5 1081.7 1101.1 1117.5 1120.0 1125.4 666.7 687.4 700.6 702.2 706.1 11599.8 11745.4 12039.6 12271.4 12430.3 670.0 671.8 672.7 674.3 685.3 5346.3 5351.5 5365.8 5369.3 5444.2 129016.4 129149.4 130862.0 132345.0 136130.3 116249.0 116266.0 116986.4 121631.4 122014.4 94733.5 94802.0 98993.0 99280.0 99789.5 9914.5 10092.1 10112.2 10137.0 10162.3 45476.0 46322.8 46516.1 46885.0 47543.3 58336.7 58365.7 58696.1 59000.4 60658.0 16082.1 16491.3 16505.4 16665.3 16720.6 18429.7 18714.8 18823.2 18935.1 18956.6 16488.2 16719.6 16804.4 17008.4 17016.8 16835.9 16841.8 16985.9 17048.8 17144.2 16220.2 16377.6 16406.8 16460.0 16517.8 10935.0 11086.7 11097.6 11169.5 11584.9 11950.7 12155.1 12214.5 12362.9 12454.7 16:07:59 INFO - PID 15113 | -------- Summary: end -------- 16:07:59 INFO - PID 15113 | 16:07:59 INFO - TEST-INFO | 15113: exit 0 16:07:59 INFO - TEST-OK | dromaeo_css | took 1108714ms 16:07:59 INFO - TEST-START | kraken 16:07:59 INFO - Initialising browser for kraken test... 16:07:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48916/getInfo.html -profile /tmp/tmpBkpQJM/profile 16:07:59 INFO - TEST-INFO | started process 15467 (/builds/slave/test/build/application/firefox/firefox http://localhost:48916/getInfo.html) 16:08:04 INFO - TEST-INFO | 15467: exit 0 16:08:04 INFO - Browser initialized. 16:08:04 INFO - Running cycle 1/1 for kraken test... 16:08:04 INFO - Using env: {'DISPLAY': ':0', 16:08:04 INFO - 'HOME': '/home/cltbld', 16:08:04 INFO - 'JSGC_DISABLE_POISONING': '1', 16:08:04 INFO - 'LANG': 'en_US.UTF-8', 16:08:04 INFO - 'LANGUAGE': 'en_US:en', 16:08:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:08:04 INFO - 'LOGNAME': 'cltbld', 16:08:04 INFO - 'MAIL': '/var/mail/cltbld', 16:08:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:08:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:08:04 INFO - 'MOZ_CRASHREPORTER': '1', 16:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:08:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:08:04 INFO - 'MOZ_NO_REMOTE': '1', 16:08:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:08:04 INFO - 'NO_EM_RESTART': '1', 16:08:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:08:04 INFO - 'PWD': '/builds/slave/test', 16:08:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:08:04 INFO - 'RUST_BACKTRACE': 'full', 16:08:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:08:04 INFO - 'SHELL': '/bin/bash', 16:08:04 INFO - 'SHLVL': '1', 16:08:04 INFO - 'STYLO_FORCE_DISABLED': '1', 16:08:04 INFO - 'TERM': 'linux', 16:08:04 INFO - 'TMOUT': '86400', 16:08:04 INFO - 'USER': 'cltbld', 16:08:04 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142', 16:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:08:04 INFO - '_': '/tools/buildbot/bin/python'} 16:08:04 INFO - TEST-INFO | started process 15699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkpQJM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:05 INFO - PID 15699 | 16:08:05 INFO - PID 15699 | (/builds/slave/test/build/application/firefox/firefox:15748): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:08:05 INFO - PID 15699 | 16:08:16 INFO - PID 15699 | RSS: Main: 154132480 16:08:16 INFO - PID 15699 | 16:08:18 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48916/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:19 INFO - PID 15699 | RSS: Main: 159719424 16:08:19 INFO - PID 15699 | 16:08:22 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48916/tests/kraken/driver.html?testName=audio-dft) 16:08:22 INFO - PID 15699 | RSS: Main: 160296960 16:08:22 INFO - PID 15699 | 16:08:25 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48916/tests/kraken/driver.html?testName=audio-fft) 16:08:26 INFO - PID 15699 | RSS: Main: 156188672 16:08:26 INFO - PID 15699 | 16:08:28 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48916/tests/kraken/driver.html?testName=audio-oscillator) 16:08:29 INFO - PID 15699 | RSS: Main: 156647424 16:08:29 INFO - PID 15699 | 16:08:31 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:31 INFO - PID 15699 | RSS: Main: 156704768 16:08:31 INFO - PID 15699 | 16:08:35 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48916/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:35 INFO - PID 15699 | RSS: Main: 158781440 16:08:35 INFO - PID 15699 | 16:08:39 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48916/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:39 INFO - PID 15699 | RSS: Main: 159404032 16:08:39 INFO - PID 15699 | 16:08:42 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48916/tests/kraken/driver.html?testName=json-parse-financial) 16:08:43 INFO - PID 15699 | RSS: Main: 159825920 16:08:43 INFO - PID 15699 | 16:08:45 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:45 INFO - PID 15699 | RSS: Main: 159465472 16:08:45 INFO - PID 15699 | 16:08:47 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:47 INFO - PID 15699 | RSS: Main: 159547392 16:08:47 INFO - PID 15699 | 16:08:50 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:50 INFO - PID 15699 | RSS: Main: 156737536 16:08:50 INFO - PID 15699 | 16:08:53 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:53 INFO - PID 15699 | RSS: Main: 156778496 16:08:53 INFO - PID 15699 | 16:08:56 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:57 INFO - PID 15699 | RSS: Main: 156958720 16:08:57 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | Cycle 1(1): loaded http://localhost:48916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48916/tests/kraken/driver.html?testName=ai-astar) 16:08:59 INFO - PID 15699 | RSS: Main: 158527488 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | __start_tp_report 16:08:59 INFO - PID 15699 | _x_x_mozilla_page_load 16:08:59 INFO - PID 15699 | _x_x_mozilla_page_load_details 16:08:59 INFO - PID 15699 | |i|pagename|runs| 16:08:59 INFO - PID 15699 | |0;ai-astar;109;110;109;107;108;108;107;109;108;107 16:08:59 INFO - PID 15699 | |1;audio-beat-detection;116;115;118;115;116;116;117;118;117;137 16:08:59 INFO - PID 15699 | |2;audio-dft;165;163;163;162;163;161;162;166;166;163 16:08:59 INFO - PID 15699 | |3;audio-fft;75;74;78;77;76;74;75;74;74;74 16:08:59 INFO - PID 15699 | |4;audio-oscillator;83;80;80;78;80;78;77;78;78;79 16:08:59 INFO - PID 15699 | |5;imaging-gaussian-blur;114;111;113;113;111;111;112;112;113;111 16:08:59 INFO - PID 15699 | |6;imaging-darkroom;160;149;148;148;147;147;147;148;149;148 16:08:59 INFO - PID 15699 | |7;imaging-desaturate;94;94;94;98;99;94;97;94;95;94 16:08:59 INFO - PID 15699 | |8;json-parse-financial;53;51;52;51;60;52;53;52;49;49 16:08:59 INFO - PID 15699 | |9;json-stringify-tinderbox;38;38;37;38;38;37;41;38;38;38 16:08:59 INFO - PID 15699 | |10;stanford-crypto-aes;74;81;74;78;74;75;75;73;78;73 16:08:59 INFO - PID 15699 | |11;stanford-crypto-ccm;115;110;107;108;112;111;107;110;108;112 16:08:59 INFO - PID 15699 | |12;stanford-crypto-pbkdf2;161;177;175;161;159;160;161;160;173;159 16:08:59 INFO - PID 15699 | |13;stanford-crypto-sha256-iterative;72;67;64;64;64;68;68;64;65;63 16:08:59 INFO - PID 15699 | __end_tp_report 16:08:59 INFO - PID 15699 | __start_cc_report 16:08:59 INFO - PID 15699 | _x_x_mozilla_cycle_collect,749 16:08:59 INFO - PID 15699 | __end_cc_report 16:08:59 INFO - PID 15699 | __startTimestamp1506726539465__endTimestamp 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | ------- Summary: start ------- 16:08:59 INFO - PID 15699 | Number of tests: 14 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.50 stddev:1.03 (1.0%) stddev-sans-first:1.05 16:08:59 INFO - PID 15699 | Values: 109.0 110.0 109.0 107.0 108.0 108.0 107.0 109.0 108.0 107.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:117.00 stddev:6.59 (5.6%) stddev-sans-first:6.92 16:08:59 INFO - PID 15699 | Values: 116.0 115.0 118.0 115.0 116.0 116.0 117.0 118.0 117.0 137.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.71 (1.1%) stddev-sans-first:1.72 16:08:59 INFO - PID 15699 | Values: 165.0 163.0 163.0 162.0 163.0 161.0 162.0 166.0 166.0 163.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#3] audio-fft Cycles:10 Average:75.10 Median:75.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 16:08:59 INFO - PID 15699 | Values: 75.0 74.0 78.0 77.0 76.0 74.0 75.0 74.0 74.0 74.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.50 stddev:1.73 (2.2%) stddev-sans-first:1.12 16:08:59 INFO - PID 15699 | Values: 83.0 80.0 80.0 78.0 80.0 78.0 77.0 78.0 78.0 79.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#5] imaging-gaussian-blur Cycles:10 Average:112.10 Median:112.50 stddev:1.10 (1.0%) stddev-sans-first:0.93 16:08:59 INFO - PID 15699 | Values: 114.0 111.0 113.0 113.0 111.0 111.0 112.0 112.0 113.0 111.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:148.00 stddev:3.90 (2.6%) stddev-sans-first:0.78 16:08:59 INFO - PID 15699 | Values: 160.0 149.0 148.0 148.0 147.0 147.0 147.0 148.0 149.0 148.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:1.95 (2.1%) stddev-sans-first:2.01 16:08:59 INFO - PID 15699 | Values: 94.0 94.0 94.0 98.0 99.0 94.0 97.0 94.0 95.0 94.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:3.08 (5.9%) stddev-sans-first:3.26 16:08:59 INFO - PID 15699 | Values: 53.0 51.0 52.0 51.0 60.0 52.0 53.0 52.0 49.0 49.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:1.10 (2.9%) stddev-sans-first:1.17 16:08:59 INFO - PID 15699 | Values: 38.0 38.0 37.0 38.0 38.0 37.0 41.0 38.0 38.0 38.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.64 (3.5%) stddev-sans-first:2.74 16:08:59 INFO - PID 15699 | Values: 74.0 81.0 74.0 78.0 74.0 75.0 75.0 73.0 78.0 73.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#11] stanford-crypto-ccm Cycles:10 Average:110.00 Median:110.50 stddev:2.58 (2.3%) stddev-sans-first:2.01 16:08:59 INFO - PID 15699 | Values: 115.0 110.0 107.0 108.0 112.0 111.0 107.0 110.0 108.0 112.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:161.00 stddev:7.28 (4.5%) stddev-sans-first:7.60 16:08:59 INFO - PID 15699 | Values: 161.0 177.0 175.0 161.0 159.0 160.0 161.0 160.0 173.0 159.0 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:2.81 (4.3%) stddev-sans-first:1.92 16:08:59 INFO - PID 15699 | Values: 72.0 67.0 64.0 64.0 64.0 68.0 68.0 64.0 65.0 63.0 16:08:59 INFO - PID 15699 | -------- Summary: end -------- 16:08:59 INFO - PID 15699 | 16:08:59 INFO - PID 15699 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:09:00 INFO - TEST-INFO | 15699: exit 0 16:09:00 INFO - TEST-OK | kraken | took 60634ms 16:09:00 INFO - SUITE-END | took 1169s 16:09:00 INFO - Completed test suite (00:19:29) 16:09:00 INFO - javascript benchmark 16:09:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8595.47497997822, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3179.984100079499, 3180.077777444541, 3183.1087295557236, 3191.106490182748, 3199.232184275773, 6071.271447426309, 6085.148079268901, 6175.629462232269, 6314.968425157879, 6318.842028949267, 6180.660063696495, 6254.749810007605, 6274.56078074535, 6338.366163383671, 6348.523860710442, 5428.240046393488, 5859.853503662422, 5872.765089396419, 5874.1776151338845, 5912.142739302799, 5584.832455026356, 5758.884822303551, 5824.737886795083, 5830.7667693292215, 5853.707314634273, 5691.0, 5696.743646535916, 5731.799387021476, 5732.111522713986, 5744.626599271055, 5744.0, 5749.82750517481, 5753.539716822645, 5756.769729210827, 5766.423357664242, 5699.031164701969, 5770.596058275923, 5774.249347584787, 5779.393163717833, 5827.941720582782, 6246.0, 6261.592996455216, 6269.655168965705, 6325.462335701471, 6389.041643753428, 6670.7665231716655, 6680.5991640501725, 6739.595624262511, 6771.356721111487, 6864.176298844171, 6796.966015169942, 6868.450523958071, 6877.2091209511045, 6886.621235832027, 6891.655417229169, 6200.224971878515, 6265.7493700251935, 6315.210598675166, 6375.681215939231, 6400.167978162855, 6977.476689248327, 7063.223045464994, 7080.114985626797, 7086.326798954091, 7093.864981602918, 6631.966840165768, 6652.7338906444165, 6720.193576770819, 6720.697568609425, 6738.090357801732, 6711.3288671132495, 6743.15710536183, 6746.0, 6746.966265168643, 6749.628770417674, 6739.696713647898, 6784.559003664746, 6787.185537735503, 6788.9660551696925, 6801.897971530431, 6581.605103693793, 6681.599104053772, 6686.732530698815, 6781.389674929182, 6782.864342713118, 5198.6880787152895, 5271.314729085271, 5291.126964050965, 5376.139817629239, 5377.27406800077, 4620.330052142421, 4688.296755486636, 4698.624110071186, 4738.668293219442, 4748.4539277982785, 5804.245448091721, 5816.563757718103, 5877.147813567009, 5911.645301281937, 5922.526197904157, 6795.52431329812, 6799.694013769392, 6859.314068593101, 6863.622500762506, 6892.758753443605, 5724.599278050579, 5785.247917770663, 5793.565482588739, 5798.768049278066, 5799.5650326225705, 5827.388124246893, 5862.384449632727, 5863.0, 5866.2960444746905, 5875.882482350329, 6396.5202609804455, 6473.352664733583, 6491.837704057436, 6499.2850786413455, 6546.24718157418, 6645.534812563074, 6649.434798042221, 6657.1345725055435, 6670.73256081343, 6827.0, 6290.654014029089, 6378.362163783585, 6429.421352078335, 6437.195350581177, 6444.45222156122, 6598.538102332791, 6663.466922646274, 6665.733370665119, 6671.83320416974, 6678.49911256648, 6791.558548694319, 6893.241743408121, 6901.102856628606, 6907.551009184387, 6923.9653801730665, 6569.408753212234, 6569.868602628017, 6580.5064620154635, 6666.966665166643, 6683.298253683293, 6584.275729669636, 6585.539012269095, 6668.333166683293, 6672.266050734513, 6677.866442671022, 6477.0, 6536.6731663415685, 6550.213974323112, 6550.312217217314, 6566.9014964774615, 6648.700808463727, 6679.2318883329035, 6695.0292207628645, 6702.229243637044, 6704.564203326768, 6400.263969643364, 6412.903806443001, 6494.545381823416, 6496.707648155939, 6501.2523559791225], "value": 6156.580238597082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.6605606841366, 909.2952961454872, 910.2808781062959, 911.6262332443699, 912.8037471943535, 40283.0, 44626.0, 44633.77683111588, 44682.32976505351, 44800.77599612006, 40385.39421908674, 40698.18603627933, 40768.59231407685, 40804.795976020156, 40820.79589602048, 7358.337749602535, 8015.278624923756, 8188.058373287059, 8190.8771368429525, 8198.42611017229, 8075.313598344148, 8200.05699344577, 8204.138565450632, 8204.917950820474, 8211.671533138668, 8138.593070346488, 8200.671973121069, 8208.425410221287, 8226.506409615413, 8254.215849494318, 8156.469829461095, 8195.631196596167, 8201.548914809682, 8217.7123800667, 8228.547429891354, 7979.760607181735, 8099.473534220316, 8111.310538604226, 8116.0, 8116.431849770518, 41153.1769364614, 41162.38256426156, 41221.175576488604, 41525.37711934323, 41615.167696646204, 3574.195805943668, 3637.3270944875285, 3637.4725664778457, 3637.836297366625, 3639.162992511711, 33382.0, 33464.83267583671, 33501.0, 33567.6643233567, 33574.6642533574, 5204.8178313758835, 5219.5041471060185, 5227.503387178212, 5233.4243233244315, 5363.141897296414, 196927.0, 197580.0, 197906.01046994817, 198509.0, 200355.0, 44927.326090108676, 45783.54216457793, 51941.48058519442, 52254.47745522572, 52806.20790688143, 55452.44547554554, 55515.0, 55788.44211557833, 55872.44127558754, 56047.43952560504, 16642.75035874463, 16717.414890478776, 16751.0, 16771.83228167727, 16839.494815155565, 13611.659708507168, 13617.727645447036, 13729.725405491834, 13739.038267321392, 13786.862131378557, 14881.925590371979, 14964.326605302787, 15113.3199006045, 15144.242787860783, 15268.0, 5922.230110085661, 5933.881322373615, 5944.7027648617395, 6012.699365031731, 6084.209052823105, 996.5913975270105, 1026.9217321812068, 1037.6990672704983, 1049.7952899184586, 1051.6476980211562, 24166.7583324168, 24200.51598968046, 24364.634530482057, 24391.878040609685, 24420.389490262885, 1123.3877536742332, 1124.4482613992802, 1132.8640563132312, 1139.1114930354338, 1151.1654050813092, 12686.936565317299, 12914.41885115172, 12952.352382380843, 13000.544980925622, 13032.478700852049, 218178.0, 233356.0, 245568.0, 245837.0, 246489.0, 55217.72391138099, 55364.16953745697, 55440.72279638576, 55473.0, 55550.44449555533, 1435.440178330452, 1475.7491226491522, 1492.1121932450176, 1509.8641122298827, 1515.6817068415535, 23359.53280934406, 23422.531549368578, 23528.529429411657, 23560.410989725395, 23590.17434389857, 38962.220755585295, 39190.608093918694, 39203.2159356817, 39257.0, 39281.41077883891, 195556.0, 196528.0, 197034.0, 197834.0, 198493.0, 37183.0, 39636.60363396329, 40118.799406002785, 40231.798841005606, 40306.79846600748, 47310.29034564553, 48345.5165448341, 48684.0, 48903.0, 48961.0, 33677.831610841786, 34050.14874628055, 34204.14489637779, 34243.183595792696, 34462.655373445945, 33651.83174084212, 33887.15282117967, 34010.0, 34010.14974625555, 34530.65469345274, 38211.23577528489, 38645.0, 38671.0, 38677.41983870188, 39078.4138237921, 33312.666873330956, 33458.83270583729, 33635.49546756849, 33937.0, 34039.0, 24591.754082458945, 25009.374765631004, 25101.24696259115, 25855.22434326898, 25867.741322586535], "value": 18028.816418792074, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.5933885288576, 598.592956789383, 603.4146877528796, 622.7415622516655, 627.8618703885146, 22725.0, 22774.089036438563, 23485.882570587164, 23514.29457116285, 23534.64698029531, 23627.291181264547, 24895.128670496535, 24918.875405622948, 24939.875300623517, 24977.625335619934, 6612.107365505655, 6750.932490675104, 6764.7970560883, 6785.558938668995, 6822.010808432799, 6424.357564243562, 6663.4669226461765, 6699.062131301622, 6711.932880671204, 6722.899156512656, 6683.899741503881, 6687.0, 6688.1305430294, 6689.264180940093, 6691.464682825363, 6669.866602667919, 6675.59946403215, 6678.131842860445, 6680.899786503206, 6683.565568238073, 6214.65819379934, 6215.502759779207, 6219.036049412348, 6219.40915613016, 6224.439800417984, 28468.572971405447, 29055.56416653752, 29157.271068223465, 29351.55972660412, 29547.704522954926, 1967.3999430173935, 1985.1662301833264, 2019.545602239499, 2020.7170996060563, 2021.706852506393, 19360.128794204295, 19403.320883769, 19875.30436434718, 19878.70181947272, 19933.20267189325, 2435.719892212383, 2490.6762120924163, 2569.768720815117, 2571.485702859417, 2572.446923911349, 122699.38650306691, 128201.0, 141820.0, 145337.2733136338, 145351.2732436331, 14736.263186840615, 14974.0, 15090.54728358151, 15242.771358429633, 15406.38374465009, 23928.162514311916, 24106.51786964286, 24182.637260441108, 24204.87897560501, 24224.636630450557, 10056.64801731936, 10196.235282353853, 10281.845772313422, 10292.433916134534, 10361.32651377673, 9452.763680908032, 9593.42439453635, 9651.469169195761, 9654.662086826927, 9935.503224838874, 8916.331275154389, 9020.323475739346, 9113.589888455035, 9217.861732074025, 9388.765280868032, 2656.2296933889343, 2761.2682639100653, 2766.3775650478883, 2813.409184071368, 2855.6715977662834, 948.6821914658528, 956.8086382723483, 961.6201600367815, 962.167724917955, 981.9558119884622, 19271.710924336145, 19378.031098445023, 19585.314513991943, 19621.01894905249, 19676.70484942727, 1019.704285757137, 1029.0841151375282, 1034.6895931220754, 1038.672818062308, 1049.3022140276782, 10531.315464494783, 10681.679549613524, 10743.247972641997, 10757.193210509244, 10968.670939871816, 431657.0, 438144.0, 441126.0, 442077.0, 458589.0, 111076.0, 112521.0, 114787.0, 115205.4239728796, 116029.0, 1143.8512993310817, 1157.0569985461989, 1201.3512703140382, 1202.963911082669, 1204.8554173499235, 16863.578410539834, 16872.013328411253, 17263.82736172622, 17477.0, 17610.031448270467, 54992.45007549873, 56504.0, 56721.0, 56880.71559642341, 57531.42468575428, 67269.0, 69781.30218697748, 70013.0, 70297.29702703112, 70993.0, 14105.647358816112, 14649.901257405523, 14697.632559186106, 14744.705105898036, 14753.704925901207, 22478.438039049153, 22620.773792261865, 22661.546769064855, 22926.19758308451, 22975.425614359774, 18054.187561560026, 18054.5486362842, 18333.633327333646, 18443.72334414958, 18515.537111572317, 15934.123623200836, 16529.33882644681, 16742.995420274336, 16843.7473437901, 17200.709946754294, 17465.21406536734, 18506.0, 18513.259469621065, 18650.0, 18696.813031869508, 14309.928450357682, 14326.57020289393, 14346.784798228244, 14389.568312950629, 14494.34775435129, 17636.29454821844, 18085.095745212424, 18162.182701778187, 18219.271229150687, 18268.81731182671], "value": 11965.683199194636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.7348530293941, 1361.8948796743425, 1370.212128026385, 1376.4219028008235, 1385.494294582477, 14220.43118275269, 14851.702965940674, 14854.48009319674, 14865.0, 14866.256687165625, 14342.498012569537, 14352.354144063516, 14482.493112741056, 14487.855121448782, 14666.560003199895, 2665.1737961231984, 2790.1629511146675, 2817.3520090379225, 2819.7180281971846, 2821.3510892494737, 2773.6671599408, 2800.271929298387, 2801.5937689035077, 2803.3692419205718, 2815.6480439945008, 2722.6460560127157, 2814.577813328007, 2815.042885418957, 2815.282103063716, 2816.0566210319566, 2667.6932152802483, 2758.0484732767163, 2789.0377819652185, 2792.511310520661, 2799.4960907036725, 2771.9445611087667, 2804.5652923796843, 2805.04628426336, 2810.901618443365, 2812.2266376746556, 14633.0, 14831.184284864328, 14919.701605967928, 14922.403103875831, 14957.775633365509, 8081.757547273592, 8374.706885259047, 8381.832363352698, 8384.622691978875, 8391.370647201484, 5029.497050294978, 5205.817796377109, 5326.520613144836, 5336.813211537617, 5342.946570534323, 1898.9525261868425, 1980.1683293016968, 1987.3441764217773, 2032.4106009257298, 2039.1027947702962, 24875.12937047213, 24883.253502394957, 25158.49683006348, 25169.37076573082, 25174.874125629438, 6614.966925165343, 6620.973749068902, 6646.368594983469, 6792.830179245559, 6796.8300792479595, 17286.0, 17304.913475432542, 17479.300827966737, 17481.300747969937, 17513.211905464286, 7844.646990885424, 8056.113827478973, 8059.395545334123, 8060.476069055492, 8085.636146373427, 6465.676716164173, 6504.317046710122, 6517.120188774455, 6536.084948107269, 7259.673314700851, 5160.864609785841, 5338.745394832211, 5354.571634269249, 5374.731263436813, 5394.190871369326, 1323.371398585664, 1356.6133651909158, 1431.7351290011381, 1457.140287230518, 1497.8052853129022, 885.751989442957, 885.7829831691148, 905.4024343932973, 907.0249481807084, 926.4256161180111, 8559.0, 8695.0, 8695.956520217358, 8698.652053917773, 8720.084391138966, 731.1263040666353, 733.2154594583744, 733.7945375294926, 743.5055687967441, 814.9877751833727, 5315.255864179018, 5357.1696387060065, 5426.430224826416, 5509.0, 5587.161925711176, 19497.0, 20568.794312056987, 20810.895945520177, 21086.789132108788, 21207.0, 20589.07349169291, 20680.48298792542, 20854.0, 21027.15891364328, 21051.263205787724, 10173.745656358651, 10419.94790026045, 10483.423411712429, 10615.150787936947, 10631.893681063091, 8513.616887240212, 8526.531040792568, 8556.229939305493, 8575.356848236532, 8606.0, 17767.0, 18056.72914906251, 18143.727844082612, 18375.63248734991, 18429.631407372046, 18153.18468153174, 18318.81681183171, 18592.535186620444, 18906.243750250385, 18923.432297030562, 10815.891841081488, 10833.349999000086, 10986.505607247853, 10989.175811814306, 10989.780204396027, 13630.1140425872, 13779.724405511633, 13968.930155349564, 13986.44054237819, 13992.860071399156, 11408.828867566826, 11445.542178312775, 11446.42767861587, 11684.532618695497, 11804.586839460577, 11090.334579925231, 11242.213045086766, 11457.255278406878, 11482.598109066143, 11558.364289964133, 10099.343542669703, 10339.0694837465, 10344.637937672145, 10354.430506322225, 10358.326708763907, 6674.0, 7248.927510724825, 7317.890231646423, 7335.1197856257595, 7366.858136988775, 7329.450291228072, 7337.119545654556, 7451.850962980819, 7524.398048156244, 7536.698532058656], "value": 6610.870635068958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.4606194402963, 518.984430467086, 536.9221462887881, 542.1677724692597, 543.7525925703802, 6276.340984196657, 6283.151774510439, 6285.371462853713, 6349.1746073010445, 6357.682115894198, 6250.343713910042, 6260.530460215479, 6267.717952692128, 6267.749290028405, 6344.143540622026, 5174.482551744814, 5207.786690656465, 5222.63441559091, 5249.107651699221, 5285.497877701612, 4833.806647734086, 5189.273501709764, 5221.2429197766305, 5241.3710354757295, 5316.867078323035, 4948.257761335793, 4966.304717339575, 5008.849734507952, 5034.295198672189, 5043.319151914481, 4958.132326842788, 5010.448850626428, 5022.522860328263, 5029.748512574393, 5055.873603159914, 4383.232934236496, 4471.955280447219, 4519.570640789119, 4530.411046563926, 4538.591526762574, 6056.4851987581105, 6057.121717351003, 6058.27300723916, 6075.817725468199, 6089.1779609753, 5709.514691251248, 5719.3136823581435, 5733.397993210695, 5734.283214598176, 5759.769609215668, 6343.365663433666, 6395.584287021329, 6416.48668106555, 6428.19647544057, 6520.707517245881, 4705.200115980291, 4909.558139767438, 4926.11329960607, 4938.999705119432, 4963.38689925772, 6704.83237919051, 6745.156855393076, 6860.759873404407, 6863.519553631248, 6887.311268873123, 4988.6009119270375, 5019.548240658358, 5029.346184996, 5043.873903152377, 5070.873228169252, 5029.698218106925, 5099.36257967754, 5102.209157580581, 5136.101182293084, 5137.51193636604, 5683.204351390808, 5701.116326969326, 5705.546614955609, 5721.0, 5742.885142297131, 6438.645874476949, 6483.059956306403, 6505.934940650627, 6514.771982980573, 6539.509536784665, 1745.877788554789, 1767.6729804986119, 1771.6722406354866, 1791.0596936608385, 1793.9103044847704, 1144.7710457908452, 1217.1479964025218, 1229.7786398448186, 1236.1964722929988, 1241.4351470081272, 5645.294338207724, 5714.771409143671, 5723.141528770634, 5766.913496297559, 5769.94230057694, 6535.705893234815, 6570.638614876228, 6571.868562628721, 6726.865462690719, 6814.216365117975, 5703.800366987219, 5709.628874123252, 5759.85600359986, 5764.221830052889, 5793.37785420083, 3497.4229252173614, 3508.9122771930906, 3542.5217595624263, 3545.6808887200277, 3567.9821600892346, 6225.408586184305, 6298.527610429236, 6391.105245265667, 6415.133956915756, 6416.0, 6224.533160013018, 6636.402723754885, 6693.2972037935315, 6739.5619284746335, 6774.8172647924375, 6265.4361107499635, 6279.96860015697, 6305.96847015762, 6338.778142764981, 6383.744650213939, 6500.537379089667, 6511.869762604816, 6521.869562608626, 6589.209294884645, 6626.237982632059, 6525.771597994048, 6538.574992625464, 6546.181727283899, 6598.571092878948, 6629.966850165912, 6363.391009686192, 6376.776812811529, 6397.136386587751, 6452.709628066842, 6478.5141114415665, 5010.847505073781, 5077.568406685473, 5077.92383114261, 5092.796288148433, 5094.872628184325, 6523.9347606525225, 6647.169103862017, 6691.631960242234, 6733.192016957996, 6736.494762892705, 6360.681965901779, 6424.614523128627, 6432.8099301629345, 6439.721271760184, 6454.806355809334, 6395.488360931207, 6427.8751218535635, 6455.354464553507, 6487.3188315226225, 6539.193692635814, 6347.3652634738, 6360.141380913703, 6392.20097487814, 6455.644939528371, 6479.157709497735, 6430.971044633024, 6519.706613202323, 6521.576097553644, 6524.380183882524, 6574.351235064585, 6260.874782504416, 6264.0, 6271.717772700331, 6336.683165841781, 6354.841128971812], "value": 5046.210744777455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [917.6191880369647, 926.1664501948246, 934.0612684252326, 941.5198248893063, 945.8202941441124, 19843.702344464844, 20466.283680071218, 20477.590448191026, 20481.283155089575, 20483.487912802186, 18249.908750456263, 18477.44567662969, 18500.0749962502, 18608.441746747587, 18619.348322808706, 955.9044095590438, 972.4214092614883, 975.0980343182563, 975.9316847820655, 975.9658411955583, 988.6935050134481, 995.372915063509, 996.432033740768, 996.8155891160122, 996.875390576178, 943.1982814607597, 1027.1218108517223, 1029.608748675506, 1038.9636362727306, 1043.1498328861953, 1031.0771859186025, 1031.9793604127876, 1032.6850310655248, 1033.0444338986445, 1033.1270076785104, 724.0623392706458, 743.8995735575683, 745.6569977810213, 746.4289818289013, 750.6659536506257, 20554.38336849897, 20661.17355305786, 20776.0, 20789.0, 20801.06395212204, 22107.778922210895, 22225.0, 22727.09091636349, 22774.430639233986, 22851.085956561717, 17373.913130434394, 17541.912290438595, 17598.560035999075, 17603.647927041515, 17616.0, 3718.5165928429133, 3728.440733889911, 3735.0849041984616, 3738.5139931808963, 3745.5879853216125, 107641.46179269053, 125451.3727431357, 150149.9999999989, 150872.0, 153435.2328238363, 16805.411810586815, 17865.285388584573, 17888.821111788977, 17972.640547189243, 18047.729284060748, 31039.379212416075, 31189.376212475625, 31255.531167032514, 31303.373932521223, 31438.37123257522, 8445.113263107409, 8468.957655211685, 8472.0, 8523.232909038215, 8534.829303413897, 4101.384792281182, 4193.6645068394455, 4307.655387568987, 4317.7193482423545, 4333.609975102256, 5332.280142180756, 5414.648047876875, 5421.132618780976, 5426.484483974016, 5432.538234250054, 1081.7403823082561, 1101.11910471624, 1117.4915413487006, 1120.0143873391364, 1125.3641692443744, 666.6766618190173, 687.3744892148121, 700.6146619359332, 702.1679310017646, 706.1279320039747, 11599.826002609967, 11745.412729363497, 12039.63881083569, 12271.38643067843, 12430.316332601793, 669.9531032827655, 671.7816709569312, 672.6703915081673, 674.2839473539852, 685.2941470285614, 5346.304980352529, 5351.464853514695, 5365.812196573179, 5369.301990741179, 5444.183372494078, 129016.35491822481, 129149.35425322813, 130862.0, 132345.0, 136130.3193484026, 116249.0, 116266.0, 116986.41506792411, 121631.39184304021, 122014.38992804979, 94733.52633236928, 94802.0, 98993.01006989981, 99280.0, 99789.50105249428, 9914.454704991294, 10092.14216791581, 10112.191024718151, 10137.036981486746, 10162.288639795439, 45476.0, 46322.768386157855, 46516.06967860692, 46885.0, 47543.286850696575, 58336.70831645815, 58365.70817145887, 58696.119558205806, 59000.40999589949, 60658.0, 16082.115483648511, 16491.257893395064, 16505.422310219084, 16665.3333866644, 16720.581985450463, 18429.72355414643, 18714.812851871306, 18823.152958116643, 18935.14791834343, 18956.620867582296, 16488.17559122063, 16719.582010449834, 16804.411845585346, 17008.404705835237, 17016.829831701525, 16835.91582042131, 16841.831581684026, 16985.91507042457, 17048.829511704724, 17144.22850971734, 16220.188990550661, 16377.590560235612, 16406.75389869129, 16460.0, 16517.752233716743, 10934.961178688012, 11086.722831928944, 11097.611583594535, 11169.497372618414, 11584.884151158718, 11950.701232469259, 12155.149139560499, 12214.511419543118, 12362.938185309376, 12454.688632784253], "value": 9101.725699282693, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1407.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 107.0, 108.0, 108.0, 107.0, 109.0, 108.0, 107.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 118.0, 115.0, 116.0, 116.0, 117.0, 118.0, 117.0, 137.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 163.0, 161.0, 162.0, 166.0, 166.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 77.0, 76.0, 74.0, 75.0, 74.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 78.0, 80.0, 78.0, 77.0, 78.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 113.0, 111.0, 111.0, 112.0, 112.0, 113.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 148.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 98.0, 99.0, 94.0, 97.0, 94.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 60.0, 52.0, 53.0, 52.0, 49.0, 49.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 41.0, 38.0, 38.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 74.0, 78.0, 74.0, 75.0, 75.0, 73.0, 78.0, 73.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 107.0, 108.0, 112.0, 111.0, 107.0, 110.0, 108.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 177.0, 175.0, 161.0, 159.0, 160.0, 161.0, 160.0, 173.0, 159.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 64.0, 64.0, 64.0, 68.0, 68.0, 64.0, 65.0, 63.0], "value": 65.9, "unit": "score"}]}]} 16:09:00 INFO - Return code: 0 16:09:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:00 INFO - # TBPL SUCCESS # 16:09:00 INFO - Running post-action listener: _package_coverage_data 16:09:00 INFO - Running post-action listener: _resource_record_post_action 16:09:00 INFO - [mozharness: 2017-09-29 23:09:00.721066Z] Finished run-tests step (success) 16:09:00 INFO - Running post-run listener: _resource_record_post_run 16:09:00 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 343552000; Read time: 24; Write time: 225216 16:09:00 INFO - TinderboxPrint: CPU usage
13.1% 16:09:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 16:09:00 INFO - TinderboxPrint: I/O write bytes / time
343,552,000 / 225,216 16:09:00 INFO - TinderboxPrint: CPU idle
8,229.0 (86.9%) 16:09:00 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 16:09:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13037568; Read time: 0; Write time: 872 16:09:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:09:00 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330108928; Read time: 8; Write time: 224312 16:09:01 INFO - Running post-run listener: _upload_blobber_files 16:09:01 INFO - Blob upload gear active. 16:09:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:01 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 16:09:01 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'] 16:09:01 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 16:09:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:09:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:02 INFO - (blobuploader) - INFO - Done attempting. 16:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:03 INFO - (blobuploader) - INFO - Done attempting. 16:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:11 INFO - (blobuploader) - INFO - Done attempting. 16:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:09:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:12 INFO - (blobuploader) - INFO - Done attempting. 16:09:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:12 INFO - Return code: 0 16:09:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c37240a6e98f0668f3a46235982f1efe2969ee7a9b441fce662d1f5f2d4e6c1c1018468df8613e2e8b4dff6a4224b5bba950d45f1376e1ec351565a1f874eb", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39fe2a6fb8ca152c76084a49db8a82aeba4d4cc25a566265fd5811935a719f4b3d396c29e3373be5a0d3599535491e1d2eed850d81c45e8a28661ce62ea21c3f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c10915e95220f11b6ccdc15358a72d0a5e917b248fbafb426469050087601e1d8cedf4e6bbeb15dcc5130efcab421fea5d51286ffd8f1d694c127dec912dfc44", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ec905c370dc36a92dcc3704b281caf055c719f21e24d1d646f39fc6321445613aec4934dce047ddc29f0e71f4b7026c1771595d7b9666dcf01bbcfe3631711"} 16:09:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:12 INFO - Contents: 16:09:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c37240a6e98f0668f3a46235982f1efe2969ee7a9b441fce662d1f5f2d4e6c1c1018468df8613e2e8b4dff6a4224b5bba950d45f1376e1ec351565a1f874eb", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39fe2a6fb8ca152c76084a49db8a82aeba4d4cc25a566265fd5811935a719f4b3d396c29e3373be5a0d3599535491e1d2eed850d81c45e8a28661ce62ea21c3f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c10915e95220f11b6ccdc15358a72d0a5e917b248fbafb426469050087601e1d8cedf4e6bbeb15dcc5130efcab421fea5d51286ffd8f1d694c127dec912dfc44", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ec905c370dc36a92dcc3704b281caf055c719f21e24d1d646f39fc6321445613aec4934dce047ddc29f0e71f4b7026c1771595d7b9666dcf01bbcfe3631711"} 16:09:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:12 INFO - Copying logs to upload dir... 16:09:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.779859 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-29 16:09:12.641817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:09:12.649373) ========= 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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 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/71c37240a6e98f0668f3a46235982f1efe2969ee7a9b441fce662d1f5f2d4e6c1c1018468df8613e2e8b4dff6a4224b5bba950d45f1376e1ec351565a1f874eb", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39fe2a6fb8ca152c76084a49db8a82aeba4d4cc25a566265fd5811935a719f4b3d396c29e3373be5a0d3599535491e1d2eed850d81c45e8a28661ce62ea21c3f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c10915e95220f11b6ccdc15358a72d0a5e917b248fbafb426469050087601e1d8cedf4e6bbeb15dcc5130efcab421fea5d51286ffd8f1d694c127dec912dfc44", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ec905c370dc36a92dcc3704b281caf055c719f21e24d1d646f39fc6321445613aec4934dce047ddc29f0e71f4b7026c1771595d7b9666dcf01bbcfe3631711"} build_url:https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/fp7g7_mhRC22F8P10CUW5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71c37240a6e98f0668f3a46235982f1efe2969ee7a9b441fce662d1f5f2d4e6c1c1018468df8613e2e8b4dff6a4224b5bba950d45f1376e1ec351565a1f874eb", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39fe2a6fb8ca152c76084a49db8a82aeba4d4cc25a566265fd5811935a719f4b3d396c29e3373be5a0d3599535491e1d2eed850d81c45e8a28661ce62ea21c3f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c10915e95220f11b6ccdc15358a72d0a5e917b248fbafb426469050087601e1d8cedf4e6bbeb15dcc5130efcab421fea5d51286ffd8f1d694c127dec912dfc44", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/27ec905c370dc36a92dcc3704b281caf055c719f21e24d1d646f39fc6321445613aec4934dce047ddc29f0e71f4b7026c1771595d7b9666dcf01bbcfe3631711"}' ========= master_lag: 0.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 16:09:12.887210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:09:12.887546) ========= 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=930c87414c89fc706ee2024c000001c6-1506710603.559424-2126063142 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 16:09:12.915583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:09:12.915872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 16:09:12.916153) ========= ========= Total master_lag: 0.37 =========