builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-001 starttime: 1505369970.43 results: success (0) revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.433742) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.434138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.434416) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.473860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.474118) ========= 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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 23:19:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.8M=0s 2017-09-13 23:19:30 (24.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.638332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.638607) ========= 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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.690571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:30.690906) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb717386aec8601a301babd4156aabc4cccff0b0 --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 cb717386aec8601a301babd4156aabc4cccff0b0 --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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 23:19:30,885 truncating revision to first 12 chars 2017-09-13 23:19:30,885 Setting DEBUG logging. 2017-09-13 23:19:30,886 attempt 1/10 2017-09-13 23:19:30,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb717386aec8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 23:19:31,144 unpacking tar archive at: mozilla-central-cb717386aec8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572002 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.294364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.294655) ========= script_repo_revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.295001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.295272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:19:31.361360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 23:19:31.361647) ========= /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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:19:31 INFO - MultiFileLogger online at 20170913 23:19:31 in /builds/slave/test 23:19: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 23:19:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:19:31 INFO - {'append_to_log': False, 23:19:31 INFO - 'base_work_dir': '/builds/slave/test', 23:19:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:19:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:19:31 INFO - 'branch': 'Firefox-Non-PGO', 23:19:31 INFO - 'buildbot_json_path': 'buildprops.json', 23:19:31 INFO - 'code_coverage': False, 23:19:31 INFO - 'config_files': ('talos/linux_config.py',), 23:19:31 INFO - 'default_actions': ('clobber', 23:19:31 INFO - 'read-buildbot-config', 23:19:31 INFO - 'download-and-extract', 23:19:31 INFO - 'populate-webroot', 23:19:31 INFO - 'create-virtualenv', 23:19:31 INFO - 'install', 23:19:31 INFO - 'setup-mitmproxy', 23:19:31 INFO - 'run-tests'), 23:19:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:19:31 INFO - 'disable_ccov_upload': False, 23:19:31 INFO - 'disable_stylo': False, 23:19:31 INFO - 'download_minidump_stackwalk': True, 23:19:31 INFO - 'download_symbols': 'ondemand', 23:19:31 INFO - 'enable_stylo': False, 23:19:31 INFO - 'enable_webrender': False, 23:19:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 23:19:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:19:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:19:31 INFO - 'gecko_profile': False, 23:19:31 INFO - 'gecko_profile_interval': 0, 23:19:31 INFO - 'installer_path': 'installer.exe', 23:19:31 INFO - 'log_level': 'info', 23:19:31 INFO - 'log_name': 'talos', 23:19:31 INFO - 'log_to_console': True, 23:19:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:19:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:19:31 INFO - 'opt_config_files': (), 23:19:31 INFO - 'pip_index': False, 23:19:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 23:19:31 INFO - 'system_bits': '32', 23:19:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:19:31 INFO - 'title': 'talos-linux64-ix-001', 23:19:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:19:31 INFO - 'use_talos_json': True, 23:19:31 INFO - 'verify': 'False', 23:19:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:19:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:19:31 INFO - 'work_dir': 'build'} 23:19:31 INFO - [mozharness: 2017-09-14 06:19:31.684212Z] Running clobber step. 23:19:31 INFO - Running pre-action listener: _resource_record_pre_action 23:19:31 INFO - Running main action method: clobber 23:19:31 INFO - rmtree: /builds/slave/test/build 23:19:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:19:33 INFO - Running post-action listener: _resource_record_post_action 23:19:33 INFO - [mozharness: 2017-09-14 06:19:33.228545Z] Finished clobber step (success) 23:19:33 INFO - [mozharness: 2017-09-14 06:19:33.228643Z] Running read-buildbot-config step. 23:19:33 INFO - Running pre-action listener: _resource_record_pre_action 23:19:33 INFO - Running main action method: read_buildbot_config 23:19:33 INFO - Using buildbot properties: 23:19:33 INFO - { 23:19:33 INFO - "project": "", 23:19:33 INFO - "product": "firefox", 23:19:33 INFO - "who": "jdolske@mozilla.com", 23:19:33 INFO - "installer_path": "public/build/target.tar.bz2", 23:19:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 23:19:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:19:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 23:19:33 INFO - "stage_platform": "linux64", 23:19:33 INFO - "basedir": "/builds/slave/test", 23:19:33 INFO - "buildnumber": 20, 23:19:33 INFO - "platform": "ubuntu64_hw", 23:19:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:19:33 INFO - "slavebuilddir": "test", 23:19:33 INFO - "taskId": "FOBkqiafQbma23zT47zfmQ", 23:19:33 INFO - "branch": "mozilla-central", 23:19:33 INFO - "script_repo_revision": "production", 23:19:33 INFO - "revision": "cb717386aec8601a301babd4156aabc4cccff0b0", 23:19:33 INFO - "slavename": "talos-linux64-ix-001", 23:19:33 INFO - "repo_path": "mozilla-central" 23:19:33 INFO - } 23:19:33 INFO - Finding installer, test and symbols from parent task. 23:19:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FOBkqiafQbma23zT47zfmQ'}, attempt #1 23:19:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FOBkqiafQbma23zT47zfmQ'}, attempt #1 23:19:34 INFO - Task dependencies: Zv5HYUSPS56G-8wZXuIJvw 23:19:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw'}, attempt #1 23:19:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json 23:19:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip 23:19:34 INFO - Running post-action listener: _resource_record_post_action 23:19:34 INFO - [mozharness: 2017-09-14 06:19:34.717503Z] Finished read-buildbot-config step (success) 23:19:34 INFO - [mozharness: 2017-09-14 06:19:34.717721Z] Running download-and-extract step. 23:19:34 INFO - Running pre-action listener: _resource_record_pre_action 23:19:34 INFO - Running main action method: download_and_extract 23:19:34 INFO - mkdir: /builds/slave/test/build/tests 23:19: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')]} 23:19:34 INFO - trying https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json 23:19:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:19:35 INFO - Downloaded 989 bytes. 23:19:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:19:35 INFO - Using the following test package requirements: 23:19:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:19:35 INFO - u'common': [u'target.common.tests.zip'], 23:19:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:19:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:19:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:19:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:19:35 INFO - u'mozbase': [u'target.common.tests.zip'], 23:19:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:19:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:19:35 INFO - u'web-platform': [u'target.common.tests.zip', 23:19:35 INFO - u'target.web-platform.tests.tar.gz'], 23:19:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:19:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 23:19:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip 23:19:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:19:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.common.tests.zip into memory 23:19:36 INFO - Content-Length response header: 54572613 23:19:36 INFO - Bytes received: 54572613 23:19:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip 23:19:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:19:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.talos.tests.zip into memory 23:19:48 INFO - Content-Length response header: 14500356 23:19:48 INFO - Bytes received: 14500356 23:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:48 INFO - trying https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:19:49 INFO - Downloaded 61337791 bytes. 23:19:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:49 INFO - mkdir: /builds/slave/test/properties 23:19:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:19:49 INFO - Writing to file /builds/slave/test/properties/build_url 23:19:49 INFO - Contents: 23:19:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 23:19:49 INFO - Running post-action listener: _resource_record_post_action 23:19:49 INFO - Running post-action listener: find_tests_for_verification 23:19:49 INFO - Running post-action listener: set_extra_try_arguments 23:19:49 INFO - [mozharness: 2017-09-14 06:19:49.879478Z] Finished download-and-extract step (success) 23:19:49 INFO - [mozharness: 2017-09-14 06:19:49.879587Z] Running populate-webroot step. 23:19:49 INFO - Running pre-action listener: _resource_record_pre_action 23:19:49 INFO - Running main action method: populate_webroot 23:19:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:19:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['tresize', 23:19:49 INFO - 'tcanvasmark']}, 23:19:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:19:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['dromaeo_css', 23:19:49 INFO - 'kraken']}, 23:19:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:19:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'tests': ['damp', 'tps']}, 23:19:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['damp', 'tps']}, 23:19:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:19:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['dromaeo_dom']}, 23:19:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:19:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['basic_compositor_video', 23:19:49 INFO - 'glvideo']}, 23:19:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:19:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['ts_paint_webext', 23:19:49 INFO - 'tp5o_webext']}, 23:19:49 INFO - 'other-e10s': {'tests': ['a11yr', 23:19:49 INFO - 'ts_paint', 23:19:49 INFO - 'tpaint', 23:19:49 INFO - 'sessionrestore', 23:19:49 INFO - 'sessionrestore_many_windows', 23:19:49 INFO - 'sessionrestore_no_auto_restore', 23:19:49 INFO - 'tabpaint']}, 23:19:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['a11yr', 23:19:49 INFO - 'ts_paint', 23:19:49 INFO - 'tpaint', 23:19:49 INFO - 'sessionrestore', 23:19:49 INFO - 'sessionrestore_many_windows', 23:19:49 INFO - 'sessionrestore_no_auto_restore', 23:19:49 INFO - 'tabpaint']}, 23:19:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:19:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:19:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['bloom_basic_singleton']}, 23:19:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['bloom_basic']}, 23:19:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:19:49 INFO - 'tsvgr_opacity', 23:19:49 INFO - 'tart', 23:19:49 INFO - 'tscrollx', 23:19:49 INFO - 'tsvg_static']}, 23:19:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['tsvgx', 23:19:49 INFO - 'tsvgr_opacity', 23:19:49 INFO - 'tart', 23:19:49 INFO - 'tscrollx', 23:19:49 INFO - 'tsvg_static']}, 23:19:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:19:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo'], 23:19:49 INFO - 'tests': ['tp5o']}, 23:19:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:49 INFO - 'talos_options': ['--mitmproxy', 23:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:49 INFO - '--firstNonBlankPaint'], 23:19:49 INFO - 'tests': ['tp6_google', 23:19:49 INFO - 'tp6_youtube', 23:19:49 INFO - 'tp6_amazon', 23:19:49 INFO - 'tp6_facebook']}, 23:19:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo', 23:19:49 INFO - '--mitmproxy', 23:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:49 INFO - '--firstNonBlankPaint'], 23:19:49 INFO - 'tests': ['tp6_google', 23:19:49 INFO - 'tp6_youtube', 23:19:49 INFO - 'tp6_amazon', 23:19:49 INFO - 'tp6_facebook']}, 23:19:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:19:49 INFO - 'talos_options': ['--stylo-threads=1', 23:19:49 INFO - '--mitmproxy', 23:19:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:19:49 INFO - '--firstNonBlankPaint'], 23:19:49 INFO - 'tests': ['tp6_google', 23:19:49 INFO - 'tp6_youtube', 23:19:49 INFO - 'tp6_amazon', 23:19:49 INFO - 'tp6_facebook']}, 23:19:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--xperf_path', 23:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:49 INFO - 'tests': ['tp5n']}, 23:19:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:19:49 INFO - 'talos_options': ['--disable-stylo', 23:19:49 INFO - '--xperf_path', 23:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:19:49 INFO - 'tests': ['tp5n']}}} 23:19:49 INFO - Running post-action listener: _resource_record_post_action 23:19:49 INFO - [mozharness: 2017-09-14 06:19:49.896316Z] Finished populate-webroot step (success) 23:19:49 INFO - [mozharness: 2017-09-14 06:19:49.896424Z] Running create-virtualenv step. 23:19:49 INFO - Running pre-action listener: _resource_record_pre_action 23:19:49 INFO - Running main action method: create_virtualenv 23:19:49 INFO - Creating virtualenv /builds/slave/test/build/venv 23:19:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:19:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 23:19:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:19:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:19:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:19:51 INFO - Installing distribute.............................................................................................................................................................................................done. 23:19:51 INFO - Installing pip...............done. 23:19:51 INFO - Return code: 0 23:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:19:52 INFO - Reading from file tmpfile_stdout 23:19:52 INFO - Output received: 23:19:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 23:19:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:52 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:19:52 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 23:19:52 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 23:19:52 INFO - Using env: {'DISPLAY': ':0', 23:19:52 INFO - 'HOME': '/home/cltbld', 23:19:52 INFO - 'LANG': 'en_US.UTF-8', 23:19:52 INFO - 'LANGUAGE': 'en_US:en', 23:19:52 INFO - 'LOGNAME': 'cltbld', 23:19:52 INFO - 'MAIL': '/var/mail/cltbld', 23:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:52 INFO - 'MOZ_NO_REMOTE': '1', 23:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:52 INFO - 'NO_EM_RESTART': '1', 23:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:52 INFO - 'PWD': '/builds/slave/test', 23:19:52 INFO - 'SHELL': '/bin/bash', 23:19:52 INFO - 'SHLVL': '1', 23:19:52 INFO - 'TERM': 'linux', 23:19:52 INFO - 'TMOUT': '86400', 23:19:52 INFO - 'USER': 'cltbld', 23:19:52 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:52 INFO - '_': '/tools/buildbot/bin/python'} 23:19:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:19:53 INFO - Downloading/unpacking pip>=1.5 23:19:53 INFO - Running setup.py egg_info for package pip 23:19:53 INFO - warning: no files found matching 'pip/cacert.pem' 23:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 23:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:19:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:19:53 INFO - Installing collected packages: pip 23:19:53 INFO - Found existing installation: pip 1.1 23:19:53 INFO - Uninstalling pip: 23:19:53 INFO - Successfully uninstalled pip 23:19:53 INFO - Running setup.py install for pip 23:19:53 INFO - warning: no files found matching 'pip/cacert.pem' 23:19:53 INFO - warning: no files found matching '*.html' under directory 'docs' 23:19:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:19:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:19:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 23:19:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 23:19:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 23:19:53 INFO - Successfully installed pip 23:19:53 INFO - Cleaning up... 23:19:53 INFO - Return code: 0 23:19:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:19: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')]} 23:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19: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')]} 23:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19: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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:19: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 23:19: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 23:19:53 INFO - Using env: {'DISPLAY': ':0', 23:19:53 INFO - 'HOME': '/home/cltbld', 23:19:53 INFO - 'LANG': 'en_US.UTF-8', 23:19:53 INFO - 'LANGUAGE': 'en_US:en', 23:19:53 INFO - 'LOGNAME': 'cltbld', 23:19:53 INFO - 'MAIL': '/var/mail/cltbld', 23:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:53 INFO - 'MOZ_NO_REMOTE': '1', 23:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:53 INFO - 'NO_EM_RESTART': '1', 23:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:53 INFO - 'PWD': '/builds/slave/test', 23:19:53 INFO - 'SHELL': '/bin/bash', 23:19:53 INFO - 'SHLVL': '1', 23:19:53 INFO - 'TERM': 'linux', 23:19:53 INFO - 'TMOUT': '86400', 23:19:53 INFO - 'USER': 'cltbld', 23:19:53 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:53 INFO - '_': '/tools/buildbot/bin/python'} 23:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:53 INFO - Downloading/unpacking psutil>=3.1.1 23:19: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 23:19: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 23:19: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 23:19: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 23:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:19:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:58 INFO - Installing collected packages: psutil 23:19:58 INFO - Running setup.py install for psutil 23:19:58 INFO - building 'psutil._psutil_linux' extension 23:19:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:19:58 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 23:19:58 INFO - building 'psutil._psutil_posix' extension 23:19:58 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 23:19:58 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 23:19:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:19:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:19:59 INFO - Successfully installed psutil 23:19:59 INFO - Cleaning up... 23:19:59 INFO - Return code: 0 23:19:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:19:59 INFO - Using env: {'DISPLAY': ':0', 23:19:59 INFO - 'HOME': '/home/cltbld', 23:19:59 INFO - 'LANG': 'en_US.UTF-8', 23:19:59 INFO - 'LANGUAGE': 'en_US:en', 23:19:59 INFO - 'LOGNAME': 'cltbld', 23:19:59 INFO - 'MAIL': '/var/mail/cltbld', 23:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:19:59 INFO - 'MOZ_NO_REMOTE': '1', 23:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:19:59 INFO - 'NO_EM_RESTART': '1', 23:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:19:59 INFO - 'PWD': '/builds/slave/test', 23:19:59 INFO - 'SHELL': '/bin/bash', 23:19:59 INFO - 'SHLVL': '1', 23:19:59 INFO - 'TERM': 'linux', 23:19:59 INFO - 'TMOUT': '86400', 23:19:59 INFO - 'USER': 'cltbld', 23:19:59 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:19:59 INFO - '_': '/tools/buildbot/bin/python'} 23:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:19:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:19: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 23:19: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 23:19: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 23:19: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 23:20:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:20:00 INFO - Installing collected packages: mozsystemmonitor 23:20:00 INFO - Running setup.py install for mozsystemmonitor 23:20:00 INFO - Successfully installed mozsystemmonitor 23:20:00 INFO - Cleaning up... 23:20:00 INFO - Return code: 0 23:20:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:20: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')]} 23:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20: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')]} 23:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20: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', '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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:20: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 jsonschema==2.5.1 23:20:00 INFO - Using env: {'DISPLAY': ':0', 23:20:00 INFO - 'HOME': '/home/cltbld', 23:20:00 INFO - 'LANG': 'en_US.UTF-8', 23:20:00 INFO - 'LANGUAGE': 'en_US:en', 23:20:00 INFO - 'LOGNAME': 'cltbld', 23:20:00 INFO - 'MAIL': '/var/mail/cltbld', 23:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:00 INFO - 'MOZ_NO_REMOTE': '1', 23:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:00 INFO - 'NO_EM_RESTART': '1', 23:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:00 INFO - 'PWD': '/builds/slave/test', 23:20:00 INFO - 'SHELL': '/bin/bash', 23:20:00 INFO - 'SHLVL': '1', 23:20:00 INFO - 'TERM': 'linux', 23:20:00 INFO - 'TMOUT': '86400', 23:20:00 INFO - 'USER': 'cltbld', 23:20:00 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:00 INFO - '_': '/tools/buildbot/bin/python'} 23:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:00 INFO - Downloading/unpacking jsonschema==2.5.1 23:20: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 23:20: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 23:20: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 23:20: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 23:20:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:20:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:20: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 23:20: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 23:20: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 23:20: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 23:20:02 INFO - Downloading functools32-3.2.3-2.tar.gz 23:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:20:02 INFO - warning: no files found matching '*.txt' 23:20:02 INFO - no previously-included directories found matching 'build' 23:20:02 INFO - no previously-included directories found matching 'dist' 23:20:02 INFO - no previously-included directories found matching '.git*' 23:20:02 INFO - Installing collected packages: jsonschema, functools32 23:20:02 INFO - Running setup.py install for functools32 23:20:02 INFO - warning: no files found matching '*.txt' 23:20:02 INFO - no previously-included directories found matching 'build' 23:20:02 INFO - no previously-included directories found matching 'dist' 23:20:02 INFO - no previously-included directories found matching '.git*' 23:20:02 INFO - Successfully installed jsonschema functools32 23:20:02 INFO - Cleaning up... 23:20:02 INFO - Return code: 0 23:20:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:20:02 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')]} 23:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:02 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')]} 23:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:02 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:02 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 23:20:02 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 23:20:02 INFO - Using env: {'DISPLAY': ':0', 23:20:02 INFO - 'HOME': '/home/cltbld', 23:20:02 INFO - 'LANG': 'en_US.UTF-8', 23:20:02 INFO - 'LANGUAGE': 'en_US:en', 23:20:02 INFO - 'LOGNAME': 'cltbld', 23:20:02 INFO - 'MAIL': '/var/mail/cltbld', 23:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:02 INFO - 'MOZ_NO_REMOTE': '1', 23:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:02 INFO - 'NO_EM_RESTART': '1', 23:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:02 INFO - 'PWD': '/builds/slave/test', 23:20:02 INFO - 'SHELL': '/bin/bash', 23:20:02 INFO - 'SHLVL': '1', 23:20:02 INFO - 'TERM': 'linux', 23:20:02 INFO - 'TMOUT': '86400', 23:20:02 INFO - 'USER': 'cltbld', 23:20:02 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:02 INFO - '_': '/tools/buildbot/bin/python'} 23:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:20:02 INFO - Cleaning up... 23:20:02 INFO - Return code: 0 23:20:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:20:02 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')]} 23:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:02 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')]} 23:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:02 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:02 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 23:20:02 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 23:20:02 INFO - Using env: {'DISPLAY': ':0', 23:20:02 INFO - 'HOME': '/home/cltbld', 23:20:02 INFO - 'LANG': 'en_US.UTF-8', 23:20:02 INFO - 'LANGUAGE': 'en_US:en', 23:20:02 INFO - 'LOGNAME': 'cltbld', 23:20:02 INFO - 'MAIL': '/var/mail/cltbld', 23:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:02 INFO - 'MOZ_NO_REMOTE': '1', 23:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:02 INFO - 'NO_EM_RESTART': '1', 23:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:02 INFO - 'PWD': '/builds/slave/test', 23:20:02 INFO - 'SHELL': '/bin/bash', 23:20:02 INFO - 'SHLVL': '1', 23:20:02 INFO - 'TERM': 'linux', 23:20:02 INFO - 'TMOUT': '86400', 23:20:02 INFO - 'USER': 'cltbld', 23:20:02 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:02 INFO - '_': '/tools/buildbot/bin/python'} 23:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:02 INFO - Downloading/unpacking blobuploader==1.2.4 23:20: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 23:20: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 23:20: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 23:20: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 23:20:03 INFO - Downloading blobuploader-1.2.4.tar.gz 23:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:20:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:20:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:04 INFO - Downloading docopt-0.6.1.tar.gz 23:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:20:04 INFO - Installing collected packages: blobuploader, requests, docopt 23:20:04 INFO - Running setup.py install for blobuploader 23:20:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:20:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:20:04 INFO - Running setup.py install for requests 23:20:04 INFO - Running setup.py install for docopt 23:20:04 INFO - Successfully installed blobuploader requests docopt 23:20:04 INFO - Cleaning up... 23:20:05 INFO - Return code: 0 23:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:05 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')]} 23:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:05 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')]} 23:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:05 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:05 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 23:20:05 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 23:20:05 INFO - Using env: {'DISPLAY': ':0', 23:20:05 INFO - 'HOME': '/home/cltbld', 23:20:05 INFO - 'LANG': 'en_US.UTF-8', 23:20:05 INFO - 'LANGUAGE': 'en_US:en', 23:20:05 INFO - 'LOGNAME': 'cltbld', 23:20:05 INFO - 'MAIL': '/var/mail/cltbld', 23:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:05 INFO - 'MOZ_NO_REMOTE': '1', 23:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:05 INFO - 'NO_EM_RESTART': '1', 23:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:05 INFO - 'PWD': '/builds/slave/test', 23:20:05 INFO - 'SHELL': '/bin/bash', 23:20:05 INFO - 'SHLVL': '1', 23:20:05 INFO - 'TERM': 'linux', 23:20:05 INFO - 'TMOUT': '86400', 23:20:05 INFO - 'USER': 'cltbld', 23:20:05 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:05 INFO - '_': '/tools/buildbot/bin/python'} 23:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:05 INFO - Running setup.py (path:/tmp/pip-RUzTuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:05 INFO - Running setup.py (path:/tmp/pip-UskHen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:05 INFO - Running setup.py (path:/tmp/pip-Bgjd61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:05 INFO - Running setup.py (path:/tmp/pip-jfXRpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:05 INFO - Running setup.py (path:/tmp/pip-xbW5Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:05 INFO - Running setup.py (path:/tmp/pip-2XGM5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:05 INFO - Running setup.py (path:/tmp/pip-zeljNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:05 INFO - Running setup.py (path:/tmp/pip-YjDxxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:05 INFO - Running setup.py (path:/tmp/pip-FQj0fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:05 INFO - Running setup.py (path:/tmp/pip-_JkfP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:05 INFO - Running setup.py (path:/tmp/pip-UTApaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:06 INFO - Running setup.py (path:/tmp/pip-ltrmZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:06 INFO - Running setup.py (path:/tmp/pip-o6m71C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:06 INFO - Running setup.py (path:/tmp/pip-bUdW4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:06 INFO - Running setup.py (path:/tmp/pip-5u7yBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:06 INFO - Running setup.py (path:/tmp/pip-9lizru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:06 INFO - Running setup.py (path:/tmp/pip-cJnSic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:20:06 INFO - Running setup.py install for manifestparser 23:20:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:20:06 INFO - Running setup.py install for mozcrash 23:20:06 INFO - Running setup.py install for mozdebug 23:20:06 INFO - Running setup.py install for mozdevice 23:20:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:20:06 INFO - Running setup.py install for mozfile 23:20:06 INFO - Running setup.py install for mozhttpd 23:20:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozinfo 23:20:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozInstall 23:20:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozleak 23:20:07 INFO - Running setup.py install for mozlog 23:20:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for moznetwork 23:20:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozprocess 23:20:07 INFO - Running setup.py install for mozprofile 23:20:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozrunner 23:20:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:20:07 INFO - Running setup.py install for mozscreenshot 23:20:08 INFO - Running setup.py install for moztest 23:20:08 INFO - Running setup.py install for mozversion 23:20:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:20:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:20:08 INFO - Cleaning up... 23:20:08 INFO - Return code: 0 23:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:08 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')]} 23:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:08 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')]} 23:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:08 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:08 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 23:20:08 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 23:20:08 INFO - Using env: {'DISPLAY': ':0', 23:20:08 INFO - 'HOME': '/home/cltbld', 23:20:08 INFO - 'LANG': 'en_US.UTF-8', 23:20:08 INFO - 'LANGUAGE': 'en_US:en', 23:20:08 INFO - 'LOGNAME': 'cltbld', 23:20:08 INFO - 'MAIL': '/var/mail/cltbld', 23:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:08 INFO - 'MOZ_NO_REMOTE': '1', 23:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:08 INFO - 'NO_EM_RESTART': '1', 23:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:08 INFO - 'PWD': '/builds/slave/test', 23:20:08 INFO - 'SHELL': '/bin/bash', 23:20:08 INFO - 'SHLVL': '1', 23:20:08 INFO - 'TERM': 'linux', 23:20:08 INFO - 'TMOUT': '86400', 23:20:08 INFO - 'USER': 'cltbld', 23:20:08 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:08 INFO - '_': '/tools/buildbot/bin/python'} 23:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:20:08 INFO - Running setup.py (path:/tmp/pip-l371cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:20:08 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)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:20:08 INFO - Running setup.py (path:/tmp/pip-oxREuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:20:08 INFO - Running setup.py (path:/tmp/pip-nMRbuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:20:08 INFO - Running setup.py (path:/tmp/pip-ls7Wyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:20:08 INFO - Running setup.py (path:/tmp/pip-ZkmZsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:20:08 INFO - Running setup.py (path:/tmp/pip-rZ1iEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:20:08 INFO - Running setup.py (path:/tmp/pip-WoQRR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:20:08 INFO - Running setup.py (path:/tmp/pip-F_3kT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:20:09 INFO - Running setup.py (path:/tmp/pip-0M9aKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:20:09 INFO - Running setup.py (path:/tmp/pip-7x8TxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:20:09 INFO - Running setup.py (path:/tmp/pip-LMMFaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:20:09 INFO - Running setup.py (path:/tmp/pip-MYIILs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:20:09 INFO - Running setup.py (path:/tmp/pip-Oue01y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:20:09 INFO - Running setup.py (path:/tmp/pip-SlXBWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:09 INFO - Running setup.py (path:/tmp/pip-Ryxx6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:20:09 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)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:20:09 INFO - Running setup.py (path:/tmp/pip-fiscRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:20:09 INFO - Running setup.py (path:/tmp/pip-TZhwy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:20:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:20: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 23:20: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 23:20: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 23:20: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 23:20:10 INFO - Downloading blessings-1.6.tar.gz 23:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:20:10 INFO - Installing collected packages: blessings 23:20:10 INFO - Running setup.py install for blessings 23:20:10 INFO - Successfully installed blessings 23:20:10 INFO - Cleaning up... 23:20:10 INFO - Return code: 0 23:20:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:11 INFO - Reading from file tmpfile_stdout 23:20:11 INFO - Current package versions: 23:20:11 INFO - argparse == 1.2.1 23:20:11 INFO - blessings == 1.6 23:20:11 INFO - blobuploader == 1.2.4 23:20:11 INFO - docopt == 0.6.1 23:20:11 INFO - functools32 == 3.2.3-2 23:20:11 INFO - jsonschema == 2.5.1 23:20:11 INFO - manifestparser == 1.1 23:20:11 INFO - mozInstall == 1.13 23:20:11 INFO - mozcrash == 1.0 23:20:11 INFO - mozdebug == 0.1 23:20:11 INFO - mozdevice == 0.51 23:20:11 INFO - mozfile == 1.2 23:20:11 INFO - mozhttpd == 0.7 23:20:11 INFO - mozinfo == 0.10 23:20:11 INFO - mozleak == 0.1 23:20:11 INFO - mozlog == 3.5 23:20:11 INFO - moznetwork == 0.27 23:20:11 INFO - mozprocess == 0.25 23:20:11 INFO - mozprofile == 0.28 23:20:11 INFO - mozrunner == 6.13 23:20:11 INFO - mozscreenshot == 0.1 23:20:11 INFO - mozsystemmonitor == 0.3 23:20:11 INFO - moztest == 0.8 23:20:11 INFO - mozversion == 1.4 23:20:11 INFO - psutil == 3.1.1 23:20:11 INFO - requests == 1.2.3 23:20:11 INFO - wsgiref == 0.1.2 23:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:20:11 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')]} 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:11 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')]} 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:11 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 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:11 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 23:20:11 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 23:20:11 INFO - Using env: {'DISPLAY': ':0', 23:20:11 INFO - 'HOME': '/home/cltbld', 23:20:11 INFO - 'LANG': 'en_US.UTF-8', 23:20:11 INFO - 'LANGUAGE': 'en_US:en', 23:20:11 INFO - 'LOGNAME': 'cltbld', 23:20:11 INFO - 'MAIL': '/var/mail/cltbld', 23:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:11 INFO - 'MOZ_NO_REMOTE': '1', 23:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:11 INFO - 'NO_EM_RESTART': '1', 23:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:11 INFO - 'PWD': '/builds/slave/test', 23:20:11 INFO - 'SHELL': '/bin/bash', 23:20:11 INFO - 'SHLVL': '1', 23:20:11 INFO - 'TERM': 'linux', 23:20:11 INFO - 'TMOUT': '86400', 23:20:11 INFO - 'USER': 'cltbld', 23:20:11 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:11 INFO - '_': '/tools/buildbot/bin/python'} 23:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 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)) 23:20:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:20:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:20:12 INFO - Installing collected packages: simplejson 23:20:12 INFO - Running setup.py install for simplejson 23:20:12 INFO - building 'simplejson._speedups' extension 23:20:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 23:20:13 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 23:20:13 INFO - Successfully installed simplejson 23:20:13 INFO - Cleaning up... 23:20:13 INFO - Return code: 0 23:20:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:20:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x157b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1744a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, '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': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', '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 23:20:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:20:13 INFO - Using env: {'DISPLAY': ':0', 23:20:13 INFO - 'HOME': '/home/cltbld', 23:20:13 INFO - 'LANG': 'en_US.UTF-8', 23:20:13 INFO - 'LANGUAGE': 'en_US:en', 23:20:13 INFO - 'LOGNAME': 'cltbld', 23:20:13 INFO - 'MAIL': '/var/mail/cltbld', 23:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:13 INFO - 'MOZ_NO_REMOTE': '1', 23:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:13 INFO - 'NO_EM_RESTART': '1', 23:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:13 INFO - 'PWD': '/builds/slave/test', 23:20:13 INFO - 'SHELL': '/bin/bash', 23:20:13 INFO - 'SHLVL': '1', 23:20:13 INFO - 'TERM': 'linux', 23:20:13 INFO - 'TMOUT': '86400', 23:20:13 INFO - 'USER': 'cltbld', 23:20:13 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:13 INFO - '_': '/tools/buildbot/bin/python'} 23:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:20:13 INFO - Cleaning up... 23:20:13 INFO - Return code: 0 23:20:13 INFO - Running post-action listener: _resource_record_post_action 23:20:13 INFO - Running post-action listener: _start_resource_monitoring 23:20:13 INFO - Starting resource monitoring. 23:20:13 INFO - [mozharness: 2017-09-14 06:20:13.901759Z] Finished create-virtualenv step (success) 23:20:13 INFO - [mozharness: 2017-09-14 06:20:13.902272Z] Running install step. 23:20:13 INFO - Running pre-action listener: _resource_record_pre_action 23:20:13 INFO - Running main action method: install 23:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:20:14 INFO - Reading from file tmpfile_stdout 23:20:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:20:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:20:14 INFO - Reading from file tmpfile_stdout 23:20:14 INFO - Output received: 23:20:14 INFO - Usage: mozinstall [options] installer 23:20:14 INFO - Options: 23:20:14 INFO - -h, --help show this help message and exit 23:20:14 INFO - -d DEST, --destination=DEST 23:20:14 INFO - Directory to install application into. [default: 23:20:14 INFO - "/builds/slave/test"] 23:20:14 INFO - --app=APP Application being installed. [default: firefox] 23:20:14 INFO - mkdir: /builds/slave/test/build/application 23:20:14 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'] 23:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:20:32 INFO - Reading from file tmpfile_stdout 23:20:32 INFO - Output received: 23:20:32 INFO - /builds/slave/test/build/application/firefox/firefox 23:20:32 INFO - Running post-action listener: _resource_record_post_action 23:20:32 INFO - [mozharness: 2017-09-14 06:20:32.231368Z] Finished install step (success) 23:20:32 INFO - [mozharness: 2017-09-14 06:20:32.231476Z] Running setup-mitmproxy step. 23:20:32 INFO - Running pre-action listener: _resource_record_pre_action 23:20:32 INFO - Running main action method: setup_mitmproxy 23:20:32 INFO - Skipping: mitmproxy is not required 23:20:32 INFO - Running post-action listener: _resource_record_post_action 23:20:32 INFO - [mozharness: 2017-09-14 06:20:32.232375Z] Finished setup-mitmproxy step (success) 23:20:32 INFO - [mozharness: 2017-09-14 06:20:32.232595Z] Running run-tests step. 23:20:32 INFO - Running pre-action listener: _resource_record_pre_action 23:20:32 INFO - Running pre-action listener: _set_gcov_prefix 23:20:32 INFO - Running main action method: run_tests 23:20:32 WARNING - Try message not found. 23:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:20:32 INFO - Python 2.7.3 23:20:32 INFO - Return code: 0 23:20:32 INFO - grabbing minidump binary from tooltool 23:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:20:32 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 0x18eb090>, '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 0x18ebd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:20:32 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 23:20:32 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 23:20:32 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 23:20:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:20:32 INFO - Return code: 0 23:20:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:20:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:20:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:20:32 INFO - ENV: RUST_BACKTRACE is now full 23:20:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:20:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:20:32 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/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 23:20:32 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/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 23:20:32 INFO - Using env: {'DISPLAY': ':0', 23:20:32 INFO - 'HOME': '/home/cltbld', 23:20:32 INFO - 'LANG': 'en_US.UTF-8', 23:20:32 INFO - 'LANGUAGE': 'en_US:en', 23:20:32 INFO - 'LOGNAME': 'cltbld', 23:20:32 INFO - 'MAIL': '/var/mail/cltbld', 23:20:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:32 INFO - 'MOZ_NO_REMOTE': '1', 23:20:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:32 INFO - 'NO_EM_RESTART': '1', 23:20:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:32 INFO - 'PWD': '/builds/slave/test', 23:20:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:32 INFO - 'RUST_BACKTRACE': 'full', 23:20:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:20:32 INFO - 'SHELL': '/bin/bash', 23:20:32 INFO - 'SHLVL': '1', 23:20:32 INFO - 'TERM': 'linux', 23:20:32 INFO - 'TMOUT': '86400', 23:20:32 INFO - 'USER': 'cltbld', 23:20:32 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:32 INFO - '_': '/tools/buildbot/bin/python'} 23:20:32 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/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 23:20:32 INFO - mozversion application_buildid: 20170914052917 23:20:32 INFO - mozversion application_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:20:32 INFO - mozversion application_display_name: Nightly 23:20:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:20:32 INFO - mozversion application_name: Firefox 23:20:32 INFO - mozversion application_remotingname: firefox 23:20:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:20:32 INFO - mozversion application_vendor: Mozilla 23:20:32 INFO - mozversion application_version: 57.0a1 23:20:32 INFO - mozversion platform_buildid: 20170914052917 23:20:32 INFO - mozversion platform_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:20:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:20:32 INFO - mozversion platform_version: 57.0a1 23:20:32 INFO - using testdate: 1505370032 23:20:32 INFO - actual date: 1505370032 23:20:32 INFO - starting webserver on 'localhost:44719' 23:20:32 INFO - SUITE-START | Running 2 tests 23:20:32 INFO - TEST-START | dromaeo_css 23:20:32 INFO - Initialising browser for dromaeo_css test... 23:20:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44719/getInfo.html -profile /tmp/tmp3n4e3i/profile 23:20:32 INFO - TEST-INFO | started process 11044 (/builds/slave/test/build/application/firefox/firefox http://localhost:44719/getInfo.html) 23:20:37 INFO - TEST-INFO | 11044: exit 0 23:20:37 INFO - Browser initialized. 23:20:37 INFO - Running cycle 1/1 for dromaeo_css test... 23:20:37 INFO - Using env: {'DISPLAY': ':0', 23:20:37 INFO - 'HOME': '/home/cltbld', 23:20:37 INFO - 'JSGC_DISABLE_POISONING': '1', 23:20:37 INFO - 'LANG': 'en_US.UTF-8', 23:20:37 INFO - 'LANGUAGE': 'en_US:en', 23:20:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:20:37 INFO - 'LOGNAME': 'cltbld', 23:20:37 INFO - 'MAIL': '/var/mail/cltbld', 23:20:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:20:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:20:37 INFO - 'MOZ_CRASHREPORTER': '1', 23:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:20:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:20:37 INFO - 'MOZ_NO_REMOTE': '1', 23:20:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:20:37 INFO - 'NO_EM_RESTART': '1', 23:20:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:20:37 INFO - 'PWD': '/builds/slave/test', 23:20:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:20:37 INFO - 'RUST_BACKTRACE': 'full', 23:20:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:20:37 INFO - 'SHELL': '/bin/bash', 23:20:37 INFO - 'SHLVL': '1', 23:20:37 INFO - 'STYLO_FORCE_DISABLED': '1', 23:20:37 INFO - 'TERM': 'linux', 23:20:37 INFO - 'TMOUT': '86400', 23:20:37 INFO - 'USER': 'cltbld', 23:20:37 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:20:37 INFO - '_': '/tools/buildbot/bin/python'} 23:20:37 INFO - TEST-INFO | started process 11274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3n4e3i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:38 INFO - PID 11274 | 23:20:38 INFO - PID 11274 | (/builds/slave/test/build/application/firefox/firefox:11323): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:20:38 INFO - PID 11274 | 23:20:49 INFO - PID 11274 | RSS: Main: 173760512 23:20:49 INFO - PID 11274 | 23:23:46 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44719/tests/dromaeo/cssquery-ext.html) 23:23:47 INFO - PID 11274 | RSS: Main: 175300608 23:23:47 INFO - PID 11274 | 23:26:49 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-ext.html (next: http://localhost:44719/tests/dromaeo/cssquery-jquery.html) 23:26:50 INFO - PID 11274 | RSS: Main: 172384256 23:26:50 INFO - PID 11274 | 23:29:51 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44719/tests/dromaeo/cssquery-mootools.html) 23:29:52 INFO - PID 11274 | RSS: Main: 175624192 23:29:52 INFO - PID 11274 | 23:32:54 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44719/tests/dromaeo/cssquery-prototype.html) 23:32:54 INFO - PID 11274 | RSS: Main: 173117440 23:32:54 INFO - PID 11274 | 23:35:58 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44719/tests/dromaeo/cssquery-yui.html) 23:35:58 INFO - PID 11274 | RSS: Main: 174874624 23:35:58 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | Cycle 1(1): loaded http://localhost:44719/tests/dromaeo/cssquery-yui.html (next: http://localhost:44719/tests/dromaeo/cssquery-dojo.html) 23:39:00 INFO - PID 11274 | RSS: Main: 177975296 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | __start_tp_report 23:39:00 INFO - PID 11274 | _x_x_mozilla_page_load 23:39:00 INFO - PID 11274 | _x_x_mozilla_page_load_details 23:39:00 INFO - PID 11274 | |i|pagename|runs| 23:39:00 INFO - PID 11274 | |0;dojo.html;3160.273137178449;3166.414213370527;3186.2671585535327;3186.4105140548986;3188.9840550797244;6203.782867599635;6225.968870155642;6317.968410157949;6343.968280158599;6406.615603063819;6282.963311053671;6287.15123458333;6295.43341099301;6331.905021424683;6343.365663433666;5697.202391665171;5816.941830581683;5820.854478638025;5835.795747148862;5897.675627840467;1272.0655394955318;5745.080787074069;5852.122181672762;5920.792772252972;5926.407359264061;5395.568354531648;5746.252987111669;5788.565857560658;5864.35492095867;5866.061430171195;5794.768209271666;5798.246227990334;5858.882822343572;5874.530037596982;5883.029300165467;5756.7121643917635;5761.539076873882;5834.620749651259;5845.357010728816;5851.356350801409;6269;6361.427471527585;6382.904256436157;6414.358564143595;6444.742210311582;6588.604683718992;6722.93277067228;6744.190697116377;6770.458363330922;6876.1748590169;6888.173419189679;6896.034555162281;6899.931000689979;6900.654967251618;6901.447884169304;6116.571839971204;6224.470919971853;6302.87394252117;6394.840128996766;6401.455876250524;6791.185057793096;6998.7900362988175;7007.614581197981;7009.369156775914;7010.298970102949;6669.1330127083165;6681.699323530453;6740.831479213059;6752.291009443938;6762.830929226809;6555.573887697285;6709.865802683919;6737.056812046318;6790.558613690095;6890.93109068913;6786.76246331376;6797.2523022467485;6808.38724514796;6809.795706128824;6813.591184528944;6776.69504872282;6856.794296171123;6858.279880612564;6876.17485901695;6886.655667216719;5239.18792587142;5335.226392173191;5382.596305277119;5383.031054410166;5394.1099718546;4561.863144105616;4592.724436533818;4610.446746390455;4656.068786242765;4668.743219122913;5839.649621022752;5842.269716285465;5877.794277200277;5878.353381128072;5883.441073098049;6797.286284940109;6804.387605115563;6805.2173999989645;6816.659167041727;6885.208201056842;5701.973644743903;5753.741081651336;5781.971090144522;5841.386654401226;5841.94158058414;5790.305163380337;5792.623479473821;5792.94207057924;5803.390643982406;5804.738786754606;6514.1531600891585;6514.348565143448;6516.837079072966;6518.087467754518;6637.435817955527;6808.353206445379;6823.658817059227;6873.140857392826;6905.654717264017;6938.444924406136;6535.248446428532;6578.605283682803;6606;6620.040094186413;6665.200175978914;6478.708458119301;6570.737170513126;6656.167979002625;6681.432078273207;6777.1189745332795;6893.20728116273;6900.03399524077;6939.097917270722;6940.618265995418;6957.373836354753;6591.439727623014;6596.0435736816935;6678.966605166943;6690.966545167243;6700.93299067003;6305;6588.8023359299295;6592.143021407186;6676.499262555425;6690.330966903271;6478.578892371981;6485.383888530582;6486.740530378732;6488.837779055561;6490.707918143789;6589.934100658932;6664.000399939854;6683.899741503784;6734.023566582916;6788.287229840796;6329.145565348619;6428.614283143026;6455.741770329134;6536.379043990813;6543.770968016097 23:39:00 INFO - PID 11274 | |1;ext.html;825.1500954017357;866.0603245478655;890.9866352004717;893.004300205271;894.3471265975837;39146.41280380789;39730.60269397305;39901.60098399015;41402.17195656085;41749.37375939363;42253.78873105638;42704.35943460851;42718.35922461165;42739.14521709572;42892.57107428925;7779.727709530153;7926.841463170733;7949.523028618272;7955.72154974576;7990.400719945998;7803;7943.721969731032;7961.562114083723;7969.641366138509;7979.7606071817645;7913.881291780628;7960.363170946311;7962.800929976739;8004.279614834663;8011.639476223584;7929.088154862207;7930.9603451982375;7954.244346787046;7962.442629016;7964.920350796505;7708.190639982777;7779.144294127642;7788.454808163431;7791.6883324667515;7793.688252469894;37999;38247;38297.425538616946;38374.424383634265;38382.80808595939;3521.3485505181366;3547.2728090741334;3556.146524834047;3556.7332450066347;3557.875474358411;31213.8439307802;31249;31301.37397252065;31335.21661958469;31340.529892051636;5031.949680503185;5167.48325167484;5244.763985620656;5245.763940622681;5260.395054568697;182816;183616;184025;184429;184570;46535.534644653795;46568.76715616468;46616.30075548869;46672.53327466682;48507.757461212466;51864.74067629638;52060;52105.310522053194;52112.739436302574;52127.73936130295;16417.58956026109;16546.503604891874;16567.834321656872;16585.336586536643;16874.74687879683;13572.728545429036;13632.659183520293;13635.863641363658;13701.177929324273;13701.657458563615;14581.125132491872;14666.779998300033;14715.190664513555;14818.703625927421;14960.47638332675;5683.261176047087;5757.222774925332;5761.711914404263;5808.361080281165;5952.494038006731;991.5141580625442;1001.7095042437611;1002.8746406699163;1015.9883430806896;1017.9796404071877;22945.31164065081;23089.422764431023;23182.840857957035;23440.413989650053;23780.405489862547;1099.7085772270354;1108.4070022538065;1113.6325012745774;1114.9275297105662;1134.8127558952845;12441.813372799415;12548.121631485708;12564;12672.49310027607;12729.10896237273;234171;236922;238269;246096;253730;56854.43145568491;57063.714681426325;57138.714306429036;57321.42678573161;57331.14003289954;1441.7332793433247;1470.624990627383;1477.1801650084305;1478.1648368671665;1483.3250870853735;26449.603255951562;27320.863395682893;27493.17520474389;27615.86192069027;27793.861030694716;36952;37746;37898.62101378951;37957.62042379541;38183.618163818006;209355;209381;209605;209787;210253;34515;34578.48132278068;34676;34685.306293874484;34858.12854678552;43568.34647480227;43768.78115609529;43801.34297985597;43907.34138987982;44122.558774411846;30237.697623023487;30298.69701303047;30363.696363036972;30377.544336835406;30652.693473064985;30446.84776576103;30699.2325191872;30971.69028309778;31006;31144.688553115084;35372.11569710778;35611.28777424385;35612.28775424529;35727.64272357243;35978.82010590035;30078.54882176813;30261.697383026767;30513;30568.700291705813;31022.379552408373;23010.07959681594;23267.534649307257;23493.647595285744;23842.64236036426;23974.640380394656 23:39:00 INFO - PID 11274 | |2;jquery.html;558.8993981083404;573.6070791507815;573.9311282646086;574.910888812234;610.5787006965195;22163.77836221639;22830;22853;22878;22979.851007449623;22311.888440557774;22577.435564110907;23152.536949261004;24383;24701.629475557882;6372.553921225504;6488.3187265337165;6517.902231466532;6520.804375868732;6526.216853977529;6222.782202622909;6405;6481.31946145655;6490;6494.31809659986;6472.2880483147055;6478.093066970628;6481.837954051163;6484.805455836309;6494.123293355384;6467.029945508164;6471.870562588721;6475;6479.449246814026;6484.059811327378;5833.562482813763;5974.97012514939;6042.9395706042815;6046.576739628228;6061.060535616986;28370.858145709346;28959.71040289591;28969.85515072411;28971.71028289711;28995.42009159805;1967.744193254882;1994.8603597748163;1999.5201151723627;2001.5196352875205;2001.629698505781;18598.62802743951;18960.5259868503;19262.71105933412;19290.614187716306;19354.129064192144;2420.5279970405777;2457.2259738182593;2468.740782217877;2475.121331927158;2482.714487833904;125121;130583;130810;132270;137213.3139334307;14328.224075091159;14412.752912323727;14588;14643.853561464462;15086.849131508545;21932.89033554822;22215.555688886456;22229;22236;22400.215992440186;9827.705168844946;9891.851622225673;9937.155341795884;9941.80116397668;9979.401235925867;9037.819243615222;9170.633174672937;9255.213306868991;9260.953695231481;9272.119148680864;8738.475691458532;8775.736727898173;8776.60505277264;8856.778580535409;9063.954680226556;2695.272276485377;2711.3492761737043;2785.7075007124367;2826.1662809471254;2828.43431313734;962.6101428921298;966.9758256043655;988.3625061835077;988.6935050134338;999.4453078541334;18702.71945920812;18881.527961801065;19012.61974760497;19205.711914321295;19502.414927552196;1049.5014867937668;1051.6161601015574;1051.805415998043;1055.350959160111;1060.0724366179593;10453.477326133814;10601;10684.412357320267;10720;10994.395308258123;476964;481125;481898;522052;523809;111833;114548.42725786318;115867.42066289783;116466;118485.40757296159;1051.3324039234988;1106.8339749037548;1106.9944650276698;1170.7716995186026;1196.461592283476;19803.40589782309;19857.60284794267;19971.500712481724;20028.499287517927;20230.08964596626;53964;54591.181132282254;55319.446805533036;55962.440375595725;57166.7141664289;71821.28178718146;71829;71938.64030680023;72117;72999.63500182464;14111.717765644835;14409.207493587954;14435.566932992027;14505.347259373564;14518.709625807214;22383.32850014502;22656.886715566317;22794.658080129142;22853.314400568008;23014.884925575265;17828.286868525633;18171.636567268844;18241.817581824012;18264.26942922268;18272;15560.922195389403;15809.920950395635;15871;16326.18369081565;16351.59121021984;18681.159347829653;18713;18749.437516874517;18970.146343414304;18977.146028428477;13981.790273146114;14046.227457489937;14047.08693934891;14050.508232211823;14134.363953622318;17866.821331786516;17986.19062142233;18126.637467250846;18161.909190453964;18179.091045447938 23:39:00 INFO - PID 11274 | |3;mootools.html;1346.6431395680145;1398.6503374156455;1424.9811384859822;1425.287356321839;1428.7356838984786;15032.398704051839;15596.610084747887;15597;15606.843931560667;15670.608234794121;15232.466863659774;15360.84639153608;15373.69252614947;15377.154256515887;15393.23033848306;2668.0528412413605;2695.1644990053096;2707.56678931371;2720.102366219143;2744.300203448118;2714.7285271472792;2728.113363156982;2735.3571910600995;2755.0081970490605;2755.2423083651956;2742.8491432971177;2828.0243316055926;2828.0384669212463;2828.6464191976;2832.5326321156986;2749.628800111979;2759.765419939308;2791.330080780618;2799.7900157488166;2802.5515917453313;2560.577504711739;2628.47430513898;2754.848483333416;2761.986190069057;2763.557830747091;14968.850311496855;15026.398944042225;15038.248087595686;15040.924795376062;15097.849021509754;7767.883481747778;8050.758477245633;8052.235037671412;8104.797380065486;8114.3914206434165;5056.974715126437;5124.795008199668;5205.661631993946;5276.472352764693;5302.575793936476;1751.6409136127063;1756.0692832798636;1788.5707430216785;1795.8922464652162;1814.292425953879;26143.346416339555;26771.46457070867;26834.329141771417;26837.194884153505;26904.730952690417;6792.422644075309;6900.6204658743245;7065.43476521877;7176.425885929113;7200.351968322876;20230.393088207376;20239.392818215478;20253.59492810165;20256.088476018616;20262;7989.520628762293;8107.270345668918;8111.229433203955;8112.878306825402;8123.634436450374;7112.786616401516;7169.175544812413;7205.4595905307315;7213.098362704662;7232.74685386009;5554.1946417770005;5743.052396354638;5750.712464376765;5798.188253644493;5848.093545500455;1766.8586513078924;1802.12596890508;1802.711566149436;1851.5186051626404;1858.4610462965588;866.6230189867427;884.1644645809777;890.5369208011798;900.4597241655085;906.2342320738965;7125.608091555015;7193.3166349196745;7271.709131634675;7320.707171713072;7327.523710958771;715.6529083394549;717.1358512991936;721.1742554774859;721.4156533208118;721.95307305025;4813.374261346003;5281.419043905167;5289.603279754034;5338.225957236179;5369.7583608737705;21015.78984210169;21501.849815018686;21883.452913676967;21883.562328753334;21885.124595016023;19988;21322.253721119687;21452.78547214539;21455.28357731409;21837.563248735256;11060.115190784878;11098.334099954029;11127.721806954729;11148.832767508495;11186.664400068012;7868.960655196687;7934.519501908924;8031.237032481905;8039.236272554098;8120.675172993014;18092.276308947494;18442.815571844647;18638.81361186371;18729.531761706065;19009.42971710851;18458.907705461388;19197.90401047986;19219.23123075117;19353.709694354315;19443.611127777647;11324.94337528307;11529.82705259405;11531.192816502764;11552.826707599224;11734.295942243492;13736.244506552235;13812.102213356502;13854.445822167001;13926.860731392962;13941.790873136708;10350.482475876026;10468.424236667057;10483.37099774016;10545.578176873147;10758.677239682822;10033.899661003297;10134.746631334276;10141.797164056825;10249.641262555775;10443.582256709951;9388.765280868032;9590.08894155054;9596.472194029395;9608.855867162138;9641.228701703987;7365.631718413951;7434.553926764412;7435.219301973215;7484.70061197546;7506.28690274423;6816;6846.657667116525;6887.139107611549;6890.207626122859;6958.373746362851 23:39:00 INFO - PID 11274 | |4;prototype.html;496.9875753106174;508.63886640485254;526.3731797499976;531.0414701463859;533.7704786941615;6395.328490508499;6399.968000159998;6404.199475065617;6429.485641148697;6478.74085036598;6297.433231009209;6298.433141017307;6351.618902865831;6359.3958573935515;6374.968125159379;5241.10901146804;5247.580193584504;5278.392984806758;5278.973605131969;5291.788328466857;4860.854174374775;5062.620303477254;5187.584993200535;5228.2680424740565;5277.815276465324;4987.925181122286;5009.918899876568;5037.924431133536;5039.118154322997;5049.3435853339015;4971.558248108045;5009.398872135331;5038.622103342264;5043.823466178666;5043.823466178685;4414.779261036967;4448.288273876165;4456.554344565518;4481.439820022497;4482.686211965164;6092.908606370908;6129.172561704202;6205.875882482325;6225.315215326311;6230.162102179868;5731.455511726379;5749.770009199627;5773.971130144364;5785.074388097926;5809.564282678816;6604.339566043357;6636.6726654669255;6670.4997125215805;6671.833204169886;6714.690635326114;4620.353150558924;4911.8772030699165;4940.851774446736;4954.777035033432;4977.477364876709;6830.497290596061;6832.3509266620085;6989.7553585624255;7014.158301003861;7106.964465177641;5519.365272993577;5550;5558.722063896789;5580.386157522669;5613.298337707786;5557.972210139004;5648.293963254593;5672.461116193955;5683.403242659461;5688.77244910199;6112.6552158525055;6121.490189022568;6135.294441139326;6136;6146.879326632305;6812.659367031728;6851.417629501449;6876.862462750717;6898.379145876795;6908.412784913338;1934.8355389792025;1962.107241205248;1970.1331414178003;1973.4967583266175;1978.2779285560666;1406.2476575032308;1425.536700572318;1437.5399872040846;1445.8265008198873;1475.5204558518524;5774.797882074107;5783.274558187364;5794.565407594448;5795.217645617872;5822.534197264209;6823.965880170567;6840.144981877265;6899.448044156456;6901.480245074948;6927.238003819576;5793.175149827791;5810.622309549865;5826.533877289807;5841.970790146107;5867.911981320283;3620;3625.3836847735947;3628.020434482675;3647.6352364763843;3657.140571965586;6599.406053455116;6604.1414616100565;6631;6646.169228846395;6659.167604049494;6987.580745155307;7039.894401583981;7049.330313620198;7067.929320706727;7070.964645176741;6570.8028759137305;6601.151677530299;6615.900761488678;6632.43624291931;6644.302348253461;6808.251092379735;6825.590464572141;6850.486213533905;6860;6875.4155896749335;6761.830954226184;6774.288699686462;6780.220274668279;6818.931810682028;6838.350356716104;6467.288598254094;6543.574667646588;6562.770303039561;6580.539362244597;6596;5529.834104976857;5551.805686800943;5556.194351819045;5561.721913904369;5566.137248726453;6531.836704082246;6567.211934567882;6637.601743895381;6714.630695311609;6950.895736564057;6503.154589903283;6551.868962620625;6575.835604109936;6578.703958321791;6606.8678626426245;6484.610923344614;6555.311692272434;6558.1802274715665;6567.343265673586;6575.30959249291;6440.806775796734;6461.386168314003;6536.921407967822;6560.442362399059;6590.736370545124;6586.473082153512;6606.8348291293105;6609.537332386687;6720.110352548451;6724.865502689821;6429.22849258092;6500.642464664489;6504.707288172138;6519.967400162969;6551.475881929339 23:39:00 INFO - PID 11274 | |5;yui.html;893.2452077994101;914.6524320758112;924.8751418558497;926.9304802139841;938.8826396700413;18406.447806565808;19137.61724765504;19183.616327673437;19187.712184317246;19231.519212019688;17367.47897563072;17446.1276936153;17760.200790964405;18235.179416926236;18587.628247435045;930.0281206139583;938.8169306985106;938.9906100939006;939.0421769794805;939.7791518993031;991.1278075293767;993.1657407777466;993.4982833668987;993.5479356892597;994.0457161125329;1004.6584161385127;1030.1449796668746;1040.8438734189895;1041.640633981279;1041.7603951091253;1027.964021259256;1029.5881647341048;1030.006044167382;1030.0574973898874;1032.385730490357;715.8103102677794;735.2169939014932;745.9403247740167;748.8652042632324;753.408574269196;19305.903470482557;19478.513037174183;19530;19544.12051457688;19554.413367598994;18838.905805471022;18875.622487550172;19322.71015934762;19469.318573849847;19517.414477565697;17134.40029598958;17155.39956101543;17255.913720431443;17270.56823579408;17420.47738567845;3734.2344819311975;3751.81240937952;3752.8311225994894;3753.230587729536;3758.229562939618;144980;146458.26770866077;147825;148182;148269;16484.83515164833;16629.91685041567;16780.748288775678;16789.6642067158;16803.663926721398;30441;31020.68979310178;31082.84458577738;31315.373692526024;31345.216369590486;7941.404394670423;7992.120866704658;8013.19868013194;8019.839603207904;8034.718784842503;4022.35642297231;4056.533498647634;4157.521884983265;4179.895502612459;4210.59999300066;5418.945810541923;5548.140038294071;5567.66594004361;5585.776568937278;5600.327960644749;1034.4775888176423;1091.5524634899652;1120.5461787975883;1128.966131016071;1129.5425352732157;701.4318402094218;704.1374316462293;718.8885722712988;718.989215161773;728.8615163118991;11960.282383057045;12514.972450690773;12667.873321266854;12673.93663031679;13189;680.1803826389189;682.8088135322117;688.5008368932483;698.8602279544111;707.8195060259601;5538.418466061005;5554.166874968706;5617.775288988395;5629.8592535186945;5681.147827825776;125700;126269;126569;128132;131097;112416.06543771092;114825;115106;117216.41391792987;118856.4057179726;92554;93402.53298733463;96771.51614242025;97500.51249743848;99334.00665993392;10314.48427578603;10356.378617282988;10479.318844275098;10492.52783624754;10596.205284603531;44729.77635111804;45156.77421612871;45159.096818064114;45214.54785452235;45480;56896;57387.71306143443;57625.423745763685;58429;59648;13497.932510337385;13742.106763060368;13816.378262977989;13881.930590346983;13893.930530347283;18206;18381;18446.26214951387;18472.261109555468;18574.814251857308;15449.613759656098;15505.689886201988;15523;15612.92193539025;15656.92171539135;16790.496285111465;16852;16880;16917.49247522527;17000.74498882493;16824.747628785823;16833.91583042077;16837.66324673475;16857.157142142598;16945.06802125895;12393.388859448214;12746.617601471971;12862.871371286541;12947.805782913452;12952.222866628032;12054.51781928713;12277.140600157903;12372.752544948871;12511.624651260478;12602.55891043809 23:39:00 INFO - PID 11274 | __end_tp_report 23:39:00 INFO - PID 11274 | __start_cc_report 23:39:00 INFO - PID 11274 | _x_x_mozilla_cycle_collect,358 23:39:00 INFO - PID 11274 | __end_cc_report 23:39:00 INFO - PID 11274 | __startTimestamp1505371140598__endTimestamp 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | ------- Summary: start ------- 23:39:00 INFO - PID 11274 | Number of tests: 6 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#0] dojo.html Cycles:165 Average:6211.01 Median:6486.74 stddev:853.39 (13.2%) stddev-sans-first:821.76 23:39:00 INFO - PID 11274 | Values: 3160.3 3166.4 3186.3 3186.4 3189.0 6203.8 6226.0 6318.0 6344.0 6406.6 6283.0 6287.2 6295.4 6331.9 6343.4 5697.2 5816.9 5820.9 5835.8 5897.7 1272.1 5745.1 5852.1 5920.8 5926.4 5395.6 5746.3 5788.6 5864.4 5866.1 5794.8 5798.2 5858.9 5874.5 5883.0 5756.7 5761.5 5834.6 5845.4 5851.4 6269.0 6361.4 6382.9 6414.4 6444.7 6588.6 6722.9 6744.2 6770.5 6876.2 6888.2 6896.0 6899.9 6900.7 6901.4 6116.6 6224.5 6302.9 6394.8 6401.5 6791.2 6998.8 7007.6 7009.4 7010.3 6669.1 6681.7 6740.8 6752.3 6762.8 6555.6 6709.9 6737.1 6790.6 6890.9 6786.8 6797.3 6808.4 6809.8 6813.6 6776.7 6856.8 6858.3 6876.2 6886.7 5239.2 5335.2 5382.6 5383.0 5394.1 4561.9 4592.7 4610.4 4656.1 4668.7 5839.6 5842.3 5877.8 5878.4 5883.4 6797.3 6804.4 6805.2 6816.7 6885.2 5702.0 5753.7 5782.0 5841.4 5841.9 5790.3 5792.6 5792.9 5803.4 5804.7 6514.2 6514.3 6516.8 6518.1 6637.4 6808.4 6823.7 6873.1 6905.7 6938.4 6535.2 6578.6 6606.0 6620.0 6665.2 6478.7 6570.7 6656.2 6681.4 6777.1 6893.2 6900.0 6939.1 6940.6 6957.4 6591.4 6596.0 6679.0 6691.0 6700.9 6305.0 6588.8 6592.1 6676.5 6690.3 6478.6 6485.4 6486.7 6488.8 6490.7 6589.9 6664.0 6683.9 6734.0 6788.3 6329.1 6428.6 6455.7 6536.4 6543.8 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#1] ext.html Cycles:180 Average:38279.86 Median:19459.69 stddev:55264.41 (284.0%) stddev-sans-first:55347.88 23:39:00 INFO - PID 11274 | Values: 825.2 866.1 891.0 893.0 894.3 39146.4 39730.6 39901.6 41402.2 41749.4 42253.8 42704.4 42718.4 42739.1 42892.6 7779.7 7926.8 7949.5 7955.7 7990.4 7803.0 7943.7 7961.6 7969.6 7979.8 7913.9 7960.4 7962.8 8004.3 8011.6 7929.1 7931.0 7954.2 7962.4 7964.9 7708.2 7779.1 7788.5 7791.7 7793.7 37999.0 38247.0 38297.4 38374.4 38382.8 3521.3 3547.3 3556.1 3556.7 3557.9 31213.8 31249.0 31301.4 31335.2 31340.5 5031.9 5167.5 5244.8 5245.8 5260.4 182816.0 183616.0 184025.0 184429.0 184570.0 46535.5 46568.8 46616.3 46672.5 48507.8 51864.7 52060.0 52105.3 52112.7 52127.7 16417.6 16546.5 16567.8 16585.3 16874.7 13572.7 13632.7 13635.9 13701.2 13701.7 14581.1 14666.8 14715.2 14818.7 14960.5 5683.3 5757.2 5761.7 5808.4 5952.5 991.5 1001.7 1002.9 1016.0 1018.0 22945.3 23089.4 23182.8 23440.4 23780.4 1099.7 1108.4 1113.6 1114.9 1134.8 12441.8 12548.1 12564.0 12672.5 12729.1 234171.0 236922.0 238269.0 246096.0 253730.0 56854.4 57063.7 57138.7 57321.4 57331.1 1441.7 1470.6 1477.2 1478.2 1483.3 26449.6 27320.9 27493.2 27615.9 27793.9 36952.0 37746.0 37898.6 37957.6 38183.6 209355.0 209381.0 209605.0 209787.0 210253.0 34515.0 34578.5 34676.0 34685.3 34858.1 43568.3 43768.8 43801.3 43907.3 44122.6 30237.7 30298.7 30363.7 30377.5 30652.7 30446.8 30699.2 30971.7 31006.0 31144.7 35372.1 35611.3 35612.3 35727.6 35978.8 30078.5 30261.7 30513.0 30568.7 31022.4 23010.1 23267.5 23493.6 23842.6 23974.6 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#2] jquery.html Cycles:180 Average:34583.13 Median:22812.33 stddev:83552.87 (366.3%) stddev-sans-first:83748.21 23:39:00 INFO - PID 11274 | Values: 558.9 573.6 573.9 574.9 610.6 22163.8 22830.0 22853.0 22878.0 22979.9 22311.9 22577.4 23152.5 24383.0 24701.6 6372.6 6488.3 6517.9 6520.8 6526.2 6222.8 6405.0 6481.3 6490.0 6494.3 6472.3 6478.1 6481.8 6484.8 6494.1 6467.0 6471.9 6475.0 6479.4 6484.1 5833.6 5975.0 6042.9 6046.6 6061.1 28370.9 28959.7 28969.9 28971.7 28995.4 1967.7 1994.9 1999.5 2001.5 2001.6 18598.6 18960.5 19262.7 19290.6 19354.1 2420.5 2457.2 2468.7 2475.1 2482.7 125121.0 130583.0 130810.0 132270.0 137213.3 14328.2 14412.8 14588.0 14643.9 15086.8 21932.9 22215.6 22229.0 22236.0 22400.2 9827.7 9891.9 9937.2 9941.8 9979.4 9037.8 9170.6 9255.2 9261.0 9272.1 8738.5 8775.7 8776.6 8856.8 9064.0 2695.3 2711.3 2785.7 2826.2 2828.4 962.6 967.0 988.4 988.7 999.4 18702.7 18881.5 19012.6 19205.7 19502.4 1049.5 1051.6 1051.8 1055.4 1060.1 10453.5 10601.0 10684.4 10720.0 10994.4 476964.0 481125.0 481898.0 522052.0 523809.0 111833.0 114548.4 115867.4 116466.0 118485.4 1051.3 1106.8 1107.0 1170.8 1196.5 19803.4 19857.6 19971.5 20028.5 20230.1 53964.0 54591.2 55319.4 55962.4 57166.7 71821.3 71829.0 71938.6 72117.0 72999.6 14111.7 14409.2 14435.6 14505.3 14518.7 22383.3 22656.9 22794.7 22853.3 23014.9 17828.3 18171.6 18241.8 18264.3 18272.0 15560.9 15809.9 15871.0 16326.2 16351.6 18681.2 18713.0 18749.4 18970.1 18977.1 13981.8 14046.2 14047.1 14050.5 14134.4 17866.8 17986.2 18126.6 18161.9 18179.1 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#3] mootools.html Cycles:180 Average:9349.38 Median:2717.42 stddev:6784.67 (249.7%) stddev-sans-first:6777.06 23:39:00 INFO - PID 11274 | Values: 1346.6 1398.7 1425.0 1425.3 1428.7 15032.4 15596.6 15597.0 15606.8 15670.6 15232.5 15360.8 15373.7 15377.2 15393.2 2668.1 2695.2 2707.6 2720.1 2744.3 2714.7 2728.1 2735.4 2755.0 2755.2 2742.8 2828.0 2828.0 2828.6 2832.5 2749.6 2759.8 2791.3 2799.8 2802.6 2560.6 2628.5 2754.8 2762.0 2763.6 14968.9 15026.4 15038.2 15040.9 15097.8 7767.9 8050.8 8052.2 8104.8 8114.4 5057.0 5124.8 5205.7 5276.5 5302.6 1751.6 1756.1 1788.6 1795.9 1814.3 26143.3 26771.5 26834.3 26837.2 26904.7 6792.4 6900.6 7065.4 7176.4 7200.4 20230.4 20239.4 20253.6 20256.1 20262.0 7989.5 8107.3 8111.2 8112.9 8123.6 7112.8 7169.2 7205.5 7213.1 7232.7 5554.2 5743.1 5750.7 5798.2 5848.1 1766.9 1802.1 1802.7 1851.5 1858.5 866.6 884.2 890.5 900.5 906.2 7125.6 7193.3 7271.7 7320.7 7327.5 715.7 717.1 721.2 721.4 722.0 4813.4 5281.4 5289.6 5338.2 5369.8 21015.8 21501.8 21883.5 21883.6 21885.1 19988.0 21322.3 21452.8 21455.3 21837.6 11060.1 11098.3 11127.7 11148.8 11186.7 7869.0 7934.5 8031.2 8039.2 8120.7 18092.3 18442.8 18638.8 18729.5 19009.4 18458.9 19197.9 19219.2 19353.7 19443.6 11324.9 11529.8 11531.2 11552.8 11734.3 13736.2 13812.1 13854.4 13926.9 13941.8 10350.5 10468.4 10483.4 10545.6 10758.7 10033.9 10134.7 10141.8 10249.6 10443.6 9388.8 9590.1 9596.5 9608.9 9641.2 7365.6 7434.6 7435.2 7484.7 7506.3 6816.0 6846.7 6887.1 6890.2 6958.4 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#4] prototype.html Cycles:180 Average:5662.57 Median:6297.93 stddev:1540.54 (24.5%) stddev-sans-first:1495.27 23:39:00 INFO - PID 11274 | Values: 497.0 508.6 526.4 531.0 533.8 6395.3 6400.0 6404.2 6429.5 6478.7 6297.4 6298.4 6351.6 6359.4 6375.0 5241.1 5247.6 5278.4 5279.0 5291.8 4860.9 5062.6 5187.6 5228.3 5277.8 4987.9 5009.9 5037.9 5039.1 5049.3 4971.6 5009.4 5038.6 5043.8 5043.8 4414.8 4448.3 4456.6 4481.4 4482.7 6092.9 6129.2 6205.9 6225.3 6230.2 5731.5 5749.8 5774.0 5785.1 5809.6 6604.3 6636.7 6670.5 6671.8 6714.7 4620.4 4911.9 4940.9 4954.8 4977.5 6830.5 6832.4 6989.8 7014.2 7107.0 5519.4 5550.0 5558.7 5580.4 5613.3 5558.0 5648.3 5672.5 5683.4 5688.8 6112.7 6121.5 6135.3 6136.0 6146.9 6812.7 6851.4 6876.9 6898.4 6908.4 1934.8 1962.1 1970.1 1973.5 1978.3 1406.2 1425.5 1437.5 1445.8 1475.5 5774.8 5783.3 5794.6 5795.2 5822.5 6824.0 6840.1 6899.4 6901.5 6927.2 5793.2 5810.6 5826.5 5842.0 5867.9 3620.0 3625.4 3628.0 3647.6 3657.1 6599.4 6604.1 6631.0 6646.2 6659.2 6987.6 7039.9 7049.3 7067.9 7071.0 6570.8 6601.2 6615.9 6632.4 6644.3 6808.3 6825.6 6850.5 6860.0 6875.4 6761.8 6774.3 6780.2 6818.9 6838.4 6467.3 6543.6 6562.8 6580.5 6596.0 5529.8 5551.8 5556.2 5561.7 5566.1 6531.8 6567.2 6637.6 6714.6 6950.9 6503.2 6551.9 6575.8 6578.7 6606.9 6484.6 6555.3 6558.2 6567.3 6575.3 6440.8 6461.4 6536.9 6560.4 6590.7 6586.5 6606.8 6609.5 6720.1 6724.9 6429.2 6500.6 6504.7 6520.0 6551.5 23:39:00 INFO - PID 11274 | 23:39:00 INFO - PID 11274 | [#5] yui.html Cycles:180 Average:24857.68 Median:18713.27 stddev:36897.03 (197.2%) stddev-sans-first:36956.66 23:39:00 INFO - PID 11274 | Values: 893.2 914.7 924.9 926.9 938.9 18406.4 19137.6 19183.6 19187.7 19231.5 17367.5 17446.1 17760.2 18235.2 18587.6 930.0 938.8 939.0 939.0 939.8 991.1 993.2 993.5 993.5 994.0 1004.7 1030.1 1040.8 1041.6 1041.8 1028.0 1029.6 1030.0 1030.1 1032.4 715.8 735.2 745.9 748.9 753.4 19305.9 19478.5 19530.0 19544.1 19554.4 18838.9 18875.6 19322.7 19469.3 19517.4 17134.4 17155.4 17255.9 17270.6 17420.5 3734.2 3751.8 3752.8 3753.2 3758.2 144980.0 146458.3 147825.0 148182.0 148269.0 16484.8 16629.9 16780.7 16789.7 16803.7 30441.0 31020.7 31082.8 31315.4 31345.2 7941.4 7992.1 8013.2 8019.8 8034.7 4022.4 4056.5 4157.5 4179.9 4210.6 5418.9 5548.1 5567.7 5585.8 5600.3 1034.5 1091.6 1120.5 1129.0 1129.5 701.4 704.1 718.9 719.0 728.9 11960.3 12515.0 12667.9 12673.9 13189.0 680.2 682.8 688.5 698.9 707.8 5538.4 5554.2 5617.8 5629.9 5681.1 125700.0 126269.0 126569.0 128132.0 131097.0 112416.1 114825.0 115106.0 117216.4 118856.4 92554.0 93402.5 96771.5 97500.5 99334.0 10314.5 10356.4 10479.3 10492.5 10596.2 44729.8 45156.8 45159.1 45214.5 45480.0 56896.0 57387.7 57625.4 58429.0 59648.0 13497.9 13742.1 13816.4 13881.9 13893.9 18206.0 18381.0 18446.3 18472.3 18574.8 15449.6 15505.7 15523.0 15612.9 15656.9 16790.5 16852.0 16880.0 16917.5 17000.7 16824.7 16833.9 16837.7 16857.2 16945.1 12393.4 12746.6 12862.9 12947.8 12952.2 12054.5 12277.1 12372.8 12511.6 12602.6 23:39:00 INFO - PID 11274 | -------- Summary: end -------- 23:39:00 INFO - PID 11274 | 23:39:01 INFO - TEST-INFO | 11274: exit 0 23:39:01 INFO - TEST-OK | dromaeo_css | took 1108720ms 23:39:01 INFO - TEST-START | kraken 23:39:01 INFO - Initialising browser for kraken test... 23:39:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44719/getInfo.html -profile /tmp/tmp0_Cicy/profile 23:39:01 INFO - TEST-INFO | started process 11638 (/builds/slave/test/build/application/firefox/firefox http://localhost:44719/getInfo.html) 23:39:06 INFO - TEST-INFO | 11638: exit 0 23:39:06 INFO - Browser initialized. 23:39:06 INFO - Running cycle 1/1 for kraken test... 23:39:06 INFO - Using env: {'DISPLAY': ':0', 23:39:06 INFO - 'HOME': '/home/cltbld', 23:39:06 INFO - 'JSGC_DISABLE_POISONING': '1', 23:39:06 INFO - 'LANG': 'en_US.UTF-8', 23:39:06 INFO - 'LANGUAGE': 'en_US:en', 23:39:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:39:06 INFO - 'LOGNAME': 'cltbld', 23:39:06 INFO - 'MAIL': '/var/mail/cltbld', 23:39:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:39:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:39:06 INFO - 'MOZ_CRASHREPORTER': '1', 23:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:39:06 INFO - 'MOZ_NO_REMOTE': '1', 23:39:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:06 INFO - 'NO_EM_RESTART': '1', 23:39:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:06 INFO - 'PWD': '/builds/slave/test', 23:39:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:39:06 INFO - 'RUST_BACKTRACE': 'full', 23:39:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:39:06 INFO - 'SHELL': '/bin/bash', 23:39:06 INFO - 'SHLVL': '1', 23:39:06 INFO - 'STYLO_FORCE_DISABLED': '1', 23:39:06 INFO - 'TERM': 'linux', 23:39:06 INFO - 'TMOUT': '86400', 23:39:06 INFO - 'USER': 'cltbld', 23:39:06 INFO - 'XDG_SESSION_COOKIE': '8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720', 23:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:06 INFO - '_': '/tools/buildbot/bin/python'} 23:39:06 INFO - TEST-INFO | started process 11869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0_Cicy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:39:07 INFO - PID 11869 | 23:39:07 INFO - PID 11869 | (/builds/slave/test/build/application/firefox/firefox:11918): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:39:07 INFO - PID 11869 | 23:39:17 INFO - PID 11869 | RSS: Main: 173101056 23:39:17 INFO - PID 11869 | 23:39:20 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44719/tests/kraken/driver.html?testName=audio-beat-detection) 23:39:21 INFO - PID 11869 | RSS: Main: 178311168 23:39:21 INFO - PID 11869 | 23:39:23 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44719/tests/kraken/driver.html?testName=audio-dft) 23:39:24 INFO - PID 11869 | RSS: Main: 178536448 23:39:24 INFO - PID 11869 | 23:39:27 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44719/tests/kraken/driver.html?testName=audio-fft) 23:39:28 INFO - PID 11869 | RSS: Main: 174301184 23:39:28 INFO - PID 11869 | 23:39:30 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44719/tests/kraken/driver.html?testName=audio-oscillator) 23:39:30 INFO - PID 11869 | RSS: Main: 174772224 23:39:30 INFO - PID 11869 | 23:39:32 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:39:33 INFO - PID 11869 | RSS: Main: 175239168 23:39:33 INFO - PID 11869 | 23:39:36 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44719/tests/kraken/driver.html?testName=imaging-darkroom) 23:39:37 INFO - PID 11869 | RSS: Main: 177569792 23:39:37 INFO - PID 11869 | 23:39:41 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44719/tests/kraken/driver.html?testName=imaging-desaturate) 23:39:41 INFO - PID 11869 | RSS: Main: 177614848 23:39:41 INFO - PID 11869 | 23:39:44 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44719/tests/kraken/driver.html?testName=json-parse-financial) 23:39:45 INFO - PID 11869 | RSS: Main: 177750016 23:39:45 INFO - PID 11869 | 23:39:46 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:39:47 INFO - PID 11869 | RSS: Main: 177573888 23:39:47 INFO - PID 11869 | 23:39:49 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:39:49 INFO - PID 11869 | RSS: Main: 177405952 23:39:49 INFO - PID 11869 | 23:39:51 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:39:52 INFO - PID 11869 | RSS: Main: 174673920 23:39:52 INFO - PID 11869 | 23:39:55 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:39:55 INFO - PID 11869 | RSS: Main: 175095808 23:39:55 INFO - PID 11869 | 23:39:58 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:39:59 INFO - PID 11869 | RSS: Main: 174907392 23:39:59 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | Cycle 1(1): loaded http://localhost:44719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44719/tests/kraken/driver.html?testName=ai-astar) 23:40:01 INFO - PID 11869 | RSS: Main: 176435200 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | __start_tp_report 23:40:01 INFO - PID 11869 | _x_x_mozilla_page_load 23:40:01 INFO - PID 11869 | _x_x_mozilla_page_load_details 23:40:01 INFO - PID 11869 | |i|pagename|runs| 23:40:01 INFO - PID 11869 | |0;ai-astar;110;108;108;107;109;109;110;109;107;113 23:40:01 INFO - PID 11869 | |1;audio-beat-detection;121;123;120;118;142;118;120;119;118;117 23:40:01 INFO - PID 11869 | |2;audio-dft;164;164;161;162;163;161;164;169;171;166 23:40:01 INFO - PID 11869 | |3;audio-fft;74;75;73;75;84;74;75;75;75;75 23:40:01 INFO - PID 11869 | |4;audio-oscillator;80;79;79;78;82;79;79;134;79;84 23:40:01 INFO - PID 11869 | |5;imaging-gaussian-blur;113;114;113;113;110;115;113;113;114;115 23:40:01 INFO - PID 11869 | |6;imaging-darkroom;149;149;153;148;148;148;150;151;150;150 23:40:01 INFO - PID 11869 | |7;imaging-desaturate;99;95;94;94;95;94;94;94;94;94 23:40:01 INFO - PID 11869 | |8;json-parse-financial;53;53;53;54;53;54;52;52;52;51 23:40:01 INFO - PID 11869 | |9;json-stringify-tinderbox;38;37;38;37;38;38;38;39;38;37 23:40:01 INFO - PID 11869 | |10;stanford-crypto-aes;76;74;74;75;74;76;75;75;78;74 23:40:01 INFO - PID 11869 | |11;stanford-crypto-ccm;114;114;117;112;115;112;125;115;120;116 23:40:01 INFO - PID 11869 | |12;stanford-crypto-pbkdf2;172;178;168;167;168;170;175;168;173;171 23:40:01 INFO - PID 11869 | |13;stanford-crypto-sha256-iterative;64;67;65;64;64;65;64;65;66;68 23:40:01 INFO - PID 11869 | __end_tp_report 23:40:01 INFO - PID 11869 | __start_cc_report 23:40:01 INFO - PID 11869 | _x_x_mozilla_cycle_collect,927 23:40:01 INFO - PID 11869 | __end_cc_report 23:40:01 INFO - PID 11869 | __startTimestamp1505371201393__endTimestamp 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | ------- Summary: start ------- 23:40:01 INFO - PID 11869 | Number of tests: 14 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:1.76 (1.6%) stddev-sans-first:1.83 23:40:01 INFO - PID 11869 | Values: 110.0 108.0 108.0 107.0 109.0 109.0 110.0 109.0 107.0 113.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:120.00 stddev:7.38 (6.2%) stddev-sans-first:7.83 23:40:01 INFO - PID 11869 | Values: 121.0 123.0 120.0 118.0 142.0 118.0 120.0 119.0 118.0 117.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.31 (2.0%) stddev-sans-first:3.50 23:40:01 INFO - PID 11869 | Values: 164.0 164.0 161.0 162.0 163.0 161.0 164.0 169.0 171.0 166.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#3] audio-fft Cycles:10 Average:75.50 Median:75.00 stddev:3.06 (4.1%) stddev-sans-first:3.20 23:40:01 INFO - PID 11869 | Values: 74.0 75.0 73.0 75.0 84.0 74.0 75.0 75.0 75.0 75.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:79.00 stddev:17.20 (21.8%) stddev-sans-first:18.14 23:40:01 INFO - PID 11869 | Values: 80.0 79.0 79.0 78.0 82.0 79.0 79.0 134.0 79.0 84.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.50 stddev:1.42 (1.2%) stddev-sans-first:1.50 23:40:01 INFO - PID 11869 | Values: 113.0 114.0 113.0 113.0 110.0 115.0 113.0 113.0 114.0 115.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.58 (1.1%) stddev-sans-first:1.66 23:40:01 INFO - PID 11869 | Values: 149.0 149.0 153.0 148.0 148.0 148.0 150.0 151.0 150.0 150.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:0.44 23:40:01 INFO - PID 11869 | Values: 99.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.95 (1.8%) stddev-sans-first:1.00 23:40:01 INFO - PID 11869 | Values: 53.0 53.0 53.0 54.0 53.0 54.0 52.0 52.0 52.0 51.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 23:40:01 INFO - PID 11869 | Values: 38.0 37.0 38.0 37.0 38.0 38.0 38.0 39.0 38.0 37.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.29 (1.7%) stddev-sans-first:1.32 23:40:01 INFO - PID 11869 | Values: 76.0 74.0 74.0 75.0 74.0 76.0 75.0 75.0 78.0 74.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:115.50 stddev:3.94 (3.4%) stddev-sans-first:4.12 23:40:01 INFO - PID 11869 | Values: 114.0 114.0 117.0 112.0 115.0 112.0 125.0 115.0 120.0 116.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:3.56 (2.1%) stddev-sans-first:3.76 23:40:01 INFO - PID 11869 | Values: 172.0 178.0 168.0 167.0 168.0 170.0 175.0 168.0 173.0 171.0 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.40 (2.2%) stddev-sans-first:1.41 23:40:01 INFO - PID 11869 | Values: 64.0 67.0 65.0 64.0 64.0 65.0 64.0 65.0 66.0 68.0 23:40:01 INFO - PID 11869 | -------- Summary: end -------- 23:40:01 INFO - PID 11869 | 23:40:01 INFO - PID 11869 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 23:40:02 INFO - TEST-INFO | 11869: exit 0 23:40:02 INFO - TEST-OK | kraken | took 60777ms 23:40:02 INFO - SUITE-END | took 1169s 23:40:02 INFO - Completed test suite (00:19:29) 23:40:02 INFO - javascript benchmark 23:40:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8561.900849382577, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.273137178449, 3166.414213370527, 3186.2671585535327, 3186.4105140548986, 3188.9840550797244, 6203.782867599635, 6225.968870155642, 6317.968410157949, 6343.968280158599, 6406.615603063819, 6282.963311053671, 6287.15123458333, 6295.43341099301, 6331.905021424683, 6343.365663433666, 5697.202391665171, 5816.941830581683, 5820.854478638025, 5835.795747148862, 5897.675627840467, 1272.0655394955318, 5745.080787074069, 5852.122181672762, 5920.792772252972, 5926.407359264061, 5395.568354531648, 5746.252987111669, 5788.565857560658, 5864.35492095867, 5866.061430171195, 5794.768209271666, 5798.246227990334, 5858.882822343572, 5874.530037596982, 5883.029300165467, 5756.7121643917635, 5761.539076873882, 5834.620749651259, 5845.357010728816, 5851.356350801409, 6269.0, 6361.427471527585, 6382.904256436157, 6414.358564143595, 6444.742210311582, 6588.604683718992, 6722.93277067228, 6744.190697116377, 6770.458363330922, 6876.1748590169, 6888.173419189679, 6896.034555162281, 6899.931000689979, 6900.654967251618, 6901.447884169304, 6116.571839971204, 6224.470919971853, 6302.87394252117, 6394.840128996766, 6401.455876250524, 6791.185057793096, 6998.7900362988175, 7007.614581197981, 7009.369156775914, 7010.298970102949, 6669.1330127083165, 6681.699323530453, 6740.831479213059, 6752.291009443938, 6762.830929226809, 6555.573887697285, 6709.865802683919, 6737.056812046318, 6790.558613690095, 6890.93109068913, 6786.76246331376, 6797.2523022467485, 6808.38724514796, 6809.795706128824, 6813.591184528944, 6776.69504872282, 6856.794296171123, 6858.279880612564, 6876.17485901695, 6886.655667216719, 5239.18792587142, 5335.226392173191, 5382.596305277119, 5383.031054410166, 5394.1099718546, 4561.863144105616, 4592.724436533818, 4610.446746390455, 4656.068786242765, 4668.743219122913, 5839.649621022752, 5842.269716285465, 5877.794277200277, 5878.353381128072, 5883.441073098049, 6797.286284940109, 6804.387605115563, 6805.2173999989645, 6816.659167041727, 6885.208201056842, 5701.973644743903, 5753.741081651336, 5781.971090144522, 5841.386654401226, 5841.94158058414, 5790.305163380337, 5792.623479473821, 5792.94207057924, 5803.390643982406, 5804.738786754606, 6514.1531600891585, 6514.348565143448, 6516.837079072966, 6518.087467754518, 6637.435817955527, 6808.353206445379, 6823.658817059227, 6873.140857392826, 6905.654717264017, 6938.444924406136, 6535.248446428532, 6578.605283682803, 6606.0, 6620.040094186413, 6665.200175978914, 6478.708458119301, 6570.737170513126, 6656.167979002625, 6681.432078273207, 6777.1189745332795, 6893.20728116273, 6900.03399524077, 6939.097917270722, 6940.618265995418, 6957.373836354753, 6591.439727623014, 6596.0435736816935, 6678.966605166943, 6690.966545167243, 6700.93299067003, 6305.0, 6588.8023359299295, 6592.143021407186, 6676.499262555425, 6690.330966903271, 6478.578892371981, 6485.383888530582, 6486.740530378732, 6488.837779055561, 6490.707918143789, 6589.934100658932, 6664.000399939854, 6683.899741503784, 6734.023566582916, 6788.287229840796, 6329.145565348619, 6428.614283143026, 6455.741770329134, 6536.379043990813, 6543.770968016097], "value": 6148.350512098522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.1500954017357, 866.0603245478655, 890.9866352004717, 893.004300205271, 894.3471265975837, 39146.41280380789, 39730.60269397305, 39901.60098399015, 41402.17195656085, 41749.37375939363, 42253.78873105638, 42704.35943460851, 42718.35922461165, 42739.14521709572, 42892.57107428925, 7779.727709530153, 7926.841463170733, 7949.523028618272, 7955.72154974576, 7990.400719945998, 7803.0, 7943.721969731032, 7961.562114083723, 7969.641366138509, 7979.7606071817645, 7913.881291780628, 7960.363170946311, 7962.800929976739, 8004.279614834663, 8011.639476223584, 7929.088154862207, 7930.9603451982375, 7954.244346787046, 7962.442629016, 7964.920350796505, 7708.190639982777, 7779.144294127642, 7788.454808163431, 7791.6883324667515, 7793.688252469894, 37999.0, 38247.0, 38297.425538616946, 38374.424383634265, 38382.80808595939, 3521.3485505181366, 3547.2728090741334, 3556.146524834047, 3556.7332450066347, 3557.875474358411, 31213.8439307802, 31249.0, 31301.37397252065, 31335.21661958469, 31340.529892051636, 5031.949680503185, 5167.48325167484, 5244.763985620656, 5245.763940622681, 5260.395054568697, 182816.0, 183616.0, 184025.0, 184429.0, 184570.0, 46535.534644653795, 46568.76715616468, 46616.30075548869, 46672.53327466682, 48507.757461212466, 51864.74067629638, 52060.0, 52105.310522053194, 52112.739436302574, 52127.73936130295, 16417.58956026109, 16546.503604891874, 16567.834321656872, 16585.336586536643, 16874.74687879683, 13572.728545429036, 13632.659183520293, 13635.863641363658, 13701.177929324273, 13701.657458563615, 14581.125132491872, 14666.779998300033, 14715.190664513555, 14818.703625927421, 14960.47638332675, 5683.261176047087, 5757.222774925332, 5761.711914404263, 5808.361080281165, 5952.494038006731, 991.5141580625442, 1001.7095042437611, 1002.8746406699163, 1015.9883430806896, 1017.9796404071877, 22945.31164065081, 23089.422764431023, 23182.840857957035, 23440.413989650053, 23780.405489862547, 1099.7085772270354, 1108.4070022538065, 1113.6325012745774, 1114.9275297105662, 1134.8127558952845, 12441.813372799415, 12548.121631485708, 12564.0, 12672.49310027607, 12729.10896237273, 234171.0, 236922.0, 238269.0, 246096.0, 253730.0, 56854.43145568491, 57063.714681426325, 57138.714306429036, 57321.42678573161, 57331.14003289954, 1441.7332793433247, 1470.624990627383, 1477.1801650084305, 1478.1648368671665, 1483.3250870853735, 26449.603255951562, 27320.863395682893, 27493.17520474389, 27615.86192069027, 27793.861030694716, 36952.0, 37746.0, 37898.62101378951, 37957.62042379541, 38183.618163818006, 209355.0, 209381.0, 209605.0, 209787.0, 210253.0, 34515.0, 34578.48132278068, 34676.0, 34685.306293874484, 34858.12854678552, 43568.34647480227, 43768.78115609529, 43801.34297985597, 43907.34138987982, 44122.558774411846, 30237.697623023487, 30298.69701303047, 30363.696363036972, 30377.544336835406, 30652.693473064985, 30446.84776576103, 30699.2325191872, 30971.69028309778, 31006.0, 31144.688553115084, 35372.11569710778, 35611.28777424385, 35612.28775424529, 35727.64272357243, 35978.82010590035, 30078.54882176813, 30261.697383026767, 30513.0, 30568.700291705813, 31022.379552408373, 23010.07959681594, 23267.534649307257, 23493.647595285744, 23842.64236036426, 23974.640380394656], "value": 17415.754039108913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8993981083404, 573.6070791507815, 573.9311282646086, 574.910888812234, 610.5787006965195, 22163.77836221639, 22830.0, 22853.0, 22878.0, 22979.851007449623, 22311.888440557774, 22577.435564110907, 23152.536949261004, 24383.0, 24701.629475557882, 6372.553921225504, 6488.3187265337165, 6517.902231466532, 6520.804375868732, 6526.216853977529, 6222.782202622909, 6405.0, 6481.31946145655, 6490.0, 6494.31809659986, 6472.2880483147055, 6478.093066970628, 6481.837954051163, 6484.805455836309, 6494.123293355384, 6467.029945508164, 6471.870562588721, 6475.0, 6479.449246814026, 6484.059811327378, 5833.562482813763, 5974.97012514939, 6042.9395706042815, 6046.576739628228, 6061.060535616986, 28370.858145709346, 28959.71040289591, 28969.85515072411, 28971.71028289711, 28995.42009159805, 1967.744193254882, 1994.8603597748163, 1999.5201151723627, 2001.5196352875205, 2001.629698505781, 18598.62802743951, 18960.5259868503, 19262.71105933412, 19290.614187716306, 19354.129064192144, 2420.5279970405777, 2457.2259738182593, 2468.740782217877, 2475.121331927158, 2482.714487833904, 125121.0, 130583.0, 130810.0, 132270.0, 137213.3139334307, 14328.224075091159, 14412.752912323727, 14588.0, 14643.853561464462, 15086.849131508545, 21932.89033554822, 22215.555688886456, 22229.0, 22236.0, 22400.215992440186, 9827.705168844946, 9891.851622225673, 9937.155341795884, 9941.80116397668, 9979.401235925867, 9037.819243615222, 9170.633174672937, 9255.213306868991, 9260.953695231481, 9272.119148680864, 8738.475691458532, 8775.736727898173, 8776.60505277264, 8856.778580535409, 9063.954680226556, 2695.272276485377, 2711.3492761737043, 2785.7075007124367, 2826.1662809471254, 2828.43431313734, 962.6101428921298, 966.9758256043655, 988.3625061835077, 988.6935050134338, 999.4453078541334, 18702.71945920812, 18881.527961801065, 19012.61974760497, 19205.711914321295, 19502.414927552196, 1049.5014867937668, 1051.6161601015574, 1051.805415998043, 1055.350959160111, 1060.0724366179593, 10453.477326133814, 10601.0, 10684.412357320267, 10720.0, 10994.395308258123, 476964.0, 481125.0, 481898.0, 522052.0, 523809.0, 111833.0, 114548.42725786318, 115867.42066289783, 116466.0, 118485.40757296159, 1051.3324039234988, 1106.8339749037548, 1106.9944650276698, 1170.7716995186026, 1196.461592283476, 19803.40589782309, 19857.60284794267, 19971.500712481724, 20028.499287517927, 20230.08964596626, 53964.0, 54591.181132282254, 55319.446805533036, 55962.440375595725, 57166.7141664289, 71821.28178718146, 71829.0, 71938.64030680023, 72117.0, 72999.63500182464, 14111.717765644835, 14409.207493587954, 14435.566932992027, 14505.347259373564, 14518.709625807214, 22383.32850014502, 22656.886715566317, 22794.658080129142, 22853.314400568008, 23014.884925575265, 17828.286868525633, 18171.636567268844, 18241.817581824012, 18264.26942922268, 18272.0, 15560.922195389403, 15809.920950395635, 15871.0, 16326.18369081565, 16351.59121021984, 18681.159347829653, 18713.0, 18749.437516874517, 18970.146343414304, 18977.146028428477, 13981.790273146114, 14046.227457489937, 14047.08693934891, 14050.508232211823, 14134.363953622318, 17866.821331786516, 17986.19062142233, 18126.637467250846, 18161.909190453964, 18179.091045447938], "value": 11819.700873076301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.6431395680145, 1398.6503374156455, 1424.9811384859822, 1425.287356321839, 1428.7356838984786, 15032.398704051839, 15596.610084747887, 15597.0, 15606.843931560667, 15670.608234794121, 15232.466863659774, 15360.84639153608, 15373.69252614947, 15377.154256515887, 15393.23033848306, 2668.0528412413605, 2695.1644990053096, 2707.56678931371, 2720.102366219143, 2744.300203448118, 2714.7285271472792, 2728.113363156982, 2735.3571910600995, 2755.0081970490605, 2755.2423083651956, 2742.8491432971177, 2828.0243316055926, 2828.0384669212463, 2828.6464191976, 2832.5326321156986, 2749.628800111979, 2759.765419939308, 2791.330080780618, 2799.7900157488166, 2802.5515917453313, 2560.577504711739, 2628.47430513898, 2754.848483333416, 2761.986190069057, 2763.557830747091, 14968.850311496855, 15026.398944042225, 15038.248087595686, 15040.924795376062, 15097.849021509754, 7767.883481747778, 8050.758477245633, 8052.235037671412, 8104.797380065486, 8114.3914206434165, 5056.974715126437, 5124.795008199668, 5205.661631993946, 5276.472352764693, 5302.575793936476, 1751.6409136127063, 1756.0692832798636, 1788.5707430216785, 1795.8922464652162, 1814.292425953879, 26143.346416339555, 26771.46457070867, 26834.329141771417, 26837.194884153505, 26904.730952690417, 6792.422644075309, 6900.6204658743245, 7065.43476521877, 7176.425885929113, 7200.351968322876, 20230.393088207376, 20239.392818215478, 20253.59492810165, 20256.088476018616, 20262.0, 7989.520628762293, 8107.270345668918, 8111.229433203955, 8112.878306825402, 8123.634436450374, 7112.786616401516, 7169.175544812413, 7205.4595905307315, 7213.098362704662, 7232.74685386009, 5554.1946417770005, 5743.052396354638, 5750.712464376765, 5798.188253644493, 5848.093545500455, 1766.8586513078924, 1802.12596890508, 1802.711566149436, 1851.5186051626404, 1858.4610462965588, 866.6230189867427, 884.1644645809777, 890.5369208011798, 900.4597241655085, 906.2342320738965, 7125.608091555015, 7193.3166349196745, 7271.709131634675, 7320.707171713072, 7327.523710958771, 715.6529083394549, 717.1358512991936, 721.1742554774859, 721.4156533208118, 721.95307305025, 4813.374261346003, 5281.419043905167, 5289.603279754034, 5338.225957236179, 5369.7583608737705, 21015.78984210169, 21501.849815018686, 21883.452913676967, 21883.562328753334, 21885.124595016023, 19988.0, 21322.253721119687, 21452.78547214539, 21455.28357731409, 21837.563248735256, 11060.115190784878, 11098.334099954029, 11127.721806954729, 11148.832767508495, 11186.664400068012, 7868.960655196687, 7934.519501908924, 8031.237032481905, 8039.236272554098, 8120.675172993014, 18092.276308947494, 18442.815571844647, 18638.81361186371, 18729.531761706065, 19009.42971710851, 18458.907705461388, 19197.90401047986, 19219.23123075117, 19353.709694354315, 19443.611127777647, 11324.94337528307, 11529.82705259405, 11531.192816502764, 11552.826707599224, 11734.295942243492, 13736.244506552235, 13812.102213356502, 13854.445822167001, 13926.860731392962, 13941.790873136708, 10350.482475876026, 10468.424236667057, 10483.37099774016, 10545.578176873147, 10758.677239682822, 10033.899661003297, 10134.746631334276, 10141.797164056825, 10249.641262555775, 10443.582256709951, 9388.765280868032, 9590.08894155054, 9596.472194029395, 9608.855867162138, 9641.228701703987, 7365.631718413951, 7434.553926764412, 7435.219301973215, 7484.70061197546, 7506.28690274423, 6816.0, 6846.657667116525, 6887.139107611549, 6890.207626122859, 6958.373746362851], "value": 6640.25060697409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.9875753106174, 508.63886640485254, 526.3731797499976, 531.0414701463859, 533.7704786941615, 6395.328490508499, 6399.968000159998, 6404.199475065617, 6429.485641148697, 6478.74085036598, 6297.433231009209, 6298.433141017307, 6351.618902865831, 6359.3958573935515, 6374.968125159379, 5241.10901146804, 5247.580193584504, 5278.392984806758, 5278.973605131969, 5291.788328466857, 4860.854174374775, 5062.620303477254, 5187.584993200535, 5228.2680424740565, 5277.815276465324, 4987.925181122286, 5009.918899876568, 5037.924431133536, 5039.118154322997, 5049.3435853339015, 4971.558248108045, 5009.398872135331, 5038.622103342264, 5043.823466178666, 5043.823466178685, 4414.779261036967, 4448.288273876165, 4456.554344565518, 4481.439820022497, 4482.686211965164, 6092.908606370908, 6129.172561704202, 6205.875882482325, 6225.315215326311, 6230.162102179868, 5731.455511726379, 5749.770009199627, 5773.971130144364, 5785.074388097926, 5809.564282678816, 6604.339566043357, 6636.6726654669255, 6670.4997125215805, 6671.833204169886, 6714.690635326114, 4620.353150558924, 4911.8772030699165, 4940.851774446736, 4954.777035033432, 4977.477364876709, 6830.497290596061, 6832.3509266620085, 6989.7553585624255, 7014.158301003861, 7106.964465177641, 5519.365272993577, 5550.0, 5558.722063896789, 5580.386157522669, 5613.298337707786, 5557.972210139004, 5648.293963254593, 5672.461116193955, 5683.403242659461, 5688.77244910199, 6112.6552158525055, 6121.490189022568, 6135.294441139326, 6136.0, 6146.879326632305, 6812.659367031728, 6851.417629501449, 6876.862462750717, 6898.379145876795, 6908.412784913338, 1934.8355389792025, 1962.107241205248, 1970.1331414178003, 1973.4967583266175, 1978.2779285560666, 1406.2476575032308, 1425.536700572318, 1437.5399872040846, 1445.8265008198873, 1475.5204558518524, 5774.797882074107, 5783.274558187364, 5794.565407594448, 5795.217645617872, 5822.534197264209, 6823.965880170567, 6840.144981877265, 6899.448044156456, 6901.480245074948, 6927.238003819576, 5793.175149827791, 5810.622309549865, 5826.533877289807, 5841.970790146107, 5867.911981320283, 3620.0, 3625.3836847735947, 3628.020434482675, 3647.6352364763843, 3657.140571965586, 6599.406053455116, 6604.1414616100565, 6631.0, 6646.169228846395, 6659.167604049494, 6987.580745155307, 7039.894401583981, 7049.330313620198, 7067.929320706727, 7070.964645176741, 6570.8028759137305, 6601.151677530299, 6615.900761488678, 6632.43624291931, 6644.302348253461, 6808.251092379735, 6825.590464572141, 6850.486213533905, 6860.0, 6875.4155896749335, 6761.830954226184, 6774.288699686462, 6780.220274668279, 6818.931810682028, 6838.350356716104, 6467.288598254094, 6543.574667646588, 6562.770303039561, 6580.539362244597, 6596.0, 5529.834104976857, 5551.805686800943, 5556.194351819045, 5561.721913904369, 5566.137248726453, 6531.836704082246, 6567.211934567882, 6637.601743895381, 6714.630695311609, 6950.895736564057, 6503.154589903283, 6551.868962620625, 6575.835604109936, 6578.703958321791, 6606.8678626426245, 6484.610923344614, 6555.311692272434, 6558.1802274715665, 6567.343265673586, 6575.30959249291, 6440.806775796734, 6461.386168314003, 6536.921407967822, 6560.442362399059, 6590.736370545124, 6586.473082153512, 6606.8348291293105, 6609.537332386687, 6720.110352548451, 6724.865502689821, 6429.22849258092, 6500.642464664489, 6504.707288172138, 6519.967400162969, 6551.475881929339], "value": 5221.010616400004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.2452077994101, 914.6524320758112, 924.8751418558497, 926.9304802139841, 938.8826396700413, 18406.447806565808, 19137.61724765504, 19183.616327673437, 19187.712184317246, 19231.519212019688, 17367.47897563072, 17446.1276936153, 17760.200790964405, 18235.179416926236, 18587.628247435045, 930.0281206139583, 938.8169306985106, 938.9906100939006, 939.0421769794805, 939.7791518993031, 991.1278075293767, 993.1657407777466, 993.4982833668987, 993.5479356892597, 994.0457161125329, 1004.6584161385127, 1030.1449796668746, 1040.8438734189895, 1041.640633981279, 1041.7603951091253, 1027.964021259256, 1029.5881647341048, 1030.006044167382, 1030.0574973898874, 1032.385730490357, 715.8103102677794, 735.2169939014932, 745.9403247740167, 748.8652042632324, 753.408574269196, 19305.903470482557, 19478.513037174183, 19530.0, 19544.12051457688, 19554.413367598994, 18838.905805471022, 18875.622487550172, 19322.71015934762, 19469.318573849847, 19517.414477565697, 17134.40029598958, 17155.39956101543, 17255.913720431443, 17270.56823579408, 17420.47738567845, 3734.2344819311975, 3751.81240937952, 3752.8311225994894, 3753.230587729536, 3758.229562939618, 144980.0, 146458.26770866077, 147825.0, 148182.0, 148269.0, 16484.83515164833, 16629.91685041567, 16780.748288775678, 16789.6642067158, 16803.663926721398, 30441.0, 31020.68979310178, 31082.84458577738, 31315.373692526024, 31345.216369590486, 7941.404394670423, 7992.120866704658, 8013.19868013194, 8019.839603207904, 8034.718784842503, 4022.35642297231, 4056.533498647634, 4157.521884983265, 4179.895502612459, 4210.59999300066, 5418.945810541923, 5548.140038294071, 5567.66594004361, 5585.776568937278, 5600.327960644749, 1034.4775888176423, 1091.5524634899652, 1120.5461787975883, 1128.966131016071, 1129.5425352732157, 701.4318402094218, 704.1374316462293, 718.8885722712988, 718.989215161773, 728.8615163118991, 11960.282383057045, 12514.972450690773, 12667.873321266854, 12673.93663031679, 13189.0, 680.1803826389189, 682.8088135322117, 688.5008368932483, 698.8602279544111, 707.8195060259601, 5538.418466061005, 5554.166874968706, 5617.775288988395, 5629.8592535186945, 5681.147827825776, 125700.0, 126269.0, 126569.0, 128132.0, 131097.0, 112416.06543771092, 114825.0, 115106.0, 117216.41391792987, 118856.4057179726, 92554.0, 93402.53298733463, 96771.51614242025, 97500.51249743848, 99334.00665993392, 10314.48427578603, 10356.378617282988, 10479.318844275098, 10492.52783624754, 10596.205284603531, 44729.77635111804, 45156.77421612871, 45159.096818064114, 45214.54785452235, 45480.0, 56896.0, 57387.71306143443, 57625.423745763685, 58429.0, 59648.0, 13497.932510337385, 13742.106763060368, 13816.378262977989, 13881.930590346983, 13893.930530347283, 18206.0, 18381.0, 18446.26214951387, 18472.261109555468, 18574.814251857308, 15449.613759656098, 15505.689886201988, 15523.0, 15612.92193539025, 15656.92171539135, 16790.496285111465, 16852.0, 16880.0, 16917.49247522527, 17000.74498882493, 16824.747628785823, 16833.91583042077, 16837.66324673475, 16857.157142142598, 16945.06802125895, 12393.388859448214, 12746.617601471971, 12862.871371286541, 12947.805782913452, 12952.222866628032, 12054.51781928713, 12277.140600157903, 12372.752544948871, 12511.624651260478, 12602.55891043809], "value": 8977.384045114637, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 108.0, 107.0, 109.0, 109.0, 110.0, 109.0, 107.0, 113.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 120.0, 118.0, 142.0, 118.0, 120.0, 119.0, 118.0, 117.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 162.0, 163.0, 161.0, 164.0, 169.0, 171.0, 166.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 75.0, 84.0, 74.0, 75.0, 75.0, 75.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 82.0, 79.0, 79.0, 134.0, 79.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 110.0, 115.0, 113.0, 113.0, 114.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 153.0, 148.0, 148.0, 148.0, 150.0, 151.0, 150.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 52.0, 52.0, 52.0, 51.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 39.0, 38.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 75.0, 74.0, 76.0, 75.0, 75.0, 78.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 112.0, 115.0, 112.0, 125.0, 115.0, 120.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 168.0, 167.0, 168.0, 170.0, 175.0, 168.0, 173.0, 171.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 68.0], "value": 65.2, "unit": "score"}]}]} 23:40:02 INFO - Return code: 0 23:40:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:40:02 INFO - # TBPL SUCCESS # 23:40:02 INFO - Running post-action listener: _package_coverage_data 23:40:02 INFO - Running post-action listener: _resource_record_post_action 23:40:02 INFO - [mozharness: 2017-09-14 06:40:02.669582Z] Finished run-tests step (success) 23:40:02 INFO - Running post-run listener: _resource_record_post_run 23:40:02 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 700416; Write bytes: 337973248; Read time: 288; Write time: 260088 23:40:02 INFO - TinderboxPrint: CPU usage
13.1% 23:40:02 INFO - TinderboxPrint: I/O read bytes / time
700,416 / 288 23:40:02 INFO - TinderboxPrint: I/O write bytes / time
337,973,248 / 260,088 23:40:02 INFO - TinderboxPrint: CPU idle
8,226.6 (86.9%) 23:40:02 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 23:40:02 INFO - TinderboxPrint: Swap in / out
0 / 0 23:40:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12607488; Read time: 0; Write time: 2220 23:40:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:40:02 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 700416; Write bytes: 325365760; Read time: 288; Write time: 257868 23:40:03 INFO - Running post-run listener: _upload_blobber_files 23:40:03 INFO - Blob upload gear active. 23:40:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:40:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:40:03 INFO - (blobuploader) - INFO - Open directory for files ... 23:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 23:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 23:40:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:04 INFO - (blobuploader) - INFO - Done attempting. 23:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:11 INFO - (blobuploader) - INFO - Done attempting. 23:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:40:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:12 INFO - (blobuploader) - INFO - Done attempting. 23:40:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 23:40:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:40:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:40:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 23:40:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:40:13 INFO - (blobuploader) - INFO - Done attempting. 23:40:13 INFO - (blobuploader) - INFO - Iteration through files over. 23:40:13 INFO - Return code: 0 23:40:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:40:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:40:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad89c2adc2a52719e8e61cc15f26a445a43e27822f9984c50712030a298fb205e89ed0440731bf910fa4444ab30f1f144820b3ad8a02c2835ce8d309e194de1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d60ecd6cc48bb918b876b08554fc0722677967e40aa68050a08ae4e49ac936c84cf3d012b11287778ab63d32c425cd1200fa70d177e93ab9dba0fa307e6b3bc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99bf9dadf0ab5f0eddbb09db3786d4645a62717bb2a721c8c542ffdf4b876032636fe9bafc4ad501fcca1f7b6472ad303c7edb2042799acbfaeb64c378f15eb4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d774aa85d886690cd7511af05e06dc767ee593b991b596d9f6e57f01c10c558e0834380726edb083593ecbb45dc9c573a4d41ae33ab72abfb23bb44914d7f40"} 23:40:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:40:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:40:13 INFO - Contents: 23:40:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad89c2adc2a52719e8e61cc15f26a445a43e27822f9984c50712030a298fb205e89ed0440731bf910fa4444ab30f1f144820b3ad8a02c2835ce8d309e194de1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d60ecd6cc48bb918b876b08554fc0722677967e40aa68050a08ae4e49ac936c84cf3d012b11287778ab63d32c425cd1200fa70d177e93ab9dba0fa307e6b3bc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99bf9dadf0ab5f0eddbb09db3786d4645a62717bb2a721c8c542ffdf4b876032636fe9bafc4ad501fcca1f7b6472ad303c7edb2042799acbfaeb64c378f15eb4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d774aa85d886690cd7511af05e06dc767ee593b991b596d9f6e57f01c10c558e0834380726edb083593ecbb45dc9c573a4d41ae33ab72abfb23bb44914d7f40"} 23:40:13 INFO - Running post-run listener: copy_logs_to_upload_dir 23:40:13 INFO - Copying logs to upload dir... 23:40:13 INFO - mkdir: /builds/slave/test/build/upload/logs 23:40:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.013877 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 23:40:13.476378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:13.479557) ========= 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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 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/5ad89c2adc2a52719e8e61cc15f26a445a43e27822f9984c50712030a298fb205e89ed0440731bf910fa4444ab30f1f144820b3ad8a02c2835ce8d309e194de1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d60ecd6cc48bb918b876b08554fc0722677967e40aa68050a08ae4e49ac936c84cf3d012b11287778ab63d32c425cd1200fa70d177e93ab9dba0fa307e6b3bc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99bf9dadf0ab5f0eddbb09db3786d4645a62717bb2a721c8c542ffdf4b876032636fe9bafc4ad501fcca1f7b6472ad303c7edb2042799acbfaeb64c378f15eb4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d774aa85d886690cd7511af05e06dc767ee593b991b596d9f6e57f01c10c558e0834380726edb083593ecbb45dc9c573a4d41ae33ab72abfb23bb44914d7f40"} build_url:https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/Zv5HYUSPS56G-8wZXuIJvw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ad89c2adc2a52719e8e61cc15f26a445a43e27822f9984c50712030a298fb205e89ed0440731bf910fa4444ab30f1f144820b3ad8a02c2835ce8d309e194de1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d60ecd6cc48bb918b876b08554fc0722677967e40aa68050a08ae4e49ac936c84cf3d012b11287778ab63d32c425cd1200fa70d177e93ab9dba0fa307e6b3bc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/99bf9dadf0ab5f0eddbb09db3786d4645a62717bb2a721c8c542ffdf4b876032636fe9bafc4ad501fcca1f7b6472ad303c7edb2042799acbfaeb64c378f15eb4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d774aa85d886690cd7511af05e06dc767ee593b991b596d9f6e57f01c10c558e0834380726edb083593ecbb45dc9c573a4d41ae33ab72abfb23bb44914d7f40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:13.508079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:13.508413) ========= 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=8c32c1c60be582960b75045f000001c1-1505363855.183078-349095720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:40:13.591156) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:40:13.591482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:40:13.591803) ========= ========= Total master_lag: 0.28 =========