builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-080 starttime: 1505341315.02 results: success (0) revision: 0e706b53052c86b247bb8037d1a3fbf2e913045e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.017652) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.018093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.018390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.036073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.036465) ========= 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=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 15:21:55-- 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% 208K=0.06s 2017-09-13 15:21:55 (208 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.224408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.280690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.281046) ========= 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=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:55.330245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 15:21:55.333590) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e706b53052c86b247bb8037d1a3fbf2e913045e --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 0e706b53052c86b247bb8037d1a3fbf2e913045e --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=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 15:21:55,403 truncating revision to first 12 chars 2017-09-13 15:21:55,403 Setting DEBUG logging. 2017-09-13 15:21:55,403 attempt 1/10 2017-09-13 15:21:55,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e706b53052c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 15:21:56,696 unpacking tar archive at: mozilla-central-0e706b53052c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.576180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 15:21:56.928787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:56.929099) ========= script_repo_revision: 0e706b53052c86b247bb8037d1a3fbf2e913045e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:56.929474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:56.929732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:21:56.942800) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-13 15:21:56.943081) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:57 INFO - MultiFileLogger online at 20170913 15:21:57 in /builds/slave/test 15:21:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:21:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:57 INFO - {'append_to_log': False, 15:21:57 INFO - 'base_work_dir': '/builds/slave/test', 15:21:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:21:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:57 INFO - 'branch': 'Firefox-Non-PGO', 15:21:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:57 INFO - 'code_coverage': False, 15:21:57 INFO - 'config_files': ('talos/linux_config.py',), 15:21:57 INFO - 'default_actions': ('clobber', 15:21:57 INFO - 'read-buildbot-config', 15:21:57 INFO - 'download-and-extract', 15:21:57 INFO - 'populate-webroot', 15:21:57 INFO - 'create-virtualenv', 15:21:57 INFO - 'install', 15:21:57 INFO - 'setup-mitmproxy', 15:21:57 INFO - 'run-tests'), 15:21:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:57 INFO - 'disable_ccov_upload': False, 15:21:57 INFO - 'disable_stylo': False, 15:21:57 INFO - 'download_minidump_stackwalk': True, 15:21:57 INFO - 'download_symbols': 'ondemand', 15:21:57 INFO - 'enable_stylo': False, 15:21:57 INFO - 'enable_webrender': False, 15:21:57 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:21:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:57 INFO - 'gecko_profile': False, 15:21:57 INFO - 'gecko_profile_interval': 0, 15:21:57 INFO - 'installer_path': 'installer.exe', 15:21:57 INFO - 'log_level': 'info', 15:21:57 INFO - 'log_name': 'talos', 15:21:57 INFO - 'log_to_console': True, 15:21:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:57 INFO - 'opt_config_files': (), 15:21:57 INFO - 'pip_index': False, 15:21:57 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:21:57 INFO - 'system_bits': '32', 15:21:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:57 INFO - 'title': 'talos-linux64-ix-080', 15:21:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:57 INFO - 'use_talos_json': True, 15:21:57 INFO - 'verify': 'False', 15:21:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:57 INFO - 'work_dir': 'build'} 15:21:57 INFO - [mozharness: 2017-09-13 22:21:57.161612Z] Running clobber step. 15:21:57 INFO - Running pre-action listener: _resource_record_pre_action 15:21:57 INFO - Running main action method: clobber 15:21:57 INFO - rmtree: /builds/slave/test/build 15:21:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:58 INFO - Running post-action listener: _resource_record_post_action 15:21:58 INFO - [mozharness: 2017-09-13 22:21:58.167196Z] Finished clobber step (success) 15:21:58 INFO - [mozharness: 2017-09-13 22:21:58.167296Z] Running read-buildbot-config step. 15:21:58 INFO - Running pre-action listener: _resource_record_pre_action 15:21:58 INFO - Running main action method: read_buildbot_config 15:21:58 INFO - Using buildbot properties: 15:21:58 INFO - { 15:21:58 INFO - "project": "", 15:21:58 INFO - "product": "firefox", 15:21:58 INFO - "who": "kwierso@gmail.com", 15:21:58 INFO - "installer_path": "public/build/target.tar.bz2", 15:21:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:21:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:21:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:21:58 INFO - "stage_platform": "linux64", 15:21:58 INFO - "basedir": "/builds/slave/test", 15:21:58 INFO - "buildnumber": 13, 15:21:58 INFO - "platform": "ubuntu64_hw", 15:21:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:21:58 INFO - "slavebuilddir": "test", 15:21:58 INFO - "taskId": "B8jtwU4oRhSQg5TEJQXUhA", 15:21:58 INFO - "branch": "mozilla-central", 15:21:58 INFO - "script_repo_revision": "production", 15:21:58 INFO - "revision": "0e706b53052c86b247bb8037d1a3fbf2e913045e", 15:21:58 INFO - "slavename": "talos-linux64-ix-080", 15:21:58 INFO - "repo_path": "mozilla-central" 15:21:58 INFO - } 15:21:58 INFO - Finding installer, test and symbols from parent task. 15:21:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8jtwU4oRhSQg5TEJQXUhA'}, attempt #1 15:21:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B8jtwU4oRhSQg5TEJQXUhA'}, attempt #1 15:21:59 INFO - Task dependencies: LVYn6kl1Sru36vqr-ftIgg 15:21:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg'}, attempt #1 15:21:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 15:21:59 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.test_packages.json 15:21:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.crashreporter-symbols.zip 15:21:59 INFO - Running post-action listener: _resource_record_post_action 15:21:59 INFO - [mozharness: 2017-09-13 22:21:59.537469Z] Finished read-buildbot-config step (success) 15:21:59 INFO - [mozharness: 2017-09-13 22:21:59.537725Z] Running download-and-extract step. 15:21:59 INFO - Running pre-action listener: _resource_record_pre_action 15:21:59 INFO - Running main action method: download_and_extract 15:21:59 INFO - mkdir: /builds/slave/test/build/tests 15:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:21:59 INFO - trying https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.test_packages.json 15:21:59 INFO - Downloading https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:21:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:22:00 INFO - Downloaded 989 bytes. 15:22:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:22:00 INFO - Using the following test package requirements: 15:22:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:22:00 INFO - u'common': [u'target.common.tests.zip'], 15:22:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:22:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:22:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:22:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:22:00 INFO - u'mozbase': [u'target.common.tests.zip'], 15:22:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:22:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:22:00 INFO - u'web-platform': [u'target.common.tests.zip', 15:22:00 INFO - u'target.web-platform.tests.tar.gz'], 15:22:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:22:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:22:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.common.tests.zip 15:22:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:22:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.common.tests.zip into memory 15:22:01 INFO - Content-Length response header: 54570176 15:22:01 INFO - Bytes received: 54570176 15:22:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.talos.tests.zip 15:22:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:22:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.talos.tests.zip into memory 15:22:12 INFO - Content-Length response header: 14499226 15:22:12 INFO - Bytes received: 14499226 15:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:13 INFO - trying https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 15:22:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:22:14 INFO - Downloaded 61235128 bytes. 15:22:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 15:22:14 INFO - mkdir: /builds/slave/test/properties 15:22:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:14 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:14 INFO - Contents: 15:22:14 INFO - build_url:https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 15:22:14 INFO - Running post-action listener: _resource_record_post_action 15:22:14 INFO - Running post-action listener: find_tests_for_verification 15:22:14 INFO - Running post-action listener: set_extra_try_arguments 15:22:14 INFO - [mozharness: 2017-09-13 22:22:14.240233Z] Finished download-and-extract step (success) 15:22:14 INFO - [mozharness: 2017-09-13 22:22:14.240330Z] Running populate-webroot step. 15:22:14 INFO - Running pre-action listener: _resource_record_pre_action 15:22:14 INFO - Running main action method: populate_webroot 15:22:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:14 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['tresize', 15:22:14 INFO - 'tcanvasmark']}, 15:22:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:14 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['dromaeo_css', 15:22:14 INFO - 'kraken']}, 15:22:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:14 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'tests': ['damp', 'tps']}, 15:22:14 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['damp', 'tps']}, 15:22:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:14 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['dromaeo_dom']}, 15:22:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:22:14 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['basic_compositor_video', 15:22:14 INFO - 'glvideo']}, 15:22:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:22:14 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['ts_paint_webext', 15:22:14 INFO - 'tp5o_webext']}, 15:22:14 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:14 INFO - 'ts_paint', 15:22:14 INFO - 'tpaint', 15:22:14 INFO - 'sessionrestore', 15:22:14 INFO - 'sessionrestore_many_windows', 15:22:14 INFO - 'sessionrestore_no_auto_restore', 15:22:14 INFO - 'tabpaint']}, 15:22:14 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['a11yr', 15:22:14 INFO - 'ts_paint', 15:22:14 INFO - 'tpaint', 15:22:14 INFO - 'sessionrestore', 15:22:14 INFO - 'sessionrestore_many_windows', 15:22:14 INFO - 'sessionrestore_no_auto_restore', 15:22:14 INFO - 'tabpaint']}, 15:22:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:22:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:22:14 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['bloom_basic_singleton']}, 15:22:14 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['bloom_basic']}, 15:22:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:14 INFO - 'tsvgr_opacity', 15:22:14 INFO - 'tart', 15:22:14 INFO - 'tscrollx', 15:22:14 INFO - 'tsvg_static']}, 15:22:14 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['tsvgx', 15:22:14 INFO - 'tsvgr_opacity', 15:22:14 INFO - 'tart', 15:22:14 INFO - 'tscrollx', 15:22:14 INFO - 'tsvg_static']}, 15:22:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:22:14 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo'], 15:22:14 INFO - 'tests': ['tp5o']}, 15:22:14 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:14 INFO - 'talos_options': ['--mitmproxy', 15:22:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:14 INFO - '--firstNonBlankPaint'], 15:22:14 INFO - 'tests': ['tp6_google', 15:22:14 INFO - 'tp6_youtube', 15:22:14 INFO - 'tp6_amazon', 15:22:14 INFO - 'tp6_facebook']}, 15:22:14 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo', 15:22:14 INFO - '--mitmproxy', 15:22:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:14 INFO - '--firstNonBlankPaint'], 15:22:14 INFO - 'tests': ['tp6_google', 15:22:14 INFO - 'tp6_youtube', 15:22:14 INFO - 'tp6_amazon', 15:22:14 INFO - 'tp6_facebook']}, 15:22:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:22:14 INFO - 'talos_options': ['--stylo-threads=1', 15:22:14 INFO - '--mitmproxy', 15:22:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:22:14 INFO - '--firstNonBlankPaint'], 15:22:14 INFO - 'tests': ['tp6_google', 15:22:14 INFO - 'tp6_youtube', 15:22:14 INFO - 'tp6_amazon', 15:22:14 INFO - 'tp6_facebook']}, 15:22:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--xperf_path', 15:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:14 INFO - 'tests': ['tp5n']}, 15:22:14 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:22:14 INFO - 'talos_options': ['--disable-stylo', 15:22:14 INFO - '--xperf_path', 15:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:14 INFO - 'tests': ['tp5n']}}} 15:22:14 INFO - Running post-action listener: _resource_record_post_action 15:22:14 INFO - [mozharness: 2017-09-13 22:22:14.255350Z] Finished populate-webroot step (success) 15:22:14 INFO - [mozharness: 2017-09-13 22:22:14.255441Z] Running create-virtualenv step. 15:22:14 INFO - Running pre-action listener: _resource_record_pre_action 15:22:14 INFO - Running main action method: create_virtualenv 15:22:14 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:14 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:22:14 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:22:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:22:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:14 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:15 INFO - Installing pip...............done. 15:22:15 INFO - Return code: 0 15:22:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:22:15 INFO - Reading from file tmpfile_stdout 15:22:15 INFO - Output received: 15:22:15 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:22:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:15 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:22:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:22:15 INFO - Using env: {'DISPLAY': ':0', 15:22:15 INFO - 'HOME': '/home/cltbld', 15:22:15 INFO - 'LANG': 'en_US.UTF-8', 15:22:15 INFO - 'LANGUAGE': 'en_US:en', 15:22:15 INFO - 'LOGNAME': 'cltbld', 15:22:15 INFO - 'MAIL': '/var/mail/cltbld', 15:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:15 INFO - 'MOZ_NO_REMOTE': '1', 15:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:15 INFO - 'NO_EM_RESTART': '1', 15:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:15 INFO - 'PWD': '/builds/slave/test', 15:22:15 INFO - 'SHELL': '/bin/bash', 15:22:15 INFO - 'SHLVL': '1', 15:22:15 INFO - 'TERM': 'linux', 15:22:15 INFO - 'TMOUT': '86400', 15:22:15 INFO - 'USER': 'cltbld', 15:22:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:15 INFO - '_': '/tools/buildbot/bin/python'} 15:22:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:22:16 INFO - Downloading/unpacking pip>=1.5 15:22:16 INFO - Running setup.py egg_info for package pip 15:22:16 INFO - warning: no files found matching 'pip/cacert.pem' 15:22:16 INFO - warning: no files found matching '*.html' under directory 'docs' 15:22:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:22:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:22:16 INFO - Installing collected packages: pip 15:22:16 INFO - Found existing installation: pip 1.1 15:22:16 INFO - Uninstalling pip: 15:22:16 INFO - Successfully uninstalled pip 15:22:16 INFO - Running setup.py install for pip 15:22:16 INFO - warning: no files found matching 'pip/cacert.pem' 15:22:16 INFO - warning: no files found matching '*.html' under directory 'docs' 15:22:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:22:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:22:16 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:22:16 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:22:16 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:22:16 INFO - Successfully installed pip 15:22:16 INFO - Cleaning up... 15:22:16 INFO - Return code: 0 15:22:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:16 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:22:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:22:16 INFO - Using env: {'DISPLAY': ':0', 15:22:16 INFO - 'HOME': '/home/cltbld', 15:22:16 INFO - 'LANG': 'en_US.UTF-8', 15:22:16 INFO - 'LANGUAGE': 'en_US:en', 15:22:16 INFO - 'LOGNAME': 'cltbld', 15:22:16 INFO - 'MAIL': '/var/mail/cltbld', 15:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:16 INFO - 'MOZ_NO_REMOTE': '1', 15:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:16 INFO - 'NO_EM_RESTART': '1', 15:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:16 INFO - 'PWD': '/builds/slave/test', 15:22:16 INFO - 'SHELL': '/bin/bash', 15:22:16 INFO - 'SHLVL': '1', 15:22:16 INFO - 'TERM': 'linux', 15:22:16 INFO - 'TMOUT': '86400', 15:22:16 INFO - 'USER': 'cltbld', 15:22:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:16 INFO - '_': '/tools/buildbot/bin/python'} 15:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:16 INFO - Downloading/unpacking psutil>=3.1.1 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:17 INFO - Installing collected packages: psutil 15:22:17 INFO - Running setup.py install for psutil 15:22:17 INFO - building 'psutil._psutil_linux' extension 15:22:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:22:18 INFO - building 'psutil._psutil_posix' extension 15:22:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:22:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:18 INFO - Successfully installed psutil 15:22:18 INFO - Cleaning up... 15:22:18 INFO - Return code: 0 15:22:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:18 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:22:18 INFO - Using env: {'DISPLAY': ':0', 15:22:18 INFO - 'HOME': '/home/cltbld', 15:22:18 INFO - 'LANG': 'en_US.UTF-8', 15:22:18 INFO - 'LANGUAGE': 'en_US:en', 15:22:18 INFO - 'LOGNAME': 'cltbld', 15:22:18 INFO - 'MAIL': '/var/mail/cltbld', 15:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:18 INFO - 'MOZ_NO_REMOTE': '1', 15:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:18 INFO - 'NO_EM_RESTART': '1', 15:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:18 INFO - 'PWD': '/builds/slave/test', 15:22:18 INFO - 'SHELL': '/bin/bash', 15:22:18 INFO - 'SHLVL': '1', 15:22:18 INFO - 'TERM': 'linux', 15:22:18 INFO - 'TMOUT': '86400', 15:22:18 INFO - 'USER': 'cltbld', 15:22:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:18 INFO - '_': '/tools/buildbot/bin/python'} 15:22:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:19 INFO - Installing collected packages: mozsystemmonitor 15:22:19 INFO - Running setup.py install for mozsystemmonitor 15:22:19 INFO - Successfully installed mozsystemmonitor 15:22:19 INFO - Cleaning up... 15:22:19 INFO - Return code: 0 15:22:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:19 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:22:19 INFO - Using env: {'DISPLAY': ':0', 15:22:19 INFO - 'HOME': '/home/cltbld', 15:22:19 INFO - 'LANG': 'en_US.UTF-8', 15:22:19 INFO - 'LANGUAGE': 'en_US:en', 15:22:19 INFO - 'LOGNAME': 'cltbld', 15:22:19 INFO - 'MAIL': '/var/mail/cltbld', 15:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:19 INFO - 'MOZ_NO_REMOTE': '1', 15:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:19 INFO - 'NO_EM_RESTART': '1', 15:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:19 INFO - 'PWD': '/builds/slave/test', 15:22:19 INFO - 'SHELL': '/bin/bash', 15:22:19 INFO - 'SHLVL': '1', 15:22:19 INFO - 'TERM': 'linux', 15:22:19 INFO - 'TMOUT': '86400', 15:22:19 INFO - 'USER': 'cltbld', 15:22:19 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:19 INFO - '_': '/tools/buildbot/bin/python'} 15:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:21 INFO - warning: no files found matching '*.txt' 15:22:21 INFO - no previously-included directories found matching 'build' 15:22:21 INFO - no previously-included directories found matching 'dist' 15:22:21 INFO - no previously-included directories found matching '.git*' 15:22:21 INFO - Installing collected packages: jsonschema, functools32 15:22:21 INFO - Running setup.py install for functools32 15:22:21 INFO - warning: no files found matching '*.txt' 15:22:21 INFO - no previously-included directories found matching 'build' 15:22:21 INFO - no previously-included directories found matching 'dist' 15:22:21 INFO - no previously-included directories found matching '.git*' 15:22:21 INFO - Successfully installed jsonschema functools32 15:22:21 INFO - Cleaning up... 15:22:21 INFO - Return code: 0 15:22:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22: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')]} 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:21 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:22:21 INFO - Using env: {'DISPLAY': ':0', 15:22:21 INFO - 'HOME': '/home/cltbld', 15:22:21 INFO - 'LANG': 'en_US.UTF-8', 15:22:21 INFO - 'LANGUAGE': 'en_US:en', 15:22:21 INFO - 'LOGNAME': 'cltbld', 15:22:21 INFO - 'MAIL': '/var/mail/cltbld', 15:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:21 INFO - 'MOZ_NO_REMOTE': '1', 15:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:21 INFO - 'NO_EM_RESTART': '1', 15:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:21 INFO - 'PWD': '/builds/slave/test', 15:22:21 INFO - 'SHELL': '/bin/bash', 15:22:21 INFO - 'SHLVL': '1', 15:22:21 INFO - 'TERM': 'linux', 15:22:21 INFO - 'TMOUT': '86400', 15:22:21 INFO - 'USER': 'cltbld', 15:22:21 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:21 INFO - '_': '/tools/buildbot/bin/python'} 15:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:21 INFO - Cleaning up... 15:22:21 INFO - Return code: 0 15:22:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22: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')]} 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:21 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:22:21 INFO - Using env: {'DISPLAY': ':0', 15:22:21 INFO - 'HOME': '/home/cltbld', 15:22:21 INFO - 'LANG': 'en_US.UTF-8', 15:22:21 INFO - 'LANGUAGE': 'en_US:en', 15:22:21 INFO - 'LOGNAME': 'cltbld', 15:22:21 INFO - 'MAIL': '/var/mail/cltbld', 15:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:21 INFO - 'MOZ_NO_REMOTE': '1', 15:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:21 INFO - 'NO_EM_RESTART': '1', 15:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:21 INFO - 'PWD': '/builds/slave/test', 15:22:21 INFO - 'SHELL': '/bin/bash', 15:22:21 INFO - 'SHLVL': '1', 15:22:21 INFO - 'TERM': 'linux', 15:22:21 INFO - 'TMOUT': '86400', 15:22:21 INFO - 'USER': 'cltbld', 15:22:21 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:21 INFO - '_': '/tools/buildbot/bin/python'} 15:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - Downloading docopt-0.6.1.tar.gz 15:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:24 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:24 INFO - Running setup.py install for blobuploader 15:22:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:24 INFO - Running setup.py install for requests 15:22:26 INFO - Running setup.py install for docopt 15:22:26 INFO - Successfully installed blobuploader requests docopt 15:22:26 INFO - Cleaning up... 15:22:26 INFO - Return code: 0 15:22:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22: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')]} 15:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:26 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:26 INFO - Using env: {'DISPLAY': ':0', 15:22:26 INFO - 'HOME': '/home/cltbld', 15:22:26 INFO - 'LANG': 'en_US.UTF-8', 15:22:26 INFO - 'LANGUAGE': 'en_US:en', 15:22:26 INFO - 'LOGNAME': 'cltbld', 15:22:26 INFO - 'MAIL': '/var/mail/cltbld', 15:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:26 INFO - 'MOZ_NO_REMOTE': '1', 15:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:26 INFO - 'NO_EM_RESTART': '1', 15:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:26 INFO - 'PWD': '/builds/slave/test', 15:22:26 INFO - 'SHELL': '/bin/bash', 15:22:26 INFO - 'SHLVL': '1', 15:22:26 INFO - 'TERM': 'linux', 15:22:26 INFO - 'TMOUT': '86400', 15:22:26 INFO - 'USER': 'cltbld', 15:22:26 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:26 INFO - '_': '/tools/buildbot/bin/python'} 15:22:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:26 INFO - Running setup.py (path:/tmp/pip-GJ3IZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:26 INFO - Running setup.py (path:/tmp/pip-nL7f4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:26 INFO - Running setup.py (path:/tmp/pip-gUiLYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:26 INFO - Running setup.py (path:/tmp/pip-C2_VLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:26 INFO - Running setup.py (path:/tmp/pip-S1MUog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:27 INFO - Running setup.py (path:/tmp/pip-ki04kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:27 INFO - Running setup.py (path:/tmp/pip-047QxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:27 INFO - Running setup.py (path:/tmp/pip-W2yMWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:27 INFO - Running setup.py (path:/tmp/pip-8Tbl0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:27 INFO - Running setup.py (path:/tmp/pip-N_BFsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:27 INFO - Running setup.py (path:/tmp/pip-ANc11X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:27 INFO - Running setup.py (path:/tmp/pip-31vuZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:27 INFO - Running setup.py (path:/tmp/pip-MaWiJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:27 INFO - Running setup.py (path:/tmp/pip-n2c_cZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:27 INFO - Running setup.py (path:/tmp/pip-B_mIxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:27 INFO - Running setup.py (path:/tmp/pip-U3eGB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:27 INFO - Running setup.py (path:/tmp/pip-pQZjiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:27 INFO - Running setup.py install for manifestparser 15:22:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:27 INFO - Running setup.py install for mozcrash 15:22:28 INFO - Running setup.py install for mozdebug 15:22:28 INFO - Running setup.py install for mozdevice 15:22:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for mozfile 15:22:28 INFO - Running setup.py install for mozhttpd 15:22:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for mozinfo 15:22:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for mozInstall 15:22:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for mozleak 15:22:28 INFO - Running setup.py install for mozlog 15:22:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for moznetwork 15:22:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Running setup.py install for mozprocess 15:22:29 INFO - Running setup.py install for mozprofile 15:22:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:29 INFO - Running setup.py install for mozrunner 15:22:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:29 INFO - Running setup.py install for mozscreenshot 15:22:29 INFO - Running setup.py install for moztest 15:22:29 INFO - Running setup.py install for mozversion 15:22:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:29 INFO - Cleaning up... 15:22:29 INFO - Return code: 0 15:22:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:29 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:29 INFO - Using env: {'DISPLAY': ':0', 15:22:29 INFO - 'HOME': '/home/cltbld', 15:22:29 INFO - 'LANG': 'en_US.UTF-8', 15:22:29 INFO - 'LANGUAGE': 'en_US:en', 15:22:29 INFO - 'LOGNAME': 'cltbld', 15:22:29 INFO - 'MAIL': '/var/mail/cltbld', 15:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:29 INFO - 'MOZ_NO_REMOTE': '1', 15:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:29 INFO - 'NO_EM_RESTART': '1', 15:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:29 INFO - 'PWD': '/builds/slave/test', 15:22:29 INFO - 'SHELL': '/bin/bash', 15:22:29 INFO - 'SHLVL': '1', 15:22:29 INFO - 'TERM': 'linux', 15:22:29 INFO - 'TMOUT': '86400', 15:22:29 INFO - 'USER': 'cltbld', 15:22:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:29 INFO - '_': '/tools/buildbot/bin/python'} 15:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:29 INFO - Running setup.py (path:/tmp/pip-WV5O1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:29 INFO - Running setup.py (path:/tmp/pip-sEbV7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:30 INFO - Running setup.py (path:/tmp/pip-ViJ8f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:30 INFO - Running setup.py (path:/tmp/pip-l8baZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:30 INFO - Running setup.py (path:/tmp/pip-XRb6fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:30 INFO - Running setup.py (path:/tmp/pip-YzJQRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:30 INFO - Running setup.py (path:/tmp/pip-QanhCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:30 INFO - Running setup.py (path:/tmp/pip-Zxr42M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:30 INFO - Running setup.py (path:/tmp/pip-T8ZVTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:30 INFO - Running setup.py (path:/tmp/pip-T82iE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:30 INFO - Running setup.py (path:/tmp/pip-ywRTfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:30 INFO - Running setup.py (path:/tmp/pip-vYu48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:30 INFO - Running setup.py (path:/tmp/pip-eeYI4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:30 INFO - Running setup.py (path:/tmp/pip-BHLKUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:30 INFO - Running setup.py (path:/tmp/pip-gOo8np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:30 INFO - Running setup.py (path:/tmp/pip-vbEQdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:31 INFO - Running setup.py (path:/tmp/pip-5FZwt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:32 INFO - Downloading blessings-1.6.tar.gz 15:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:32 INFO - Installing collected packages: blessings 15:22:32 INFO - Running setup.py install for blessings 15:22:32 INFO - Successfully installed blessings 15:22:32 INFO - Cleaning up... 15:22:32 INFO - Return code: 0 15:22:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:32 INFO - Reading from file tmpfile_stdout 15:22:32 INFO - Current package versions: 15:22:32 INFO - argparse == 1.2.1 15:22:32 INFO - blessings == 1.6 15:22:32 INFO - blobuploader == 1.2.4 15:22:32 INFO - docopt == 0.6.1 15:22:32 INFO - functools32 == 3.2.3-2 15:22:32 INFO - jsonschema == 2.5.1 15:22:32 INFO - manifestparser == 1.1 15:22:32 INFO - mozInstall == 1.13 15:22:32 INFO - mozcrash == 1.0 15:22:32 INFO - mozdebug == 0.1 15:22:32 INFO - mozdevice == 0.51 15:22:32 INFO - mozfile == 1.2 15:22:32 INFO - mozhttpd == 0.7 15:22:32 INFO - mozinfo == 0.10 15:22:32 INFO - mozleak == 0.1 15:22:32 INFO - mozlog == 3.5 15:22:32 INFO - moznetwork == 0.27 15:22:32 INFO - mozprocess == 0.25 15:22:32 INFO - mozprofile == 0.28 15:22:32 INFO - mozrunner == 6.13 15:22:32 INFO - mozscreenshot == 0.1 15:22:32 INFO - mozsystemmonitor == 0.3 15:22:32 INFO - moztest == 0.8 15:22:32 INFO - mozversion == 1.4 15:22:32 INFO - psutil == 3.1.1 15:22:32 INFO - requests == 1.2.3 15:22:32 INFO - wsgiref == 0.1.2 15:22:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:32 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:32 INFO - Using env: {'DISPLAY': ':0', 15:22:32 INFO - 'HOME': '/home/cltbld', 15:22:32 INFO - 'LANG': 'en_US.UTF-8', 15:22:32 INFO - 'LANGUAGE': 'en_US:en', 15:22:32 INFO - 'LOGNAME': 'cltbld', 15:22:32 INFO - 'MAIL': '/var/mail/cltbld', 15:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:32 INFO - 'MOZ_NO_REMOTE': '1', 15:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:32 INFO - 'NO_EM_RESTART': '1', 15:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:32 INFO - 'PWD': '/builds/slave/test', 15:22:32 INFO - 'SHELL': '/bin/bash', 15:22:32 INFO - 'SHLVL': '1', 15:22:32 INFO - 'TERM': 'linux', 15:22:32 INFO - 'TMOUT': '86400', 15:22:32 INFO - 'USER': 'cltbld', 15:22:32 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:32 INFO - '_': '/tools/buildbot/bin/python'} 15:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:22:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:34 INFO - Installing collected packages: simplejson 15:22:34 INFO - Running setup.py install for simplejson 15:22:34 INFO - building 'simplejson._speedups' extension 15:22:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:22:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:22:35 INFO - Successfully installed simplejson 15:22:35 INFO - Cleaning up... 15:22:35 INFO - Return code: 0 15:22:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:35 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 0x27181f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a84a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, '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': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:35 INFO - Using env: {'DISPLAY': ':0', 15:22:35 INFO - 'HOME': '/home/cltbld', 15:22:35 INFO - 'LANG': 'en_US.UTF-8', 15:22:35 INFO - 'LANGUAGE': 'en_US:en', 15:22:35 INFO - 'LOGNAME': 'cltbld', 15:22:35 INFO - 'MAIL': '/var/mail/cltbld', 15:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:35 INFO - 'MOZ_NO_REMOTE': '1', 15:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:35 INFO - 'NO_EM_RESTART': '1', 15:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:35 INFO - 'PWD': '/builds/slave/test', 15:22:35 INFO - 'SHELL': '/bin/bash', 15:22:35 INFO - 'SHLVL': '1', 15:22:35 INFO - 'TERM': 'linux', 15:22:35 INFO - 'TMOUT': '86400', 15:22:35 INFO - 'USER': 'cltbld', 15:22:35 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:35 INFO - '_': '/tools/buildbot/bin/python'} 15:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:35 INFO - Cleaning up... 15:22:35 INFO - Return code: 0 15:22:35 INFO - Running post-action listener: _resource_record_post_action 15:22:35 INFO - Running post-action listener: _start_resource_monitoring 15:22:35 INFO - Starting resource monitoring. 15:22:35 INFO - [mozharness: 2017-09-13 22:22:35.333949Z] Finished create-virtualenv step (success) 15:22:35 INFO - [mozharness: 2017-09-13 22:22:35.334465Z] Running install step. 15:22:35 INFO - Running pre-action listener: _resource_record_pre_action 15:22:35 INFO - Running main action method: install 15:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:35 INFO - Reading from file tmpfile_stdout 15:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:35 INFO - Reading from file tmpfile_stdout 15:22:35 INFO - Output received: 15:22:35 INFO - Usage: mozinstall [options] installer 15:22:35 INFO - Options: 15:22:35 INFO - -h, --help show this help message and exit 15:22:35 INFO - -d DEST, --destination=DEST 15:22:35 INFO - Directory to install application into. [default: 15:22:35 INFO - "/builds/slave/test"] 15:22:35 INFO - --app=APP Application being installed. [default: firefox] 15:22:35 INFO - mkdir: /builds/slave/test/build/application 15:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:22:53 INFO - Reading from file tmpfile_stdout 15:22:53 INFO - Output received: 15:22:53 INFO - /builds/slave/test/build/application/firefox/firefox 15:22:53 INFO - Running post-action listener: _resource_record_post_action 15:22:53 INFO - [mozharness: 2017-09-13 22:22:53.410937Z] Finished install step (success) 15:22:53 INFO - [mozharness: 2017-09-13 22:22:53.411186Z] Running setup-mitmproxy step. 15:22:53 INFO - Running pre-action listener: _resource_record_pre_action 15:22:53 INFO - Running main action method: setup_mitmproxy 15:22:53 INFO - Skipping: mitmproxy is not required 15:22:53 INFO - Running post-action listener: _resource_record_post_action 15:22:53 INFO - [mozharness: 2017-09-13 22:22:53.412315Z] Finished setup-mitmproxy step (success) 15:22:53 INFO - [mozharness: 2017-09-13 22:22:53.412535Z] Running run-tests step. 15:22:53 INFO - Running pre-action listener: _resource_record_pre_action 15:22:53 INFO - Running pre-action listener: _set_gcov_prefix 15:22:53 INFO - Running main action method: run_tests 15:22:53 WARNING - Try message not found. 15:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:22:53 INFO - Python 2.7.3 15:22:53 INFO - Return code: 0 15:22:53 INFO - grabbing minidump binary from tooltool 15:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:53 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 0x2a88090>, '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 0x2a88d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a82f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:22:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:22:53 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:22:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:22:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:22:53 INFO - Return code: 0 15:22:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:22:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:22:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:22:53 INFO - ENV: RUST_BACKTRACE is now full 15:22:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:22:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:22:53 INFO - Using env: {'DISPLAY': ':0', 15:22:53 INFO - 'HOME': '/home/cltbld', 15:22:53 INFO - 'LANG': 'en_US.UTF-8', 15:22:53 INFO - 'LANGUAGE': 'en_US:en', 15:22:53 INFO - 'LOGNAME': 'cltbld', 15:22:53 INFO - 'MAIL': '/var/mail/cltbld', 15:22:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:53 INFO - 'MOZ_NO_REMOTE': '1', 15:22:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:53 INFO - 'NO_EM_RESTART': '1', 15:22:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:53 INFO - 'PWD': '/builds/slave/test', 15:22:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:53 INFO - 'RUST_BACKTRACE': 'full', 15:22:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:22:53 INFO - 'SHELL': '/bin/bash', 15:22:53 INFO - 'SHLVL': '1', 15:22:53 INFO - 'TERM': 'linux', 15:22:53 INFO - 'TMOUT': '86400', 15:22:53 INFO - 'USER': 'cltbld', 15:22:53 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:53 INFO - '_': '/tools/buildbot/bin/python'} 15:22:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:22:53 INFO - mozversion application_buildid: 20170913213200 15:22:53 INFO - mozversion application_changeset: 0e706b53052c86b247bb8037d1a3fbf2e913045e 15:22:53 INFO - mozversion application_display_name: Nightly 15:22:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:22:53 INFO - mozversion application_name: Firefox 15:22:53 INFO - mozversion application_remotingname: firefox 15:22:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:22:53 INFO - mozversion application_vendor: Mozilla 15:22:53 INFO - mozversion application_version: 57.0a1 15:22:53 INFO - mozversion platform_buildid: 20170913213200 15:22:53 INFO - mozversion platform_changeset: 0e706b53052c86b247bb8037d1a3fbf2e913045e 15:22:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:22:53 INFO - mozversion platform_version: 57.0a1 15:22:53 INFO - using testdate: 1505341373 15:22:53 INFO - actual date: 1505341373 15:22:53 INFO - starting webserver on 'localhost:47353' 15:22:53 INFO - SUITE-START | Running 2 tests 15:22:53 INFO - TEST-START | dromaeo_css 15:22:53 INFO - Initialising browser for dromaeo_css test... 15:22:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47353/getInfo.html -profile /tmp/tmpJsYugn/profile 15:22:53 INFO - TEST-INFO | started process 4473 (/builds/slave/test/build/application/firefox/firefox http://localhost:47353/getInfo.html) 15:22:59 INFO - TEST-INFO | 4473: exit 0 15:22:59 INFO - Browser initialized. 15:22:59 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:59 INFO - Using env: {'DISPLAY': ':0', 15:22:59 INFO - 'HOME': '/home/cltbld', 15:22:59 INFO - 'JSGC_DISABLE_POISONING': '1', 15:22:59 INFO - 'LANG': 'en_US.UTF-8', 15:22:59 INFO - 'LANGUAGE': 'en_US:en', 15:22:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:22:59 INFO - 'LOGNAME': 'cltbld', 15:22:59 INFO - 'MAIL': '/var/mail/cltbld', 15:22:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:22:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:22:59 INFO - 'MOZ_CRASHREPORTER': '1', 15:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:22:59 INFO - 'MOZ_NO_REMOTE': '1', 15:22:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:59 INFO - 'NO_EM_RESTART': '1', 15:22:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:59 INFO - 'PWD': '/builds/slave/test', 15:22:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:22:59 INFO - 'RUST_BACKTRACE': 'full', 15:22:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:22:59 INFO - 'SHELL': '/bin/bash', 15:22:59 INFO - 'SHLVL': '1', 15:22:59 INFO - 'STYLO_FORCE_DISABLED': '1', 15:22:59 INFO - 'TERM': 'linux', 15:22:59 INFO - 'TMOUT': '86400', 15:22:59 INFO - 'USER': 'cltbld', 15:22:59 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:59 INFO - '_': '/tools/buildbot/bin/python'} 15:22:59 INFO - TEST-INFO | started process 4703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsYugn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:00 INFO - PID 4703 | 15:23:00 INFO - PID 4703 | (/builds/slave/test/build/application/firefox/firefox:4753): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:23:00 INFO - PID 4703 | 15:23:10 INFO - PID 4703 | RSS: Main: 173846528 15:23:10 INFO - PID 4703 | 15:26:08 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47353/tests/dromaeo/cssquery-ext.html) 15:26:09 INFO - PID 4703 | RSS: Main: 176549888 15:26:09 INFO - PID 4703 | 15:29:11 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-ext.html (next: http://localhost:47353/tests/dromaeo/cssquery-jquery.html) 15:29:11 INFO - PID 4703 | RSS: Main: 170967040 15:29:11 INFO - PID 4703 | 15:32:13 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47353/tests/dromaeo/cssquery-mootools.html) 15:32:14 INFO - PID 4703 | RSS: Main: 173195264 15:32:14 INFO - PID 4703 | 15:35:15 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47353/tests/dromaeo/cssquery-prototype.html) 15:35:16 INFO - PID 4703 | RSS: Main: 173481984 15:35:16 INFO - PID 4703 | 15:38:19 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47353/tests/dromaeo/cssquery-yui.html) 15:38:20 INFO - PID 4703 | RSS: Main: 174829568 15:38:20 INFO - PID 4703 | 15:41:21 INFO - PID 4703 | Cycle 1(1): loaded http://localhost:47353/tests/dromaeo/cssquery-yui.html (next: http://localhost:47353/tests/dromaeo/cssquery-dojo.html) 15:41:22 INFO - PID 4703 | RSS: Main: 177545216 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | __start_tp_report 15:41:22 INFO - PID 4703 | _x_x_mozilla_page_load 15:41:22 INFO - PID 4703 | _x_x_mozilla_page_load_details 15:41:22 INFO - PID 4703 | |i|pagename|runs| 15:41:22 INFO - PID 4703 | |0;dojo.html;3168.382165477731;3172.9048128556146;3185.347003864207;3212.052444528864;3218.0667606394145;6223.066540018999;6306.117143599889;6311.715972781224;6370.872582548352;6397.744090236391;6313.116163737081;6372.426481616653;6374.840628984278;6486.870262594745;6503.512236582252;1291.6328278715387;5862.794802181925;5897.557683173758;5926.703664816763;5946.851328716773;5678.772849086032;5817;5820.912686309709;5892.734826932799;5895.263092113486;5834;5835.503982161521;5891.88216235675;5901.822945311605;5906.5570082244;5808.912866307009;5832.300123985106;5882.29412470502;5902.085176797603;5906.143609176688;5812.912806307909;5816.592838501307;5866.354700982888;5895.55783316253;5898.262717160355;6094.360092190301;6230.875382492325;6365.425144078532;6383.361663833626;6460.030995350688;6638.4689224861895;6641.634710090943;6728.495362847757;6728.529002969794;6768.932310676929;6884.51808373414;6907.447404207652;6939.965300173517;6951.582905025714;6958.269381714948;6233.906491402633;6302.1177035215105;6310.305866354697;6313.779017734358;6349.777757778455;7002.739506888809;7011.193712723;7022.648867556704;7079.646017699094;7088.503804733619;6660.933390666129;6664.166979127609;6666.600003999679;6743.662816859138;6758.05387245786;6623.3376662333385;6749.763758268437;6816.113905192294;6885.827854303682;6897.896531552031;6822.556533825285;6844.691988860513;6850.6574671266235;6881.380675739208;6897.620630865351;6798.218204906499;6804.183497980274;6882.965585172142;6886.311368863074;6902.689378977958;5221.13851214553;5240.3973543042275;5298.708571028554;5320.441353657888;5323.201519772065;4546.977265113654;4615.8846028848875;4620.561046700625;4647.767611619405;4736;5804.04233301509;5823.242978412779;5866.6186697864505;5870.178175055496;5877.970610146922;6773.254941956381;6856.6228857412325;6929.133858267716;6940.514164008572;6956.443484521226;5785.739641716133;5802.622829516068;5865.384134665884;5870.471657550841;5884.529237660977;5728;5756.94243057564;5785.161151633074;5802.47777700009;5816.360200377955;6502.349765023459;6533.41199292066;6534.607923524603;6535.934640653532;6550.246721627074;6771.289014653489;6813.89779153323;6893.0694356261265;6910.343517365842;6919.342662447059;6519.511036672174;6570.901436478553;6604.9009264862025;6708.6310252936555;6723.663816809042;6580.868382632416;6640.037194606852;6657.567258128206;6678.365555272241;6757.358050985148;6854.177498700188;6894.793156205322;6959.164900212007;6963.61700106499;6972.1284839395075;6615.6030638161865;6637.402633762985;6643.069970204272;6738.225104113089;6745.52781305304;6639.933600664125;6644.202695676357;6718.596884186964;6728.831779205559;6735.360140786617;6439.613623182624;6551.574147680385;6570;6611.603303801788;6640.369164929324;6700.6984685688285;6700.765473208415;6711.597304161571;6747.190337159573;6759.628220447726;6269.874602508015;6408.61548307103;6427.807165785034;6455.483561315177;6531.444827189742 15:41:22 INFO - PID 4703 | |1;ext.html;817.9795505112371;824.3322908444164;847.4660963592936;871.1419252036743;879.6481407437028;39585.802070989674;43061.569384306145;43127.56872431275;43514.12971740563;44338.77830610846;43029.7848510757;43256.56743432565;43419;43477.7826110869;43621.12757744843;7735.9226407735905;7880.4089693272945;7881.960590197041;7889;7890;7793.142754297023;7869.409794265424;7886.329661978739;7886.329661978739;7891.565963871984;7877.645505952217;7930.484518506308;7932.087809901848;7935.563544005077;7944;7882.211778822129;7907.881381779278;7924.722634707815;7925;7926.762197134067;7764.495307804975;7819.687212511492;7829.334506566948;7836.686532538692;7837.412194085467;38823.41764873529;39087.60912390868;39116.21767564633;39140.217195655925;39159.216815663814;3589.6589823966683;3629.237860049393;3630.3283892479976;3631.5642122945414;3633.94549081764;32152;32159.356812863847;32164.6783532164;32255.677443225737;32367;5126.307948426952;5131.563817075553;5138.665986710889;5178.818741344073;5184.559312458446;184971;185026;186375;186781;186782;46891;46979.060418791436;47116.5288347119;47167.29249061267;47181.999999999316;48609.75695121573;48707;48738.756306218245;48826.75586622044;48873.26690099651;15755.369785208462;16074.196290185444;16095.758563621555;16106.194690265675;16111.436099736688;13328.33358332099;13330.133541319783;13338.13302135358;13340.666483337995;13342.266175360253;12715.936420318025;12946.417411216518;12968;13015.804762928563;13202.33988300581;5023.824166154167;5049.267856160836;5143.922841157386;5186.170212765939;5243.187305967581;993.980120397588;996.5017491254373;1002.5839276700087;1015.3349556040805;1025.1644909398817;22502.324930252118;22900.198493052663;22959.88520057389;22991.540169196523;23503.41241468943;1101.1026013798728;1108.6563165418584;1120.383788916093;1123.7808627317759;1126.4367816091954;12052.879471205175;12076.75846483083;12158.817617735742;12280.692982675504;12330.691732706755;222950;223546;223840;233482;238083;57091.42908570861;57113.14330285049;57221.14168287479;57225.42774572201;57311.426885731446;1430.95540255614;1453.4476898778607;1454.3092031285266;1454.374618913856;1456.213644631908;26774;27000.59499107554;27396;27506.587401189397;27614.5857812137;36799.816000919825;36850;36966.815165923996;37023;37039.44440833336;183305;183360;183434;183479;184879;33517.83241083779;33794.49308260427;33865;33897.830510847285;33941.151471212426;41959.790201048796;41977;42156.78921605372;42301.78849105735;42350.576494235895;31440.371192576476;31534.684653153174;31534.842325788224;31840.68159318377;32259.516107258878;31067.84466077655;31212.531812022382;31234.839088875866;31356.216094596904;31447.685523145392;35126.64873351234;35405;35509.1122721934;35696.464553032245;35856.92429227127;31183.37633247277;31197.220069497536;31259.84370078135;31336;31741.36517269688;22477.550448991256;22737.270510077462;23039.76960230376;23285.3014409568;23508.647370289116 15:41:22 INFO - PID 4703 | |2;jquery.html;562.1736048009425;570.885822835433;572.1475002246649;573.2519062623275;579.3106203617695;22236.555268894634;23011.884940575317;23090.65364019541;23109;23110.191143309967;22908.885455572698;23867.28398148054;24347.513049738995;24640.260792176217;24669.75330246697;6383.202099737533;6441.838954026163;6490.993895946112;6493.220813502363;6534.673266336664;6348.143000694893;6369.71336289868;6458.354164583528;6463.289038205794;6633.303503132174;6598.835029124286;6610.933890661104;6612.338766123373;6614.074029635831;6614.834629134262;6198.442140207403;6471.320511346288;6583.4074933256;6586.8682626347445;6587.604743715368;6002.039673652238;6006.669633170174;6016.278046634432;6021.909671354933;6025.969870150665;27696.861515692293;28229.29426764327;28251.43497130046;28257;28278.717212828018;2072.720182775321;2091.6862470629526;2095.95808083839;2096.8532202745814;2097.035363732685;17057.48827535176;17491.47525574235;17710.91144544282;17875.37436189727;17888.91055544727;2356.929292121239;2411;2415.468596908695;2421.2615152378517;2447.3392184110367;121991;129878;134939;140911;141461.29269353588;13925.303734813218;14147.504837330644;14155.716885662228;14190.645233869029;14348.426062957366;21952.45118872041;22051.66922496164;22056;22138.225162119572;22201.555968880533;9943.45311007887;10037.096661300518;10162.542685579167;10200.846987295197;10214.387136771817;9212.861807072899;9288.814223715488;9345.20565751905;9367.344285899922;9542.427454352623;8655.134486551295;8716.95641521801;8763.912360876437;8907.084976730033;8912.242459391024;2591.287395966124;2593.6239245309325;2631.250093723318;2671.679398472157;2747.8626068696485;959.6209497248688;973.255459573427;981.5828272983953;1002.4135880509838;1003.247564326755;18526.536836579195;18762.437126886216;18817.341393051178;18955.81044189568;19343;1037.123630532199;1038.8130136575337;1041.4688508860536;1042.5673345561506;1050.7425680708122;10444.68665940023;10460.52927618259;10555.736106597244;10788.406637635006;10816.621418250323;456284;460316;464572;470983;471827;100575;103576.48211758892;105667;107491;107683.46158269315;1041.4168065882977;1123.2418117770635;1168.3749194181073;1195.8505186851469;1203.3381640097912;19444;19597.51006224856;19683.015849207197;19736.82894881533;20117;52891.206631901325;53772;54147.458525414244;55432.44567554273;56408.87182256414;68413.31586684269;68436.65781671258;68645.3135468639;68783;68916;13863.861361386256;14036.859631403555;14039.087459315111;14088.577342679737;14166.433342666178;21649.45876353041;21725.782742172374;22035.66946495836;22040.228591999203;22341.77658223462;17286.22212000438;17465;17540.561485962444;17576.38482653101;17858.821411785717;15854.128022958386;16131;16303.59241018984;16582.66834663276;16684.666306673556;18098.09509524492;18195.18121684501;18222.908885455487;18240.270389184283;18422.90788546049;14007.159570425807;14020;14049.508267210598;14075.859241407456;14144.717105658036;17505.03722295286;17557.297708091533;17594;17856.821431786037;17897.552561186076 15:41:22 INFO - PID 4703 | |3;mootools.html;1341.9597412077637;1393.2963853254105;1395.044394589706;1403.0669604712855;1404.8805851502627;15109.84890151098;15733.449329273464;15743.763843542356;15747.68504629908;15756.290966906488;15312.540623781304;15370.538883833475;15413.383464661429;15417.15205663688;15447.382104715798;2460.225029115827;2595.7144714081437;2599.0773275487213;2600.6619139511836;2603.700574433936;2624.3439140214946;2674.879630416636;2675.250929739676;2682.637843891069;2699.91900242993;2561.5005074010573;2656.6015097735303;2656.9468610627778;2657.9468410631775;2659.2819938616562;2661.813673042888;2670.2923725212836;2689.924030387841;2705.2425320910174;2707.187843646908;2675.0102462088958;2679.236417620988;2684.650995370609;2690.4081102157493;2701.0411303987;14866.554003379915;15230.771538426932;15236.466723664618;15237.847621523864;15268.694626107415;7923.286904178594;8187.26314631686;8203.548804815733;8204.712835050745;8211.466254693425;4934.827281045146;4994.850154495371;5077.543021128116;5241.895162096736;5383.865403364908;1778.404234581404;1793.3723196880987;1797.4607617714764;1815.945521634353;1840.68708319586;26386.20841374762;26554.33614159642;26557;26594;26647.866760666268;6405.743770249231;6571.3757193066585;6710.396064354231;6735.393814556714;6753.729850806011;17027.40404085851;17032.659346812994;17078.23147958345;17114;17192.31230750781;7775.533467991939;7815.843683126305;7817.8827317590285;7822.2568855959735;7823.100343460461;7206.531575447579;7217.566945983258;7280.890786638205;7301.415886729049;7310.305520975498;4994.675346102492;5124.282600435942;5151.9484805152215;5208.687478751287;5346.732663366816;1421.644588852787;1502.353987785241;1505.1345476351141;1515.9393624254906;1531.1655147944398;732.8351120997839;881.9470831750116;893.4549924546021;910.6493999809989;911.8814554107923;8126.39052071097;8261.83476330482;8307.501549907025;8386.580670966427;8433.156684331641;916.9266458683289;958.2956526952685;963.9566219520138;972.411690926979;992;5511.118221084607;5523.558115350762;5532.253145825262;5598.356189038232;5620.269364982526;21460.141594336365;21610.35168944934;21951.231706890183;22259.443513912283;22342.441438964157;20797.27209547689;21917.342479725314;22220.55558888813;22348.888255558617;22373.55252894933;11517.078633709283;11591.130665200144;11600.477978490988;11603.129765267639;11717.414129293502;8064.193580641889;8306.127856574973;8414.537200454033;8447;8601.784955376166;18273.725894111332;18354.26582936721;18520.72218916744;18684.906575467037;19157;19051.61896762085;19052.333168339042;19056.904715476336;19182.616347673247;19194.712079318542;10197.847032294374;10416.531256093645;10420.905804890377;10424.061834434937;10433.634822781167;13880.861191387958;13900;13923;14079.436822526985;14110.858891410955;11208.103351732005;11339.943300283447;11471.541138354372;11644.475998579916;11796;11050.115990720884;11167.832482512606;11236.831447528457;11344.149188811038;11432.371219583003;9397.154256116708;9463.763405914908;9552.283578731483;9668.226541876493;9716.076972687584;7340.70637174507;7377.852442951218;7406.481546291708;7411.888821667571;7475.588842613491;6992.510524263253;7113.82215444618;7145.928540714526;7179.748708795167;7216.675249613675 15:41:22 INFO - PID 4703 | |4;prototype.html;485.7158562241089;503.72808658138206;508.8269988204008;513.4147072337536;527.1881302793698;6192.62844229346;6201.658908760022;6246.500279977602;6305.558610897233;6334.841628959279;6102.511799056076;6166.3525329840395;6187.845303867405;6212.565120441571;6219.782307619234;5096.643234973553;5135.589152867761;5168.8449346519665;5175.2754614353835;5197.4022987356375;4785.736784476852;4982.153033984213;5110.565601923841;5175.58595312376;5179.559737422323;4929.8521044368545;4948.579370753472;4963.1810751226185;4974.37820272466;4983.626228032894;4868.56182943535;4904;4950.752462376867;4966.801327946878;4992.975035124819;4390.429244198233;4420.182266280748;4443.42235509385;4455.710378825366;4490.438695163105;5993.741314323997;6024.548158888101;6051.515878729691;6073.908891366633;6104.908426373608;5657.915131273035;5664.433556644344;5679.148127780824;5689.886202275973;5733.197352370671;6512.641804700739;6521.348045094762;6580.0129980502825;6583.868322633521;6603.834904127387;4582.656300777455;4849.660523763338;4859.246816743411;4883.902321953541;4899.191633380488;6566.244881838602;6594;6665.766698165589;6876.346747059071;6884.724611015503;4955.4548999610015;4982.950170498321;4991.376077990251;4997.500249975046;4999.10016197088;5020.748962551857;5050.520200580939;5061.595072394273;5067.46791586878;5070.847874563769;5662.603617746719;5673.971630141906;5675.517581005578;5695.829125126253;5697.544196464273;6591.34086591337;6601.5378923475855;6603.339666033358;6607.768728094494;6626.403623673892;1735.8177391373977;1747.8863873848413;1748.5715999580184;1753.3424965637885;1767.1782621081259;1161.3786624156037;1215.7629262293945;1227.846519185102;1229.9139060265695;1233.735421193284;5686.658800471985;5689.829305120853;5701.40135285789;5705.543556515552;5738.5982981191755;6647.567908085959;6657.866842663119;6710.1947766267385;6792.558483698643;6795.592264464148;5544.918740845496;5570.582206334541;5602;5603.187537806995;5639.915401268902;3478.5999610044664;3485.5991560970815;3506.947395789065;3523.982380088083;3530.8940731777575;6401.655652313067;6422.518311126684;6432.839179020469;6478.902816457757;6537.280899101095;6801.387875091265;6879.759208427681;6896.586204827727;6898.689558969859;6917.273686262971;6030.949477177781;6361.840953976188;6404.903926441107;6420.967895160495;6481.967590162019;6488.578242414228;6532.510061745483;6542.724168787231;6587.703553340207;6636.535442518977;6572.934270657423;6597.538172327891;6617.8014659560295;6656;6665.600383861903;6493.512986526124;6510.381513756375;6511.153550038464;6569.24453687832;6585.6377899216;4900;4954.603631709382;4974.278729584118;5005.049040682259;5018.949810501848;6535.313792051957;6644.57473022353;6646.338415396151;6693.765718199839;6743.8988415172835;6393.849107160756;6426.61440313564;6448.29068802422;6490.253620833664;6494.025896115431;6342.016987366966;6381.457576106083;6469.3530646936815;6484.837879053061;6583.210014798255;6360.650164240826;6398.232212134573;6439.7424103035355;6465.709043093166;6468.15913931186;6449.6130232186215;6473.902891456726;6529.608223506605;6540.574862633914;6635.4831939072365;6271.153394291712;6283.874322513433;6315.884178800154;6341.143945567474;6414.03789431589 15:41:22 INFO - PID 4703 | |5;yui.html;888.0276097673047;893.3657103456545;907.5598334807621;912.6760000199927;916.1296768070334;18896.62206755866;19803;19803.306884259055;19816.306429274995;19920.90039549804;18026.4592062238;18137.093145342715;18266.360677376295;18267.36064237752;18280;960.2414092866644;970.7524581231776;973.095021629884;973.464594473037;973.6251543155901;979.8677178580907;986.6004268271325;987.0327079462131;989.5101924547323;990.3414229537349;996.5166894056376;1028.5371582787739;1034.2915103154364;1040.5525623981684;1040.973975650611;1028.9742756431074;1031.5718976624692;1031.5976769060073;1031.9432431216242;1033.1424917318607;724.3589423360364;742.2021327073363;750.2684882239827;750.8122969257686;753.2166546791331;19384.90307548467;19467.415977520697;19491.415257542154;19575.21699132033;19583.608327833506;21044.684329735068;21508.892455537778;21891.890540547356;21992.230271940567;22173.113075476962;16546.172691365504;16636.750448743278;16959.83040169595;16984.660306793918;17121.486355409357;3543.1850674345046;3593.9281214375565;3609.3864043112735;3609.927801443983;3620.456931460276;105510.47244763804;136547.31726341404;140226;141088.29455852654;145906;16769.91615041917;16806.15969201535;16885.662286754196;17048.659026819394;17100.914495427693;30732;30881.536776948364;31051.844740776152;31273.8436307817;31519.684803152133;8735.213830755263;8891.066438024043;8911.153440423279;8926.553672316359;8954.641814327484;4169.60388763067;4230.196262710076;4260.595243451867;4276.593723596254;4283.571642835754;5229.08491014071;5342.572594192533;5377;5392.973035134799;5399.487048730443;995.4475266227313;1046.4401545173296;1046.7173863056933;1050.2858056521638;1057.3285963413289;674.5480528046221;689.1661090081058;698.552926127279;700.9088818453569;711.3846522757777;11648.94175529117;11882.762344753057;11910.166288359731;13181.670458238428;13201.537946171838;680.7311112110689;684.910961574992;703.2686006553128;704.7956092733152;711.5446114486732;4786;4898.24077268024;4971.279164521196;4986.950130498722;5067.898642027212;115746.42126789481;122232.38883805524;123540.38229808974;124141;125645;101990;106722;109129;115455;115808.42095789636;89553;93302.53348733348;93557.5322123385;93953.5302323484;94285.52857235669;9901.118722487801;9903.811542614932;9980.550875210487;10100.090991810772;10102.797944041225;42035.7898210507;43857.34213986857;43906.780466097465;43941;46141.30788038115;54709.45290547043;55170.44829551653;55387.72306138444;55775.442245577025;57522;14983.77524337114;15361.078335299917;15368.615784605474;15480.225988700746;15502.922485387951;17344.219510121824;17516.124193790005;17710.468685939442;17804.91097544504;17872.195751190968;15428.614284642974;15588.22058897028;15739.213039348217;15871.52385428439;15903.602409939844;16479.423220187236;16622.418215362406;16690.332386704395;16788.244528996467;16818.66362672764;15313;15403.84596154069;15596;15637.921810390875;15695.058296502246;11228.887711122785;11438.94280528592;11441.084713222755;11469.369184694922;11775;11354.375509347065;11529;11643.243189192675;11799.115066370228;11805.881941180478 15:41:22 INFO - PID 4703 | __end_tp_report 15:41:22 INFO - PID 4703 | __start_cc_report 15:41:22 INFO - PID 4703 | _x_x_mozilla_cycle_collect,387 15:41:22 INFO - PID 4703 | __end_cc_report 15:41:22 INFO - PID 4703 | __startTimestamp1505342482034__endTimestamp 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | ------- Summary: start ------- 15:41:22 INFO - PID 4703 | Number of tests: 6 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#0] dojo.html Cycles:165 Average:6235.53 Median:6531.44 stddev:857.53 (13.1%) stddev-sans-first:825.71 15:41:22 INFO - PID 4703 | Values: 3168.4 3172.9 3185.3 3212.1 3218.1 6223.1 6306.1 6311.7 6370.9 6397.7 6313.1 6372.4 6374.8 6486.9 6503.5 1291.6 5862.8 5897.6 5926.7 5946.9 5678.8 5817.0 5820.9 5892.7 5895.3 5834.0 5835.5 5891.9 5901.8 5906.6 5808.9 5832.3 5882.3 5902.1 5906.1 5812.9 5816.6 5866.4 5895.6 5898.3 6094.4 6230.9 6365.4 6383.4 6460.0 6638.5 6641.6 6728.5 6728.5 6768.9 6884.5 6907.4 6940.0 6951.6 6958.3 6233.9 6302.1 6310.3 6313.8 6349.8 7002.7 7011.2 7022.6 7079.6 7088.5 6660.9 6664.2 6666.6 6743.7 6758.1 6623.3 6749.8 6816.1 6885.8 6897.9 6822.6 6844.7 6850.7 6881.4 6897.6 6798.2 6804.2 6883.0 6886.3 6902.7 5221.1 5240.4 5298.7 5320.4 5323.2 4547.0 4615.9 4620.6 4647.8 4736.0 5804.0 5823.2 5866.6 5870.2 5878.0 6773.3 6856.6 6929.1 6940.5 6956.4 5785.7 5802.6 5865.4 5870.5 5884.5 5728.0 5756.9 5785.2 5802.5 5816.4 6502.3 6533.4 6534.6 6535.9 6550.2 6771.3 6813.9 6893.1 6910.3 6919.3 6519.5 6570.9 6604.9 6708.6 6723.7 6580.9 6640.0 6657.6 6678.4 6757.4 6854.2 6894.8 6959.2 6963.6 6972.1 6615.6 6637.4 6643.1 6738.2 6745.5 6639.9 6644.2 6718.6 6728.8 6735.4 6439.6 6551.6 6570.0 6611.6 6640.4 6700.7 6700.8 6711.6 6747.2 6759.6 6269.9 6408.6 6427.8 6455.5 6531.4 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#1] ext.html Cycles:180 Average:37128.66 Median:35602.79 stddev:51914.12 (145.8%) stddev-sans-first:51988.16 15:41:22 INFO - PID 4703 | Values: 818.0 824.3 847.5 871.1 879.6 39585.8 43061.6 43127.6 43514.1 44338.8 43029.8 43256.6 43419.0 43477.8 43621.1 7735.9 7880.4 7882.0 7889.0 7890.0 7793.1 7869.4 7886.3 7886.3 7891.6 7877.6 7930.5 7932.1 7935.6 7944.0 7882.2 7907.9 7924.7 7925.0 7926.8 7764.5 7819.7 7829.3 7836.7 7837.4 38823.4 39087.6 39116.2 39140.2 39159.2 3589.7 3629.2 3630.3 3631.6 3633.9 32152.0 32159.4 32164.7 32255.7 32367.0 5126.3 5131.6 5138.7 5178.8 5184.6 184971.0 185026.0 186375.0 186781.0 186782.0 46891.0 46979.1 47116.5 47167.3 47182.0 48609.8 48707.0 48738.8 48826.8 48873.3 15755.4 16074.2 16095.8 16106.2 16111.4 13328.3 13330.1 13338.1 13340.7 13342.3 12715.9 12946.4 12968.0 13015.8 13202.3 5023.8 5049.3 5143.9 5186.2 5243.2 994.0 996.5 1002.6 1015.3 1025.2 22502.3 22900.2 22959.9 22991.5 23503.4 1101.1 1108.7 1120.4 1123.8 1126.4 12052.9 12076.8 12158.8 12280.7 12330.7 222950.0 223546.0 223840.0 233482.0 238083.0 57091.4 57113.1 57221.1 57225.4 57311.4 1431.0 1453.4 1454.3 1454.4 1456.2 26774.0 27000.6 27396.0 27506.6 27614.6 36799.8 36850.0 36966.8 37023.0 37039.4 183305.0 183360.0 183434.0 183479.0 184879.0 33517.8 33794.5 33865.0 33897.8 33941.2 41959.8 41977.0 42156.8 42301.8 42350.6 31440.4 31534.7 31534.8 31840.7 32259.5 31067.8 31212.5 31234.8 31356.2 31447.7 35126.6 35405.0 35509.1 35696.5 35856.9 31183.4 31197.2 31259.8 31336.0 31741.4 22477.6 22737.3 23039.8 23285.3 23508.6 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#2] jquery.html Cycles:180 Average:33222.26 Median:22045.95 stddev:78278.36 (355.1%) stddev-sans-first:78459.54 15:41:22 INFO - PID 4703 | Values: 562.2 570.9 572.1 573.3 579.3 22236.6 23011.9 23090.7 23109.0 23110.2 22908.9 23867.3 24347.5 24640.3 24669.8 6383.2 6441.8 6491.0 6493.2 6534.7 6348.1 6369.7 6458.4 6463.3 6633.3 6598.8 6610.9 6612.3 6614.1 6614.8 6198.4 6471.3 6583.4 6586.9 6587.6 6002.0 6006.7 6016.3 6021.9 6026.0 27696.9 28229.3 28251.4 28257.0 28278.7 2072.7 2091.7 2096.0 2096.9 2097.0 17057.5 17491.5 17710.9 17875.4 17888.9 2356.9 2411.0 2415.5 2421.3 2447.3 121991.0 129878.0 134939.0 140911.0 141461.3 13925.3 14147.5 14155.7 14190.6 14348.4 21952.5 22051.7 22056.0 22138.2 22201.6 9943.5 10037.1 10162.5 10200.8 10214.4 9212.9 9288.8 9345.2 9367.3 9542.4 8655.1 8717.0 8763.9 8907.1 8912.2 2591.3 2593.6 2631.3 2671.7 2747.9 959.6 973.3 981.6 1002.4 1003.2 18526.5 18762.4 18817.3 18955.8 19343.0 1037.1 1038.8 1041.5 1042.6 1050.7 10444.7 10460.5 10555.7 10788.4 10816.6 456284.0 460316.0 464572.0 470983.0 471827.0 100575.0 103576.5 105667.0 107491.0 107683.5 1041.4 1123.2 1168.4 1195.9 1203.3 19444.0 19597.5 19683.0 19736.8 20117.0 52891.2 53772.0 54147.5 55432.4 56408.9 68413.3 68436.7 68645.3 68783.0 68916.0 13863.9 14036.9 14039.1 14088.6 14166.4 21649.5 21725.8 22035.7 22040.2 22341.8 17286.2 17465.0 17540.6 17576.4 17858.8 15854.1 16131.0 16303.6 16582.7 16684.7 18098.1 18195.2 18222.9 18240.3 18422.9 14007.2 14020.0 14049.5 14075.9 14144.7 17505.0 17557.3 17594.0 17856.8 17897.6 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#3] mootools.html Cycles:180 Average:9342.07 Median:2656.77 stddev:6735.23 (253.5%) stddev-sans-first:6727.30 15:41:22 INFO - PID 4703 | Values: 1342.0 1393.3 1395.0 1403.1 1404.9 15109.8 15733.4 15743.8 15747.7 15756.3 15312.5 15370.5 15413.4 15417.2 15447.4 2460.2 2595.7 2599.1 2600.7 2603.7 2624.3 2674.9 2675.3 2682.6 2699.9 2561.5 2656.6 2656.9 2657.9 2659.3 2661.8 2670.3 2689.9 2705.2 2707.2 2675.0 2679.2 2684.7 2690.4 2701.0 14866.6 15230.8 15236.5 15237.8 15268.7 7923.3 8187.3 8203.5 8204.7 8211.5 4934.8 4994.9 5077.5 5241.9 5383.9 1778.4 1793.4 1797.5 1815.9 1840.7 26386.2 26554.3 26557.0 26594.0 26647.9 6405.7 6571.4 6710.4 6735.4 6753.7 17027.4 17032.7 17078.2 17114.0 17192.3 7775.5 7815.8 7817.9 7822.3 7823.1 7206.5 7217.6 7280.9 7301.4 7310.3 4994.7 5124.3 5151.9 5208.7 5346.7 1421.6 1502.4 1505.1 1515.9 1531.2 732.8 881.9 893.5 910.6 911.9 8126.4 8261.8 8307.5 8386.6 8433.2 916.9 958.3 964.0 972.4 992.0 5511.1 5523.6 5532.3 5598.4 5620.3 21460.1 21610.4 21951.2 22259.4 22342.4 20797.3 21917.3 22220.6 22348.9 22373.6 11517.1 11591.1 11600.5 11603.1 11717.4 8064.2 8306.1 8414.5 8447.0 8601.8 18273.7 18354.3 18520.7 18684.9 19157.0 19051.6 19052.3 19056.9 19182.6 19194.7 10197.8 10416.5 10420.9 10424.1 10433.6 13880.9 13900.0 13923.0 14079.4 14110.9 11208.1 11339.9 11471.5 11644.5 11796.0 11050.1 11167.8 11236.8 11344.1 11432.4 9397.2 9463.8 9552.3 9668.2 9716.1 7340.7 7377.9 7406.5 7411.9 7475.6 6992.5 7113.8 7145.9 7179.7 7216.7 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#4] prototype.html Cycles:180 Average:5480.87 Median:6103.71 stddev:1533.51 (25.1%) stddev-sans-first:1491.28 15:41:22 INFO - PID 4703 | Values: 485.7 503.7 508.8 513.4 527.2 6192.6 6201.7 6246.5 6305.6 6334.8 6102.5 6166.4 6187.8 6212.6 6219.8 5096.6 5135.6 5168.8 5175.3 5197.4 4785.7 4982.2 5110.6 5175.6 5179.6 4929.9 4948.6 4963.2 4974.4 4983.6 4868.6 4904.0 4950.8 4966.8 4993.0 4390.4 4420.2 4443.4 4455.7 4490.4 5993.7 6024.5 6051.5 6073.9 6104.9 5657.9 5664.4 5679.1 5689.9 5733.2 6512.6 6521.3 6580.0 6583.9 6603.8 4582.7 4849.7 4859.2 4883.9 4899.2 6566.2 6594.0 6665.8 6876.3 6884.7 4955.5 4983.0 4991.4 4997.5 4999.1 5020.7 5050.5 5061.6 5067.5 5070.8 5662.6 5674.0 5675.5 5695.8 5697.5 6591.3 6601.5 6603.3 6607.8 6626.4 1735.8 1747.9 1748.6 1753.3 1767.2 1161.4 1215.8 1227.8 1229.9 1233.7 5686.7 5689.8 5701.4 5705.5 5738.6 6647.6 6657.9 6710.2 6792.6 6795.6 5544.9 5570.6 5602.0 5603.2 5639.9 3478.6 3485.6 3506.9 3524.0 3530.9 6401.7 6422.5 6432.8 6478.9 6537.3 6801.4 6879.8 6896.6 6898.7 6917.3 6030.9 6361.8 6404.9 6421.0 6482.0 6488.6 6532.5 6542.7 6587.7 6636.5 6572.9 6597.5 6617.8 6656.0 6665.6 6493.5 6510.4 6511.2 6569.2 6585.6 4900.0 4954.6 4974.3 5005.0 5018.9 6535.3 6644.6 6646.3 6693.8 6743.9 6393.8 6426.6 6448.3 6490.3 6494.0 6342.0 6381.5 6469.4 6484.8 6583.2 6360.7 6398.2 6439.7 6465.7 6468.2 6449.6 6473.9 6529.6 6540.6 6635.5 6271.2 6283.9 6315.9 6341.1 6414.0 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | [#5] yui.html Cycles:180 Average:23998.89 Median:19693.30 stddev:34749.98 (176.5%) stddev-sans-first:34804.14 15:41:22 INFO - PID 4703 | Values: 888.0 893.4 907.6 912.7 916.1 18896.6 19803.0 19803.3 19816.3 19920.9 18026.5 18137.1 18266.4 18267.4 18280.0 960.2 970.8 973.1 973.5 973.6 979.9 986.6 987.0 989.5 990.3 996.5 1028.5 1034.3 1040.6 1041.0 1029.0 1031.6 1031.6 1031.9 1033.1 724.4 742.2 750.3 750.8 753.2 19384.9 19467.4 19491.4 19575.2 19583.6 21044.7 21508.9 21891.9 21992.2 22173.1 16546.2 16636.8 16959.8 16984.7 17121.5 3543.2 3593.9 3609.4 3609.9 3620.5 105510.5 136547.3 140226.0 141088.3 145906.0 16769.9 16806.2 16885.7 17048.7 17100.9 30732.0 30881.5 31051.8 31273.8 31519.7 8735.2 8891.1 8911.2 8926.6 8954.6 4169.6 4230.2 4260.6 4276.6 4283.6 5229.1 5342.6 5377.0 5393.0 5399.5 995.4 1046.4 1046.7 1050.3 1057.3 674.5 689.2 698.6 700.9 711.4 11648.9 11882.8 11910.2 13181.7 13201.5 680.7 684.9 703.3 704.8 711.5 4786.0 4898.2 4971.3 4987.0 5067.9 115746.4 122232.4 123540.4 124141.0 125645.0 101990.0 106722.0 109129.0 115455.0 115808.4 89553.0 93302.5 93557.5 93953.5 94285.5 9901.1 9903.8 9980.6 10100.1 10102.8 42035.8 43857.3 43906.8 43941.0 46141.3 54709.5 55170.4 55387.7 55775.4 57522.0 14983.8 15361.1 15368.6 15480.2 15502.9 17344.2 17516.1 17710.5 17804.9 17872.2 15428.6 15588.2 15739.2 15871.5 15903.6 16479.4 16622.4 16690.3 16788.2 16818.7 15313.0 15403.8 15596.0 15637.9 15695.1 11228.9 11438.9 11441.1 11469.4 11775.0 11354.4 11529.0 11643.2 11799.1 11805.9 15:41:22 INFO - PID 4703 | -------- Summary: end -------- 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | 15:41:22 INFO - PID 4703 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 15:41:22 INFO - PID 4703 | 15:41:22 INFO - TEST-INFO | 4703: exit 0 15:41:22 INFO - TEST-OK | dromaeo_css | took 1109141ms 15:41:22 INFO - TEST-START | kraken 15:41:22 INFO - Initialising browser for kraken test... 15:41:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47353/getInfo.html -profile /tmp/tmpwmgchW/profile 15:41:22 INFO - TEST-INFO | started process 5069 (/builds/slave/test/build/application/firefox/firefox http://localhost:47353/getInfo.html) 15:41:28 INFO - TEST-INFO | 5069: exit 0 15:41:28 INFO - Browser initialized. 15:41:28 INFO - Running cycle 1/1 for kraken test... 15:41:28 INFO - Using env: {'DISPLAY': ':0', 15:41:28 INFO - 'HOME': '/home/cltbld', 15:41:28 INFO - 'JSGC_DISABLE_POISONING': '1', 15:41:28 INFO - 'LANG': 'en_US.UTF-8', 15:41:28 INFO - 'LANGUAGE': 'en_US:en', 15:41:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:41:28 INFO - 'LOGNAME': 'cltbld', 15:41:28 INFO - 'MAIL': '/var/mail/cltbld', 15:41:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:41:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:41:28 INFO - 'MOZ_CRASHREPORTER': '1', 15:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:41:28 INFO - 'MOZ_NO_REMOTE': '1', 15:41:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:28 INFO - 'NO_EM_RESTART': '1', 15:41:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:28 INFO - 'PWD': '/builds/slave/test', 15:41:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:41:28 INFO - 'RUST_BACKTRACE': 'full', 15:41:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:41:28 INFO - 'SHELL': '/bin/bash', 15:41:28 INFO - 'SHLVL': '1', 15:41:28 INFO - 'STYLO_FORCE_DISABLED': '1', 15:41:28 INFO - 'TERM': 'linux', 15:41:28 INFO - 'TMOUT': '86400', 15:41:28 INFO - 'USER': 'cltbld', 15:41:28 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163', 15:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:28 INFO - '_': '/tools/buildbot/bin/python'} 15:41:28 INFO - TEST-INFO | started process 5302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmgchW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:29 INFO - PID 5302 | 15:41:29 INFO - PID 5302 | (/builds/slave/test/build/application/firefox/firefox:5352): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:41:29 INFO - PID 5302 | 15:41:40 INFO - PID 5302 | RSS: Main: 173596672 15:41:40 INFO - PID 5302 | 15:41:42 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47353/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:43 INFO - PID 5302 | RSS: Main: 177799168 15:41:43 INFO - PID 5302 | 15:41:46 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47353/tests/kraken/driver.html?testName=audio-dft) 15:41:46 INFO - PID 5302 | RSS: Main: 178814976 15:41:46 INFO - PID 5302 | 15:41:49 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47353/tests/kraken/driver.html?testName=audio-fft) 15:41:50 INFO - PID 5302 | RSS: Main: 174108672 15:41:50 INFO - PID 5302 | 15:41:52 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47353/tests/kraken/driver.html?testName=audio-oscillator) 15:41:53 INFO - PID 5302 | RSS: Main: 175579136 15:41:53 INFO - PID 5302 | 15:41:55 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:55 INFO - PID 5302 | RSS: Main: 175071232 15:41:55 INFO - PID 5302 | 15:41:59 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47353/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:59 INFO - PID 5302 | RSS: Main: 177225728 15:41:59 INFO - PID 5302 | 15:42:03 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47353/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:03 INFO - PID 5302 | RSS: Main: 177569792 15:42:03 INFO - PID 5302 | 15:42:07 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47353/tests/kraken/driver.html?testName=json-parse-financial) 15:42:07 INFO - PID 5302 | RSS: Main: 178094080 15:42:07 INFO - PID 5302 | 15:42:09 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:09 INFO - PID 5302 | RSS: Main: 177750016 15:42:09 INFO - PID 5302 | 15:42:11 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:12 INFO - PID 5302 | RSS: Main: 177778688 15:42:12 INFO - PID 5302 | 15:42:14 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:15 INFO - PID 5302 | RSS: Main: 174649344 15:42:15 INFO - PID 5302 | 15:42:17 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:18 INFO - PID 5302 | RSS: Main: 174891008 15:42:18 INFO - PID 5302 | 15:42:21 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:21 INFO - PID 5302 | RSS: Main: 175067136 15:42:21 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | Cycle 1(1): loaded http://localhost:47353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47353/tests/kraken/driver.html?testName=ai-astar) 15:42:23 INFO - PID 5302 | RSS: Main: 176467968 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | __start_tp_report 15:42:23 INFO - PID 5302 | _x_x_mozilla_page_load 15:42:23 INFO - PID 5302 | _x_x_mozilla_page_load_details 15:42:23 INFO - PID 5302 | |i|pagename|runs| 15:42:23 INFO - PID 5302 | |0;ai-astar;106;106;107;106;107;95;108;109;107;108 15:42:23 INFO - PID 5302 | |1;audio-beat-detection;117;118;115;114;117;142;117;116;120;118 15:42:23 INFO - PID 5302 | |2;audio-dft;163;162;161;162;162;163;163;168;167;165 15:42:23 INFO - PID 5302 | |3;audio-fft;75;75;74;73;74;73;72;74;74;75 15:42:23 INFO - PID 5302 | |4;audio-oscillator;79;79;79;78;79;78;78;79;82;80 15:42:23 INFO - PID 5302 | |5;imaging-gaussian-blur;114;113;115;114;117;114;110;114;114;114 15:42:23 INFO - PID 5302 | |6;imaging-darkroom;150;147;149;148;150;148;150;149;149;149 15:42:23 INFO - PID 5302 | |7;imaging-desaturate;96;94;95;93;94;94;95;94;94;94 15:42:23 INFO - PID 5302 | |8;json-parse-financial;54;55;53;53;54;54;53;54;53;52 15:42:23 INFO - PID 5302 | |9;json-stringify-tinderbox;38;38;43;38;38;39;38;39;39;39 15:42:23 INFO - PID 5302 | |10;stanford-crypto-aes;82;77;75;75;76;75;78;74;74;76 15:42:23 INFO - PID 5302 | |11;stanford-crypto-ccm;119;116;115;109;114;114;120;112;117;115 15:42:23 INFO - PID 5302 | |12;stanford-crypto-pbkdf2;164;165;173;167;189;164;172;165;168;165 15:42:23 INFO - PID 5302 | |13;stanford-crypto-sha256-iterative;75;62;65;68;66;67;65;66;64;64 15:42:23 INFO - PID 5302 | __end_tp_report 15:42:23 INFO - PID 5302 | __start_cc_report 15:42:23 INFO - PID 5302 | _x_x_mozilla_cycle_collect,909 15:42:23 INFO - PID 5302 | __end_cc_report 15:42:23 INFO - PID 5302 | __startTimestamp1505342543740__endTimestamp 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | ------- Summary: start ------- 15:42:23 INFO - PID 5302 | Number of tests: 14 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#0] ai-astar Cycles:10 Average:105.90 Median:107.50 stddev:3.96 (3.7%) stddev-sans-first:4.20 15:42:23 INFO - PID 5302 | Values: 106.0 106.0 107.0 106.0 107.0 95.0 108.0 109.0 107.0 108.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:117.50 stddev:8.11 (6.9%) stddev-sans-first:8.56 15:42:23 INFO - PID 5302 | Values: 117.0 118.0 115.0 114.0 117.0 142.0 117.0 116.0 120.0 118.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.45 15:42:23 INFO - PID 5302 | Values: 163.0 162.0 161.0 162.0 162.0 163.0 163.0 168.0 167.0 165.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.99 (1.3%) stddev-sans-first:0.97 15:42:23 INFO - PID 5302 | Values: 75.0 75.0 74.0 73.0 74.0 73.0 72.0 74.0 74.0 75.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.00 stddev:1.20 (1.5%) stddev-sans-first:1.27 15:42:23 INFO - PID 5302 | Values: 79.0 79.0 79.0 78.0 79.0 78.0 78.0 79.0 82.0 80.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.73 (1.5%) stddev-sans-first:1.83 15:42:23 INFO - PID 5302 | Values: 114.0 113.0 115.0 114.0 117.0 114.0 110.0 114.0 114.0 114.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 15:42:23 INFO - PID 5302 | Values: 150.0 147.0 149.0 148.0 150.0 148.0 150.0 149.0 149.0 149.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.60 15:42:23 INFO - PID 5302 | Values: 96.0 94.0 95.0 93.0 94.0 94.0 95.0 94.0 94.0 94.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 15:42:23 INFO - PID 5302 | Values: 54.0 55.0 53.0 53.0 54.0 54.0 53.0 54.0 53.0 52.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.58 15:42:23 INFO - PID 5302 | Values: 38.0 38.0 43.0 38.0 38.0 39.0 38.0 39.0 39.0 39.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.39 (3.2%) stddev-sans-first:1.33 15:42:23 INFO - PID 5302 | Values: 82.0 77.0 75.0 75.0 76.0 75.0 78.0 74.0 74.0 76.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:115.50 stddev:3.21 (2.8%) stddev-sans-first:3.08 15:42:23 INFO - PID 5302 | Values: 119.0 116.0 115.0 109.0 114.0 114.0 120.0 112.0 117.0 115.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:167.50 stddev:7.66 (4.6%) stddev-sans-first:7.89 15:42:23 INFO - PID 5302 | Values: 164.0 165.0 173.0 167.0 189.0 164.0 172.0 165.0 168.0 165.0 15:42:23 INFO - PID 5302 | 15:42:23 INFO - PID 5302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:3.52 (5.3%) stddev-sans-first:1.79 15:42:23 INFO - PID 5302 | Values: 75.0 62.0 65.0 68.0 66.0 67.0 65.0 66.0 64.0 64.0 15:42:23 INFO - PID 5302 | -------- Summary: end -------- 15:42:23 INFO - PID 5302 | 15:42:24 INFO - PID 5302 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:42:24 INFO - TEST-INFO | 5302: exit 0 15:42:24 INFO - TEST-OK | kraken | took 61573ms 15:42:24 INFO - SUITE-END | took 1170s 15:42:24 INFO - Completed test suite (00:19:31) 15:42:24 INFO - javascript benchmark 15:42:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8455.39645912785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.382165477731, 3172.9048128556146, 3185.347003864207, 3212.052444528864, 3218.0667606394145, 6223.066540018999, 6306.117143599889, 6311.715972781224, 6370.872582548352, 6397.744090236391, 6313.116163737081, 6372.426481616653, 6374.840628984278, 6486.870262594745, 6503.512236582252, 1291.6328278715387, 5862.794802181925, 5897.557683173758, 5926.703664816763, 5946.851328716773, 5678.772849086032, 5817.0, 5820.912686309709, 5892.734826932799, 5895.263092113486, 5834.0, 5835.503982161521, 5891.88216235675, 5901.822945311605, 5906.5570082244, 5808.912866307009, 5832.300123985106, 5882.29412470502, 5902.085176797603, 5906.143609176688, 5812.912806307909, 5816.592838501307, 5866.354700982888, 5895.55783316253, 5898.262717160355, 6094.360092190301, 6230.875382492325, 6365.425144078532, 6383.361663833626, 6460.030995350688, 6638.4689224861895, 6641.634710090943, 6728.495362847757, 6728.529002969794, 6768.932310676929, 6884.51808373414, 6907.447404207652, 6939.965300173517, 6951.582905025714, 6958.269381714948, 6233.906491402633, 6302.1177035215105, 6310.305866354697, 6313.779017734358, 6349.777757778455, 7002.739506888809, 7011.193712723, 7022.648867556704, 7079.646017699094, 7088.503804733619, 6660.933390666129, 6664.166979127609, 6666.600003999679, 6743.662816859138, 6758.05387245786, 6623.3376662333385, 6749.763758268437, 6816.113905192294, 6885.827854303682, 6897.896531552031, 6822.556533825285, 6844.691988860513, 6850.6574671266235, 6881.380675739208, 6897.620630865351, 6798.218204906499, 6804.183497980274, 6882.965585172142, 6886.311368863074, 6902.689378977958, 5221.13851214553, 5240.3973543042275, 5298.708571028554, 5320.441353657888, 5323.201519772065, 4546.977265113654, 4615.8846028848875, 4620.561046700625, 4647.767611619405, 4736.0, 5804.04233301509, 5823.242978412779, 5866.6186697864505, 5870.178175055496, 5877.970610146922, 6773.254941956381, 6856.6228857412325, 6929.133858267716, 6940.514164008572, 6956.443484521226, 5785.739641716133, 5802.622829516068, 5865.384134665884, 5870.471657550841, 5884.529237660977, 5728.0, 5756.94243057564, 5785.161151633074, 5802.47777700009, 5816.360200377955, 6502.349765023459, 6533.41199292066, 6534.607923524603, 6535.934640653532, 6550.246721627074, 6771.289014653489, 6813.89779153323, 6893.0694356261265, 6910.343517365842, 6919.342662447059, 6519.511036672174, 6570.901436478553, 6604.9009264862025, 6708.6310252936555, 6723.663816809042, 6580.868382632416, 6640.037194606852, 6657.567258128206, 6678.365555272241, 6757.358050985148, 6854.177498700188, 6894.793156205322, 6959.164900212007, 6963.61700106499, 6972.1284839395075, 6615.6030638161865, 6637.402633762985, 6643.069970204272, 6738.225104113089, 6745.52781305304, 6639.933600664125, 6644.202695676357, 6718.596884186964, 6728.831779205559, 6735.360140786617, 6439.613623182624, 6551.574147680385, 6570.0, 6611.603303801788, 6640.369164929324, 6700.6984685688285, 6700.765473208415, 6711.597304161571, 6747.190337159573, 6759.628220447726, 6269.874602508015, 6408.61548307103, 6427.807165785034, 6455.483561315177, 6531.444827189742], "value": 6172.44003754801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.9795505112371, 824.3322908444164, 847.4660963592936, 871.1419252036743, 879.6481407437028, 39585.802070989674, 43061.569384306145, 43127.56872431275, 43514.12971740563, 44338.77830610846, 43029.7848510757, 43256.56743432565, 43419.0, 43477.7826110869, 43621.12757744843, 7735.9226407735905, 7880.4089693272945, 7881.960590197041, 7889.0, 7890.0, 7793.142754297023, 7869.409794265424, 7886.329661978739, 7886.329661978739, 7891.565963871984, 7877.645505952217, 7930.484518506308, 7932.087809901848, 7935.563544005077, 7944.0, 7882.211778822129, 7907.881381779278, 7924.722634707815, 7925.0, 7926.762197134067, 7764.495307804975, 7819.687212511492, 7829.334506566948, 7836.686532538692, 7837.412194085467, 38823.41764873529, 39087.60912390868, 39116.21767564633, 39140.217195655925, 39159.216815663814, 3589.6589823966683, 3629.237860049393, 3630.3283892479976, 3631.5642122945414, 3633.94549081764, 32152.0, 32159.356812863847, 32164.6783532164, 32255.677443225737, 32367.0, 5126.307948426952, 5131.563817075553, 5138.665986710889, 5178.818741344073, 5184.559312458446, 184971.0, 185026.0, 186375.0, 186781.0, 186782.0, 46891.0, 46979.060418791436, 47116.5288347119, 47167.29249061267, 47181.999999999316, 48609.75695121573, 48707.0, 48738.756306218245, 48826.75586622044, 48873.26690099651, 15755.369785208462, 16074.196290185444, 16095.758563621555, 16106.194690265675, 16111.436099736688, 13328.33358332099, 13330.133541319783, 13338.13302135358, 13340.666483337995, 13342.266175360253, 12715.936420318025, 12946.417411216518, 12968.0, 13015.804762928563, 13202.33988300581, 5023.824166154167, 5049.267856160836, 5143.922841157386, 5186.170212765939, 5243.187305967581, 993.980120397588, 996.5017491254373, 1002.5839276700087, 1015.3349556040805, 1025.1644909398817, 22502.324930252118, 22900.198493052663, 22959.88520057389, 22991.540169196523, 23503.41241468943, 1101.1026013798728, 1108.6563165418584, 1120.383788916093, 1123.7808627317759, 1126.4367816091954, 12052.879471205175, 12076.75846483083, 12158.817617735742, 12280.692982675504, 12330.691732706755, 222950.0, 223546.0, 223840.0, 233482.0, 238083.0, 57091.42908570861, 57113.14330285049, 57221.14168287479, 57225.42774572201, 57311.426885731446, 1430.95540255614, 1453.4476898778607, 1454.3092031285266, 1454.374618913856, 1456.213644631908, 26774.0, 27000.59499107554, 27396.0, 27506.587401189397, 27614.5857812137, 36799.816000919825, 36850.0, 36966.815165923996, 37023.0, 37039.44440833336, 183305.0, 183360.0, 183434.0, 183479.0, 184879.0, 33517.83241083779, 33794.49308260427, 33865.0, 33897.830510847285, 33941.151471212426, 41959.790201048796, 41977.0, 42156.78921605372, 42301.78849105735, 42350.576494235895, 31440.371192576476, 31534.684653153174, 31534.842325788224, 31840.68159318377, 32259.516107258878, 31067.84466077655, 31212.531812022382, 31234.839088875866, 31356.216094596904, 31447.685523145392, 35126.64873351234, 35405.0, 35509.1122721934, 35696.464553032245, 35856.92429227127, 31183.37633247277, 31197.220069497536, 31259.84370078135, 31336.0, 31741.36517269688, 22477.550448991256, 22737.270510077462, 23039.76960230376, 23285.3014409568, 23508.647370289116], "value": 17150.13596112893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.1736048009425, 570.885822835433, 572.1475002246649, 573.2519062623275, 579.3106203617695, 22236.555268894634, 23011.884940575317, 23090.65364019541, 23109.0, 23110.191143309967, 22908.885455572698, 23867.28398148054, 24347.513049738995, 24640.260792176217, 24669.75330246697, 6383.202099737533, 6441.838954026163, 6490.993895946112, 6493.220813502363, 6534.673266336664, 6348.143000694893, 6369.71336289868, 6458.354164583528, 6463.289038205794, 6633.303503132174, 6598.835029124286, 6610.933890661104, 6612.338766123373, 6614.074029635831, 6614.834629134262, 6198.442140207403, 6471.320511346288, 6583.4074933256, 6586.8682626347445, 6587.604743715368, 6002.039673652238, 6006.669633170174, 6016.278046634432, 6021.909671354933, 6025.969870150665, 27696.861515692293, 28229.29426764327, 28251.43497130046, 28257.0, 28278.717212828018, 2072.720182775321, 2091.6862470629526, 2095.95808083839, 2096.8532202745814, 2097.035363732685, 17057.48827535176, 17491.47525574235, 17710.91144544282, 17875.37436189727, 17888.91055544727, 2356.929292121239, 2411.0, 2415.468596908695, 2421.2615152378517, 2447.3392184110367, 121991.0, 129878.0, 134939.0, 140911.0, 141461.29269353588, 13925.303734813218, 14147.504837330644, 14155.716885662228, 14190.645233869029, 14348.426062957366, 21952.45118872041, 22051.66922496164, 22056.0, 22138.225162119572, 22201.555968880533, 9943.45311007887, 10037.096661300518, 10162.542685579167, 10200.846987295197, 10214.387136771817, 9212.861807072899, 9288.814223715488, 9345.20565751905, 9367.344285899922, 9542.427454352623, 8655.134486551295, 8716.95641521801, 8763.912360876437, 8907.084976730033, 8912.242459391024, 2591.287395966124, 2593.6239245309325, 2631.250093723318, 2671.679398472157, 2747.8626068696485, 959.6209497248688, 973.255459573427, 981.5828272983953, 1002.4135880509838, 1003.247564326755, 18526.536836579195, 18762.437126886216, 18817.341393051178, 18955.81044189568, 19343.0, 1037.123630532199, 1038.8130136575337, 1041.4688508860536, 1042.5673345561506, 1050.7425680708122, 10444.68665940023, 10460.52927618259, 10555.736106597244, 10788.406637635006, 10816.621418250323, 456284.0, 460316.0, 464572.0, 470983.0, 471827.0, 100575.0, 103576.48211758892, 105667.0, 107491.0, 107683.46158269315, 1041.4168065882977, 1123.2418117770635, 1168.3749194181073, 1195.8505186851469, 1203.3381640097912, 19444.0, 19597.51006224856, 19683.015849207197, 19736.82894881533, 20117.0, 52891.206631901325, 53772.0, 54147.458525414244, 55432.44567554273, 56408.87182256414, 68413.31586684269, 68436.65781671258, 68645.3135468639, 68783.0, 68916.0, 13863.861361386256, 14036.859631403555, 14039.087459315111, 14088.577342679737, 14166.433342666178, 21649.45876353041, 21725.782742172374, 22035.66946495836, 22040.228591999203, 22341.77658223462, 17286.22212000438, 17465.0, 17540.561485962444, 17576.38482653101, 17858.821411785717, 15854.128022958386, 16131.0, 16303.59241018984, 16582.66834663276, 16684.666306673556, 18098.09509524492, 18195.18121684501, 18222.908885455487, 18240.270389184283, 18422.90788546049, 14007.159570425807, 14020.0, 14049.508267210598, 14075.859241407456, 14144.717105658036, 17505.03722295286, 17557.297708091533, 17594.0, 17856.821431786037, 17897.552561186076], "value": 11677.841707396872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.9597412077637, 1393.2963853254105, 1395.044394589706, 1403.0669604712855, 1404.8805851502627, 15109.84890151098, 15733.449329273464, 15743.763843542356, 15747.68504629908, 15756.290966906488, 15312.540623781304, 15370.538883833475, 15413.383464661429, 15417.15205663688, 15447.382104715798, 2460.225029115827, 2595.7144714081437, 2599.0773275487213, 2600.6619139511836, 2603.700574433936, 2624.3439140214946, 2674.879630416636, 2675.250929739676, 2682.637843891069, 2699.91900242993, 2561.5005074010573, 2656.6015097735303, 2656.9468610627778, 2657.9468410631775, 2659.2819938616562, 2661.813673042888, 2670.2923725212836, 2689.924030387841, 2705.2425320910174, 2707.187843646908, 2675.0102462088958, 2679.236417620988, 2684.650995370609, 2690.4081102157493, 2701.0411303987, 14866.554003379915, 15230.771538426932, 15236.466723664618, 15237.847621523864, 15268.694626107415, 7923.286904178594, 8187.26314631686, 8203.548804815733, 8204.712835050745, 8211.466254693425, 4934.827281045146, 4994.850154495371, 5077.543021128116, 5241.895162096736, 5383.865403364908, 1778.404234581404, 1793.3723196880987, 1797.4607617714764, 1815.945521634353, 1840.68708319586, 26386.20841374762, 26554.33614159642, 26557.0, 26594.0, 26647.866760666268, 6405.743770249231, 6571.3757193066585, 6710.396064354231, 6735.393814556714, 6753.729850806011, 17027.40404085851, 17032.659346812994, 17078.23147958345, 17114.0, 17192.31230750781, 7775.533467991939, 7815.843683126305, 7817.8827317590285, 7822.2568855959735, 7823.100343460461, 7206.531575447579, 7217.566945983258, 7280.890786638205, 7301.415886729049, 7310.305520975498, 4994.675346102492, 5124.282600435942, 5151.9484805152215, 5208.687478751287, 5346.732663366816, 1421.644588852787, 1502.353987785241, 1505.1345476351141, 1515.9393624254906, 1531.1655147944398, 732.8351120997839, 881.9470831750116, 893.4549924546021, 910.6493999809989, 911.8814554107923, 8126.39052071097, 8261.83476330482, 8307.501549907025, 8386.580670966427, 8433.156684331641, 916.9266458683289, 958.2956526952685, 963.9566219520138, 972.411690926979, 992.0, 5511.118221084607, 5523.558115350762, 5532.253145825262, 5598.356189038232, 5620.269364982526, 21460.141594336365, 21610.35168944934, 21951.231706890183, 22259.443513912283, 22342.441438964157, 20797.27209547689, 21917.342479725314, 22220.55558888813, 22348.888255558617, 22373.55252894933, 11517.078633709283, 11591.130665200144, 11600.477978490988, 11603.129765267639, 11717.414129293502, 8064.193580641889, 8306.127856574973, 8414.537200454033, 8447.0, 8601.784955376166, 18273.725894111332, 18354.26582936721, 18520.72218916744, 18684.906575467037, 19157.0, 19051.61896762085, 19052.333168339042, 19056.904715476336, 19182.616347673247, 19194.712079318542, 10197.847032294374, 10416.531256093645, 10420.905804890377, 10424.061834434937, 10433.634822781167, 13880.861191387958, 13900.0, 13923.0, 14079.436822526985, 14110.858891410955, 11208.103351732005, 11339.943300283447, 11471.541138354372, 11644.475998579916, 11796.0, 11050.115990720884, 11167.832482512606, 11236.831447528457, 11344.149188811038, 11432.371219583003, 9397.154256116708, 9463.763405914908, 9552.283578731483, 9668.226541876493, 9716.076972687584, 7340.70637174507, 7377.852442951218, 7406.481546291708, 7411.888821667571, 7475.588842613491, 6992.510524263253, 7113.82215444618, 7145.928540714526, 7179.748708795167, 7216.675249613675], "value": 6640.785143194899, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.7158562241089, 503.72808658138206, 508.8269988204008, 513.4147072337536, 527.1881302793698, 6192.62844229346, 6201.658908760022, 6246.500279977602, 6305.558610897233, 6334.841628959279, 6102.511799056076, 6166.3525329840395, 6187.845303867405, 6212.565120441571, 6219.782307619234, 5096.643234973553, 5135.589152867761, 5168.8449346519665, 5175.2754614353835, 5197.4022987356375, 4785.736784476852, 4982.153033984213, 5110.565601923841, 5175.58595312376, 5179.559737422323, 4929.8521044368545, 4948.579370753472, 4963.1810751226185, 4974.37820272466, 4983.626228032894, 4868.56182943535, 4904.0, 4950.752462376867, 4966.801327946878, 4992.975035124819, 4390.429244198233, 4420.182266280748, 4443.42235509385, 4455.710378825366, 4490.438695163105, 5993.741314323997, 6024.548158888101, 6051.515878729691, 6073.908891366633, 6104.908426373608, 5657.915131273035, 5664.433556644344, 5679.148127780824, 5689.886202275973, 5733.197352370671, 6512.641804700739, 6521.348045094762, 6580.0129980502825, 6583.868322633521, 6603.834904127387, 4582.656300777455, 4849.660523763338, 4859.246816743411, 4883.902321953541, 4899.191633380488, 6566.244881838602, 6594.0, 6665.766698165589, 6876.346747059071, 6884.724611015503, 4955.4548999610015, 4982.950170498321, 4991.376077990251, 4997.500249975046, 4999.10016197088, 5020.748962551857, 5050.520200580939, 5061.595072394273, 5067.46791586878, 5070.847874563769, 5662.603617746719, 5673.971630141906, 5675.517581005578, 5695.829125126253, 5697.544196464273, 6591.34086591337, 6601.5378923475855, 6603.339666033358, 6607.768728094494, 6626.403623673892, 1735.8177391373977, 1747.8863873848413, 1748.5715999580184, 1753.3424965637885, 1767.1782621081259, 1161.3786624156037, 1215.7629262293945, 1227.846519185102, 1229.9139060265695, 1233.735421193284, 5686.658800471985, 5689.829305120853, 5701.40135285789, 5705.543556515552, 5738.5982981191755, 6647.567908085959, 6657.866842663119, 6710.1947766267385, 6792.558483698643, 6795.592264464148, 5544.918740845496, 5570.582206334541, 5602.0, 5603.187537806995, 5639.915401268902, 3478.5999610044664, 3485.5991560970815, 3506.947395789065, 3523.982380088083, 3530.8940731777575, 6401.655652313067, 6422.518311126684, 6432.839179020469, 6478.902816457757, 6537.280899101095, 6801.387875091265, 6879.759208427681, 6896.586204827727, 6898.689558969859, 6917.273686262971, 6030.949477177781, 6361.840953976188, 6404.903926441107, 6420.967895160495, 6481.967590162019, 6488.578242414228, 6532.510061745483, 6542.724168787231, 6587.703553340207, 6636.535442518977, 6572.934270657423, 6597.538172327891, 6617.8014659560295, 6656.0, 6665.600383861903, 6493.512986526124, 6510.381513756375, 6511.153550038464, 6569.24453687832, 6585.6377899216, 4900.0, 4954.603631709382, 4974.278729584118, 5005.049040682259, 5018.949810501848, 6535.313792051957, 6644.57473022353, 6646.338415396151, 6693.765718199839, 6743.8988415172835, 6393.849107160756, 6426.61440313564, 6448.29068802422, 6490.253620833664, 6494.025896115431, 6342.016987366966, 6381.457576106083, 6469.3530646936815, 6484.837879053061, 6583.210014798255, 6360.650164240826, 6398.232212134573, 6439.7424103035355, 6465.709043093166, 6468.15913931186, 6449.6130232186215, 6473.902891456726, 6529.608223506605, 6540.574862633914, 6635.4831939072365, 6271.153394291712, 6283.874322513433, 6315.884178800154, 6341.143945567474, 6414.03789431589], "value": 5028.5962258139425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.0276097673047, 893.3657103456545, 907.5598334807621, 912.6760000199927, 916.1296768070334, 18896.62206755866, 19803.0, 19803.306884259055, 19816.306429274995, 19920.90039549804, 18026.4592062238, 18137.093145342715, 18266.360677376295, 18267.36064237752, 18280.0, 960.2414092866644, 970.7524581231776, 973.095021629884, 973.464594473037, 973.6251543155901, 979.8677178580907, 986.6004268271325, 987.0327079462131, 989.5101924547323, 990.3414229537349, 996.5166894056376, 1028.5371582787739, 1034.2915103154364, 1040.5525623981684, 1040.973975650611, 1028.9742756431074, 1031.5718976624692, 1031.5976769060073, 1031.9432431216242, 1033.1424917318607, 724.3589423360364, 742.2021327073363, 750.2684882239827, 750.8122969257686, 753.2166546791331, 19384.90307548467, 19467.415977520697, 19491.415257542154, 19575.21699132033, 19583.608327833506, 21044.684329735068, 21508.892455537778, 21891.890540547356, 21992.230271940567, 22173.113075476962, 16546.172691365504, 16636.750448743278, 16959.83040169595, 16984.660306793918, 17121.486355409357, 3543.1850674345046, 3593.9281214375565, 3609.3864043112735, 3609.927801443983, 3620.456931460276, 105510.47244763804, 136547.31726341404, 140226.0, 141088.29455852654, 145906.0, 16769.91615041917, 16806.15969201535, 16885.662286754196, 17048.659026819394, 17100.914495427693, 30732.0, 30881.536776948364, 31051.844740776152, 31273.8436307817, 31519.684803152133, 8735.213830755263, 8891.066438024043, 8911.153440423279, 8926.553672316359, 8954.641814327484, 4169.60388763067, 4230.196262710076, 4260.595243451867, 4276.593723596254, 4283.571642835754, 5229.08491014071, 5342.572594192533, 5377.0, 5392.973035134799, 5399.487048730443, 995.4475266227313, 1046.4401545173296, 1046.7173863056933, 1050.2858056521638, 1057.3285963413289, 674.5480528046221, 689.1661090081058, 698.552926127279, 700.9088818453569, 711.3846522757777, 11648.94175529117, 11882.762344753057, 11910.166288359731, 13181.670458238428, 13201.537946171838, 680.7311112110689, 684.910961574992, 703.2686006553128, 704.7956092733152, 711.5446114486732, 4786.0, 4898.24077268024, 4971.279164521196, 4986.950130498722, 5067.898642027212, 115746.42126789481, 122232.38883805524, 123540.38229808974, 124141.0, 125645.0, 101990.0, 106722.0, 109129.0, 115455.0, 115808.42095789636, 89553.0, 93302.53348733348, 93557.5322123385, 93953.5302323484, 94285.52857235669, 9901.118722487801, 9903.811542614932, 9980.550875210487, 10100.090991810772, 10102.797944041225, 42035.7898210507, 43857.34213986857, 43906.780466097465, 43941.0, 46141.30788038115, 54709.45290547043, 55170.44829551653, 55387.72306138444, 55775.442245577025, 57522.0, 14983.77524337114, 15361.078335299917, 15368.615784605474, 15480.225988700746, 15502.922485387951, 17344.219510121824, 17516.124193790005, 17710.468685939442, 17804.91097544504, 17872.195751190968, 15428.614284642974, 15588.22058897028, 15739.213039348217, 15871.52385428439, 15903.602409939844, 16479.423220187236, 16622.418215362406, 16690.332386704395, 16788.244528996467, 16818.66362672764, 15313.0, 15403.84596154069, 15596.0, 15637.921810390875, 15695.058296502246, 11228.887711122785, 11438.94280528592, 11441.084713222755, 11469.369184694922, 11775.0, 11354.375509347065, 11529.0, 11643.243189192675, 11799.115066370228, 11805.881941180478], "value": 8851.667939486271, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 107.0, 106.0, 107.0, 95.0, 108.0, 109.0, 107.0, 108.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 115.0, 114.0, 117.0, 142.0, 117.0, 116.0, 120.0, 118.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0, 168.0, 167.0, 165.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 73.0, 74.0, 73.0, 72.0, 74.0, 74.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 79.0, 78.0, 78.0, 79.0, 82.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 117.0, 114.0, 110.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 149.0, 148.0, 150.0, 148.0, 150.0, 149.0, 149.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 53.0, 52.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 43.0, 38.0, 38.0, 39.0, 38.0, 39.0, 39.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 75.0, 75.0, 76.0, 75.0, 78.0, 74.0, 74.0, 76.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 115.0, 109.0, 114.0, 114.0, 120.0, 112.0, 117.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 173.0, 167.0, 189.0, 164.0, 172.0, 165.0, 168.0, 165.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 62.0, 65.0, 68.0, 66.0, 67.0, 65.0, 66.0, 64.0, 64.0], "value": 66.2, "unit": "score"}]}]} 15:42:24 INFO - Return code: 0 15:42:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:25 INFO - # TBPL SUCCESS # 15:42:25 INFO - Running post-action listener: _package_coverage_data 15:42:25 INFO - Running post-action listener: _resource_record_post_action 15:42:25 INFO - [mozharness: 2017-09-13 22:42:25.048696Z] Finished run-tests step (success) 15:42:25 INFO - Running post-run listener: _resource_record_post_run 15:42:25 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 330727424; Read time: 8; Write time: 239720 15:42:25 INFO - TinderboxPrint: CPU usage
13.1% 15:42:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 15:42:25 INFO - TinderboxPrint: I/O write bytes / time
330,727,424 / 239,720 15:42:25 INFO - TinderboxPrint: CPU idle
8,234.0 (86.9%) 15:42:25 INFO - TinderboxPrint: CPU user
1,192.8 (12.6%) 15:42:25 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9945088; Read time: 0; Write time: 1108 15:42:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:42:25 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 320782336; Read time: 0; Write time: 238612 15:42:25 INFO - Running post-run listener: _upload_blobber_files 15:42:25 INFO - Blob upload gear active. 15:42:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:25 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 15:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 15:42:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 15:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:27 INFO - (blobuploader) - INFO - Done attempting. 15:42:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:42:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:42:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:28 INFO - (blobuploader) - INFO - Done attempting. 15:42:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 15:42:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 15:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:29 INFO - (blobuploader) - INFO - Done attempting. 15:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:42:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:37 INFO - (blobuploader) - INFO - Done attempting. 15:42:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:37 INFO - Return code: 0 15:42:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e49620477bf23e537358e593639e15084fb2941d04a27cd9d15d0187d9e07bc3a6813f897a00799c8798d054f49d9ed71ea9f1ba744d1745fa372c623be7639", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9b02f8ef4e4a1548d51fd215bd196f45a857a190760159a7cf88e0ecdf20981b758eb293e454e94e03ca21b39ba5e210788e9fd7ad794dddaf0962f84a52d0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7f363311f9787bc1da6196b7a8d30f843ce3dadac74f1f341be87e0189fac842382ab4f1096201ce2b4000457a08de8edaa0b659726ea4f5897c38289af254", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05575fa922d3a9ddd3b69010d91f5164f18a2c4a179a9aaf251ed87e7da76e225268f44b4c13d3fcc31e54d4b751ea478f77c0ff7d2b25fce1ec8045e9e637cd"} 15:42:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:37 INFO - Contents: 15:42:37 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e49620477bf23e537358e593639e15084fb2941d04a27cd9d15d0187d9e07bc3a6813f897a00799c8798d054f49d9ed71ea9f1ba744d1745fa372c623be7639", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9b02f8ef4e4a1548d51fd215bd196f45a857a190760159a7cf88e0ecdf20981b758eb293e454e94e03ca21b39ba5e210788e9fd7ad794dddaf0962f84a52d0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7f363311f9787bc1da6196b7a8d30f843ce3dadac74f1f341be87e0189fac842382ab4f1096201ce2b4000457a08de8edaa0b659726ea4f5897c38289af254", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05575fa922d3a9ddd3b69010d91f5164f18a2c4a179a9aaf251ed87e7da76e225268f44b4c13d3fcc31e54d4b751ea478f77c0ff7d2b25fce1ec8045e9e637cd"} 15:42:37 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:37 INFO - Copying logs to upload dir... 15:42:37 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.084756 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-13 15:42:37.065890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:37.070796) ========= 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=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e49620477bf23e537358e593639e15084fb2941d04a27cd9d15d0187d9e07bc3a6813f897a00799c8798d054f49d9ed71ea9f1ba744d1745fa372c623be7639", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9b02f8ef4e4a1548d51fd215bd196f45a857a190760159a7cf88e0ecdf20981b758eb293e454e94e03ca21b39ba5e210788e9fd7ad794dddaf0962f84a52d0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7f363311f9787bc1da6196b7a8d30f843ce3dadac74f1f341be87e0189fac842382ab4f1096201ce2b4000457a08de8edaa0b659726ea4f5897c38289af254", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05575fa922d3a9ddd3b69010d91f5164f18a2c4a179a9aaf251ed87e7da76e225268f44b4c13d3fcc31e54d4b751ea478f77c0ff7d2b25fce1ec8045e9e637cd"} build_url:https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/LVYn6kl1Sru36vqr-ftIgg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e49620477bf23e537358e593639e15084fb2941d04a27cd9d15d0187d9e07bc3a6813f897a00799c8798d054f49d9ed71ea9f1ba744d1745fa372c623be7639", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b9b02f8ef4e4a1548d51fd215bd196f45a857a190760159a7cf88e0ecdf20981b758eb293e454e94e03ca21b39ba5e210788e9fd7ad794dddaf0962f84a52d0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7f363311f9787bc1da6196b7a8d30f843ce3dadac74f1f341be87e0189fac842382ab4f1096201ce2b4000457a08de8edaa0b659726ea4f5897c38289af254", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05575fa922d3a9ddd3b69010d91f5164f18a2c4a179a9aaf251ed87e7da76e225268f44b4c13d3fcc31e54d4b751ea478f77c0ff7d2b25fce1ec8045e9e637cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:37.098980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:37.099320) ========= 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=781b77c4c33858b1f599d705000001c1-1505341313.896710-1794739163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:42:37.187443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 15:42:37.187765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 15:42:37.188060) ========= ========= Total master_lag: 0.21 =========