builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-079 starttime: 1505371582.61 results: success (0) revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.610707) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.611133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.611441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.636724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.637015) ========= 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=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 23:46:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.5M=0s 2017-09-13 23:46:22 (86.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078428 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.732410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.732761) ========= 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=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.782357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:22.782727) ========= 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=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 23:46:22,874 truncating revision to first 12 chars 2017-09-13 23:46:22,874 Setting DEBUG logging. 2017-09-13 23:46:22,874 attempt 1/10 2017-09-13 23:46:22,874 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:46:23,339 unpacking tar archive at: mozilla-central-cb717386aec8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:23.594678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:23.595025) ========= script_repo_revision: cb717386aec8601a301babd4156aabc4cccff0b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:23.595466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:23.595768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:46:23.609093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-13 23:46:23.609419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:46:23 INFO - MultiFileLogger online at 20170913 23:46:23 in /builds/slave/test 23:46:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:46:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:46:23 INFO - {'append_to_log': False, 23:46:23 INFO - 'base_work_dir': '/builds/slave/test', 23:46:23 INFO - 'blob_upload_branch': 'Firefox', 23:46:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:46:23 INFO - 'branch': 'Firefox', 23:46:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:46:23 INFO - 'code_coverage': False, 23:46:23 INFO - 'config_files': ('talos/linux_config.py',), 23:46:23 INFO - 'default_actions': ('clobber', 23:46:23 INFO - 'read-buildbot-config', 23:46:23 INFO - 'download-and-extract', 23:46:23 INFO - 'populate-webroot', 23:46:23 INFO - 'create-virtualenv', 23:46:23 INFO - 'install', 23:46:23 INFO - 'setup-mitmproxy', 23:46:23 INFO - 'run-tests'), 23:46:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:46:23 INFO - 'disable_ccov_upload': False, 23:46:23 INFO - 'disable_stylo': False, 23:46:23 INFO - 'download_minidump_stackwalk': True, 23:46:23 INFO - 'download_symbols': 'ondemand', 23:46:23 INFO - 'enable_stylo': False, 23:46:23 INFO - 'enable_webrender': False, 23:46:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 23:46:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:46:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:46:23 INFO - 'gecko_profile': False, 23:46:23 INFO - 'gecko_profile_interval': 0, 23:46:23 INFO - 'installer_path': 'installer.exe', 23:46:23 INFO - 'log_level': 'info', 23:46:23 INFO - 'log_name': 'talos', 23:46:23 INFO - 'log_to_console': True, 23:46:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:46:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:46:23 INFO - 'opt_config_files': (), 23:46:23 INFO - 'pip_index': False, 23:46:23 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 23:46:23 INFO - 'system_bits': '32', 23:46:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:46:23 INFO - 'title': 'talos-linux64-ix-079', 23:46:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:46:23 INFO - 'use_talos_json': True, 23:46:23 INFO - 'verify': 'False', 23:46:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:46:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:46:23 INFO - 'work_dir': 'build'} 23:46:23 INFO - [mozharness: 2017-09-14 06:46:23.842252Z] Running clobber step. 23:46:23 INFO - Running pre-action listener: _resource_record_pre_action 23:46:23 INFO - Running main action method: clobber 23:46:23 INFO - rmtree: /builds/slave/test/build 23:46:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:46:25 INFO - Running post-action listener: _resource_record_post_action 23:46:25 INFO - [mozharness: 2017-09-14 06:46:25.338512Z] Finished clobber step (success) 23:46:25 INFO - [mozharness: 2017-09-14 06:46:25.338610Z] Running read-buildbot-config step. 23:46:25 INFO - Running pre-action listener: _resource_record_pre_action 23:46:25 INFO - Running main action method: read_buildbot_config 23:46:25 INFO - Using buildbot properties: 23:46:25 INFO - { 23:46:25 INFO - "project": "", 23:46:25 INFO - "product": "firefox", 23:46:25 INFO - "who": "jdolske@mozilla.com", 23:46:25 INFO - "installer_path": "public/build/target.tar.bz2", 23:46:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 23:46:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:46:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 23:46:25 INFO - "stage_platform": "linux64-pgo", 23:46:25 INFO - "basedir": "/builds/slave/test", 23:46:25 INFO - "buildnumber": 15, 23:46:25 INFO - "platform": "ubuntu64_hw", 23:46:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:46:25 INFO - "slavebuilddir": "test", 23:46:25 INFO - "taskId": "VtGNF96RToqr-hoR-wQ25g", 23:46:25 INFO - "branch": "mozilla-central", 23:46:25 INFO - "script_repo_revision": "production", 23:46:25 INFO - "revision": "cb717386aec8601a301babd4156aabc4cccff0b0", 23:46:25 INFO - "slavename": "talos-linux64-ix-079", 23:46:25 INFO - "repo_path": "mozilla-central" 23:46:25 INFO - } 23:46:25 INFO - Finding installer, test and symbols from parent task. 23:46:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VtGNF96RToqr-hoR-wQ25g'}, attempt #1 23:46:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VtGNF96RToqr-hoR-wQ25g'}, attempt #1 23:46:26 INFO - Task dependencies: Jpw2lK2MQ5ysikvcV-Flhw 23:46:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw'}, attempt #1 23:46:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 23:46:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.test_packages.json 23:46:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.crashreporter-symbols.zip 23:46:26 INFO - Running post-action listener: _resource_record_post_action 23:46:26 INFO - [mozharness: 2017-09-14 06:46:26.895727Z] Finished read-buildbot-config step (success) 23:46:26 INFO - [mozharness: 2017-09-14 06:46:26.895943Z] Running download-and-extract step. 23:46:26 INFO - Running pre-action listener: _resource_record_pre_action 23:46:26 INFO - Running main action method: download_and_extract 23:46:26 INFO - mkdir: /builds/slave/test/build/tests 23:46:26 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:46:26 INFO - trying https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.test_packages.json 23:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:46:27 INFO - Downloaded 989 bytes. 23:46:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:46:27 INFO - Using the following test package requirements: 23:46:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:46:27 INFO - u'common': [u'target.common.tests.zip'], 23:46:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:46:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:46:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:46:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:46:27 INFO - u'mozbase': [u'target.common.tests.zip'], 23:46:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:46:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:46:27 INFO - u'web-platform': [u'target.common.tests.zip', 23:46:27 INFO - u'target.web-platform.tests.tar.gz'], 23:46:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:46:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 23:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.common.tests.zip 23:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.common.tests.zip into memory 23:46:28 INFO - Content-Length response header: 55170781 23:46:28 INFO - Bytes received: 55170781 23:46:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.talos.tests.zip 23:46:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:46:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.talos.tests.zip into memory 23:46:40 INFO - Content-Length response header: 14500356 23:46:40 INFO - Bytes received: 14500356 23:46:40 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:46:40 INFO - trying https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 23:46:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:46:41 INFO - Downloaded 62203452 bytes. 23:46:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 23:46:41 INFO - mkdir: /builds/slave/test/properties 23:46:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:46:41 INFO - Writing to file /builds/slave/test/properties/build_url 23:46:41 INFO - Contents: 23:46:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 23:46:41 INFO - Running post-action listener: _resource_record_post_action 23:46:41 INFO - Running post-action listener: find_tests_for_verification 23:46:41 INFO - Running post-action listener: set_extra_try_arguments 23:46:41 INFO - [mozharness: 2017-09-14 06:46:41.959336Z] Finished download-and-extract step (success) 23:46:41 INFO - [mozharness: 2017-09-14 06:46:41.959499Z] Running populate-webroot step. 23:46:41 INFO - Running pre-action listener: _resource_record_pre_action 23:46:41 INFO - Running main action method: populate_webroot 23:46:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:46:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['tresize', 23:46:41 INFO - 'tcanvasmark']}, 23:46:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:46:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['dromaeo_css', 23:46:41 INFO - 'kraken']}, 23:46:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:46:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'tests': ['damp', 'tps']}, 23:46:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['damp', 'tps']}, 23:46:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:46:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['dromaeo_dom']}, 23:46:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:46:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['basic_compositor_video', 23:46:41 INFO - 'glvideo']}, 23:46:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:46:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['ts_paint_webext', 23:46:41 INFO - 'tp5o_webext']}, 23:46:41 INFO - 'other-e10s': {'tests': ['a11yr', 23:46:41 INFO - 'ts_paint', 23:46:41 INFO - 'tpaint', 23:46:41 INFO - 'sessionrestore', 23:46:41 INFO - 'sessionrestore_many_windows', 23:46:41 INFO - 'sessionrestore_no_auto_restore', 23:46:41 INFO - 'tabpaint']}, 23:46:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['a11yr', 23:46:41 INFO - 'ts_paint', 23:46:41 INFO - 'tpaint', 23:46:41 INFO - 'sessionrestore', 23:46:41 INFO - 'sessionrestore_many_windows', 23:46:41 INFO - 'sessionrestore_no_auto_restore', 23:46:41 INFO - 'tabpaint']}, 23:46:41 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:46:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:46:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['bloom_basic_singleton']}, 23:46:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['bloom_basic']}, 23:46:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:46:41 INFO - 'tsvgr_opacity', 23:46:41 INFO - 'tart', 23:46:41 INFO - 'tscrollx', 23:46:41 INFO - 'tsvg_static']}, 23:46:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['tsvgx', 23:46:41 INFO - 'tsvgr_opacity', 23:46:41 INFO - 'tart', 23:46:41 INFO - 'tscrollx', 23:46:41 INFO - 'tsvg_static']}, 23:46:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:46:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo'], 23:46:41 INFO - 'tests': ['tp5o']}, 23:46:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:46:41 INFO - 'talos_options': ['--mitmproxy', 23:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:46:41 INFO - '--firstNonBlankPaint'], 23:46:41 INFO - 'tests': ['tp6_google', 23:46:41 INFO - 'tp6_youtube', 23:46:41 INFO - 'tp6_amazon', 23:46:41 INFO - 'tp6_facebook']}, 23:46:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo', 23:46:41 INFO - '--mitmproxy', 23:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:46:41 INFO - '--firstNonBlankPaint'], 23:46:41 INFO - 'tests': ['tp6_google', 23:46:41 INFO - 'tp6_youtube', 23:46:41 INFO - 'tp6_amazon', 23:46:41 INFO - 'tp6_facebook']}, 23:46:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:46:41 INFO - 'talos_options': ['--stylo-threads=1', 23:46:41 INFO - '--mitmproxy', 23:46:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:46:41 INFO - '--firstNonBlankPaint'], 23:46:41 INFO - 'tests': ['tp6_google', 23:46:41 INFO - 'tp6_youtube', 23:46:41 INFO - 'tp6_amazon', 23:46:41 INFO - 'tp6_facebook']}, 23:46:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--xperf_path', 23:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:41 INFO - 'tests': ['tp5n']}, 23:46:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:46:41 INFO - 'talos_options': ['--disable-stylo', 23:46:41 INFO - '--xperf_path', 23:46:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:46:41 INFO - 'tests': ['tp5n']}}} 23:46:41 INFO - Running post-action listener: _resource_record_post_action 23:46:41 INFO - [mozharness: 2017-09-14 06:46:41.980774Z] Finished populate-webroot step (success) 23:46:41 INFO - [mozharness: 2017-09-14 06:46:41.980879Z] Running create-virtualenv step. 23:46:41 INFO - Running pre-action listener: _resource_record_pre_action 23:46:41 INFO - Running main action method: create_virtualenv 23:46:41 INFO - Creating virtualenv /builds/slave/test/build/venv 23:46:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:46:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 23:46:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:46:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:46:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:46:42 INFO - Installing distribute.............................................................................................................................................................................................done. 23:46:42 INFO - Installing pip...............done. 23:46:42 INFO - Return code: 0 23:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:46:42 INFO - Reading from file tmpfile_stdout 23:46:42 INFO - Output received: 23:46:42 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:46:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:46:42 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:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:42 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:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:42 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:42 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:46:42 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:46:42 INFO - Using env: {'DISPLAY': ':0', 23:46:42 INFO - 'HOME': '/home/cltbld', 23:46:42 INFO - 'LANG': 'en_US.UTF-8', 23:46:42 INFO - 'LANGUAGE': 'en_US:en', 23:46:42 INFO - 'LOGNAME': 'cltbld', 23:46:42 INFO - 'MAIL': '/var/mail/cltbld', 23:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:42 INFO - 'MOZ_NO_REMOTE': '1', 23:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:42 INFO - 'NO_EM_RESTART': '1', 23:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:42 INFO - 'PWD': '/builds/slave/test', 23:46:42 INFO - 'SHELL': '/bin/bash', 23:46:42 INFO - 'SHLVL': '1', 23:46:42 INFO - 'TERM': 'linux', 23:46:42 INFO - 'TMOUT': '86400', 23:46:42 INFO - 'USER': 'cltbld', 23:46:42 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:42 INFO - '_': '/tools/buildbot/bin/python'} 23:46:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:46:44 INFO - Downloading/unpacking pip>=1.5 23:46:44 INFO - Running setup.py egg_info for package pip 23:46:44 INFO - warning: no files found matching 'pip/cacert.pem' 23:46:44 INFO - warning: no files found matching '*.html' under directory 'docs' 23:46:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:46:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:46:44 INFO - Installing collected packages: pip 23:46:44 INFO - Found existing installation: pip 1.1 23:46:44 INFO - Uninstalling pip: 23:46:44 INFO - Successfully uninstalled pip 23:46:44 INFO - Running setup.py install for pip 23:46:44 INFO - warning: no files found matching 'pip/cacert.pem' 23:46:44 INFO - warning: no files found matching '*.html' under directory 'docs' 23:46:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:46:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:46:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 23:46:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 23:46:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 23:46:44 INFO - Successfully installed pip 23:46:44 INFO - Cleaning up... 23:46:44 INFO - Return code: 0 23:46:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:46:44 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:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:44 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:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:44 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:44 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:46:44 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:46:44 INFO - Using env: {'DISPLAY': ':0', 23:46:44 INFO - 'HOME': '/home/cltbld', 23:46:44 INFO - 'LANG': 'en_US.UTF-8', 23:46:44 INFO - 'LANGUAGE': 'en_US:en', 23:46:44 INFO - 'LOGNAME': 'cltbld', 23:46:44 INFO - 'MAIL': '/var/mail/cltbld', 23:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:44 INFO - 'MOZ_NO_REMOTE': '1', 23:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:44 INFO - 'NO_EM_RESTART': '1', 23:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:44 INFO - 'PWD': '/builds/slave/test', 23:46:44 INFO - 'SHELL': '/bin/bash', 23:46:44 INFO - 'SHLVL': '1', 23:46:44 INFO - 'TERM': 'linux', 23:46:44 INFO - 'TMOUT': '86400', 23:46:44 INFO - 'USER': 'cltbld', 23:46:44 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:44 INFO - '_': '/tools/buildbot/bin/python'} 23:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:44 INFO - Downloading/unpacking psutil>=3.1.1 23:46:44 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:46:44 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:46:44 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:46:44 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:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:46:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:45 INFO - Installing collected packages: psutil 23:46:45 INFO - Running setup.py install for psutil 23:46:45 INFO - building 'psutil._psutil_linux' extension 23:46:45 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:46:45 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:46:45 INFO - building 'psutil._psutil_posix' extension 23:46:45 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:46:46 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:46:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:46:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:46:46 INFO - Successfully installed psutil 23:46:46 INFO - Cleaning up... 23:46:46 INFO - Return code: 0 23:46:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:46:46 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:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:46 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:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:46 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:46 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:46:46 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:46:46 INFO - Using env: {'DISPLAY': ':0', 23:46:46 INFO - 'HOME': '/home/cltbld', 23:46:46 INFO - 'LANG': 'en_US.UTF-8', 23:46:46 INFO - 'LANGUAGE': 'en_US:en', 23:46:46 INFO - 'LOGNAME': 'cltbld', 23:46:46 INFO - 'MAIL': '/var/mail/cltbld', 23:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:46 INFO - 'MOZ_NO_REMOTE': '1', 23:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:46 INFO - 'NO_EM_RESTART': '1', 23:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:46 INFO - 'PWD': '/builds/slave/test', 23:46:46 INFO - 'SHELL': '/bin/bash', 23:46:46 INFO - 'SHLVL': '1', 23:46:46 INFO - 'TERM': 'linux', 23:46:46 INFO - 'TMOUT': '86400', 23:46:46 INFO - 'USER': 'cltbld', 23:46:46 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:46 INFO - '_': '/tools/buildbot/bin/python'} 23:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:46:46 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:46:46 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:46:46 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:46:46 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:46:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:46:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:46:47 INFO - Installing collected packages: mozsystemmonitor 23:46:47 INFO - Running setup.py install for mozsystemmonitor 23:46:47 INFO - Successfully installed mozsystemmonitor 23:46:47 INFO - Cleaning up... 23:46:48 INFO - Return code: 0 23:46:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:46: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:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46: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:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:46:48 INFO - Using env: {'DISPLAY': ':0', 23:46:48 INFO - 'HOME': '/home/cltbld', 23:46:48 INFO - 'LANG': 'en_US.UTF-8', 23:46:48 INFO - 'LANGUAGE': 'en_US:en', 23:46:48 INFO - 'LOGNAME': 'cltbld', 23:46:48 INFO - 'MAIL': '/var/mail/cltbld', 23:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:48 INFO - 'MOZ_NO_REMOTE': '1', 23:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:48 INFO - 'NO_EM_RESTART': '1', 23:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:48 INFO - 'PWD': '/builds/slave/test', 23:46:48 INFO - 'SHELL': '/bin/bash', 23:46:48 INFO - 'SHLVL': '1', 23:46:48 INFO - 'TERM': 'linux', 23:46:48 INFO - 'TMOUT': '86400', 23:46:48 INFO - 'USER': 'cltbld', 23:46:48 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:48 INFO - '_': '/tools/buildbot/bin/python'} 23:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:48 INFO - Downloading/unpacking jsonschema==2.5.1 23:46:48 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:46:48 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:46:48 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:46:48 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:46:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:46:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:46:49 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:46:49 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:46:49 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:46:49 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:46:49 INFO - Downloading functools32-3.2.3-2.tar.gz 23:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:46:50 INFO - warning: no files found matching '*.txt' 23:46:50 INFO - no previously-included directories found matching 'build' 23:46:50 INFO - no previously-included directories found matching 'dist' 23:46:50 INFO - no previously-included directories found matching '.git*' 23:46:50 INFO - Installing collected packages: jsonschema, functools32 23:46:50 INFO - Running setup.py install for functools32 23:46:51 INFO - warning: no files found matching '*.txt' 23:46:51 INFO - no previously-included directories found matching 'build' 23:46:51 INFO - no previously-included directories found matching 'dist' 23:46:51 INFO - no previously-included directories found matching '.git*' 23:46:51 INFO - Successfully installed jsonschema functools32 23:46:51 INFO - Cleaning up... 23:46:51 INFO - Return code: 0 23:46:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:46:51 INFO - Using env: {'DISPLAY': ':0', 23:46:51 INFO - 'HOME': '/home/cltbld', 23:46:51 INFO - 'LANG': 'en_US.UTF-8', 23:46:51 INFO - 'LANGUAGE': 'en_US:en', 23:46:51 INFO - 'LOGNAME': 'cltbld', 23:46:51 INFO - 'MAIL': '/var/mail/cltbld', 23:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:51 INFO - 'MOZ_NO_REMOTE': '1', 23:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:51 INFO - 'NO_EM_RESTART': '1', 23:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:51 INFO - 'PWD': '/builds/slave/test', 23:46:51 INFO - 'SHELL': '/bin/bash', 23:46:51 INFO - 'SHLVL': '1', 23:46:51 INFO - 'TERM': 'linux', 23:46:51 INFO - 'TMOUT': '86400', 23:46:51 INFO - 'USER': 'cltbld', 23:46:51 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:51 INFO - '_': '/tools/buildbot/bin/python'} 23:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:46:51 INFO - Cleaning up... 23:46:51 INFO - Return code: 0 23:46:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:46:51 INFO - Using env: {'DISPLAY': ':0', 23:46:51 INFO - 'HOME': '/home/cltbld', 23:46:51 INFO - 'LANG': 'en_US.UTF-8', 23:46:51 INFO - 'LANGUAGE': 'en_US:en', 23:46:51 INFO - 'LOGNAME': 'cltbld', 23:46:51 INFO - 'MAIL': '/var/mail/cltbld', 23:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:51 INFO - 'MOZ_NO_REMOTE': '1', 23:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:51 INFO - 'NO_EM_RESTART': '1', 23:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:51 INFO - 'PWD': '/builds/slave/test', 23:46:51 INFO - 'SHELL': '/bin/bash', 23:46:51 INFO - 'SHLVL': '1', 23:46:51 INFO - 'TERM': 'linux', 23:46:51 INFO - 'TMOUT': '86400', 23:46:51 INFO - 'USER': 'cltbld', 23:46:51 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:51 INFO - '_': '/tools/buildbot/bin/python'} 23:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:53 INFO - Downloading blobuploader-1.2.4.tar.gz 23:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:46:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:46: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:46: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:46: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:46: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:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:46: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:46: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:46: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:46: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:46:53 INFO - Downloading docopt-0.6.1.tar.gz 23:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:46:53 INFO - Installing collected packages: blobuploader, requests, docopt 23:46:53 INFO - Running setup.py install for blobuploader 23:46:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:46:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:46:53 INFO - Running setup.py install for requests 23:46:54 INFO - Running setup.py install for docopt 23:46:54 INFO - Successfully installed blobuploader requests docopt 23:46:54 INFO - Cleaning up... 23:46:54 INFO - Return code: 0 23:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:54 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:54 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:46:54 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:46:54 INFO - Using env: {'DISPLAY': ':0', 23:46:54 INFO - 'HOME': '/home/cltbld', 23:46:54 INFO - 'LANG': 'en_US.UTF-8', 23:46:54 INFO - 'LANGUAGE': 'en_US:en', 23:46:54 INFO - 'LOGNAME': 'cltbld', 23:46:54 INFO - 'MAIL': '/var/mail/cltbld', 23:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:54 INFO - 'MOZ_NO_REMOTE': '1', 23:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:54 INFO - 'NO_EM_RESTART': '1', 23:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:54 INFO - 'PWD': '/builds/slave/test', 23:46:54 INFO - 'SHELL': '/bin/bash', 23:46:54 INFO - 'SHLVL': '1', 23:46:54 INFO - 'TERM': 'linux', 23:46:54 INFO - 'TMOUT': '86400', 23:46:54 INFO - 'USER': 'cltbld', 23:46:54 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:54 INFO - '_': '/tools/buildbot/bin/python'} 23:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:54 INFO - Running setup.py (path:/tmp/pip-yhbkQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:54 INFO - Running setup.py (path:/tmp/pip-Uqs1iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:54 INFO - Running setup.py (path:/tmp/pip-3AHVHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:54 INFO - Running setup.py (path:/tmp/pip-pLhPhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:54 INFO - Running setup.py (path:/tmp/pip-5k9Jf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:54 INFO - Running setup.py (path:/tmp/pip-UzvWzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:54 INFO - Running setup.py (path:/tmp/pip-7jipCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:55 INFO - Running setup.py (path:/tmp/pip-6r58iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:55 INFO - Running setup.py (path:/tmp/pip-MlfgNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:55 INFO - Running setup.py (path:/tmp/pip-rsUTVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:55 INFO - Running setup.py (path:/tmp/pip-ZlNfe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:55 INFO - Running setup.py (path:/tmp/pip-bv04PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:55 INFO - Running setup.py (path:/tmp/pip-Tr5jUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:55 INFO - Running setup.py (path:/tmp/pip-fuah26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:55 INFO - Running setup.py (path:/tmp/pip-2B456q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:55 INFO - Running setup.py (path:/tmp/pip-XHGRFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:55 INFO - Running setup.py (path:/tmp/pip-8iqQu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:46:55 INFO - Running setup.py install for manifestparser 23:46:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:46:55 INFO - Running setup.py install for mozcrash 23:46:55 INFO - Running setup.py install for mozdebug 23:46:56 INFO - Running setup.py install for mozdevice 23:46:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for mozfile 23:46:56 INFO - Running setup.py install for mozhttpd 23:46:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for mozinfo 23:46:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for mozInstall 23:46:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for mozleak 23:46:56 INFO - Running setup.py install for mozlog 23:46:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for moznetwork 23:46:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:46:56 INFO - Running setup.py install for mozprocess 23:46:56 INFO - Running setup.py install for mozprofile 23:46:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:46:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:46:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:46:57 INFO - Running setup.py install for mozrunner 23:46:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:46:57 INFO - Running setup.py install for mozscreenshot 23:46:57 INFO - Running setup.py install for moztest 23:46:57 INFO - Running setup.py install for mozversion 23:46:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:46:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:46:57 INFO - Cleaning up... 23:46:57 INFO - Return code: 0 23:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:46:57 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:46:57 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:46:57 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:46:57 INFO - Using env: {'DISPLAY': ':0', 23:46:57 INFO - 'HOME': '/home/cltbld', 23:46:57 INFO - 'LANG': 'en_US.UTF-8', 23:46:57 INFO - 'LANGUAGE': 'en_US:en', 23:46:57 INFO - 'LOGNAME': 'cltbld', 23:46:57 INFO - 'MAIL': '/var/mail/cltbld', 23:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:46:57 INFO - 'MOZ_NO_REMOTE': '1', 23:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:46:57 INFO - 'NO_EM_RESTART': '1', 23:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:46:57 INFO - 'PWD': '/builds/slave/test', 23:46:57 INFO - 'SHELL': '/bin/bash', 23:46:57 INFO - 'SHLVL': '1', 23:46:57 INFO - 'TERM': 'linux', 23:46:57 INFO - 'TMOUT': '86400', 23:46:57 INFO - 'USER': 'cltbld', 23:46:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:46:57 INFO - '_': '/tools/buildbot/bin/python'} 23:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:46:57 INFO - Running setup.py (path:/tmp/pip-XCuvsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:46:57 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:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:46:57 INFO - Running setup.py (path:/tmp/pip-giwlgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:46:57 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:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:46:57 INFO - Running setup.py (path:/tmp/pip-UhJWws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:46:57 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:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:46:57 INFO - Running setup.py (path:/tmp/pip-kPEYzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:46:58 INFO - Running setup.py (path:/tmp/pip-WjT86q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:46:58 INFO - Running setup.py (path:/tmp/pip-prPisg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:46:58 INFO - Running setup.py (path:/tmp/pip-ZWVbXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:46:58 INFO - Running setup.py (path:/tmp/pip-OgsZwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:46:58 INFO - Running setup.py (path:/tmp/pip-ai2SjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:46:58 INFO - Running setup.py (path:/tmp/pip-gak66X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:46:58 INFO - Running setup.py (path:/tmp/pip-TUdwYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:46:58 INFO - Running setup.py (path:/tmp/pip-I0DkMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:46:58 INFO - Running setup.py (path:/tmp/pip-g9DNLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:46:58 INFO - Running setup.py (path:/tmp/pip-uur8aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:58 INFO - Running setup.py (path:/tmp/pip-La0iqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:46:58 INFO - Running setup.py (path:/tmp/pip-wcKDbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:46:58 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:46:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:46:58 INFO - Running setup.py (path:/tmp/pip-ioF6aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 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:46:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:47:00 INFO - Downloading blessings-1.6.tar.gz 23:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:47:00 INFO - Installing collected packages: blessings 23:47:00 INFO - Running setup.py install for blessings 23:47:00 INFO - Successfully installed blessings 23:47:00 INFO - Cleaning up... 23:47:00 INFO - Return code: 0 23:47:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:47:00 INFO - Reading from file tmpfile_stdout 23:47:00 INFO - Current package versions: 23:47:00 INFO - argparse == 1.2.1 23:47:00 INFO - blessings == 1.6 23:47:00 INFO - blobuploader == 1.2.4 23:47:00 INFO - docopt == 0.6.1 23:47:00 INFO - functools32 == 3.2.3-2 23:47:00 INFO - jsonschema == 2.5.1 23:47:00 INFO - manifestparser == 1.1 23:47:00 INFO - mozInstall == 1.13 23:47:00 INFO - mozcrash == 1.0 23:47:00 INFO - mozdebug == 0.1 23:47:00 INFO - mozdevice == 0.51 23:47:00 INFO - mozfile == 1.2 23:47:00 INFO - mozhttpd == 0.7 23:47:00 INFO - mozinfo == 0.10 23:47:00 INFO - mozleak == 0.1 23:47:00 INFO - mozlog == 3.5 23:47:00 INFO - moznetwork == 0.27 23:47:00 INFO - mozprocess == 0.25 23:47:00 INFO - mozprofile == 0.28 23:47:00 INFO - mozrunner == 6.13 23:47:00 INFO - mozscreenshot == 0.1 23:47:00 INFO - mozsystemmonitor == 0.3 23:47:00 INFO - moztest == 0.8 23:47:00 INFO - mozversion == 1.4 23:47:00 INFO - psutil == 3.1.1 23:47:00 INFO - requests == 1.2.3 23:47:00 INFO - wsgiref == 0.1.2 23:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:47: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:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:47: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:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:47:00 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 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:47:00 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:47:00 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:47:00 INFO - Using env: {'DISPLAY': ':0', 23:47:00 INFO - 'HOME': '/home/cltbld', 23:47:00 INFO - 'LANG': 'en_US.UTF-8', 23:47:00 INFO - 'LANGUAGE': 'en_US:en', 23:47:00 INFO - 'LOGNAME': 'cltbld', 23:47:00 INFO - 'MAIL': '/var/mail/cltbld', 23:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:47:00 INFO - 'MOZ_NO_REMOTE': '1', 23:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:47:00 INFO - 'NO_EM_RESTART': '1', 23:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:47:00 INFO - 'PWD': '/builds/slave/test', 23:47:00 INFO - 'SHELL': '/bin/bash', 23:47:00 INFO - 'SHLVL': '1', 23:47:00 INFO - 'TERM': 'linux', 23:47:00 INFO - 'TMOUT': '86400', 23:47:00 INFO - 'USER': 'cltbld', 23:47:00 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:47:00 INFO - '_': '/tools/buildbot/bin/python'} 23:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 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:47:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:47: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:47: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:47: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:47: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:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:47:01 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:47:01 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:47:01 INFO - Installing collected packages: simplejson 23:47:01 INFO - Running setup.py install for simplejson 23:47:01 INFO - building 'simplejson._speedups' extension 23:47:01 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:47:02 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:47:02 INFO - Successfully installed simplejson 23:47:02 INFO - Cleaning up... 23:47:02 INFO - Return code: 0 23:47:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:47: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:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:47: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:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:47: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c1fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, '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': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', '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:47: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', 'jsonschema'] in /builds/slave/test/build 23:47: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 jsonschema 23:47:02 INFO - Using env: {'DISPLAY': ':0', 23:47:02 INFO - 'HOME': '/home/cltbld', 23:47:02 INFO - 'LANG': 'en_US.UTF-8', 23:47:02 INFO - 'LANGUAGE': 'en_US:en', 23:47:02 INFO - 'LOGNAME': 'cltbld', 23:47:02 INFO - 'MAIL': '/var/mail/cltbld', 23:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:47:02 INFO - 'MOZ_NO_REMOTE': '1', 23:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:47:02 INFO - 'NO_EM_RESTART': '1', 23:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:47:02 INFO - 'PWD': '/builds/slave/test', 23:47:02 INFO - 'SHELL': '/bin/bash', 23:47:02 INFO - 'SHLVL': '1', 23:47:02 INFO - 'TERM': 'linux', 23:47:02 INFO - 'TMOUT': '86400', 23:47:02 INFO - 'USER': 'cltbld', 23:47:02 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:47:02 INFO - '_': '/tools/buildbot/bin/python'} 23:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:47:03 INFO - Cleaning up... 23:47:03 INFO - Return code: 0 23:47:03 INFO - Running post-action listener: _resource_record_post_action 23:47:03 INFO - Running post-action listener: _start_resource_monitoring 23:47:03 INFO - Starting resource monitoring. 23:47:03 INFO - [mozharness: 2017-09-14 06:47:03.173980Z] Finished create-virtualenv step (success) 23:47:03 INFO - [mozharness: 2017-09-14 06:47:03.174440Z] Running install step. 23:47:03 INFO - Running pre-action listener: _resource_record_pre_action 23:47:03 INFO - Running main action method: install 23:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:47:03 INFO - Reading from file tmpfile_stdout 23:47:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:47:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:47:03 INFO - Reading from file tmpfile_stdout 23:47:03 INFO - Output received: 23:47:03 INFO - Usage: mozinstall [options] installer 23:47:03 INFO - Options: 23:47:03 INFO - -h, --help show this help message and exit 23:47:03 INFO - -d DEST, --destination=DEST 23:47:03 INFO - Directory to install application into. [default: 23:47:03 INFO - "/builds/slave/test"] 23:47:03 INFO - --app=APP Application being installed. [default: firefox] 23:47:03 INFO - mkdir: /builds/slave/test/build/application 23:47:03 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:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:47:21 INFO - Reading from file tmpfile_stdout 23:47:21 INFO - Output received: 23:47:21 INFO - /builds/slave/test/build/application/firefox/firefox 23:47:21 INFO - Running post-action listener: _resource_record_post_action 23:47:21 INFO - [mozharness: 2017-09-14 06:47:21.292314Z] Finished install step (success) 23:47:21 INFO - [mozharness: 2017-09-14 06:47:21.292567Z] Running setup-mitmproxy step. 23:47:21 INFO - Running pre-action listener: _resource_record_pre_action 23:47:21 INFO - Running main action method: setup_mitmproxy 23:47:21 INFO - Skipping: mitmproxy is not required 23:47:21 INFO - Running post-action listener: _resource_record_post_action 23:47:21 INFO - [mozharness: 2017-09-14 06:47:21.293697Z] Finished setup-mitmproxy step (success) 23:47:21 INFO - [mozharness: 2017-09-14 06:47:21.293917Z] Running run-tests step. 23:47:21 INFO - Running pre-action listener: _resource_record_pre_action 23:47:21 INFO - Running pre-action listener: _set_gcov_prefix 23:47:21 INFO - Running main action method: run_tests 23:47:21 WARNING - Try message not found. 23:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:47:21 INFO - Python 2.7.3 23:47:21 INFO - Return code: 0 23:47:21 INFO - grabbing minidump binary from tooltool 23:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:47:21 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 0x2c23090>, '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 0x2c23d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:47:21 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:47:21 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:47:21 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:47:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:47:21 INFO - Return code: 0 23:47:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:47:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:47:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:47:21 INFO - ENV: RUST_BACKTRACE is now full 23:47:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:47:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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:47:21 INFO - Using env: {'DISPLAY': ':0', 23:47:21 INFO - 'HOME': '/home/cltbld', 23:47:21 INFO - 'LANG': 'en_US.UTF-8', 23:47:21 INFO - 'LANGUAGE': 'en_US:en', 23:47:21 INFO - 'LOGNAME': 'cltbld', 23:47:21 INFO - 'MAIL': '/var/mail/cltbld', 23:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:47:21 INFO - 'MOZ_NO_REMOTE': '1', 23:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:47:21 INFO - 'NO_EM_RESTART': '1', 23:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:47:21 INFO - 'PWD': '/builds/slave/test', 23:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:47:21 INFO - 'RUST_BACKTRACE': 'full', 23:47:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:47:21 INFO - 'SHELL': '/bin/bash', 23:47:21 INFO - 'SHLVL': '1', 23:47:21 INFO - 'TERM': 'linux', 23:47:21 INFO - 'TMOUT': '86400', 23:47:21 INFO - 'USER': 'cltbld', 23:47:21 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:47:21 INFO - '_': '/tools/buildbot/bin/python'} 23:47:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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:47:21 INFO - mozversion application_buildid: 20170914052917 23:47:21 INFO - mozversion application_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:47:21 INFO - mozversion application_display_name: Nightly 23:47:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:47:21 INFO - mozversion application_name: Firefox 23:47:21 INFO - mozversion application_remotingname: firefox 23:47:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:47:21 INFO - mozversion application_vendor: Mozilla 23:47:21 INFO - mozversion application_version: 57.0a1 23:47:21 INFO - mozversion platform_buildid: 20170914052917 23:47:21 INFO - mozversion platform_changeset: cb717386aec8601a301babd4156aabc4cccff0b0 23:47:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:47:21 INFO - mozversion platform_version: 57.0a1 23:47:21 INFO - using testdate: 1505371641 23:47:21 INFO - actual date: 1505371641 23:47:21 INFO - starting webserver on 'localhost:34212' 23:47:21 INFO - SUITE-START | Running 2 tests 23:47:21 INFO - TEST-START | dromaeo_css 23:47:21 INFO - Initialising browser for dromaeo_css test... 23:47:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34212/getInfo.html -profile /tmp/tmpZFQUDg/profile 23:47:21 INFO - TEST-INFO | started process 28114 (/builds/slave/test/build/application/firefox/firefox http://localhost:34212/getInfo.html) 23:47:27 INFO - TEST-INFO | 28114: exit 0 23:47:27 INFO - Browser initialized. 23:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:47:27 INFO - Using env: {'DISPLAY': ':0', 23:47:27 INFO - 'HOME': '/home/cltbld', 23:47:27 INFO - 'JSGC_DISABLE_POISONING': '1', 23:47:27 INFO - 'LANG': 'en_US.UTF-8', 23:47:27 INFO - 'LANGUAGE': 'en_US:en', 23:47:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:47:27 INFO - 'LOGNAME': 'cltbld', 23:47:27 INFO - 'MAIL': '/var/mail/cltbld', 23:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:47:27 INFO - 'MOZ_CRASHREPORTER': '1', 23:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:47:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:47:27 INFO - 'MOZ_NO_REMOTE': '1', 23:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:47:27 INFO - 'NO_EM_RESTART': '1', 23:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:47:27 INFO - 'PWD': '/builds/slave/test', 23:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:47:27 INFO - 'RUST_BACKTRACE': 'full', 23:47:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:47:27 INFO - 'SHELL': '/bin/bash', 23:47:27 INFO - 'SHLVL': '1', 23:47:27 INFO - 'STYLO_FORCE_DISABLED': '1', 23:47:27 INFO - 'TERM': 'linux', 23:47:27 INFO - 'TMOUT': '86400', 23:47:27 INFO - 'USER': 'cltbld', 23:47:27 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 23:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:47:27 INFO - '_': '/tools/buildbot/bin/python'} 23:47:27 INFO - TEST-INFO | started process 28345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZFQUDg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:28 INFO - PID 28345 | 23:47:28 INFO - PID 28345 | (/builds/slave/test/build/application/firefox/firefox:28394): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:47:28 INFO - PID 28345 | 23:47:38 INFO - PID 28345 | RSS: Main: 166821888 23:47:38 INFO - PID 28345 | 23:50:36 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34212/tests/dromaeo/cssquery-ext.html) 23:50:37 INFO - PID 28345 | RSS: Main: 170168320 23:50:37 INFO - PID 28345 | 23:53:39 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-ext.html (next: http://localhost:34212/tests/dromaeo/cssquery-jquery.html) 23:53:39 INFO - PID 28345 | RSS: Main: 165625856 23:53:39 INFO - PID 28345 | 23:56:41 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34212/tests/dromaeo/cssquery-mootools.html) 23:56:41 INFO - PID 28345 | RSS: Main: 168415232 23:56:41 INFO - PID 28345 | 23:59:43 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34212/tests/dromaeo/cssquery-prototype.html) 23:59:44 INFO - PID 28345 | RSS: Main: 166965248 23:59:44 INFO - PID 28345 | 00:02:47 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34212/tests/dromaeo/cssquery-yui.html) 00:02:47 INFO - PID 28345 | RSS: Main: 168853504 00:02:47 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | Cycle 1(1): loaded http://localhost:34212/tests/dromaeo/cssquery-yui.html (next: http://localhost:34212/tests/dromaeo/cssquery-dojo.html) 00:05:49 INFO - PID 28345 | RSS: Main: 170504192 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | __start_tp_report 00:05:49 INFO - PID 28345 | _x_x_mozilla_page_load 00:05:49 INFO - PID 28345 | _x_x_mozilla_page_load_details 00:05:49 INFO - PID 28345 | |i|pagename|runs| 00:05:49 INFO - PID 28345 | |0;dojo.html;3843.9423408648877;3846.0961674006603;3879.573246942836;3895.74677645953;3912.941305880414;6147.81556553303;6161.199044124258;6282.465990390817;6305.148804911341;6375;6277.748890044393;6288.05679148128;6291.370862913706;6296.464800491964;6368.363163683629;5641.746121424546;5657.151427285919;5717.714114294279;5727.3699893011735;5742.885142297151;980.329193382985;5610.831675049755;5643.068893632546;5672.319321681383;5709.514691251248;5633.830985070434;5653.349864765563;5699.430056994288;5705.828825135252;5719.513841323493;5639.971800140973;5651.547876169897;5717.256756621654;5720.942790572082;5724.9427505724825;5590.496855283044;5641.717914104278;5712.257406537124;5717.371089180187;5730.426957304237;6102.176206212149;6244.750209991595;6293.213348331458;6315.905261421082;6348.016057511093;6616.536842421033;6702.597844129368;6720.630365329905;6730.899036514456;6733.057371967929;6767.898481522781;6789.083473731032;6864.176298844171;6864.38220560147;6874.968754686837;6359.777407790752;6422.165118534561;6434.099226108348;6447.903281450735;6454.903176452404;7004.824879378057;7040.964795175992;7051.788446346618;7110;7114.217436082027;6641.767538136239;6709.463242940651;6718.294579069225;6762.425193858478;6844.794656160323;6820.31796820314;6854.760083397057;6879.724811007603;6880.277570854988;6914.654267286615;6748.7300507979135;6833.384995350442;6842.589444633338;6847.931520684829;6850.965745171342;6754.662266886636;6769.05233267343;6772.966135169391;6854.657267136723;6856.451483881277;4920.926186107211;4964.404271487445;5011.649184557119;5024.924626130611;5045.520675535819;4440.4005459263235;4595.6783025187915;4625.352450656911;4634.026854360622;4647.814087436464;6303.936960630427;6311.842203944846;6319.210098737658;6399.976003839363;6410.743570257231;6804.829879253059;6817.386435220854;6817.863642727217;6887.621180835102;6903.620300883399;6344.68276586178;6380.968095159495;6382.297947225801;6402.967985160138;6403.135576697179;5451.64564303319;5520.66875987442;5556.444355564411;5583.609147359646;5587.552995760329;6954.3045695430055;7059.364657180879;7079.29207079288;7133.89299160513;7162.140543134858;6804.829879253059;6807.285235050248;6812.965935170292;6916.239213686591;6925.515213935077;6980.6509674515055;7016.859662806613;7080.327368899946;7096.396806271525;7114.537555058904;6754.18949726036;6778.8644227116165;6796.048553202457;6819.488538359544;6839.829004274933;6841.144856892888;6861.176658800976;6935.098437203132;6937.202221744362;6939.271376505596;6464.159659244268;6546.869062618625;6567.310432404529;6570.310117437792;6660.866782664417;6481.967590162019;6519.706613202323;6525.967370163309;6526.282108967915;6541.443977261986;6513.674316284072;6568.014797780371;6575.079488871466;6575.572587781779;6578.210614726264;6619.172603424572;6619.635920024445;6666.233383160805;6696.263411024686;6697.229818570927;6320.841978950563;6401.775937842153;6403.583767055126;6415.679216039086;6494.1232933553365 00:05:49 INFO - PID 28345 | |1;ext.html;893.6023469556048;933.3653115881198;947.5451783144091;989.6189966862755;1000.8899021107682;43356;43769.562304376945;44436.77781611095;44447.555524444746;44530.109397812026;42185.789071054605;42278;42390.94022649436;42475.78762106193;42486.36270455938;7356.77929662111;7497.550146991171;7503.549787012769;7508.662110205027;7512.962435187844;7416.517926334798;7436.628168591576;7500.887486687704;7502.362299204574;7506.849863002737;7984.800379990517;8204.384671149657;8208.138145494726;8209.384296177781;8209.753707388758;8109.918900811005;8120.75637730869;8144.348452123875;8148.307393871499;8149.388795840336;7828.882566761503;8044.356451483867;8051.919480805175;8053.43625946184;8065.233802788725;40664;40853;40922.38616420756;40954.1809163818;40965.385519217234;3829.3681542545446;3866.4586957825927;3868.574456809749;3875.476810630557;3876.030992251937;32865;33700.32599348024;33808.15479613029;33844.49233261503;34029.6597034029;5454.972725136349;5471.316085489314;5522.364928033247;5523.530499907512;5536.833894983157;212680;216337;223470;224398;273025.999999998;53061.46938530565;53128.46871531235;53163;53210.201846972326;53566;56021.43978560244;56281.43718562844;56435.61386316834;56454.717726411924;56508.71745641246;15970.281337339848;16043.518694439186;16065.11641859709;16070.276837542338;16077;12792.61622151337;12897.742045159044;12945.223286602833;12949.482020719253;12954;14950.626234344229;14970;14975.625609359853;15121.697566048617;15146.091234525964;5908.438698323653;5938.851528711817;5943.673097979567;5955.374685657944;6030.909536356959;1063.128234847433;1106.5957489193056;1119.283658458587;1121.7924683933497;1127.21095233337;25793;25868.741312587008;25885;25887.482250354886;25941.09206177775;1216.2641601830942;1220.5117952818944;1222.5659890738837;1222.6882145053132;1223.1499108119772;13603.455861765418;13617.523386681418;13653.590392288248;13832;13931.233782142079;293661;295450;295723;296033;296722;59357;59506.404935950086;59611;59689.701551492835;59728.40271597228;1491.56744544081;1509.6225943513903;1527.2211172301984;1527.2287494815268;1545.0883978452766;24992.506743930608;25397.22219444621;25590.61614075753;25650;25779.871100644377;41480.58519414767;41575.168496630504;41602.58397415987;41623.37564936468;41645.58354416417;234015;234973;235052;235097;235537;34367.82816085903;34982.30035399328;37658;37747.62252377441;38206.61793382031;48352;48857.755711221216;48939.5106048935;49195.262071068246;49395.50604493909;34458.82770586131;34693;34740.826295868355;34788.130296742784;34988.47517287192;34180.82909585436;34666.82666586651;34774.304513909075;35312.646873531965;35562.28875422425;40246.99382515343;40477;40804.59195408008;40914.18171636491;41356.79321603373;33808.3238335227;34095.31809363848;34484.655153449145;34596.654033459345;34631.82684086564;25047.624285636095;25157.33959859017;25214.117505887207;25873.22380328593;26269 00:05:49 INFO - PID 28345 | |2;jquery.html;565.502357925026;581.1573218832693;590.6190507122908;596.4989408896527;600.249687890137;22932.197373091924;24012.159574414898;24043.038278468885;24083.15708950187;24106;23813.761862381372;24720.87639561804;24986.75013249867;25030.499390012188;25369.873150634266;6426.678666066689;6592.143021407211;6599.4390476809285;6604.372584604479;6618.139641846553;6316.242050953869;6527.706253218593;6538.1827271591055;6610.40506354428;6624.039514270428;6484.221893372802;6515.837104072389;6518.478521718275;6550.410463058324;6556.311587283338;6467.417932386108;6500.93499065008;6522.347765223463;6739.326067393271;6759.32406759325;6288.842778930518;6291.307956124822;6307.400796924285;6308.684565771739;6310.9684451577905;28742.13773586775;28983.275418114506;29015.709842901724;29092.854535727398;29100.126996189938;2264.275431861805;2285.3029825903095;2285.5543169082034;2286.2341115726254;2291.1179196009657;19458;20559.177632894814;20635.277765278293;20655.070521826554;20679;2531.240627811649;2539.619057141425;2595.3122422558035;2596.545604519202;2596.5845464725744;134815;139368;155673;163098;163365;15526.301316440788;15622.453214137451;16179.271932763055;16184.352625894833;16528.6694266114;25174.23780335359;25184.37039074038;25184.496310073697;25193.748062519142;25258.621120683205;10185.33795303303;10189.388636681822;10404.531796069195;10421.218408619385;10436.686899393031;9224.123708247706;9227.492487913229;9242.07579242084;9281.164695177466;9294.442333460014;9803.950980245054;9864.704058878246;10025.498725063717;10057.748556286006;10077.899221007843;2907.7237662422035;2940.779441541893;2962.837043962603;2981.7912746107563;3018.592490013864;998.7652901568125;1015.8780946286493;1020.2654089055868;1023.4473384372504;1053.3890343600692;20243;20399.898000509904;20710;20814.58370832575;21310.893445532674;1066.3548553125402;1075.8547596074586;1085.2891356161726;1101.7521057762099;1110.6112860498922;11220.775584488265;11240.325580465198;11266.211365204357;11379.08967282632;11385.259958102697;570447;579185;579413;581831;592123;128060;129672;130130;131157;132897.33551332183;1163.3775929877474;1200.4717924113363;1207.6558180918396;1217.573849152807;1217.6103646833105;17944;18476.168572414004;18490.89054656725;18574;18699.906500467412;61526.07710884251;64796.67601661962;65036.674816625615;65250;65496.67251663711;83781.48655540343;84426.57786711027;84516.57741711252;84563;85121.57439213012;14785.11289322644;14883.10701357922;14979.475718349806;15184.924075379995;15208.847911521187;23139.421514462272;23444.53110937806;23666.88166559225;23674.171404001467;23828.642570361113;19100.23599056022;19427.125779340247;19457.61084778325;19606.705899411805;19609.509762256057;15992.600184995468;16946.898451600606;17195.14024298755;17459.214335354685;17777.644447111245;19279.51801204981;19324;19369.612607748048;19524.609507810048;19539.436845052645;14616.780748288997;14657.853421465648;14688.678018978344;14722.852771472148;14799;17360.131993400533;17364.82635173632;18595.72106418432;18825;18858.905705471385 00:05:49 INFO - PID 28345 | |3;mootools.html;1353.370682632576;1460.744369735296;1493.2682985337187;1496.633324835415;1503.8420965798591;17369.82630173698;17891.46325610232;17921.37275195365;17943.641127177463;17947;17361.392351267707;17434.302627894867;17482.125893705295;17494.475165745018;17505.124743762826;2723.7644715548413;2793.25978615667;2801.817881837674;2803.313188268877;2806.3124534488975;2742.5886117082396;2751.312171957011;2756.682981457128;2780.8609569521545;2885.047934181715;2785.2897511134634;2787.23351078453;2799.8740056697397;2816.8450735209553;2819.16834533813;2666.1601595497455;2729.249456399496;2806.7473927346537;2809.030884344898;2819.5629677400034;2722.060888993294;2746.2036009557405;2746.217328061513;2759.6412466379243;2760.1305588739483;16623.66752664952;16827.158642067847;16840.831591684047;16894.74657880133;17019.149042547946;8388.748337549883;8636.524991125485;8664.826703465895;8668.349873759431;8672.219500245008;5427.185922111676;5572.136318870582;5588.245586845765;5710.71446427677;5738.8278351649515;2047.2834507922257;2068.13138481838;2090.886516016886;2092.5814837032653;2143.9035243414082;30009.249768755737;30280.091597252118;30301.545476817864;30319.696803031908;30359.848200758854;6915.135608048994;6929.341712537301;7020.613866237406;7106.076210092655;7194.136703595602;19323.51691207703;19392.321268755524;19470.22119115248;19473.805261947484;19491.415257542012;8430.578471076422;8447.704330348408;8470.322374210049;8484.915150848536;8488.702895398632;7543.962280188564;7731.149573546905;7737.5744334062165;7741.922580774233;7796.337311328487;5525.972370138124;5545.585875601696;5625.38120806711;5668.773249070074;5797.652140871562;1550.4573399310377;1570.9921450392676;1576.905385676863;1582.8338024507261;1593.6334643032167;919.1268295119529;931.902150274225;947.6635794293064;948.966786162481;955.7658373698488;7852.332551733052;7867.842643147105;7882;7911.960440197762;7972.2824945755165;763.816683995837;785.4580339565681;786.9921300787033;792.5482474989201;797.1629788721818;4339.804708788112;4389.517153113155;5273.3935597406025;5301.857392481789;5486.835394938158;24235;24573.631395529083;25139;25347.619785703228;25348;24891.875540622183;25285.115020974546;25450.236492905242;25455.36361590938;25488;11774.05807535395;12146.817797733042;12211.389430528616;12226.694332641577;12312.50749970009;8083.110857805519;8086.5148091114725;8196.795080123045;8245.711400100967;8267.83464330698;20714.58570828545;21142.47143821417;21194.682079769125;21571.921403929427;21662.783372166075;21450.892745536174;21770.12919483203;22133.33599992003;22311.66532502046;22992.540149197255;12328.137030407785;12427.689307767378;12502.937485312515;12583.182093163916;12602.810957835456;15442.922785386001;15688.137152456724;15688.529344119695;15694.764578531103;15703;11504.827427588425;11545.307281563133;11716.23844450108;11761.411929403666;11929;11657.766844663229;11698.70753231176;11783.116266280234;11964.64106076819;12202.572909948109;10944.452777361259;10978.011978921935;11153.832692509457;11160.33038017689;11168.888311116785;7174.713011479483;7423.443241756781;7527;7544.886826697713;7562.168161502121;7400.148982867039;7546.849063018819;7562.697492100475;7600.771976840703;7634.541927484369 00:05:49 INFO - PID 28345 | |4;prototype.html;525.4823998361611;552.3234038303078;553.5212041584026;559.1054313099041;572.5362456410307;6156.491659543407;6201.790650823092;6240.970239910409;6315.936840631598;6389.122007752867;6189;6218.31598524162;6221.160143380643;6269.310375858652;6344.968275158618;5182.585393168538;5195.246689230059;5218.877941242651;5221.190715439094;5270.92093618596;4855.732934688591;5155.613329000321;5209.296744939442;5253.4221235664045;5259.8422047338645;4961.231009193562;4969.801207951696;4971.552560269575;5016.322796422491;5026.1706818375105;4953;4964.379452568429;4993.800247990076;5033.320501732256;5041.81517343424;4403.581659742319;4483.417155769729;4516.887077823048;4523;4534.773261336953;6126.693665316761;6159.291681456645;6168.383161683841;6192.504599632019;6255.808608232495;5868.735906884201;5878.265216847894;5888.5289176865745;5890.234269544974;5909.674967876765;6698.732050717966;6710.765123220664;6728.764493242713;6743.35938085881;6753.797386078426;5062.645614806965;5083.847484575469;5091.79632814687;5092.872678183038;5100.617453690988;6895;7030.683619237096;7049.68276427562;7067.611281379522;7074.717011319541;5224.92162617561;5262.973685131627;5266.709656134271;5272.736363181825;5278.5249327560705;5273.209018647157;5306.151015837448;5314.229436731653;5317.282166907418;5323.600729945192;5838.649681019152;5862.501687356623;5863.736131874076;5888.116782482576;5905.704714764244;6717.664116794141;6724.394804467622;6750.662466876636;6780.898286525706;6797.0823938767635;1739.252121587704;1747.881355932179;1790.919408626615;1826.7990521042675;1827.798942116366;1282.3460035381836;1283.3519072868141;1302.5310888080282;1309.3387839141174;1310.8361454818148;6235.220597425322;6269.435750782452;6279.215098112736;6357.459615932605;6381.245157581609;6662.200535935719;6763.458923286125;6789.694463749143;6862.245153033163;6891.793246202622;6259.436650701458;6280.905786413207;6291.811245662638;6297.748090076346;6357.792019516277;3597.1906321078072;3598.370285200132;3609.5307610011055;3617.7829330239742;3624.2817886585062;7011.614361210182;7101.644917754092;7117.3238542338395;7121.394681452135;7143.821404464826;7013.929860701328;7016.122984626922;7063.788086357417;7067.505274630829;7079.185893622196;7130.92869071313;7162.212156662763;7162.247963963709;7165.856682866418;7173.497855150194;6824.4199243064895;6861.828454288483;6873.2783057778215;6882.5870447773295;6891.310868913069;6698.330166983263;6817.625030623363;6819.147606549182;6819.795406137824;6838.692258848463;6918.965405172942;7061.894071589033;7149.428045756431;7158.355747982707;7237.927620723725;5062.696238225718;5180.171172612364;5180.378354597472;5213.7914483421755;5235.3717553893775;6759.087523184504;6802;6816.454683625398;6856.314368563303;6873.725050997904;6378.170837791057;6477.4170324671;6517.315681853527;6519.445847103049;6574.901376479453;6409.743610255724;6594.252523081484;6601.339866013553;6611.504137189634;6615.6030638161865;6193.535484838745;6529.444997175293;6565.343465653396;6584.901226481702;6641.734330626721;6662.367075127855;6687.465002799667;6711.765088221889;6720.899186512109;6764.391204791593;6311.684415779285;6466.741330346734;6483.067992786548;6515.413612774873;6520.576162549419 00:05:49 INFO - PID 28345 | |5;yui.html;905.0406569036821;921.3550514639754;927.4481683398376;935.96256149754;979.9902000979988;17607.559811004732;18028.63942721145;18053.368132115364;18055.36806211783;18114.728279075807;16920.23858926348;17070.317187312492;17072.402465913696;17083.57291067721;17086.231119599615;1012.3571532077128;1029.6602121299952;1029.8558201851747;1031.840064789955;1032.0453580438066;1044.6604853422668;1044.7022598559413;1044.843273508976;1049.380865289479;1051.9368837869713;1069.9251052426334;1095.594629986902;1100.8899110088967;1106.8450416941635;1109.3454861631635;1088.7441451259026;1089.1667874076338;1091.154355374587;1091.5688303120262;1101.0255923507673;792.8810678398287;812.1026265976129;815.510693583845;816.9918300816976;817.1501638296165;18715.157817898227;18931.242750289974;18946.43160705181;18950.526236844053;18999.335023274256;22167.77832221673;22656.773432265632;22786;22883.771162288496;22984.77015229843;16027.679446411006;16063;16082.839171608251;16363.427280045142;16415.507534773977;4020.979895100506;4036.9192616147807;4043.777592232426;4047.898802529931;4048.5748996355546;117641;146970;150716;150803;153033.23483382622;18847.434576962714;18876.24495020184;19091.331803387093;19117.13972871224;19151.425457236026;34546.65453345485;35023.12442188965;35678.82160589232;35681.82159089188;35684.821575891954;9378.812423751624;9529.666461673947;9532.428054316762;9551.044895510393;9571.61713531451;4407.845725399596;4477.910441791146;4478.328250762412;4484.977575112103;4486.528914463935;6121.418465245794;6217.626942383471;6264.2796078451565;6281.7173227204885;6287.276963149205;1177.528988404645;1201.243216773427;1208.4984731336572;1221.1635030004475;1221.7495413440224;694.191267173737;705.1397295299727;718.8202949262684;723.4827098624509;727.5598263050883;12686.04854635906;12749;12769;13119.803202951964;13146.34268286601;713.2724620886667;731.9085114360705;736.3152268390448;744.4528271720282;753.7701001194579;5833.066709326487;5914.704264786744;5950;6021.2473440819895;6049.5462840287155;154526;155161;156434.21782891013;157473;157817;137903;138050;139354.30322848322;139844.30077849547;142554.2872285632;119686;120517.39741301237;120790.3960480192;121276.39361803135;122822.38588806998;11219.382933938712;11265.26775759573;11289.830652540382;11374.658760237206;11394.373309467726;52611;53806.461935380146;54021.45978540322;54101.45898541122;55056.449435505136;67777.66111169412;67904.3209567898;68179.65910170418;68640;69559.30440695529;16163.838361616234;16338;16477.176141193133;16505;16697.582560436087;17466.82533174652;17616.823831761518;17633.382831600833;17749.29002839872;17754.28982840672;15991.68016639684;16075.115868627337;16100.758488622445;16186.67626647484;16323.918380408022;15924.840751592335;16098.11460369691;16120.113393763455;16199;16320.755188671941;16142.273597687898;16174.757378639566;16316.755248671043;16325.755113673067;16394.754078689068;12410.689732756753;12462.688432789253;12510.87489125097;12667.493300267886;12724.1729287596;12560.497580097059;12614.180078294881;12629;12817.038722095693;12918.22490650564 00:05:49 INFO - PID 28345 | __end_tp_report 00:05:49 INFO - PID 28345 | __start_cc_report 00:05:49 INFO - PID 28345 | _x_x_mozilla_cycle_collect,344 00:05:49 INFO - PID 28345 | __end_cc_report 00:05:49 INFO - PID 28345 | __startTimestamp1505372749288__endTimestamp 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | ------- Summary: start ------- 00:05:49 INFO - PID 28345 | Number of tests: 6 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#0] dojo.html Cycles:165 Average:6258.18 Median:6519.71 stddev:844.99 (13.0%) stddev-sans-first:826.09 00:05:49 INFO - PID 28345 | Values: 3843.9 3846.1 3879.6 3895.7 3912.9 6147.8 6161.2 6282.5 6305.1 6375.0 6277.7 6288.1 6291.4 6296.5 6368.4 5641.7 5657.2 5717.7 5727.4 5742.9 980.3 5610.8 5643.1 5672.3 5709.5 5633.8 5653.3 5699.4 5705.8 5719.5 5640.0 5651.5 5717.3 5720.9 5724.9 5590.5 5641.7 5712.3 5717.4 5730.4 6102.2 6244.8 6293.2 6315.9 6348.0 6616.5 6702.6 6720.6 6730.9 6733.1 6767.9 6789.1 6864.2 6864.4 6875.0 6359.8 6422.2 6434.1 6447.9 6454.9 7004.8 7041.0 7051.8 7110.0 7114.2 6641.8 6709.5 6718.3 6762.4 6844.8 6820.3 6854.8 6879.7 6880.3 6914.7 6748.7 6833.4 6842.6 6847.9 6851.0 6754.7 6769.1 6773.0 6854.7 6856.5 4920.9 4964.4 5011.6 5024.9 5045.5 4440.4 4595.7 4625.4 4634.0 4647.8 6303.9 6311.8 6319.2 6400.0 6410.7 6804.8 6817.4 6817.9 6887.6 6903.6 6344.7 6381.0 6382.3 6403.0 6403.1 5451.6 5520.7 5556.4 5583.6 5587.6 6954.3 7059.4 7079.3 7133.9 7162.1 6804.8 6807.3 6813.0 6916.2 6925.5 6980.7 7016.9 7080.3 7096.4 7114.5 6754.2 6778.9 6796.0 6819.5 6839.8 6841.1 6861.2 6935.1 6937.2 6939.3 6464.2 6546.9 6567.3 6570.3 6660.9 6482.0 6519.7 6526.0 6526.3 6541.4 6513.7 6568.0 6575.1 6575.6 6578.2 6619.2 6619.6 6666.2 6696.3 6697.2 6320.8 6401.8 6403.6 6415.7 6494.1 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#1] ext.html Cycles:180 Average:43232.63 Median:21017.99 stddev:66569.97 (316.7%) stddev-sans-first:66680.81 00:05:49 INFO - PID 28345 | Values: 893.6 933.4 947.5 989.6 1000.9 43356.0 43769.6 44436.8 44447.6 44530.1 42185.8 42278.0 42390.9 42475.8 42486.4 7356.8 7497.6 7503.5 7508.7 7513.0 7416.5 7436.6 7500.9 7502.4 7506.8 7984.8 8204.4 8208.1 8209.4 8209.8 8109.9 8120.8 8144.3 8148.3 8149.4 7828.9 8044.4 8051.9 8053.4 8065.2 40664.0 40853.0 40922.4 40954.2 40965.4 3829.4 3866.5 3868.6 3875.5 3876.0 32865.0 33700.3 33808.2 33844.5 34029.7 5455.0 5471.3 5522.4 5523.5 5536.8 212680.0 216337.0 223470.0 224398.0 273026.0 53061.5 53128.5 53163.0 53210.2 53566.0 56021.4 56281.4 56435.6 56454.7 56508.7 15970.3 16043.5 16065.1 16070.3 16077.0 12792.6 12897.7 12945.2 12949.5 12954.0 14950.6 14970.0 14975.6 15121.7 15146.1 5908.4 5938.9 5943.7 5955.4 6030.9 1063.1 1106.6 1119.3 1121.8 1127.2 25793.0 25868.7 25885.0 25887.5 25941.1 1216.3 1220.5 1222.6 1222.7 1223.1 13603.5 13617.5 13653.6 13832.0 13931.2 293661.0 295450.0 295723.0 296033.0 296722.0 59357.0 59506.4 59611.0 59689.7 59728.4 1491.6 1509.6 1527.2 1527.2 1545.1 24992.5 25397.2 25590.6 25650.0 25779.9 41480.6 41575.2 41602.6 41623.4 41645.6 234015.0 234973.0 235052.0 235097.0 235537.0 34367.8 34982.3 37658.0 37747.6 38206.6 48352.0 48857.8 48939.5 49195.3 49395.5 34458.8 34693.0 34740.8 34788.1 34988.5 34180.8 34666.8 34774.3 35312.6 35562.3 40247.0 40477.0 40804.6 40914.2 41356.8 33808.3 34095.3 34484.7 34596.7 34631.8 25047.6 25157.3 25214.1 25873.2 26269.0 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#2] jquery.html Cycles:180 Average:38943.03 Median:2288.68 stddev:97595.87 (4264.3%) stddev-sans-first:97827.12 00:05:49 INFO - PID 28345 | Values: 565.5 581.2 590.6 596.5 600.2 22932.2 24012.2 24043.0 24083.2 24106.0 23813.8 24720.9 24986.8 25030.5 25369.9 6426.7 6592.1 6599.4 6604.4 6618.1 6316.2 6527.7 6538.2 6610.4 6624.0 6484.2 6515.8 6518.5 6550.4 6556.3 6467.4 6500.9 6522.3 6739.3 6759.3 6288.8 6291.3 6307.4 6308.7 6311.0 28742.1 28983.3 29015.7 29092.9 29100.1 2264.3 2285.3 2285.6 2286.2 2291.1 19458.0 20559.2 20635.3 20655.1 20679.0 2531.2 2539.6 2595.3 2596.5 2596.6 134815.0 139368.0 155673.0 163098.0 163365.0 15526.3 15622.5 16179.3 16184.4 16528.7 25174.2 25184.4 25184.5 25193.7 25258.6 10185.3 10189.4 10404.5 10421.2 10436.7 9224.1 9227.5 9242.1 9281.2 9294.4 9804.0 9864.7 10025.5 10057.7 10077.9 2907.7 2940.8 2962.8 2981.8 3018.6 998.8 1015.9 1020.3 1023.4 1053.4 20243.0 20399.9 20710.0 20814.6 21310.9 1066.4 1075.9 1085.3 1101.8 1110.6 11220.8 11240.3 11266.2 11379.1 11385.3 570447.0 579185.0 579413.0 581831.0 592123.0 128060.0 129672.0 130130.0 131157.0 132897.3 1163.4 1200.5 1207.7 1217.6 1217.6 17944.0 18476.2 18490.9 18574.0 18699.9 61526.1 64796.7 65036.7 65250.0 65496.7 83781.5 84426.6 84516.6 84563.0 85121.6 14785.1 14883.1 14979.5 15184.9 15208.8 23139.4 23444.5 23666.9 23674.2 23828.6 19100.2 19427.1 19457.6 19606.7 19609.5 15992.6 16946.9 17195.1 17459.2 17777.6 19279.5 19324.0 19369.6 19524.6 19539.4 14616.8 14657.9 14688.7 14722.9 14799.0 17360.1 17364.8 18595.7 18825.0 18858.9 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#3] mootools.html Cycles:180 Average:10281.76 Median:2746.21 stddev:7801.82 (284.1%) stddev-sans-first:7794.87 00:05:49 INFO - PID 28345 | Values: 1353.4 1460.7 1493.3 1496.6 1503.8 17369.8 17891.5 17921.4 17943.6 17947.0 17361.4 17434.3 17482.1 17494.5 17505.1 2723.8 2793.3 2801.8 2803.3 2806.3 2742.6 2751.3 2756.7 2780.9 2885.0 2785.3 2787.2 2799.9 2816.8 2819.2 2666.2 2729.2 2806.7 2809.0 2819.6 2722.1 2746.2 2746.2 2759.6 2760.1 16623.7 16827.2 16840.8 16894.7 17019.1 8388.7 8636.5 8664.8 8668.3 8672.2 5427.2 5572.1 5588.2 5710.7 5738.8 2047.3 2068.1 2090.9 2092.6 2143.9 30009.2 30280.1 30301.5 30319.7 30359.8 6915.1 6929.3 7020.6 7106.1 7194.1 19323.5 19392.3 19470.2 19473.8 19491.4 8430.6 8447.7 8470.3 8484.9 8488.7 7544.0 7731.1 7737.6 7741.9 7796.3 5526.0 5545.6 5625.4 5668.8 5797.7 1550.5 1571.0 1576.9 1582.8 1593.6 919.1 931.9 947.7 949.0 955.8 7852.3 7867.8 7882.0 7912.0 7972.3 763.8 785.5 787.0 792.5 797.2 4339.8 4389.5 5273.4 5301.9 5486.8 24235.0 24573.6 25139.0 25347.6 25348.0 24891.9 25285.1 25450.2 25455.4 25488.0 11774.1 12146.8 12211.4 12226.7 12312.5 8083.1 8086.5 8196.8 8245.7 8267.8 20714.6 21142.5 21194.7 21571.9 21662.8 21450.9 21770.1 22133.3 22311.7 22992.5 12328.1 12427.7 12502.9 12583.2 12602.8 15442.9 15688.1 15688.5 15694.8 15703.0 11504.8 11545.3 11716.2 11761.4 11929.0 11657.8 11698.7 11783.1 11964.6 12202.6 10944.5 10978.0 11153.8 11160.3 11168.9 7174.7 7423.4 7527.0 7544.9 7562.2 7400.1 7546.8 7562.7 7600.8 7634.5 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#4] prototype.html Cycles:180 Average:5691.61 Median:6274.33 stddev:1600.93 (25.5%) stddev-sans-first:1557.75 00:05:49 INFO - PID 28345 | Values: 525.5 552.3 553.5 559.1 572.5 6156.5 6201.8 6241.0 6315.9 6389.1 6189.0 6218.3 6221.2 6269.3 6345.0 5182.6 5195.2 5218.9 5221.2 5270.9 4855.7 5155.6 5209.3 5253.4 5259.8 4961.2 4969.8 4971.6 5016.3 5026.2 4953.0 4964.4 4993.8 5033.3 5041.8 4403.6 4483.4 4516.9 4523.0 4534.8 6126.7 6159.3 6168.4 6192.5 6255.8 5868.7 5878.3 5888.5 5890.2 5909.7 6698.7 6710.8 6728.8 6743.4 6753.8 5062.6 5083.8 5091.8 5092.9 5100.6 6895.0 7030.7 7049.7 7067.6 7074.7 5224.9 5263.0 5266.7 5272.7 5278.5 5273.2 5306.2 5314.2 5317.3 5323.6 5838.6 5862.5 5863.7 5888.1 5905.7 6717.7 6724.4 6750.7 6780.9 6797.1 1739.3 1747.9 1790.9 1826.8 1827.8 1282.3 1283.4 1302.5 1309.3 1310.8 6235.2 6269.4 6279.2 6357.5 6381.2 6662.2 6763.5 6789.7 6862.2 6891.8 6259.4 6280.9 6291.8 6297.7 6357.8 3597.2 3598.4 3609.5 3617.8 3624.3 7011.6 7101.6 7117.3 7121.4 7143.8 7013.9 7016.1 7063.8 7067.5 7079.2 7130.9 7162.2 7162.2 7165.9 7173.5 6824.4 6861.8 6873.3 6882.6 6891.3 6698.3 6817.6 6819.1 6819.8 6838.7 6919.0 7061.9 7149.4 7158.4 7237.9 5062.7 5180.2 5180.4 5213.8 5235.4 6759.1 6802.0 6816.5 6856.3 6873.7 6378.2 6477.4 6517.3 6519.4 6574.9 6409.7 6594.3 6601.3 6611.5 6615.6 6193.5 6529.4 6565.3 6584.9 6641.7 6662.4 6687.5 6711.8 6720.9 6764.4 6311.7 6466.7 6483.1 6515.4 6520.6 00:05:49 INFO - PID 28345 | 00:05:49 INFO - PID 28345 | [#5] yui.html Cycles:180 Average:27808.77 Median:16995.28 stddev:42514.14 (250.2%) stddev-sans-first:42585.41 00:05:49 INFO - PID 28345 | Values: 905.0 921.4 927.4 936.0 980.0 17607.6 18028.6 18053.4 18055.4 18114.7 16920.2 17070.3 17072.4 17083.6 17086.2 1012.4 1029.7 1029.9 1031.8 1032.0 1044.7 1044.7 1044.8 1049.4 1051.9 1069.9 1095.6 1100.9 1106.8 1109.3 1088.7 1089.2 1091.2 1091.6 1101.0 792.9 812.1 815.5 817.0 817.2 18715.2 18931.2 18946.4 18950.5 18999.3 22167.8 22656.8 22786.0 22883.8 22984.8 16027.7 16063.0 16082.8 16363.4 16415.5 4021.0 4036.9 4043.8 4047.9 4048.6 117641.0 146970.0 150716.0 150803.0 153033.2 18847.4 18876.2 19091.3 19117.1 19151.4 34546.7 35023.1 35678.8 35681.8 35684.8 9378.8 9529.7 9532.4 9551.0 9571.6 4407.8 4477.9 4478.3 4485.0 4486.5 6121.4 6217.6 6264.3 6281.7 6287.3 1177.5 1201.2 1208.5 1221.2 1221.7 694.2 705.1 718.8 723.5 727.6 12686.0 12749.0 12769.0 13119.8 13146.3 713.3 731.9 736.3 744.5 753.8 5833.1 5914.7 5950.0 6021.2 6049.5 154526.0 155161.0 156434.2 157473.0 157817.0 137903.0 138050.0 139354.3 139844.3 142554.3 119686.0 120517.4 120790.4 121276.4 122822.4 11219.4 11265.3 11289.8 11374.7 11394.4 52611.0 53806.5 54021.5 54101.5 55056.4 67777.7 67904.3 68179.7 68640.0 69559.3 16163.8 16338.0 16477.2 16505.0 16697.6 17466.8 17616.8 17633.4 17749.3 17754.3 15991.7 16075.1 16100.8 16186.7 16323.9 15924.8 16098.1 16120.1 16199.0 16320.8 16142.3 16174.8 16316.8 16325.8 16394.8 12410.7 12462.7 12510.9 12667.5 12724.2 12560.5 12614.2 12629.0 12817.0 12918.2 00:05:49 INFO - PID 28345 | -------- Summary: end -------- 00:05:49 INFO - PID 28345 | 00:05:50 INFO - TEST-INFO | 28345: exit 0 00:05:50 INFO - TEST-OK | dromaeo_css | took 1108381ms 00:05:50 INFO - TEST-START | kraken 00:05:50 INFO - Initialising browser for kraken test... 00:05:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34212/getInfo.html -profile /tmp/tmpCzmwf9/profile 00:05:50 INFO - TEST-INFO | started process 28709 (/builds/slave/test/build/application/firefox/firefox http://localhost:34212/getInfo.html) 00:05:55 INFO - TEST-INFO | 28709: exit 0 00:05:55 INFO - Browser initialized. 00:05:55 INFO - Running cycle 1/1 for kraken test... 00:05:55 INFO - Using env: {'DISPLAY': ':0', 00:05:55 INFO - 'HOME': '/home/cltbld', 00:05:55 INFO - 'JSGC_DISABLE_POISONING': '1', 00:05:55 INFO - 'LANG': 'en_US.UTF-8', 00:05:55 INFO - 'LANGUAGE': 'en_US:en', 00:05:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:05:55 INFO - 'LOGNAME': 'cltbld', 00:05:55 INFO - 'MAIL': '/var/mail/cltbld', 00:05:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:05:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:05:55 INFO - 'MOZ_CRASHREPORTER': '1', 00:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:05:55 INFO - 'MOZ_NO_REMOTE': '1', 00:05:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:05:55 INFO - 'NO_EM_RESTART': '1', 00:05:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:55 INFO - 'PWD': '/builds/slave/test', 00:05:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:05:55 INFO - 'RUST_BACKTRACE': 'full', 00:05:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:05:55 INFO - 'SHELL': '/bin/bash', 00:05:55 INFO - 'SHLVL': '1', 00:05:55 INFO - 'STYLO_FORCE_DISABLED': '1', 00:05:55 INFO - 'TERM': 'linux', 00:05:55 INFO - 'TMOUT': '86400', 00:05:55 INFO - 'USER': 'cltbld', 00:05:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410', 00:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:55 INFO - '_': '/tools/buildbot/bin/python'} 00:05:55 INFO - TEST-INFO | started process 28944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzmwf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:05:56 INFO - PID 28944 | 00:05:56 INFO - PID 28944 | (/builds/slave/test/build/application/firefox/firefox:28996): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:05:56 INFO - PID 28944 | 00:06:06 INFO - PID 28944 | RSS: Main: 166621184 00:06:06 INFO - PID 28944 | 00:06:09 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34212/tests/kraken/driver.html?testName=audio-beat-detection) 00:06:10 INFO - PID 28944 | RSS: Main: 171638784 00:06:10 INFO - PID 28944 | 00:06:12 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34212/tests/kraken/driver.html?testName=audio-dft) 00:06:13 INFO - PID 28944 | RSS: Main: 172109824 00:06:13 INFO - PID 28944 | 00:06:16 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34212/tests/kraken/driver.html?testName=audio-fft) 00:06:16 INFO - PID 28944 | RSS: Main: 166899712 00:06:16 INFO - PID 28944 | 00:06:18 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34212/tests/kraken/driver.html?testName=audio-oscillator) 00:06:19 INFO - PID 28944 | RSS: Main: 168296448 00:06:19 INFO - PID 28944 | 00:06:21 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34212/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:06:22 INFO - PID 28944 | RSS: Main: 168644608 00:06:22 INFO - PID 28944 | 00:06:25 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34212/tests/kraken/driver.html?testName=imaging-darkroom) 00:06:25 INFO - PID 28944 | RSS: Main: 169201664 00:06:25 INFO - PID 28944 | 00:06:29 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34212/tests/kraken/driver.html?testName=imaging-desaturate) 00:06:29 INFO - PID 28944 | RSS: Main: 169521152 00:06:29 INFO - PID 28944 | 00:06:32 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34212/tests/kraken/driver.html?testName=json-parse-financial) 00:06:33 INFO - PID 28944 | RSS: Main: 171892736 00:06:33 INFO - PID 28944 | 00:06:35 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34212/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:06:35 INFO - PID 28944 | RSS: Main: 171397120 00:06:35 INFO - PID 28944 | 00:06:37 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:06:37 INFO - PID 28944 | RSS: Main: 171458560 00:06:37 INFO - PID 28944 | 00:06:39 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:06:40 INFO - PID 28944 | RSS: Main: 168034304 00:06:40 INFO - PID 28944 | 00:06:42 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:06:43 INFO - PID 28944 | RSS: Main: 168419328 00:06:43 INFO - PID 28944 | 00:06:46 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:06:46 INFO - PID 28944 | RSS: Main: 168624128 00:06:46 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:34212/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34212/tests/kraken/driver.html?testName=ai-astar) 00:06:48 INFO - PID 28944 | RSS: Main: 170270720 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | __start_tp_report 00:06:48 INFO - PID 28944 | _x_x_mozilla_page_load 00:06:48 INFO - PID 28944 | _x_x_mozilla_page_load_details 00:06:48 INFO - PID 28944 | |i|pagename|runs| 00:06:48 INFO - PID 28944 | |0;ai-astar;105;105;105;106;105;108;108;106;107;107 00:06:48 INFO - PID 28944 | |1;audio-beat-detection;114;115;112;117;112;114;116;111;134;113 00:06:48 INFO - PID 28944 | |2;audio-dft;162;163;161;160;162;161;161;162;164;164 00:06:48 INFO - PID 28944 | |3;audio-fft;74;74;73;73;74;76;76;75;74;73 00:06:48 INFO - PID 28944 | |4;audio-oscillator;79;78;78;79;80;80;81;77;77;77 00:06:48 INFO - PID 28944 | |5;imaging-gaussian-blur;114;114;110;114;113;113;113;114;113;114 00:06:48 INFO - PID 28944 | |6;imaging-darkroom;150;150;149;149;151;148;149;150;149;149 00:06:48 INFO - PID 28944 | |7;imaging-desaturate;94;94;94;94;94;94;94;96;93;93 00:06:48 INFO - PID 28944 | |8;json-parse-financial;45;43;43;50;46;48;48;45;47;46 00:06:48 INFO - PID 28944 | |9;json-stringify-tinderbox;38;39;38;39;39;39;39;38;39;38 00:06:48 INFO - PID 28944 | |10;stanford-crypto-aes;71;75;73;74;76;72;71;71;72;71 00:06:48 INFO - PID 28944 | |11;stanford-crypto-ccm;115;107;103;109;107;120;105;104;104;112 00:06:48 INFO - PID 28944 | |12;stanford-crypto-pbkdf2;155;151;160;155;158;152;153;160;155;163 00:06:48 INFO - PID 28944 | |13;stanford-crypto-sha256-iterative;64;61;60;59;60;61;59;58;59;66 00:06:48 INFO - PID 28944 | __end_tp_report 00:06:48 INFO - PID 28944 | __start_cc_report 00:06:48 INFO - PID 28944 | _x_x_mozilla_cycle_collect,903 00:06:48 INFO - PID 28944 | __end_cc_report 00:06:48 INFO - PID 28944 | __startTimestamp1505372808882__endTimestamp 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | ------- Summary: start ------- 00:06:48 INFO - PID 28944 | Number of tests: 14 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#0] ai-astar Cycles:10 Average:106.20 Median:106.50 stddev:1.23 (1.2%) stddev-sans-first:1.22 00:06:48 INFO - PID 28944 | Values: 105.0 105.0 105.0 106.0 105.0 108.0 108.0 106.0 107.0 107.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:114.50 stddev:6.66 (5.8%) stddev-sans-first:7.04 00:06:48 INFO - PID 28944 | Values: 114.0 115.0 112.0 117.0 112.0 114.0 116.0 111.0 134.0 113.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:1.41 00:06:48 INFO - PID 28944 | Values: 162.0 163.0 161.0 160.0 162.0 161.0 161.0 162.0 164.0 164.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 00:06:48 INFO - PID 28944 | Values: 74.0 74.0 73.0 73.0 74.0 76.0 76.0 75.0 74.0 73.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.51 00:06:48 INFO - PID 28944 | Values: 79.0 78.0 78.0 79.0 80.0 80.0 81.0 77.0 77.0 77.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.23 (1.1%) stddev-sans-first:1.27 00:06:48 INFO - PID 28944 | Values: 114.0 114.0 110.0 114.0 113.0 113.0 113.0 114.0 113.0 114.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 00:06:48 INFO - PID 28944 | Values: 150.0 150.0 149.0 149.0 151.0 148.0 149.0 150.0 149.0 149.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 00:06:48 INFO - PID 28944 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 93.0 93.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#8] json-parse-financial Cycles:10 Average:46.10 Median:46.50 stddev:2.23 (4.8%) stddev-sans-first:2.33 00:06:48 INFO - PID 28944 | Values: 45.0 43.0 43.0 50.0 46.0 48.0 48.0 45.0 47.0 46.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#9] json-stringify-tinderbox Cycles:10 Average:38.60 Median:39.00 stddev:0.52 (1.3%) stddev-sans-first:0.50 00:06:48 INFO - PID 28944 | Values: 38.0 39.0 38.0 39.0 39.0 39.0 39.0 38.0 39.0 38.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:72.50 stddev:1.84 (2.5%) stddev-sans-first:1.86 00:06:48 INFO - PID 28944 | Values: 71.0 75.0 73.0 74.0 76.0 72.0 71.0 71.0 72.0 71.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#11] stanford-crypto-ccm Cycles:10 Average:108.60 Median:108.00 stddev:5.52 (5.1%) stddev-sans-first:5.35 00:06:48 INFO - PID 28944 | Values: 115.0 107.0 103.0 109.0 107.0 120.0 105.0 104.0 104.0 112.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.50 stddev:3.91 (2.5%) stddev-sans-first:4.12 00:06:48 INFO - PID 28944 | Values: 155.0 151.0 160.0 155.0 158.0 152.0 153.0 160.0 155.0 163.0 00:06:48 INFO - PID 28944 | 00:06:48 INFO - PID 28944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:60.50 stddev:2.50 (4.1%) stddev-sans-first:2.35 00:06:48 INFO - PID 28944 | Values: 64.0 61.0 60.0 59.0 60.0 61.0 59.0 58.0 59.0 66.0 00:06:48 INFO - PID 28944 | -------- Summary: end -------- 00:06:48 INFO - PID 28944 | 00:06:49 INFO - PID 28944 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:06:49 INFO - TEST-INFO | 28944: exit 0 00:06:49 INFO - TEST-OK | kraken | took 59778ms 00:06:49 INFO - SUITE-END | took 1168s 00:06:50 INFO - Completed test suite (00:19:28) 00:06:50 INFO - javascript benchmark 00:06:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8952.97817969688, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3843.9423408648877, 3846.0961674006603, 3879.573246942836, 3895.74677645953, 3912.941305880414, 6147.81556553303, 6161.199044124258, 6282.465990390817, 6305.148804911341, 6375.0, 6277.748890044393, 6288.05679148128, 6291.370862913706, 6296.464800491964, 6368.363163683629, 5641.746121424546, 5657.151427285919, 5717.714114294279, 5727.3699893011735, 5742.885142297151, 980.329193382985, 5610.831675049755, 5643.068893632546, 5672.319321681383, 5709.514691251248, 5633.830985070434, 5653.349864765563, 5699.430056994288, 5705.828825135252, 5719.513841323493, 5639.971800140973, 5651.547876169897, 5717.256756621654, 5720.942790572082, 5724.9427505724825, 5590.496855283044, 5641.717914104278, 5712.257406537124, 5717.371089180187, 5730.426957304237, 6102.176206212149, 6244.750209991595, 6293.213348331458, 6315.905261421082, 6348.016057511093, 6616.536842421033, 6702.597844129368, 6720.630365329905, 6730.899036514456, 6733.057371967929, 6767.898481522781, 6789.083473731032, 6864.176298844171, 6864.38220560147, 6874.968754686837, 6359.777407790752, 6422.165118534561, 6434.099226108348, 6447.903281450735, 6454.903176452404, 7004.824879378057, 7040.964795175992, 7051.788446346618, 7110.0, 7114.217436082027, 6641.767538136239, 6709.463242940651, 6718.294579069225, 6762.425193858478, 6844.794656160323, 6820.31796820314, 6854.760083397057, 6879.724811007603, 6880.277570854988, 6914.654267286615, 6748.7300507979135, 6833.384995350442, 6842.589444633338, 6847.931520684829, 6850.965745171342, 6754.662266886636, 6769.05233267343, 6772.966135169391, 6854.657267136723, 6856.451483881277, 4920.926186107211, 4964.404271487445, 5011.649184557119, 5024.924626130611, 5045.520675535819, 4440.4005459263235, 4595.6783025187915, 4625.352450656911, 4634.026854360622, 4647.814087436464, 6303.936960630427, 6311.842203944846, 6319.210098737658, 6399.976003839363, 6410.743570257231, 6804.829879253059, 6817.386435220854, 6817.863642727217, 6887.621180835102, 6903.620300883399, 6344.68276586178, 6380.968095159495, 6382.297947225801, 6402.967985160138, 6403.135576697179, 5451.64564303319, 5520.66875987442, 5556.444355564411, 5583.609147359646, 5587.552995760329, 6954.3045695430055, 7059.364657180879, 7079.29207079288, 7133.89299160513, 7162.140543134858, 6804.829879253059, 6807.285235050248, 6812.965935170292, 6916.239213686591, 6925.515213935077, 6980.6509674515055, 7016.859662806613, 7080.327368899946, 7096.396806271525, 7114.537555058904, 6754.18949726036, 6778.8644227116165, 6796.048553202457, 6819.488538359544, 6839.829004274933, 6841.144856892888, 6861.176658800976, 6935.098437203132, 6937.202221744362, 6939.271376505596, 6464.159659244268, 6546.869062618625, 6567.310432404529, 6570.310117437792, 6660.866782664417, 6481.967590162019, 6519.706613202323, 6525.967370163309, 6526.282108967915, 6541.443977261986, 6513.674316284072, 6568.014797780371, 6575.079488871466, 6575.572587781779, 6578.210614726264, 6619.172603424572, 6619.635920024445, 6666.233383160805, 6696.263411024686, 6697.229818570927, 6320.841978950563, 6401.775937842153, 6403.583767055126, 6415.679216039086, 6494.1232933553365], "value": 6202.733558977932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.6023469556048, 933.3653115881198, 947.5451783144091, 989.6189966862755, 1000.8899021107682, 43356.0, 43769.562304376945, 44436.77781611095, 44447.555524444746, 44530.109397812026, 42185.789071054605, 42278.0, 42390.94022649436, 42475.78762106193, 42486.36270455938, 7356.77929662111, 7497.550146991171, 7503.549787012769, 7508.662110205027, 7512.962435187844, 7416.517926334798, 7436.628168591576, 7500.887486687704, 7502.362299204574, 7506.849863002737, 7984.800379990517, 8204.384671149657, 8208.138145494726, 8209.384296177781, 8209.753707388758, 8109.918900811005, 8120.75637730869, 8144.348452123875, 8148.307393871499, 8149.388795840336, 7828.882566761503, 8044.356451483867, 8051.919480805175, 8053.43625946184, 8065.233802788725, 40664.0, 40853.0, 40922.38616420756, 40954.1809163818, 40965.385519217234, 3829.3681542545446, 3866.4586957825927, 3868.574456809749, 3875.476810630557, 3876.030992251937, 32865.0, 33700.32599348024, 33808.15479613029, 33844.49233261503, 34029.6597034029, 5454.972725136349, 5471.316085489314, 5522.364928033247, 5523.530499907512, 5536.833894983157, 212680.0, 216337.0, 223470.0, 224398.0, 273025.999999998, 53061.46938530565, 53128.46871531235, 53163.0, 53210.201846972326, 53566.0, 56021.43978560244, 56281.43718562844, 56435.61386316834, 56454.717726411924, 56508.71745641246, 15970.281337339848, 16043.518694439186, 16065.11641859709, 16070.276837542338, 16077.0, 12792.61622151337, 12897.742045159044, 12945.223286602833, 12949.482020719253, 12954.0, 14950.626234344229, 14970.0, 14975.625609359853, 15121.697566048617, 15146.091234525964, 5908.438698323653, 5938.851528711817, 5943.673097979567, 5955.374685657944, 6030.909536356959, 1063.128234847433, 1106.5957489193056, 1119.283658458587, 1121.7924683933497, 1127.21095233337, 25793.0, 25868.741312587008, 25885.0, 25887.482250354886, 25941.09206177775, 1216.2641601830942, 1220.5117952818944, 1222.5659890738837, 1222.6882145053132, 1223.1499108119772, 13603.455861765418, 13617.523386681418, 13653.590392288248, 13832.0, 13931.233782142079, 293661.0, 295450.0, 295723.0, 296033.0, 296722.0, 59357.0, 59506.404935950086, 59611.0, 59689.701551492835, 59728.40271597228, 1491.56744544081, 1509.6225943513903, 1527.2211172301984, 1527.2287494815268, 1545.0883978452766, 24992.506743930608, 25397.22219444621, 25590.61614075753, 25650.0, 25779.871100644377, 41480.58519414767, 41575.168496630504, 41602.58397415987, 41623.37564936468, 41645.58354416417, 234015.0, 234973.0, 235052.0, 235097.0, 235537.0, 34367.82816085903, 34982.30035399328, 37658.0, 37747.62252377441, 38206.61793382031, 48352.0, 48857.755711221216, 48939.5106048935, 49195.262071068246, 49395.50604493909, 34458.82770586131, 34693.0, 34740.826295868355, 34788.130296742784, 34988.47517287192, 34180.82909585436, 34666.82666586651, 34774.304513909075, 35312.646873531965, 35562.28875422425, 40246.99382515343, 40477.0, 40804.59195408008, 40914.18171636491, 41356.79321603373, 33808.3238335227, 34095.31809363848, 34484.655153449145, 34596.654033459345, 34631.82684086564, 25047.624285636095, 25157.33959859017, 25214.117505887207, 25873.22380328593, 26269.0], "value": 18587.788591236073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.502357925026, 581.1573218832693, 590.6190507122908, 596.4989408896527, 600.249687890137, 22932.197373091924, 24012.159574414898, 24043.038278468885, 24083.15708950187, 24106.0, 23813.761862381372, 24720.87639561804, 24986.75013249867, 25030.499390012188, 25369.873150634266, 6426.678666066689, 6592.143021407211, 6599.4390476809285, 6604.372584604479, 6618.139641846553, 6316.242050953869, 6527.706253218593, 6538.1827271591055, 6610.40506354428, 6624.039514270428, 6484.221893372802, 6515.837104072389, 6518.478521718275, 6550.410463058324, 6556.311587283338, 6467.417932386108, 6500.93499065008, 6522.347765223463, 6739.326067393271, 6759.32406759325, 6288.842778930518, 6291.307956124822, 6307.400796924285, 6308.684565771739, 6310.9684451577905, 28742.13773586775, 28983.275418114506, 29015.709842901724, 29092.854535727398, 29100.126996189938, 2264.275431861805, 2285.3029825903095, 2285.5543169082034, 2286.2341115726254, 2291.1179196009657, 19458.0, 20559.177632894814, 20635.277765278293, 20655.070521826554, 20679.0, 2531.240627811649, 2539.619057141425, 2595.3122422558035, 2596.545604519202, 2596.5845464725744, 134815.0, 139368.0, 155673.0, 163098.0, 163365.0, 15526.301316440788, 15622.453214137451, 16179.271932763055, 16184.352625894833, 16528.6694266114, 25174.23780335359, 25184.37039074038, 25184.496310073697, 25193.748062519142, 25258.621120683205, 10185.33795303303, 10189.388636681822, 10404.531796069195, 10421.218408619385, 10436.686899393031, 9224.123708247706, 9227.492487913229, 9242.07579242084, 9281.164695177466, 9294.442333460014, 9803.950980245054, 9864.704058878246, 10025.498725063717, 10057.748556286006, 10077.899221007843, 2907.7237662422035, 2940.779441541893, 2962.837043962603, 2981.7912746107563, 3018.592490013864, 998.7652901568125, 1015.8780946286493, 1020.2654089055868, 1023.4473384372504, 1053.3890343600692, 20243.0, 20399.898000509904, 20710.0, 20814.58370832575, 21310.893445532674, 1066.3548553125402, 1075.8547596074586, 1085.2891356161726, 1101.7521057762099, 1110.6112860498922, 11220.775584488265, 11240.325580465198, 11266.211365204357, 11379.08967282632, 11385.259958102697, 570447.0, 579185.0, 579413.0, 581831.0, 592123.0, 128060.0, 129672.0, 130130.0, 131157.0, 132897.33551332183, 1163.3775929877474, 1200.4717924113363, 1207.6558180918396, 1217.573849152807, 1217.6103646833105, 17944.0, 18476.168572414004, 18490.89054656725, 18574.0, 18699.906500467412, 61526.07710884251, 64796.67601661962, 65036.674816625615, 65250.0, 65496.67251663711, 83781.48655540343, 84426.57786711027, 84516.57741711252, 84563.0, 85121.57439213012, 14785.11289322644, 14883.10701357922, 14979.475718349806, 15184.924075379995, 15208.847911521187, 23139.421514462272, 23444.53110937806, 23666.88166559225, 23674.171404001467, 23828.642570361113, 19100.23599056022, 19427.125779340247, 19457.61084778325, 19606.705899411805, 19609.509762256057, 15992.600184995468, 16946.898451600606, 17195.14024298755, 17459.214335354685, 17777.644447111245, 19279.51801204981, 19324.0, 19369.612607748048, 19524.609507810048, 19539.436845052645, 14616.780748288997, 14657.853421465648, 14688.678018978344, 14722.852771472148, 14799.0, 17360.131993400533, 17364.82635173632, 18595.72106418432, 18825.0, 18858.905705471385], "value": 12543.972680775601, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.370682632576, 1460.744369735296, 1493.2682985337187, 1496.633324835415, 1503.8420965798591, 17369.82630173698, 17891.46325610232, 17921.37275195365, 17943.641127177463, 17947.0, 17361.392351267707, 17434.302627894867, 17482.125893705295, 17494.475165745018, 17505.124743762826, 2723.7644715548413, 2793.25978615667, 2801.817881837674, 2803.313188268877, 2806.3124534488975, 2742.5886117082396, 2751.312171957011, 2756.682981457128, 2780.8609569521545, 2885.047934181715, 2785.2897511134634, 2787.23351078453, 2799.8740056697397, 2816.8450735209553, 2819.16834533813, 2666.1601595497455, 2729.249456399496, 2806.7473927346537, 2809.030884344898, 2819.5629677400034, 2722.060888993294, 2746.2036009557405, 2746.217328061513, 2759.6412466379243, 2760.1305588739483, 16623.66752664952, 16827.158642067847, 16840.831591684047, 16894.74657880133, 17019.149042547946, 8388.748337549883, 8636.524991125485, 8664.826703465895, 8668.349873759431, 8672.219500245008, 5427.185922111676, 5572.136318870582, 5588.245586845765, 5710.71446427677, 5738.8278351649515, 2047.2834507922257, 2068.13138481838, 2090.886516016886, 2092.5814837032653, 2143.9035243414082, 30009.249768755737, 30280.091597252118, 30301.545476817864, 30319.696803031908, 30359.848200758854, 6915.135608048994, 6929.341712537301, 7020.613866237406, 7106.076210092655, 7194.136703595602, 19323.51691207703, 19392.321268755524, 19470.22119115248, 19473.805261947484, 19491.415257542012, 8430.578471076422, 8447.704330348408, 8470.322374210049, 8484.915150848536, 8488.702895398632, 7543.962280188564, 7731.149573546905, 7737.5744334062165, 7741.922580774233, 7796.337311328487, 5525.972370138124, 5545.585875601696, 5625.38120806711, 5668.773249070074, 5797.652140871562, 1550.4573399310377, 1570.9921450392676, 1576.905385676863, 1582.8338024507261, 1593.6334643032167, 919.1268295119529, 931.902150274225, 947.6635794293064, 948.966786162481, 955.7658373698488, 7852.332551733052, 7867.842643147105, 7882.0, 7911.960440197762, 7972.2824945755165, 763.816683995837, 785.4580339565681, 786.9921300787033, 792.5482474989201, 797.1629788721818, 4339.804708788112, 4389.517153113155, 5273.3935597406025, 5301.857392481789, 5486.835394938158, 24235.0, 24573.631395529083, 25139.0, 25347.619785703228, 25348.0, 24891.875540622183, 25285.115020974546, 25450.236492905242, 25455.36361590938, 25488.0, 11774.05807535395, 12146.817797733042, 12211.389430528616, 12226.694332641577, 12312.50749970009, 8083.110857805519, 8086.5148091114725, 8196.795080123045, 8245.711400100967, 8267.83464330698, 20714.58570828545, 21142.47143821417, 21194.682079769125, 21571.921403929427, 21662.783372166075, 21450.892745536174, 21770.12919483203, 22133.33599992003, 22311.66532502046, 22992.540149197255, 12328.137030407785, 12427.689307767378, 12502.937485312515, 12583.182093163916, 12602.810957835456, 15442.922785386001, 15688.137152456724, 15688.529344119695, 15694.764578531103, 15703.0, 11504.827427588425, 11545.307281563133, 11716.23844450108, 11761.411929403666, 11929.0, 11657.766844663229, 11698.70753231176, 11783.116266280234, 11964.64106076819, 12202.572909948109, 10944.452777361259, 10978.011978921935, 11153.832692509457, 11160.33038017689, 11168.888311116785, 7174.713011479483, 7423.443241756781, 7527.0, 7544.886826697713, 7562.168161502121, 7400.148982867039, 7546.849063018819, 7562.697492100475, 7600.771976840703, 7634.541927484369], "value": 7099.003040363303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.4823998361611, 552.3234038303078, 553.5212041584026, 559.1054313099041, 572.5362456410307, 6156.491659543407, 6201.790650823092, 6240.970239910409, 6315.936840631598, 6389.122007752867, 6189.0, 6218.31598524162, 6221.160143380643, 6269.310375858652, 6344.968275158618, 5182.585393168538, 5195.246689230059, 5218.877941242651, 5221.190715439094, 5270.92093618596, 4855.732934688591, 5155.613329000321, 5209.296744939442, 5253.4221235664045, 5259.8422047338645, 4961.231009193562, 4969.801207951696, 4971.552560269575, 5016.322796422491, 5026.1706818375105, 4953.0, 4964.379452568429, 4993.800247990076, 5033.320501732256, 5041.81517343424, 4403.581659742319, 4483.417155769729, 4516.887077823048, 4523.0, 4534.773261336953, 6126.693665316761, 6159.291681456645, 6168.383161683841, 6192.504599632019, 6255.808608232495, 5868.735906884201, 5878.265216847894, 5888.5289176865745, 5890.234269544974, 5909.674967876765, 6698.732050717966, 6710.765123220664, 6728.764493242713, 6743.35938085881, 6753.797386078426, 5062.645614806965, 5083.847484575469, 5091.79632814687, 5092.872678183038, 5100.617453690988, 6895.0, 7030.683619237096, 7049.68276427562, 7067.611281379522, 7074.717011319541, 5224.92162617561, 5262.973685131627, 5266.709656134271, 5272.736363181825, 5278.5249327560705, 5273.209018647157, 5306.151015837448, 5314.229436731653, 5317.282166907418, 5323.600729945192, 5838.649681019152, 5862.501687356623, 5863.736131874076, 5888.116782482576, 5905.704714764244, 6717.664116794141, 6724.394804467622, 6750.662466876636, 6780.898286525706, 6797.0823938767635, 1739.252121587704, 1747.881355932179, 1790.919408626615, 1826.7990521042675, 1827.798942116366, 1282.3460035381836, 1283.3519072868141, 1302.5310888080282, 1309.3387839141174, 1310.8361454818148, 6235.220597425322, 6269.435750782452, 6279.215098112736, 6357.459615932605, 6381.245157581609, 6662.200535935719, 6763.458923286125, 6789.694463749143, 6862.245153033163, 6891.793246202622, 6259.436650701458, 6280.905786413207, 6291.811245662638, 6297.748090076346, 6357.792019516277, 3597.1906321078072, 3598.370285200132, 3609.5307610011055, 3617.7829330239742, 3624.2817886585062, 7011.614361210182, 7101.644917754092, 7117.3238542338395, 7121.394681452135, 7143.821404464826, 7013.929860701328, 7016.122984626922, 7063.788086357417, 7067.505274630829, 7079.185893622196, 7130.92869071313, 7162.212156662763, 7162.247963963709, 7165.856682866418, 7173.497855150194, 6824.4199243064895, 6861.828454288483, 6873.2783057778215, 6882.5870447773295, 6891.310868913069, 6698.330166983263, 6817.625030623363, 6819.147606549182, 6819.795406137824, 6838.692258848463, 6918.965405172942, 7061.894071589033, 7149.428045756431, 7158.355747982707, 7237.927620723725, 5062.696238225718, 5180.171172612364, 5180.378354597472, 5213.7914483421755, 5235.3717553893775, 6759.087523184504, 6802.0, 6816.454683625398, 6856.314368563303, 6873.725050997904, 6378.170837791057, 6477.4170324671, 6517.315681853527, 6519.445847103049, 6574.901376479453, 6409.743610255724, 6594.252523081484, 6601.339866013553, 6611.504137189634, 6615.6030638161865, 6193.535484838745, 6529.444997175293, 6565.343465653396, 6584.901226481702, 6641.734330626721, 6662.367075127855, 6687.465002799667, 6711.765088221889, 6720.899186512109, 6764.391204791593, 6311.684415779285, 6466.741330346734, 6483.067992786548, 6515.413612774873, 6520.576162549419], "value": 5226.571794824685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.0406569036821, 921.3550514639754, 927.4481683398376, 935.96256149754, 979.9902000979988, 17607.559811004732, 18028.63942721145, 18053.368132115364, 18055.36806211783, 18114.728279075807, 16920.23858926348, 17070.317187312492, 17072.402465913696, 17083.57291067721, 17086.231119599615, 1012.3571532077128, 1029.6602121299952, 1029.8558201851747, 1031.840064789955, 1032.0453580438066, 1044.6604853422668, 1044.7022598559413, 1044.843273508976, 1049.380865289479, 1051.9368837869713, 1069.9251052426334, 1095.594629986902, 1100.8899110088967, 1106.8450416941635, 1109.3454861631635, 1088.7441451259026, 1089.1667874076338, 1091.154355374587, 1091.5688303120262, 1101.0255923507673, 792.8810678398287, 812.1026265976129, 815.510693583845, 816.9918300816976, 817.1501638296165, 18715.157817898227, 18931.242750289974, 18946.43160705181, 18950.526236844053, 18999.335023274256, 22167.77832221673, 22656.773432265632, 22786.0, 22883.771162288496, 22984.77015229843, 16027.679446411006, 16063.0, 16082.839171608251, 16363.427280045142, 16415.507534773977, 4020.979895100506, 4036.9192616147807, 4043.777592232426, 4047.898802529931, 4048.5748996355546, 117641.0, 146970.0, 150716.0, 150803.0, 153033.23483382622, 18847.434576962714, 18876.24495020184, 19091.331803387093, 19117.13972871224, 19151.425457236026, 34546.65453345485, 35023.12442188965, 35678.82160589232, 35681.82159089188, 35684.821575891954, 9378.812423751624, 9529.666461673947, 9532.428054316762, 9551.044895510393, 9571.61713531451, 4407.845725399596, 4477.910441791146, 4478.328250762412, 4484.977575112103, 4486.528914463935, 6121.418465245794, 6217.626942383471, 6264.2796078451565, 6281.7173227204885, 6287.276963149205, 1177.528988404645, 1201.243216773427, 1208.4984731336572, 1221.1635030004475, 1221.7495413440224, 694.191267173737, 705.1397295299727, 718.8202949262684, 723.4827098624509, 727.5598263050883, 12686.04854635906, 12749.0, 12769.0, 13119.803202951964, 13146.34268286601, 713.2724620886667, 731.9085114360705, 736.3152268390448, 744.4528271720282, 753.7701001194579, 5833.066709326487, 5914.704264786744, 5950.0, 6021.2473440819895, 6049.5462840287155, 154526.0, 155161.0, 156434.21782891013, 157473.0, 157817.0, 137903.0, 138050.0, 139354.30322848322, 139844.30077849547, 142554.2872285632, 119686.0, 120517.39741301237, 120790.3960480192, 121276.39361803135, 122822.38588806998, 11219.382933938712, 11265.26775759573, 11289.830652540382, 11374.658760237206, 11394.373309467726, 52611.0, 53806.461935380146, 54021.45978540322, 54101.45898541122, 55056.449435505136, 67777.66111169412, 67904.3209567898, 68179.65910170418, 68640.0, 69559.30440695529, 16163.838361616234, 16338.0, 16477.176141193133, 16505.0, 16697.582560436087, 17466.82533174652, 17616.823831761518, 17633.382831600833, 17749.29002839872, 17754.28982840672, 15991.68016639684, 16075.115868627337, 16100.758488622445, 16186.67626647484, 16323.918380408022, 15924.840751592335, 16098.11460369691, 16120.113393763455, 16199.0, 16320.755188671941, 16142.273597687898, 16174.757378639566, 16316.755248671043, 16325.755113673067, 16394.754078689068, 12410.689732756753, 12462.688432789253, 12510.87489125097, 12667.493300267886, 12724.1729287596, 12560.497580097059, 12614.180078294881, 12629.0, 12817.038722095693, 12918.22490650564], "value": 9596.623385399684, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 106.0, 105.0, 108.0, 108.0, 106.0, 107.0, 107.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 112.0, 117.0, 112.0, 114.0, 116.0, 111.0, 134.0, 113.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0, 164.0, 164.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 73.0, 74.0, 76.0, 76.0, 75.0, 74.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 80.0, 80.0, 81.0, 77.0, 77.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 151.0, 148.0, 149.0, 150.0, 149.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 93.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 43.0, 43.0, 50.0, 46.0, 48.0, 48.0, 45.0, 47.0, 46.0], "value": 46.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 38.0, 39.0, 38.0], "value": 38.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 73.0, 74.0, 76.0, 72.0, 71.0, 71.0, 72.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 103.0, 109.0, 107.0, 120.0, 105.0, 104.0, 104.0, 112.0], "value": 108.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 151.0, 160.0, 155.0, 158.0, 152.0, 153.0, 160.0, 155.0, 163.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 59.0, 60.0, 61.0, 59.0, 58.0, 59.0, 66.0], "value": 60.7, "unit": "score"}]}]} 00:06:50 INFO - Return code: 0 00:06:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:06:50 INFO - # TBPL SUCCESS # 00:06:50 INFO - Running post-action listener: _package_coverage_data 00:06:50 INFO - Running post-action listener: _resource_record_post_action 00:06:50 INFO - [mozharness: 2017-09-14 07:06:50.170112Z] Finished run-tests step (success) 00:06:50 INFO - Running post-run listener: _resource_record_post_run 00:06:50 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327909376; Read time: 56; Write time: 331440 00:06:50 INFO - TinderboxPrint: CPU usage
13.1% 00:06:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 56 00:06:50 INFO - TinderboxPrint: I/O write bytes / time
327,909,376 / 331,440 00:06:50 INFO - TinderboxPrint: CPU idle
8,219.7 (86.9%) 00:06:50 INFO - TinderboxPrint: CPU user
1,187.0 (12.6%) 00:06:50 INFO - TinderboxPrint: Swap in / out
0 / 0 00:06:50 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13369344; Read time: 0; Write time: 1316 00:06:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:06:50 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314052608; Read time: 56; Write time: 330124 00:06:50 INFO - Running post-run listener: _upload_blobber_files 00:06:50 INFO - Blob upload gear active. 00:06:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:06:50 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 00:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:06:51 INFO - (blobuploader) - INFO - Open directory for files ... 00:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 00:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 00:06:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:52 INFO - (blobuploader) - INFO - Done attempting. 00:06:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:06:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:06:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:06:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:06:53 INFO - (blobuploader) - INFO - Done attempting. 00:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:07:00 INFO - (blobuploader) - INFO - Done attempting. 00:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 00:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 00:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:07:01 INFO - (blobuploader) - INFO - Done attempting. 00:07:01 INFO - (blobuploader) - INFO - Iteration through files over. 00:07:01 INFO - Return code: 0 00:07:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:07:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:07:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f394e3cfccb3eb330061ea2b53ee97cfae45fe8fad8d037e065da1418971bbdb3654f8bdb1e1cc4c1dcd540d5697f7272f8eb373684ea80a15849a51e833e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b64261b59cbc69868863bf523a336c98da24d01892cb8ed6adc8c675e2bf80cb8e1c4f6293f02cd32b7923681fd4eb45c816879640ada64a4165d197613fe4d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510e1e0e51406bb8b965bd28bee048f768fae3484ce34bb5010254c94320b0d006b586ba94748ffbfe765544b7d8d3ee29c0962e5a95d15e968315b9f9f6337a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05bf2ae4a4aaf49bf8bda9df00eb6358451b5ab3bbf180683ec7176d4c3ccc0c07576e75448b461ceef051d34d6b8af7d56a7ceaea72573187def065b5f0182d"} 00:07:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:07:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:07:01 INFO - Contents: 00:07:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f394e3cfccb3eb330061ea2b53ee97cfae45fe8fad8d037e065da1418971bbdb3654f8bdb1e1cc4c1dcd540d5697f7272f8eb373684ea80a15849a51e833e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b64261b59cbc69868863bf523a336c98da24d01892cb8ed6adc8c675e2bf80cb8e1c4f6293f02cd32b7923681fd4eb45c816879640ada64a4165d197613fe4d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510e1e0e51406bb8b965bd28bee048f768fae3484ce34bb5010254c94320b0d006b586ba94748ffbfe765544b7d8d3ee29c0962e5a95d15e968315b9f9f6337a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05bf2ae4a4aaf49bf8bda9df00eb6358451b5ab3bbf180683ec7176d4c3ccc0c07576e75448b461ceef051d34d6b8af7d56a7ceaea72573187def065b5f0182d"} 00:07:01 INFO - Running post-run listener: copy_logs_to_upload_dir 00:07:01 INFO - Copying logs to upload dir... 00:07:01 INFO - mkdir: /builds/slave/test/build/upload/logs 00:07:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.478981 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-14 00:07:01.185202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:07:01.188646) ========= 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=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f394e3cfccb3eb330061ea2b53ee97cfae45fe8fad8d037e065da1418971bbdb3654f8bdb1e1cc4c1dcd540d5697f7272f8eb373684ea80a15849a51e833e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b64261b59cbc69868863bf523a336c98da24d01892cb8ed6adc8c675e2bf80cb8e1c4f6293f02cd32b7923681fd4eb45c816879640ada64a4165d197613fe4d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510e1e0e51406bb8b965bd28bee048f768fae3484ce34bb5010254c94320b0d006b586ba94748ffbfe765544b7d8d3ee29c0962e5a95d15e968315b9f9f6337a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05bf2ae4a4aaf49bf8bda9df00eb6358451b5ab3bbf180683ec7176d4c3ccc0c07576e75448b461ceef051d34d6b8af7d56a7ceaea72573187def065b5f0182d"} build_url:https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011512 build_url: 'https://queue.taskcluster.net/v1/task/Jpw2lK2MQ5ysikvcV-Flhw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15f394e3cfccb3eb330061ea2b53ee97cfae45fe8fad8d037e065da1418971bbdb3654f8bdb1e1cc4c1dcd540d5697f7272f8eb373684ea80a15849a51e833e9", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b64261b59cbc69868863bf523a336c98da24d01892cb8ed6adc8c675e2bf80cb8e1c4f6293f02cd32b7923681fd4eb45c816879640ada64a4165d197613fe4d", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510e1e0e51406bb8b965bd28bee048f768fae3484ce34bb5010254c94320b0d006b586ba94748ffbfe765544b7d8d3ee29c0962e5a95d15e968315b9f9f6337a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05bf2ae4a4aaf49bf8bda9df00eb6358451b5ab3bbf180683ec7176d4c3ccc0c07576e75448b461ceef051d34d6b8af7d56a7ceaea72573187def065b5f0182d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 00:07:01.217301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:07:01.217613) ========= 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=1258088b6da462a47ba2cd90000001a2-1505371082.171609-1479675410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:07:01.303188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:07:01.303503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 00:07:01.303810) ========= ========= Total master_lag: 0.26 =========