builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1506293011.01 results: success (0) revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.011140) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.012281) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.012751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.129241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.129542) ========= 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=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 15:43:31-- 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% 46.4M=0s 2017-09-24 15:43:31 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.215081 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.372435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.372770) ========= 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=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.423268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:31.423617) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b44e80e0590e6eed86a1902365424673c8c2eaec --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 b44e80e0590e6eed86a1902365424673c8c2eaec --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=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 15:43:31,507 truncating revision to first 12 chars 2017-09-24 15:43:31,507 Setting DEBUG logging. 2017-09-24 15:43:31,507 attempt 1/10 2017-09-24 15:43:31,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b44e80e0590e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 15:43:31,756 unpacking tar archive at: mozilla-central-b44e80e0590e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.599250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.041579) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.041907) ========= script_repo_revision: b44e80e0590e6eed86a1902365424673c8c2eaec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.042354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.042622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:43:32.058113) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-24 15:43:32.058408) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:32 INFO - MultiFileLogger online at 20170924 15:43:32 in /builds/slave/test 15:43:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:43:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:32 INFO - {'append_to_log': False, 15:43:32 INFO - 'base_work_dir': '/builds/slave/test', 15:43:32 INFO - 'blob_upload_branch': 'Firefox', 15:43:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:32 INFO - 'branch': 'Firefox', 15:43:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:32 INFO - 'code_coverage': False, 15:43:32 INFO - 'config_files': ('talos/linux_config.py',), 15:43:32 INFO - 'default_actions': ('clobber', 15:43:32 INFO - 'read-buildbot-config', 15:43:32 INFO - 'download-and-extract', 15:43:32 INFO - 'populate-webroot', 15:43:32 INFO - 'create-virtualenv', 15:43:32 INFO - 'install', 15:43:32 INFO - 'setup-mitmproxy', 15:43:32 INFO - 'run-tests'), 15:43:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:32 INFO - 'disable_ccov_upload': False, 15:43:32 INFO - 'disable_stylo': False, 15:43:32 INFO - 'download_minidump_stackwalk': True, 15:43:32 INFO - 'download_symbols': 'ondemand', 15:43:32 INFO - 'enable_stylo': False, 15:43:32 INFO - 'enable_webrender': False, 15:43:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:43:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:32 INFO - 'gecko_profile': False, 15:43:32 INFO - 'gecko_profile_interval': 0, 15:43:32 INFO - 'installer_path': 'installer.exe', 15:43:32 INFO - 'log_level': 'info', 15:43:32 INFO - 'log_name': 'talos', 15:43:32 INFO - 'log_to_console': True, 15:43:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:32 INFO - 'opt_config_files': (), 15:43:32 INFO - 'pip_index': False, 15:43:32 INFO - 'suite': 'dromaeojs-e10s', 15:43:32 INFO - 'system_bits': '32', 15:43:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:32 INFO - 'title': 'talos-linux64-ix-008', 15:43:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:32 INFO - 'use_talos_json': True, 15:43:32 INFO - 'verify': 'False', 15:43:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:32 INFO - 'work_dir': 'build'} 15:43:32 INFO - [mozharness: 2017-09-24 22:43:32.291472Z] Running clobber step. 15:43:32 INFO - Running pre-action listener: _resource_record_pre_action 15:43:32 INFO - Running main action method: clobber 15:43:32 INFO - rmtree: /builds/slave/test/build 15:43:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:33 INFO - Running post-action listener: _resource_record_post_action 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.284107Z] Finished clobber step (success) 15:43:33 INFO - [mozharness: 2017-09-24 22:43:33.284204Z] Running read-buildbot-config step. 15:43:33 INFO - Running pre-action listener: _resource_record_pre_action 15:43:33 INFO - Running main action method: read_buildbot_config 15:43:33 INFO - Using buildbot properties: 15:43:33 INFO - { 15:43:33 INFO - "project": "", 15:43:33 INFO - "product": "firefox", 15:43:33 INFO - "who": "archaeopteryx@coole-files.de", 15:43:33 INFO - "installer_path": "public/build/target.tar.bz2", 15:43:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 15:43:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:43:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 15:43:33 INFO - "stage_platform": "linux64-qr", 15:43:33 INFO - "basedir": "/builds/slave/test", 15:43:33 INFO - "buildnumber": 80, 15:43:33 INFO - "platform": "ubuntu64_hw_qr", 15:43:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:43:33 INFO - "slavebuilddir": "test", 15:43:33 INFO - "taskId": "UnEpj3gvTtqlb02JXix2nw", 15:43:33 INFO - "branch": "mozilla-central", 15:43:33 INFO - "script_repo_revision": "production", 15:43:33 INFO - "revision": "b44e80e0590e6eed86a1902365424673c8c2eaec", 15:43:33 INFO - "slavename": "talos-linux64-ix-008", 15:43:33 INFO - "repo_path": "mozilla-central" 15:43:33 INFO - } 15:43:33 INFO - Finding installer, test and symbols from parent task. 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UnEpj3gvTtqlb02JXix2nw'}, attempt #1 15:43:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UnEpj3gvTtqlb02JXix2nw'}, attempt #1 15:43:34 INFO - Task dependencies: B7iTL-CwQoyRUaZIwcocAA 15:43:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA'}, attempt #1 15:43:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip 15:43:34 INFO - Running post-action listener: _resource_record_post_action 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.611285Z] Finished read-buildbot-config step (success) 15:43:34 INFO - [mozharness: 2017-09-24 22:43:34.611503Z] Running download-and-extract step. 15:43:34 INFO - Running pre-action listener: _resource_record_pre_action 15:43:34 INFO - Running main action method: download_and_extract 15:43:34 INFO - mkdir: /builds/slave/test/build/tests 15:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:34 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json 15:43:34 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:43:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:43:35 INFO - Downloaded 989 bytes. 15:43:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:43:35 INFO - Using the following test package requirements: 15:43:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:43:35 INFO - u'common': [u'target.common.tests.zip'], 15:43:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:43:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:43:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:43:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:43:35 INFO - u'mozbase': [u'target.common.tests.zip'], 15:43:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:43:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:43:35 INFO - u'web-platform': [u'target.common.tests.zip', 15:43:35 INFO - u'target.web-platform.tests.tar.gz'], 15:43:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:43:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip 15:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.common.tests.zip into memory 15:43:38 INFO - Content-Length response header: 54943940 15:43:38 INFO - Bytes received: 54943940 15:43:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip 15:43:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:43:48 INFO - Fetch https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.talos.tests.zip into memory 15:43:50 INFO - Content-Length response header: 14513823 15:43:50 INFO - Bytes received: 14513823 15:43:50 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:43:50 INFO - trying https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:43:55 INFO - Downloaded 61537979 bytes. 15:43:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - mkdir: /builds/slave/test/properties 15:43:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:55 INFO - Contents: 15:43:55 INFO - build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - Running post-action listener: find_tests_for_verification 15:43:55 INFO - Running post-action listener: set_extra_try_arguments 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.185813Z] Finished download-and-extract step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.186040Z] Running populate-webroot step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: populate_webroot 15:43:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tresize', 15:43:55 INFO - 'tcanvasmark']}, 15:43:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_css', 15:43:55 INFO - 'kraken']}, 15:43:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['damp', 'tps']}, 15:43:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['dromaeo_dom']}, 15:43:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:43:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['basic_compositor_video', 15:43:55 INFO - 'glvideo']}, 15:43:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:43:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['ts_paint_webext', 15:43:55 INFO - 'tp5o_webext']}, 15:43:55 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['a11yr', 15:43:55 INFO - 'ts_paint', 15:43:55 INFO - 'tpaint', 15:43:55 INFO - 'sessionrestore', 15:43:55 INFO - 'sessionrestore_many_windows', 15:43:55 INFO - 'sessionrestore_no_auto_restore', 15:43:55 INFO - 'tabpaint']}, 15:43:55 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:43:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest_singletons']}, 15:43:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['perf_reftest']}, 15:43:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tsvgx', 15:43:55 INFO - 'tsvgr_opacity', 15:43:55 INFO - 'tart', 15:43:55 INFO - 'tscrollx', 15:43:55 INFO - 'tsvg_static']}, 15:43:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo'], 15:43:55 INFO - 'tests': ['tp5o']}, 15:43:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:43:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:43:55 INFO - 'talos_options': ['--stylo-threads=1', 15:43:55 INFO - '--mitmproxy', 15:43:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:43:55 INFO - '--firstNonBlankPaint'], 15:43:55 INFO - 'tests': ['tp6_google', 15:43:55 INFO - 'tp6_youtube', 15:43:55 INFO - 'tp6_amazon', 15:43:55 INFO - 'tp6_facebook']}, 15:43:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}, 15:43:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:43:55 INFO - 'talos_options': ['--disable-stylo', 15:43:55 INFO - '--xperf_path', 15:43:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:55 INFO - 'tests': ['tp5n']}}} 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.207012Z] Finished populate-webroot step (success) 15:43:55 INFO - [mozharness: 2017-09-24 22:43:55.207118Z] Running create-virtualenv step. 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: create_virtualenv 15:43:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:43:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:43:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:43:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:56 INFO - Installing pip...............done. 15:43:56 INFO - Return code: 0 15:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:56 INFO - Reading from file tmpfile_stdout 15:43:56 INFO - Output received: 15:43:56 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:43:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:56 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:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:56 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:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:56 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:43:56 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:43:56 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:43:56 INFO - Using env: {'DISPLAY': ':0', 15:43:56 INFO - 'HOME': '/home/cltbld', 15:43:56 INFO - 'LANG': 'en_US.UTF-8', 15:43:56 INFO - 'LANGUAGE': 'en_US:en', 15:43:56 INFO - 'LOGNAME': 'cltbld', 15:43:56 INFO - 'MAIL': '/var/mail/cltbld', 15:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:56 INFO - 'MOZ_NO_REMOTE': '1', 15:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:56 INFO - 'NO_EM_RESTART': '1', 15:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:56 INFO - 'PWD': '/builds/slave/test', 15:43:56 INFO - 'SHELL': '/bin/bash', 15:43:56 INFO - 'SHLVL': '1', 15:43:56 INFO - 'TERM': 'linux', 15:43:56 INFO - 'TMOUT': '86400', 15:43:56 INFO - 'USER': 'cltbld', 15:43:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:56 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking pip>=1.5 15:43:57 INFO - Running setup.py egg_info for package pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing collected packages: pip 15:43:57 INFO - Found existing installation: pip 1.1 15:43:57 INFO - Uninstalling pip: 15:43:57 INFO - Successfully uninstalled pip 15:43:57 INFO - Running setup.py install for pip 15:43:57 INFO - warning: no files found matching 'pip/cacert.pem' 15:43:57 INFO - warning: no files found matching '*.html' under directory 'docs' 15:43:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:43:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:43:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:43:57 INFO - Successfully installed pip 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:43:57 INFO - Using env: {'DISPLAY': ':0', 15:43:57 INFO - 'HOME': '/home/cltbld', 15:43:57 INFO - 'LANG': 'en_US.UTF-8', 15:43:57 INFO - 'LANGUAGE': 'en_US:en', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MAIL': '/var/mail/cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SHLVL': '1', 15:43:57 INFO - 'TERM': 'linux', 15:43:57 INFO - 'TMOUT': '86400', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - '_': '/tools/buildbot/bin/python'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 INFO - Downloading/unpacking psutil>=3.1.1 15:43:57 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:43:57 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:43:57 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:43:57 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:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:58 INFO - Installing collected packages: psutil 15:43:58 INFO - Running setup.py install for psutil 15:43:58 INFO - building 'psutil._psutil_linux' extension 15:43:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:43:59 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:43:59 INFO - building 'psutil._psutil_posix' extension 15:43:59 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:43:59 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:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:59 INFO - Successfully installed psutil 15:43:59 INFO - Cleaning up... 15:43:59 INFO - Return code: 0 15:43:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43: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:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43: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:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:43:59 INFO - Using env: {'DISPLAY': ':0', 15:43:59 INFO - 'HOME': '/home/cltbld', 15:43:59 INFO - 'LANG': 'en_US.UTF-8', 15:43:59 INFO - 'LANGUAGE': 'en_US:en', 15:43:59 INFO - 'LOGNAME': 'cltbld', 15:43:59 INFO - 'MAIL': '/var/mail/cltbld', 15:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:59 INFO - 'MOZ_NO_REMOTE': '1', 15:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:59 INFO - 'NO_EM_RESTART': '1', 15:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:59 INFO - 'PWD': '/builds/slave/test', 15:43:59 INFO - 'SHELL': '/bin/bash', 15:43:59 INFO - 'SHLVL': '1', 15:43:59 INFO - 'TERM': 'linux', 15:43:59 INFO - 'TMOUT': '86400', 15:43:59 INFO - 'USER': 'cltbld', 15:43:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:59 INFO - '_': '/tools/buildbot/bin/python'} 15:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:44:00 INFO - Installing collected packages: mozsystemmonitor 15:44:00 INFO - Running setup.py install for mozsystemmonitor 15:44:00 INFO - Successfully installed mozsystemmonitor 15:44:00 INFO - Cleaning up... 15:44:01 INFO - Return code: 0 15:44:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:44:01 INFO - Using env: {'DISPLAY': ':0', 15:44:01 INFO - 'HOME': '/home/cltbld', 15:44:01 INFO - 'LANG': 'en_US.UTF-8', 15:44:01 INFO - 'LANGUAGE': 'en_US:en', 15:44:01 INFO - 'LOGNAME': 'cltbld', 15:44:01 INFO - 'MAIL': '/var/mail/cltbld', 15:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:01 INFO - 'MOZ_NO_REMOTE': '1', 15:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:01 INFO - 'NO_EM_RESTART': '1', 15:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:01 INFO - 'PWD': '/builds/slave/test', 15:44:01 INFO - 'SHELL': '/bin/bash', 15:44:01 INFO - 'SHLVL': '1', 15:44:01 INFO - 'TERM': 'linux', 15:44:01 INFO - 'TMOUT': '86400', 15:44:01 INFO - 'USER': 'cltbld', 15:44:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:01 INFO - '_': '/tools/buildbot/bin/python'} 15:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:01 INFO - Downloading/unpacking jsonschema==2.5.1 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:03 INFO - warning: no files found matching '*.txt' 15:44:03 INFO - no previously-included directories found matching 'build' 15:44:03 INFO - no previously-included directories found matching 'dist' 15:44:03 INFO - no previously-included directories found matching '.git*' 15:44:03 INFO - Installing collected packages: jsonschema, functools32 15:44:03 INFO - Running setup.py install for functools32 15:44:03 INFO - warning: no files found matching '*.txt' 15:44:03 INFO - no previously-included directories found matching 'build' 15:44:03 INFO - no previously-included directories found matching 'dist' 15:44:03 INFO - no previously-included directories found matching '.git*' 15:44:03 INFO - Successfully installed jsonschema functools32 15:44:03 INFO - Cleaning up... 15:44:03 INFO - Return code: 0 15:44:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:03 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:03 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:44:03 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:44:03 INFO - Using env: {'DISPLAY': ':0', 15:44:03 INFO - 'HOME': '/home/cltbld', 15:44:03 INFO - 'LANG': 'en_US.UTF-8', 15:44:03 INFO - 'LANGUAGE': 'en_US:en', 15:44:03 INFO - 'LOGNAME': 'cltbld', 15:44:03 INFO - 'MAIL': '/var/mail/cltbld', 15:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:03 INFO - 'MOZ_NO_REMOTE': '1', 15:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:03 INFO - 'NO_EM_RESTART': '1', 15:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:03 INFO - 'PWD': '/builds/slave/test', 15:44:03 INFO - 'SHELL': '/bin/bash', 15:44:03 INFO - 'SHLVL': '1', 15:44:03 INFO - 'TERM': 'linux', 15:44:03 INFO - 'TMOUT': '86400', 15:44:03 INFO - 'USER': 'cltbld', 15:44:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:03 INFO - '_': '/tools/buildbot/bin/python'} 15:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:44:03 INFO - Cleaning up... 15:44:03 INFO - Return code: 0 15:44:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:04 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:04 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:44:04 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:44:04 INFO - Using env: {'DISPLAY': ':0', 15:44:04 INFO - 'HOME': '/home/cltbld', 15:44:04 INFO - 'LANG': 'en_US.UTF-8', 15:44:04 INFO - 'LANGUAGE': 'en_US:en', 15:44:04 INFO - 'LOGNAME': 'cltbld', 15:44:04 INFO - 'MAIL': '/var/mail/cltbld', 15:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:04 INFO - 'MOZ_NO_REMOTE': '1', 15:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:04 INFO - 'NO_EM_RESTART': '1', 15:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:04 INFO - 'PWD': '/builds/slave/test', 15:44:04 INFO - 'SHELL': '/bin/bash', 15:44:04 INFO - 'SHLVL': '1', 15:44:04 INFO - 'TERM': 'linux', 15:44:04 INFO - 'TMOUT': '86400', 15:44:04 INFO - 'USER': 'cltbld', 15:44:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:04 INFO - '_': '/tools/buildbot/bin/python'} 15:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:05 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:44:05 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:44:05 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:44:05 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:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:05 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:44:05 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:44:05 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:44:05 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:44:05 INFO - Downloading docopt-0.6.1.tar.gz 15:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:05 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:05 INFO - Running setup.py install for blobuploader 15:44:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:05 INFO - Running setup.py install for requests 15:44:06 INFO - Running setup.py install for docopt 15:44:06 INFO - Successfully installed blobuploader requests docopt 15:44:06 INFO - Cleaning up... 15:44:06 INFO - Return code: 0 15:44:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:06 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:06 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:44:06 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:44:06 INFO - Using env: {'DISPLAY': ':0', 15:44:06 INFO - 'HOME': '/home/cltbld', 15:44:06 INFO - 'LANG': 'en_US.UTF-8', 15:44:06 INFO - 'LANGUAGE': 'en_US:en', 15:44:06 INFO - 'LOGNAME': 'cltbld', 15:44:06 INFO - 'MAIL': '/var/mail/cltbld', 15:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:06 INFO - 'MOZ_NO_REMOTE': '1', 15:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:06 INFO - 'NO_EM_RESTART': '1', 15:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:06 INFO - 'PWD': '/builds/slave/test', 15:44:06 INFO - 'SHELL': '/bin/bash', 15:44:06 INFO - 'SHLVL': '1', 15:44:06 INFO - 'TERM': 'linux', 15:44:06 INFO - 'TMOUT': '86400', 15:44:06 INFO - 'USER': 'cltbld', 15:44:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:06 INFO - '_': '/tools/buildbot/bin/python'} 15:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:06 INFO - Running setup.py (path:/tmp/pip-OzQKp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:06 INFO - Running setup.py (path:/tmp/pip-tzn6MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:06 INFO - Running setup.py (path:/tmp/pip-487SvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:06 INFO - Running setup.py (path:/tmp/pip-VTbmT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:06 INFO - Running setup.py (path:/tmp/pip-4hS8Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:07 INFO - Running setup.py (path:/tmp/pip-tgqEhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:07 INFO - Running setup.py (path:/tmp/pip-f9lYn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:07 INFO - Running setup.py (path:/tmp/pip-RK8kUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:07 INFO - Running setup.py (path:/tmp/pip-3VNJ9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:07 INFO - Running setup.py (path:/tmp/pip-4vePwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:07 INFO - Running setup.py (path:/tmp/pip-_4czQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:07 INFO - Running setup.py (path:/tmp/pip-8SOoOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:07 INFO - Running setup.py (path:/tmp/pip-ZWuRM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:07 INFO - Running setup.py (path:/tmp/pip-3bFctI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:07 INFO - Running setup.py (path:/tmp/pip-CgPSfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:07 INFO - Running setup.py (path:/tmp/pip-ZM3gPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:07 INFO - Running setup.py (path:/tmp/pip-oSyvpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:07 INFO - Running setup.py install for manifestparser 15:44:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozcrash 15:44:08 INFO - Running setup.py install for mozdebug 15:44:08 INFO - Running setup.py install for mozdevice 15:44:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozfile 15:44:08 INFO - Running setup.py install for mozhttpd 15:44:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozinfo 15:44:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozInstall 15:44:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozleak 15:44:08 INFO - Running setup.py install for mozlog 15:44:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for moznetwork 15:44:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:08 INFO - Running setup.py install for mozprocess 15:44:09 INFO - Running setup.py install for mozprofile 15:44:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for mozrunner 15:44:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Running setup.py install for mozscreenshot 15:44:09 INFO - Running setup.py install for moztest 15:44:09 INFO - Running setup.py install for mozversion 15:44:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:09 INFO - Cleaning up... 15:44:09 INFO - Return code: 0 15:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:09 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:09 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:44:09 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:44:09 INFO - Using env: {'DISPLAY': ':0', 15:44:09 INFO - 'HOME': '/home/cltbld', 15:44:09 INFO - 'LANG': 'en_US.UTF-8', 15:44:09 INFO - 'LANGUAGE': 'en_US:en', 15:44:09 INFO - 'LOGNAME': 'cltbld', 15:44:09 INFO - 'MAIL': '/var/mail/cltbld', 15:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:09 INFO - 'MOZ_NO_REMOTE': '1', 15:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:09 INFO - 'NO_EM_RESTART': '1', 15:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:09 INFO - 'PWD': '/builds/slave/test', 15:44:09 INFO - 'SHELL': '/bin/bash', 15:44:09 INFO - 'SHLVL': '1', 15:44:09 INFO - 'TERM': 'linux', 15:44:09 INFO - 'TMOUT': '86400', 15:44:09 INFO - 'USER': 'cltbld', 15:44:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:09 INFO - '_': '/tools/buildbot/bin/python'} 15:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:09 INFO - Running setup.py (path:/tmp/pip-NzKuyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:09 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:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:09 INFO - Running setup.py (path:/tmp/pip-wWm2jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:10 INFO - Running setup.py (path:/tmp/pip-37pspq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:10 INFO - Running setup.py (path:/tmp/pip-E0oc26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:10 INFO - Running setup.py (path:/tmp/pip-oMiCX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:10 INFO - Running setup.py (path:/tmp/pip-Jhog4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:10 INFO - Running setup.py (path:/tmp/pip-fL9y0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:10 INFO - Running setup.py (path:/tmp/pip-M6N54T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:10 INFO - Running setup.py (path:/tmp/pip-LTM_UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:10 INFO - Running setup.py (path:/tmp/pip-t4BoZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:10 INFO - Running setup.py (path:/tmp/pip-qRFE9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:10 INFO - Running setup.py (path:/tmp/pip-ERmnp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:10 INFO - Running setup.py (path:/tmp/pip-pKbHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:10 INFO - Running setup.py (path:/tmp/pip-8KbPDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:10 INFO - Running setup.py (path:/tmp/pip-FeeHhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:10 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:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:10 INFO - Running setup.py (path:/tmp/pip-xp69rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:11 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:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:11 INFO - Running setup.py (path:/tmp/pip-Oge4oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:11 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:44:11 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:44:11 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:44:11 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:44:11 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:44:11 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:44:11 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:44:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:12 INFO - Downloading blessings-1.6.tar.gz 15:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:12 INFO - Installing collected packages: blessings 15:44:12 INFO - Running setup.py install for blessings 15:44:12 INFO - Successfully installed blessings 15:44:12 INFO - Cleaning up... 15:44:12 INFO - Return code: 0 15:44:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:12 INFO - Reading from file tmpfile_stdout 15:44:12 INFO - Current package versions: 15:44:12 INFO - argparse == 1.2.1 15:44:12 INFO - blessings == 1.6 15:44:12 INFO - blobuploader == 1.2.4 15:44:12 INFO - docopt == 0.6.1 15:44:12 INFO - functools32 == 3.2.3-2 15:44:12 INFO - jsonschema == 2.5.1 15:44:12 INFO - manifestparser == 1.1 15:44:12 INFO - mozInstall == 1.13 15:44:12 INFO - mozcrash == 1.0 15:44:12 INFO - mozdebug == 0.1 15:44:12 INFO - mozdevice == 0.51 15:44:12 INFO - mozfile == 1.2 15:44:12 INFO - mozhttpd == 0.7 15:44:12 INFO - mozinfo == 0.10 15:44:12 INFO - mozleak == 0.1 15:44:12 INFO - mozlog == 3.5 15:44:12 INFO - moznetwork == 0.27 15:44:12 INFO - mozprocess == 0.25 15:44:12 INFO - mozprofile == 0.28 15:44:12 INFO - mozrunner == 6.13 15:44:12 INFO - mozscreenshot == 0.1 15:44:12 INFO - mozsystemmonitor == 0.3 15:44:12 INFO - moztest == 0.8 15:44:12 INFO - mozversion == 1.4 15:44:12 INFO - psutil == 3.1.1 15:44:12 INFO - requests == 1.2.3 15:44:12 INFO - wsgiref == 0.1.2 15:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:12 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 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44:12 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:44:12 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:44:12 INFO - Using env: {'DISPLAY': ':0', 15:44:12 INFO - 'HOME': '/home/cltbld', 15:44:12 INFO - 'LANG': 'en_US.UTF-8', 15:44:12 INFO - 'LANGUAGE': 'en_US:en', 15:44:12 INFO - 'LOGNAME': 'cltbld', 15:44:12 INFO - 'MAIL': '/var/mail/cltbld', 15:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:12 INFO - 'MOZ_NO_REMOTE': '1', 15:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:12 INFO - 'NO_EM_RESTART': '1', 15:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:12 INFO - 'PWD': '/builds/slave/test', 15:44:12 INFO - 'SHELL': '/bin/bash', 15:44:12 INFO - 'SHLVL': '1', 15:44:12 INFO - 'TERM': 'linux', 15:44:12 INFO - 'TMOUT': '86400', 15:44:12 INFO - 'USER': 'cltbld', 15:44:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:12 INFO - '_': '/tools/buildbot/bin/python'} 15:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 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:44:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:44:12 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:44:12 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:44:12 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:44:12 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:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:44:14 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:44:14 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:44:14 INFO - Installing collected packages: simplejson 15:44:14 INFO - Running setup.py install for simplejson 15:44:14 INFO - building 'simplejson._speedups' extension 15:44:14 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:44:14 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:44:15 INFO - Successfully installed simplejson 15:44:15 INFO - Cleaning up... 15:44:15 INFO - Return code: 0 15:44:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44: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:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44: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:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, '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': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', '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:44: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', 'jsonschema'] in /builds/slave/test/build 15:44: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 jsonschema 15:44:15 INFO - Using env: {'DISPLAY': ':0', 15:44:15 INFO - 'HOME': '/home/cltbld', 15:44:15 INFO - 'LANG': 'en_US.UTF-8', 15:44:15 INFO - 'LANGUAGE': 'en_US:en', 15:44:15 INFO - 'LOGNAME': 'cltbld', 15:44:15 INFO - 'MAIL': '/var/mail/cltbld', 15:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:15 INFO - 'MOZ_NO_REMOTE': '1', 15:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:15 INFO - 'NO_EM_RESTART': '1', 15:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:15 INFO - 'PWD': '/builds/slave/test', 15:44:15 INFO - 'SHELL': '/bin/bash', 15:44:15 INFO - 'SHLVL': '1', 15:44:15 INFO - 'TERM': 'linux', 15:44:15 INFO - 'TMOUT': '86400', 15:44:15 INFO - 'USER': 'cltbld', 15:44:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:15 INFO - '_': '/tools/buildbot/bin/python'} 15:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:44:15 INFO - Cleaning up... 15:44:15 INFO - Return code: 0 15:44:15 INFO - Running post-action listener: _resource_record_post_action 15:44:15 INFO - Running post-action listener: _start_resource_monitoring 15:44:15 INFO - Starting resource monitoring. 15:44:15 INFO - [mozharness: 2017-09-24 22:44:15.363972Z] Finished create-virtualenv step (success) 15:44:15 INFO - [mozharness: 2017-09-24 22:44:15.364501Z] Running install step. 15:44:15 INFO - Running pre-action listener: _resource_record_pre_action 15:44:15 INFO - Running main action method: install 15:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:15 INFO - Reading from file tmpfile_stdout 15:44:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:44:15 INFO - Reading from file tmpfile_stdout 15:44:15 INFO - Output received: 15:44:15 INFO - Usage: mozinstall [options] installer 15:44:15 INFO - Options: 15:44:15 INFO - -h, --help show this help message and exit 15:44:15 INFO - -d DEST, --destination=DEST 15:44:15 INFO - Directory to install application into. [default: 15:44:15 INFO - "/builds/slave/test"] 15:44:15 INFO - --app=APP Application being installed. [default: firefox] 15:44:15 INFO - mkdir: /builds/slave/test/build/application 15:44:15 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:44:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:44:33 INFO - Reading from file tmpfile_stdout 15:44:33 INFO - Output received: 15:44:33 INFO - /builds/slave/test/build/application/firefox/firefox 15:44:33 INFO - Running post-action listener: _resource_record_post_action 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.469252Z] Finished install step (success) 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.469503Z] Running setup-mitmproxy step. 15:44:33 INFO - Running pre-action listener: _resource_record_pre_action 15:44:33 INFO - Running main action method: setup_mitmproxy 15:44:33 INFO - Skipping: mitmproxy is not required 15:44:33 INFO - Running post-action listener: _resource_record_post_action 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.470635Z] Finished setup-mitmproxy step (success) 15:44:33 INFO - [mozharness: 2017-09-24 22:44:33.470855Z] Running run-tests step. 15:44:33 INFO - Running pre-action listener: _resource_record_pre_action 15:44:33 INFO - Running pre-action listener: _set_gcov_prefix 15:44:33 INFO - Running main action method: run_tests 15:44:33 WARNING - Try message not found. 15:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:33 INFO - Python 2.7.3 15:44:33 INFO - Return code: 0 15:44:33 INFO - grabbing minidump binary from tooltool 15:44:33 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:44:33 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 0x1aafd60>, '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 0x1ab0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab0ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:33 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:44:33 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:44:33 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:44:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:33 INFO - Return code: 0 15:44:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:44:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:33 INFO - ENV: RUST_BACKTRACE is now full 15:44:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:44:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:44:33 INFO - Using env: {'DISPLAY': ':0', 15:44:33 INFO - 'HOME': '/home/cltbld', 15:44:33 INFO - 'LANG': 'en_US.UTF-8', 15:44:33 INFO - 'LANGUAGE': 'en_US:en', 15:44:33 INFO - 'LOGNAME': 'cltbld', 15:44:33 INFO - 'MAIL': '/var/mail/cltbld', 15:44:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:33 INFO - 'MOZ_ACCELERATED': '1', 15:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:33 INFO - 'MOZ_NO_REMOTE': '1', 15:44:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:33 INFO - 'MOZ_WEBRENDER': '1', 15:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:33 INFO - 'NO_EM_RESTART': '1', 15:44:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:33 INFO - 'PWD': '/builds/slave/test', 15:44:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:33 INFO - 'RUST_BACKTRACE': 'full', 15:44:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:33 INFO - 'SHELL': '/bin/bash', 15:44:33 INFO - 'SHLVL': '1', 15:44:33 INFO - 'TERM': 'linux', 15:44:33 INFO - 'TMOUT': '86400', 15:44:33 INFO - 'USER': 'cltbld', 15:44:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:33 INFO - '_': '/tools/buildbot/bin/python'} 15:44:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:44:33 INFO - mozversion application_buildid: 20170924215251 15:44:33 INFO - mozversion application_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:33 INFO - mozversion application_display_name: Nightly 15:44:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:33 INFO - mozversion application_name: Firefox 15:44:33 INFO - mozversion application_remotingname: firefox 15:44:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:33 INFO - mozversion application_vendor: Mozilla 15:44:33 INFO - mozversion application_version: 58.0a1 15:44:33 INFO - mozversion platform_buildid: 20170924215251 15:44:33 INFO - mozversion platform_changeset: b44e80e0590e6eed86a1902365424673c8c2eaec 15:44:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:33 INFO - mozversion platform_version: 58.0a1 15:44:33 INFO - using testdate: 1506293073 15:44:33 INFO - actual date: 1506293073 15:44:33 INFO - starting webserver on 'localhost:47012' 15:44:33 INFO - SUITE-START | Running 2 tests 15:44:33 INFO - TEST-START | dromaeo_css 15:44:33 INFO - Initialising browser for dromaeo_css test... 15:44:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47012/getInfo.html -profile /tmp/tmpGTboCJ/profile 15:44:33 INFO - TEST-INFO | started process 31335 (/builds/slave/test/build/application/firefox/firefox http://localhost:47012/getInfo.html) 15:44:40 INFO - TEST-INFO | 31335: exit 0 15:44:40 INFO - Browser initialized. 15:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:40 INFO - Using env: {'DISPLAY': ':0', 15:44:40 INFO - 'HOME': '/home/cltbld', 15:44:40 INFO - 'JSGC_DISABLE_POISONING': '1', 15:44:40 INFO - 'LANG': 'en_US.UTF-8', 15:44:40 INFO - 'LANGUAGE': 'en_US:en', 15:44:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:44:40 INFO - 'LOGNAME': 'cltbld', 15:44:40 INFO - 'MAIL': '/var/mail/cltbld', 15:44:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:44:40 INFO - 'MOZ_ACCELERATED': '1', 15:44:40 INFO - 'MOZ_CRASHREPORTER': '1', 15:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:44:40 INFO - 'MOZ_NO_REMOTE': '1', 15:44:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:40 INFO - 'MOZ_WEBRENDER': '1', 15:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:40 INFO - 'NO_EM_RESTART': '1', 15:44:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:40 INFO - 'PWD': '/builds/slave/test', 15:44:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:40 INFO - 'RUST_BACKTRACE': 'full', 15:44:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:44:40 INFO - 'SHELL': '/bin/bash', 15:44:40 INFO - 'SHLVL': '1', 15:44:40 INFO - 'TERM': 'linux', 15:44:40 INFO - 'TMOUT': '86400', 15:44:40 INFO - 'USER': 'cltbld', 15:44:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 15:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:40 INFO - '_': '/tools/buildbot/bin/python'} 15:44:40 INFO - TEST-INFO | started process 31580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGTboCJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:40 INFO - PID 31580 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:44:41 INFO - PID 31580 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 15:44:41 INFO - PID 31580 | 15:44:41 INFO - PID 31580 | (/builds/slave/test/build/application/firefox/firefox:31639): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:44:41 INFO - PID 31580 | 15:44:51 INFO - PID 31580 | RSS: Main: 206229504 15:44:51 INFO - PID 31580 | 15:47:50 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47012/tests/dromaeo/cssquery-ext.html) 15:47:51 INFO - PID 31580 | RSS: Main: 208470016 15:47:51 INFO - PID 31580 | 15:50:53 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-ext.html (next: http://localhost:47012/tests/dromaeo/cssquery-jquery.html) 15:50:54 INFO - PID 31580 | RSS: Main: 208916480 15:50:54 INFO - PID 31580 | 15:53:56 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47012/tests/dromaeo/cssquery-mootools.html) 15:53:56 INFO - PID 31580 | RSS: Main: 212017152 15:53:56 INFO - PID 31580 | 15:56:58 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47012/tests/dromaeo/cssquery-prototype.html) 15:56:59 INFO - PID 31580 | RSS: Main: 210186240 15:56:59 INFO - PID 31580 | 16:00:03 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47012/tests/dromaeo/cssquery-yui.html) 16:00:03 INFO - PID 31580 | RSS: Main: 211542016 16:00:03 INFO - PID 31580 | 16:03:05 INFO - PID 31580 | Cycle 1(1): loaded http://localhost:47012/tests/dromaeo/cssquery-yui.html (next: http://localhost:47012/tests/dromaeo/cssquery-dojo.html) 16:03:06 INFO - PID 31580 | RSS: Main: 216662016 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | __start_tp_report 16:03:06 INFO - PID 31580 | _x_x_mozilla_page_load 16:03:06 INFO - PID 31580 | _x_x_mozilla_page_load_details 16:03:06 INFO - PID 31580 | |i|pagename|runs| 16:03:06 INFO - PID 31580 | |0;dojo.html;3105.875764969401;3141.4659507883666;3153.76346773992;3157.352742687749;3177.888773892913;6271.498280137589;6354.428101470867;6442;6453.935460645392;6487.837804054895;6320.304766475696;6339.11252424661;6393.968030159855;6427.068075129115;6455.322191169918;5862.912056319158;5922.111683247525;5950.523958083365;5959.821205363846;5969.283685957691;5747.33905600855;5876.823695289148;5894.351621321673;5934.406559344075;5983.970080149593;5803.274590676166;5874.706264686792;5907.6750778707365;5916.201312822757;5974.22335096439;5635.154726790973;5764.654120752768;5776.335721392052;5787.768489260467;5792.131180322943;5681.892031053946;5730.885382292373;5750.482456578928;5775.624584402;5776.566757493205;6228.314885362606;6306.558540902139;6325.272593651743;6341.112244285804;6366.822137904503;6778.423833974118;6789.35501127397;6876.518643694943;6879.449644028466;6879.931200687979;6717.059611654372;6867.07294515239;6878.8624227515165;6978.057962175092;6995.510314278003;6206.813795586139;6269.2476902771505;6292.622442653455;6315.842103947392;6317.3366796486625;6960.721571137098;6987.650617469208;6999.930000700029;7015;7020.719171233196;6623.370779775913;6626.668666566652;6642.7342906284175;6714.429273511709;6752.932470675329;6899.517033807686;6918.06606108179;6953.130858642669;6966.651667416609;6987.755428559976;6816.522843400914;6858.897116543256;6865.931340686529;6910.896336554955;6940.861182776316;6738.629375384401;6780.491463140185;6783.59298442095;6837;6884.690188941509;5395.136778115482;5402.270693456333;5414.485623865727;5424.701641409761;5442.836714898559;4648.48866624671;4704.9059018819435;4714.528547145258;4721.291806229025;4748.881277968078;5801.82594522165;5829.09649004405;5843.2695913010875;5866.384029676822;5869.354371019184;6693.933060669331;6810.148731408574;6841.863162736718;6847.315268473113;6921.688524016431;5696.3449203341315;5709.229254050733;5765.567582431335;5767.8558036049435;5768.048272035151;5743;5818;5819.709014549256;5828.591998560145;5864.0031194697;6592.17597800275;6631.436327912182;6662.86674266512;6686.565373250821;6700.961350990604;6817.181938167451;6867.107276054081;6880.965595172092;6949.339812717783;6960;6376.840578985377;6575.80272591823;6586.571872828251;6602.273749887412;6603.372679595431;6714.496412769159;6714.966425167843;6725.798226053226;6734.595924244561;6735.25912149673;6899.275576064441;6924.307569243036;6929.1684997800585;6931.445484361138;6931.549449285781;6706.362895524917;6709.094272273181;6714.966425167843;6722.092517510074;6734.057231987624;6514.54398192141;6529.804105876831;6578.309277525791;6618.404343609098;6707.865842683216;6518.902216466662;6595.142631457879;6600.207975043026;6618.371254730793;6633.402993730588;6657.467402607683;6740.292269311652;6744.5616034957575;6801.5238933274195;6819.454443644596;6302.243730752339;6415.71129299192;6514.446272066738;6535.901961470487;6589.4069533742195 16:03:06 INFO - PID 31580 | |1;ext.html;876.0407353947428;896.3008853094589;901.3780491460891;903.0382642485754;903.6837107012542;39002.21995560087;42351.94120146994;42492.36261456081;42617.360739588934;42656.78671606642;39078.609213907854;39597.60402395975;39633.80183099081;39634.603653963524;39684.60315396845;7223.458240631948;7247.492675512716;7297.89053164203;7299.598522081284;7360.411167106646;7140.321669441395;7248.311410416002;7288.234735352791;7327.157376901671;7327.377172940306;7239.312265334811;7268.6729097190755;7284.344409003189;7285.417166626684;7320.780376588684;7191.496595238335;7837.529748215097;8098.75703728889;8145.3483721302155;8157.714479993172;7995.2804247618;8081.111077781439;8089.635966381527;8106.878396824052;8110.878336824952;37464.812675936715;37817.62182378196;37858;37928;37936.241275174616;3553.8045407502577;3581.426971684518;3582.5342705448124;3586.6951309138753;3593.443016332473;30755.538666920012;30961.535576966362;31224.37551248985;31266.531002034986;31346.902858400073;5097.949020509822;5115.667481613683;5136.948630513722;5154.871128221787;5229.973850130725;177100;178236;179899;180497;180881;42388.576114238465;43182.784086079366;47666.76166619144;47971;48050;52207.73896130495;52638.73680631573;52752.47247527476;53001.46998529966;53092.46907530953;15708.450204242796;15714.528564143095;15834.208289585475;15857.207139642971;15879.52361429159;12761.425735841909;12790.10469267161;12896.226226426445;12914.483420663257;12924.095313328166;14195.219262940638;14232.217228052557;14272.21502817355;14290.499832505813;14360.210188439736;5618.690971996498;5667.348254950651;5738.713064346766;5795.88408231833;5890.350701803502;989.6783545347647;989.747614358334;1006.8439391894268;1007.6120693533043;1022.754538910656;22422.887885560467;22829.885850570972;22968.196113136295;23037.884810576175;23099.53800923972;1082.0856376361962;1102.2284400919389;1104.917131215162;1114.1087130295732;1128.1764312052248;12024.939875300568;12215.144939854124;12281.508739650313;12291.56979505713;12295.754084918251;218622;218682;218695;219457;219508;52146.47853521492;52406.475935240924;52513;52638.21042684363;52959.73520132375;1430.5064752660317;1472.4846303793802;1474.8820094392422;1483.5475180069966;1486.323722706166;22356.329310120724;22374.440638984157;22445.77554224437;22563.887180563994;22830.54338913179;37920.051998700255;37962.43056354102;38014.049648759;38039;38049.239015218984;183184;185677;186144;186623;187041;32812.17969550685;33316.83341583374;33628.159296017795;34090.318193635496;34167.97496075122;43056.56943430525;43262.134757305306;43270.350944736485;43584.78207608942;43605.78197109121;31248;31563.21091972719;31802.681973179973;31884.362312754078;31905.361892762478;30652.693473064985;31055;31163.37673246477;31202.687973120886;31470.842645786626;34854.30291394208;35530.28939421249;35777.46333804943;35784.642153578134;35850.4622430669;30270.697293027668;30314;30985;31209;31998.52002220015;22750;22832.200872969366;23075.538489229784;23155;23351.76648233564 16:03:06 INFO - PID 31580 | |2;jquery.html;578.8494991302263;586.1998372221918;591.3317950715691;605.300877486503;607.3410349770501;21875.453113672145;22400.663990040164;22463.887680561595;22618.66072008921;22698.319050428494;23487.76512234877;24020.639690404616;25067.498650026988;25268.115615953444;25829.095981640647;6476.643784591857;6677.332266773333;6679.6994135263785;6688.799336019927;6707.295733947938;6510.08858759774;6582.3417658234275;6623.2052153741615;6625.801225963229;6663.267040625527;6457.225132984048;6685.8662826743675;6698.732050717966;6703.061571380011;6726.125603671516;6631.502637302197;6749.865002699968;6751.831204219885;6754.696038678271;6787.864242715167;6252.030935205005;6304.527160462938;6314.084457753646;6318.178636777189;6319.273283572356;28779.56830647542;29623.407531849458;30071.09786706402;30602.54096188559;30661.693383066107;2003.24878170686;2032.4918770307422;2032.7967203279554;2035.3588619584932;2036.4603380104284;19829.9008504958;20240.696389554167;20543.691844622343;20551.075201615964;20570.897145514326;2399.9040038398443;2457.8033757299554;2526.4441822798954;2527.949441011188;2539.0351666366846;118612;125544.37227813802;139933;146453;147636;14592.45796462375;14796.112233266038;15017.70578921882;15075;15352.616184595474;23744.168954086523;23796.643050354258;23841.046358145828;23956;23990.760092398854;9938.850917236246;9971.650992215238;10001.24990625706;10035.498225088862;10197.847032294521;9324;9333.439993600407;9343.392679475812;9418.434893906388;9440.57517411718;9015.14356136166;9102.271818254523;9157.587908543997;9442.48066356357;9457.101575350469;2701.8784154713085;2758.5586306191312;2837.929051773722;2859.442408730319;2959.674435812059;953.1707414549248;965.7826988927435;966.1111777165025;971.7279161834698;974.8196583632051;19055.61888762217;19406.12672429716;19625.705614415794;19817.30639427642;19830.603387932162;988.3871999360299;1029.552144817007;1039.599754094664;1042.801867645145;1053.4785281285813;10645.20160987929;10879.12966962641;10963.725906852393;10989.6153634624;11124.55501779936;451103;458771;460137;475703;477953;109180.454097729;110609;111062;111273;111930.44034779775;1134.773045390925;1139.0432037088885;1151.758130792543;1153.6193056291404;1156.4738044190042;16982.74525882088;17343.826561734222;17626.5593360167;17852.928824270584;17874.46376608704;55467.44532554623;55834.720826395605;55846.720766395905;57498.7125064372;58252.70873645604;70798.64600676963;71145.6442717783;71750.64124679343;72527;72923;14483.348249329016;14684.118952862862;14844.777328339867;14864.108153510824;14882.330295136528;22674.546509070056;22781.31656050321;23100.653490197325;23138.3058508245;23581.056757730184;17498.650026999643;17561.473155805346;18114.27542898269;18420.539486512946;18457.630847383247;15683.686326273639;16368.590785229988;16749.413770517975;16814.411495597597;17069.82930170732;18730.906345468185;18968.810311897258;18979.24083036663;19224.423267301445;19236.519087022938;13617.65955851072;14481.348339324966;14485.637859053608;14512.782308265596;14741.631459213606;18064.277428902697;18127.184276707845;18175.45473635793;18212.45362639123;18225.635487289914 16:03:06 INFO - PID 31580 | |3;mootools.html;1340.544214966911;1376.2430663135278;1399.0766094377714;1400.9509667161649;1407.1064873805137;14843.851561484382;15452.30464629093;15513.301901414436;15520.068795872256;15535.456259030936;15169.317380717866;15232.923835380807;15301.846981530209;15333.539993800205;15343;2789.623400840891;2807.270109771464;2842.7157284271616;2843.2607522044314;2855.129185598392;2767.114523352528;2825.293676580855;2839.6308479897584;2845.8007939444246;2850.957235641467;2745.862706864659;2759.310172456886;2766.585012248159;2774.1261502626608;2781.680106787725;2323.512062466884;2409.2170044735444;2761.9723802761914;2861.3275880168144;2866.584345269924;2664.521190739139;2686.6910305314946;2709.1195361507393;2715.5383584790634;2719;14666.19335936523;14716.33776480061;14783.260836958108;14795;14849.628759281104;8045.919540804575;8307.916920830774;8317.625706843206;8355.791105222357;8394.24451799341;5158.40678321994;5353.892922141575;5355.143177091647;5505.03661859177;5508.173773933902;1873.0541076756151;1900.4773687235981;1905.4664693885734;1932.6424611446928;1946.698261769428;26303.342416439744;26726.19821405361;26912.59631105535;26973.055943042094;27448.588271175948;6893.172819261721;7028.964855175794;7136.857262854714;7154.35610795031;7181.461390395742;16705.248263828158;16724;16785.83214167867;16807.41174058902;16887.831121688872;7720.7683769487;8004;8039.598020099089;8108.5945702714625;8160.836783264302;7400;7468.5145465544565;7500.249975002456;7509.66206520697;7552.811179720551;5274.182501712241;5293.761780719877;5386.703731294817;5417.241586177938;5420.810271640474;1565.2078370266208;1567.615934096131;1570.2227397438112;1583.6595132046666;1596.9840301597067;851.4635779458902;857.34413173922;872.7643536245305;873.366809063424;882;7248.710051597983;7275.636218189069;7363.190049094595;7385.29839665231;7524.134724506752;693.6913073682264;708.0794966543473;725.1942662769666;744.2706147975015;756.5158298688843;4386.605205531518;4440.2007638625355;4448.243798554254;4452.176347375681;4475.283954567253;21692.674609880865;21968.121275149133;22254;22466.32601021972;22726.772732272795;20636;21330.466738331666;21646.458838529164;21703.34889953304;21874.453138671342;9601.37591056593;9954.900450995543;11251.549938002388;11862.822057669142;11883.821742673867;8243.134470880472;8835.425697329652;8855.070217627057;8915.28677705769;9007.324450666358;18453.261869525606;18618.627627447106;18797.718034229772;18865.24539018424;18918.14868330956;18858.434246972614;19735;19899.701504477154;19939.601207976048;20117.49706257355;10162;10422.062014418738;10569.63006294776;10587.311824731369;10605.151587873106;13209.207447553177;13297.069205155933;13298.135621184592;13312.866871331164;13330.066895317623;10837.024667779622;10880.891191087987;11137.498812553617;11179.10567154642;11388.772224555296;10081;10418.374897506174;10619.734506637396;10763.838542422027;10823.188260880308;9876.35803672759;10037.949810250902;10062.69811905644;10064.39613623185;10064.496775161359;6714.462842972453;6792.626405547742;6802.557833740791;6973.442124629916;6992.895106573507;6716.731330746716;6813.7955861324235;6842.247352791289;6865.656717164222;6874.896876546756 16:03:06 INFO - PID 31580 | |4;prototype.html;516.6564234783866;520.6719766547076;538.5772168847456;549.066586802436;555.96664200148;6011.278646562413;6134.846628834276;6155.446009859112;6197.907031394533;6314.747904829005;6119.602225855328;6183.25800903891;6215.254169499655;6228.968855155729;6271.404216599427;5165.76754046067;5186.273921650972;5213.843584692465;5250.6587071840395;5254.238135470355;5064.366954130734;5172.482751724835;5236.842894713165;5265.183127027041;5281.8943621127555;5186.5850731941355;5219.556337711299;5256.500632439912;5263.736813159327;5284.075286824809;5180.300659410969;5181.81863634771;5204.9479505204845;5224.537129603717;5283.762230699608;4812.181929072031;4827.227643577046;4855.393075865517;4864.537868902484;4931.926021109686;6184.19605451293;6193.473554747807;6199.907001394983;6212.502999760053;6238.532110091761;5997.73010214537;6003.699815009232;6028.156058151862;6097.69511524422;6141.846453838645;6599.406053455212;6617.338266173392;6639.668016599151;6646.435053020499;6666.966530228734;5254.133068043769;5299.49654782795;5306.469353064701;5318.25544423781;5353.38436079848;6878.209005964328;7018.824529386755;7034.331738484836;7064.999999999948;7071.646417679095;5513.117901135799;5526.143447765603;5546.861328466821;5585.804496842591;5614.9438505615235;5558.944410555923;5639;5639.746211420496;5657.32112146545;5681.34664513578;6066.423689749467;6082.817515474454;6104.175936248638;6122.54080943931;6137;6743.123393958754;6782.118324617768;6792.524523283323;6794.3545363190415;6801.829954251183;1834.4313262888547;1852.9629407411776;1854.8052454492354;1896.3741965151467;1905.4664693885734;1433.5341014170435;1450.9637259068397;1458.3874772595536;1465.6116129225763;1490.5304828978838;5567.805126820542;5634.154876768435;5640.605157638925;5641.858953526113;5652.802151924663;6542.509311801634;6623.271440141581;6648.767293144717;6704.396604305636;6713.899291510631;5628.831135065954;5664.1874600128385;5676.943230567642;5720.256366672306;5731.942680573141;3492.231709024011;3511.3328467591587;3537.858485660545;3544.680978711928;3598.892033239007;6349.8730025400155;6357.427831495188;6399.360063993563;6558.540902136805;6581.934180658132;6707;6768.052472653832;6822.147231596051;6927.480438966997;7005.124359455068;6505.479561635152;6515.674216289071;6520.771772987922;6557.114789503451;6590.340965903467;6689.866202676017;6750.527463077734;6767.796966091025;6836.453083753188;6850.21222559412;6696.229933557508;6728.865422691617;6744.055832183596;6769.830754230987;6785.5250132490255;6391.808245752635;6392.712327945346;6401.295857455583;6465.935340646722;6470.22357317125;4950.504949505164;4977.527134922177;5018.673786203885;5027.874303142451;5086.109930762028;6456.483481321389;6690.632015239208;6716.1940567130305;6824;6834.658267086526;6222.315545289924;6271.278802937538;6358.77744278948;6491.285958544462;6585.670716464062;6417.839554011187;6430.356964303533;6510;6582.670866456754;6595.647892182187;6367.662790813795;6448.161738973903;6450.838729031811;6506.479481641362;6537.084808126961;6314.916492223804;6423.678816059271;6603.669816509251;6690.866182676222;6691.230508491391;6336.94049433945;6393.488520918222;6398.936010639834;6399.680015999088;6472.676366181578 16:03:06 INFO - PID 31580 | |5;yui.html;880.3045593980755;904.3353135445446;905.8233644439333;915.7939463620686;927.0914503786287;18952.147153378097;19724.112414941344;19737.309194178208;19761.604767904635;19812.801871981275;16475.752863707054;16585.170741462938;16956.49130526083;17752.911235443837;17824.554386140353;945.8723072385243;954.8233576788316;955.1928620315857;957.5403806173041;961.4952150121208;965.377331621104;978.9461579613119;980.039561229995;980.8038392321529;988.940663560185;986.6004268271362;1014.8122597319519;1018.1294992781177;1018.5365658625345;1047.08903254169;982.1160955140359;998.6055508074306;998.9550470228858;1001.62439085343;1002.6190047781832;744.9180590135081;747.0661672908864;748.4386709967524;754.0988518720131;756.9016027916391;19787.406377808544;20104.39686809398;20229.696554551694;20386.69419958702;20408.489787755276;21934.232301869517;21992;22324.776752232432;22345.441363965867;22404.66393004106;17272.740908886375;17390;17462.738058929128;17686.646267074586;17689.911550442295;3790.336691079078;3790.3935370340614;3808.923821523582;3834.2523207974455;3838.5777564467885;124117;125653.37173314167;128159;130342;130807;16897.98612083279;16919.91540042292;16979.49061528156;17094.57263568396;17152.31390744381;30435.695643043287;30784;31049.223769405493;31198.220044498616;31324.843375783432;8250.587470626444;8340.457870238415;8363.790905227417;8370.707025254087;8383.664653413916;4353.521112677603;4442;4457.955420445754;4471.8434854779925;4474.261746811805;5281.603879709037;5356.812511562077;5499.395066542677;5506.559475241971;5535.114381698909;976.8046390721884;981.3621146254849;986.7138529826414;992.6972273456665;993.279872092727;689.9793006209821;695.7112798188695;704.3132945378215;712.6828561290176;716.2300526933567;12032.81950770739;12156.817647735292;12184.939075304566;12745.362731863555;12939.02957278208;656.9737210511622;657.0571230284557;667.4927055437902;675.2943174382782;677.5155763628931;5256.92114618281;5296.172108155544;5306.734663266821;5335.439778823167;5373.328333958255;115091.42454287675;115826.42086789681;117507;119400.40299798445;122101;107240.46379768051;109479.45260273648;109794.45102774435;112137.43931280292;113693;89458;90016.54991725131;91580;91810.54094729618;92382.53808730913;9914.603415863285;9966.750831229278;10137.949310253402;10234.590616375559;10276.22928280367;43101.3534796972;43446.56553434425;43815.56184438115;44055;45116.0976780456;53647.463525365805;54413.45586544084;54619.72690136524;55067.72466137644;55589.7220513911;14038.719225615227;14236;14241.50154744579;14272.286385680882;14465;17559;17596.120193990504;17671.204795784477;17785.46643600694;18000.369987050915;14307.926905481921;14424.206668633326;14474.34865431037;14695.92652036733;14944.7758283628;14458.421663133777;14648.853511465175;14734.410623574937;14778.778318325449;14812.259387030821;15387.307571159101;15659.451919182773;15675.137867416945;15755.527334179993;15814.130222837854;10686.946565267124;10901.182411319025;10950.616728414467;11230.719232019264;11261.380624065756;11948.522059117886;11985.34080625574;12117.515299387926;12284.570040048555;12533.060020498317 16:03:06 INFO - PID 31580 | __end_tp_report 16:03:06 INFO - PID 31580 | __start_cc_report 16:03:06 INFO - PID 31580 | _x_x_mozilla_cycle_collect,286 16:03:06 INFO - PID 31580 | __end_cc_report 16:03:06 INFO - PID 31580 | __startTimestamp1506294186005__endTimestamp 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | ------- Summary: start ------- 16:03:06 INFO - PID 31580 | Number of tests: 6 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#0] dojo.html Cycles:165 Average:6272.17 Median:6535.90 stddev:769.25 (11.8%) stddev-sans-first:730.40 16:03:06 INFO - PID 31580 | Values: 3105.9 3141.5 3153.8 3157.4 3177.9 6271.5 6354.4 6442.0 6453.9 6487.8 6320.3 6339.1 6394.0 6427.1 6455.3 5862.9 5922.1 5950.5 5959.8 5969.3 5747.3 5876.8 5894.4 5934.4 5984.0 5803.3 5874.7 5907.7 5916.2 5974.2 5635.2 5764.7 5776.3 5787.8 5792.1 5681.9 5730.9 5750.5 5775.6 5776.6 6228.3 6306.6 6325.3 6341.1 6366.8 6778.4 6789.4 6876.5 6879.4 6879.9 6717.1 6867.1 6878.9 6978.1 6995.5 6206.8 6269.2 6292.6 6315.8 6317.3 6960.7 6987.7 6999.9 7015.0 7020.7 6623.4 6626.7 6642.7 6714.4 6752.9 6899.5 6918.1 6953.1 6966.7 6987.8 6816.5 6858.9 6865.9 6910.9 6940.9 6738.6 6780.5 6783.6 6837.0 6884.7 5395.1 5402.3 5414.5 5424.7 5442.8 4648.5 4704.9 4714.5 4721.3 4748.9 5801.8 5829.1 5843.3 5866.4 5869.4 6693.9 6810.1 6841.9 6847.3 6921.7 5696.3 5709.2 5765.6 5767.9 5768.0 5743.0 5818.0 5819.7 5828.6 5864.0 6592.2 6631.4 6662.9 6686.6 6701.0 6817.2 6867.1 6881.0 6949.3 6960.0 6376.8 6575.8 6586.6 6602.3 6603.4 6714.5 6715.0 6725.8 6734.6 6735.3 6899.3 6924.3 6929.2 6931.4 6931.5 6706.4 6709.1 6715.0 6722.1 6734.1 6514.5 6529.8 6578.3 6618.4 6707.9 6518.9 6595.1 6600.2 6618.4 6633.4 6657.5 6740.3 6744.6 6801.5 6819.5 6302.2 6415.7 6514.4 6535.9 6589.4 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#1] ext.html Cycles:180 Average:36388.90 Median:35653.88 stddev:50596.12 (141.9%) stddev-sans-first:50667.78 16:03:06 INFO - PID 31580 | Values: 876.0 896.3 901.4 903.0 903.7 39002.2 42351.9 42492.4 42617.4 42656.8 39078.6 39597.6 39633.8 39634.6 39684.6 7223.5 7247.5 7297.9 7299.6 7360.4 7140.3 7248.3 7288.2 7327.2 7327.4 7239.3 7268.7 7284.3 7285.4 7320.8 7191.5 7837.5 8098.8 8145.3 8157.7 7995.3 8081.1 8089.6 8106.9 8110.9 37464.8 37817.6 37858.0 37928.0 37936.2 3553.8 3581.4 3582.5 3586.7 3593.4 30755.5 30961.5 31224.4 31266.5 31346.9 5097.9 5115.7 5136.9 5154.9 5230.0 177100.0 178236.0 179899.0 180497.0 180881.0 42388.6 43182.8 47666.8 47971.0 48050.0 52207.7 52638.7 52752.5 53001.5 53092.5 15708.5 15714.5 15834.2 15857.2 15879.5 12761.4 12790.1 12896.2 12914.5 12924.1 14195.2 14232.2 14272.2 14290.5 14360.2 5618.7 5667.3 5738.7 5795.9 5890.4 989.7 989.7 1006.8 1007.6 1022.8 22422.9 22829.9 22968.2 23037.9 23099.5 1082.1 1102.2 1104.9 1114.1 1128.2 12024.9 12215.1 12281.5 12291.6 12295.8 218622.0 218682.0 218695.0 219457.0 219508.0 52146.5 52406.5 52513.0 52638.2 52959.7 1430.5 1472.5 1474.9 1483.5 1486.3 22356.3 22374.4 22445.8 22563.9 22830.5 37920.1 37962.4 38014.0 38039.0 38049.2 183184.0 185677.0 186144.0 186623.0 187041.0 32812.2 33316.8 33628.2 34090.3 34168.0 43056.6 43262.1 43270.4 43584.8 43605.8 31248.0 31563.2 31802.7 31884.4 31905.4 30652.7 31055.0 31163.4 31202.7 31470.8 34854.3 35530.3 35777.5 35784.6 35850.5 30270.7 30314.0 30985.0 31209.0 31998.5 22750.0 22832.2 23075.5 23155.0 23351.8 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#2] jquery.html Cycles:180 Average:33900.87 Median:23313.04 stddev:78511.40 (336.8%) stddev-sans-first:78691.78 16:03:06 INFO - PID 31580 | Values: 578.8 586.2 591.3 605.3 607.3 21875.5 22400.7 22463.9 22618.7 22698.3 23487.8 24020.6 25067.5 25268.1 25829.1 6476.6 6677.3 6679.7 6688.8 6707.3 6510.1 6582.3 6623.2 6625.8 6663.3 6457.2 6685.9 6698.7 6703.1 6726.1 6631.5 6749.9 6751.8 6754.7 6787.9 6252.0 6304.5 6314.1 6318.2 6319.3 28779.6 29623.4 30071.1 30602.5 30661.7 2003.2 2032.5 2032.8 2035.4 2036.5 19829.9 20240.7 20543.7 20551.1 20570.9 2399.9 2457.8 2526.4 2527.9 2539.0 118612.0 125544.4 139933.0 146453.0 147636.0 14592.5 14796.1 15017.7 15075.0 15352.6 23744.2 23796.6 23841.0 23956.0 23990.8 9938.9 9971.7 10001.2 10035.5 10197.8 9324.0 9333.4 9343.4 9418.4 9440.6 9015.1 9102.3 9157.6 9442.5 9457.1 2701.9 2758.6 2837.9 2859.4 2959.7 953.2 965.8 966.1 971.7 974.8 19055.6 19406.1 19625.7 19817.3 19830.6 988.4 1029.6 1039.6 1042.8 1053.5 10645.2 10879.1 10963.7 10989.6 11124.6 451103.0 458771.0 460137.0 475703.0 477953.0 109180.5 110609.0 111062.0 111273.0 111930.4 1134.8 1139.0 1151.8 1153.6 1156.5 16982.7 17343.8 17626.6 17852.9 17874.5 55467.4 55834.7 55846.7 57498.7 58252.7 70798.6 71145.6 71750.6 72527.0 72923.0 14483.3 14684.1 14844.8 14864.1 14882.3 22674.5 22781.3 23100.7 23138.3 23581.1 17498.7 17561.5 18114.3 18420.5 18457.6 15683.7 16368.6 16749.4 16814.4 17069.8 18730.9 18968.8 18979.2 19224.4 19236.5 13617.7 14481.3 14485.6 14512.8 14741.6 18064.3 18127.2 18175.5 18212.5 18225.6 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#3] mootools.html Cycles:180 Average:9265.32 Median:2712.33 stddev:6734.17 (248.3%) stddev-sans-first:6726.74 16:03:06 INFO - PID 31580 | Values: 1340.5 1376.2 1399.1 1401.0 1407.1 14843.9 15452.3 15513.3 15520.1 15535.5 15169.3 15232.9 15301.8 15333.5 15343.0 2789.6 2807.3 2842.7 2843.3 2855.1 2767.1 2825.3 2839.6 2845.8 2851.0 2745.9 2759.3 2766.6 2774.1 2781.7 2323.5 2409.2 2762.0 2861.3 2866.6 2664.5 2686.7 2709.1 2715.5 2719.0 14666.2 14716.3 14783.3 14795.0 14849.6 8045.9 8307.9 8317.6 8355.8 8394.2 5158.4 5353.9 5355.1 5505.0 5508.2 1873.1 1900.5 1905.5 1932.6 1946.7 26303.3 26726.2 26912.6 26973.1 27448.6 6893.2 7029.0 7136.9 7154.4 7181.5 16705.2 16724.0 16785.8 16807.4 16887.8 7720.8 8004.0 8039.6 8108.6 8160.8 7400.0 7468.5 7500.2 7509.7 7552.8 5274.2 5293.8 5386.7 5417.2 5420.8 1565.2 1567.6 1570.2 1583.7 1597.0 851.5 857.3 872.8 873.4 882.0 7248.7 7275.6 7363.2 7385.3 7524.1 693.7 708.1 725.2 744.3 756.5 4386.6 4440.2 4448.2 4452.2 4475.3 21692.7 21968.1 22254.0 22466.3 22726.8 20636.0 21330.5 21646.5 21703.3 21874.5 9601.4 9954.9 11251.5 11862.8 11883.8 8243.1 8835.4 8855.1 8915.3 9007.3 18453.3 18618.6 18797.7 18865.2 18918.1 18858.4 19735.0 19899.7 19939.6 20117.5 10162.0 10422.1 10569.6 10587.3 10605.2 13209.2 13297.1 13298.1 13312.9 13330.1 10837.0 10880.9 11137.5 11179.1 11388.8 10081.0 10418.4 10619.7 10763.8 10823.2 9876.4 10037.9 10062.7 10064.4 10064.5 6714.5 6792.6 6802.6 6973.4 6992.9 6716.7 6813.8 6842.2 6865.7 6874.9 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#4] prototype.html Cycles:180 Average:5626.40 Median:6188.83 stddev:1506.02 (24.3%) stddev-sans-first:1460.60 16:03:06 INFO - PID 31580 | Values: 516.7 520.7 538.6 549.1 556.0 6011.3 6134.8 6155.4 6197.9 6314.7 6119.6 6183.3 6215.3 6229.0 6271.4 5165.8 5186.3 5213.8 5250.7 5254.2 5064.4 5172.5 5236.8 5265.2 5281.9 5186.6 5219.6 5256.5 5263.7 5284.1 5180.3 5181.8 5204.9 5224.5 5283.8 4812.2 4827.2 4855.4 4864.5 4931.9 6184.2 6193.5 6199.9 6212.5 6238.5 5997.7 6003.7 6028.2 6097.7 6141.8 6599.4 6617.3 6639.7 6646.4 6667.0 5254.1 5299.5 5306.5 5318.3 5353.4 6878.2 7018.8 7034.3 7065.0 7071.6 5513.1 5526.1 5546.9 5585.8 5614.9 5558.9 5639.0 5639.7 5657.3 5681.3 6066.4 6082.8 6104.2 6122.5 6137.0 6743.1 6782.1 6792.5 6794.4 6801.8 1834.4 1853.0 1854.8 1896.4 1905.5 1433.5 1451.0 1458.4 1465.6 1490.5 5567.8 5634.2 5640.6 5641.9 5652.8 6542.5 6623.3 6648.8 6704.4 6713.9 5628.8 5664.2 5676.9 5720.3 5731.9 3492.2 3511.3 3537.9 3544.7 3598.9 6349.9 6357.4 6399.4 6558.5 6581.9 6707.0 6768.1 6822.1 6927.5 7005.1 6505.5 6515.7 6520.8 6557.1 6590.3 6689.9 6750.5 6767.8 6836.5 6850.2 6696.2 6728.9 6744.1 6769.8 6785.5 6391.8 6392.7 6401.3 6465.9 6470.2 4950.5 4977.5 5018.7 5027.9 5086.1 6456.5 6690.6 6716.2 6824.0 6834.7 6222.3 6271.3 6358.8 6491.3 6585.7 6417.8 6430.4 6510.0 6582.7 6595.6 6367.7 6448.2 6450.8 6506.5 6537.1 6314.9 6423.7 6603.7 6690.9 6691.2 6336.9 6393.5 6398.9 6399.7 6472.7 16:03:06 INFO - PID 31580 | 16:03:06 INFO - PID 31580 | [#5] yui.html Cycles:180 Average:23565.34 Median:22158.39 stddev:33722.83 (152.2%) stddev-sans-first:33774.41 16:03:06 INFO - PID 31580 | Values: 880.3 904.3 905.8 915.8 927.1 18952.1 19724.1 19737.3 19761.6 19812.8 16475.8 16585.2 16956.5 17752.9 17824.6 945.9 954.8 955.2 957.5 961.5 965.4 978.9 980.0 980.8 988.9 986.6 1014.8 1018.1 1018.5 1047.1 982.1 998.6 999.0 1001.6 1002.6 744.9 747.1 748.4 754.1 756.9 19787.4 20104.4 20229.7 20386.7 20408.5 21934.2 21992.0 22324.8 22345.4 22404.7 17272.7 17390.0 17462.7 17686.6 17689.9 3790.3 3790.4 3808.9 3834.3 3838.6 124117.0 125653.4 128159.0 130342.0 130807.0 16898.0 16919.9 16979.5 17094.6 17152.3 30435.7 30784.0 31049.2 31198.2 31324.8 8250.6 8340.5 8363.8 8370.7 8383.7 4353.5 4442.0 4458.0 4471.8 4474.3 5281.6 5356.8 5499.4 5506.6 5535.1 976.8 981.4 986.7 992.7 993.3 690.0 695.7 704.3 712.7 716.2 12032.8 12156.8 12184.9 12745.4 12939.0 657.0 657.1 667.5 675.3 677.5 5256.9 5296.2 5306.7 5335.4 5373.3 115091.4 115826.4 117507.0 119400.4 122101.0 107240.5 109479.5 109794.5 112137.4 113693.0 89458.0 90016.5 91580.0 91810.5 92382.5 9914.6 9966.8 10137.9 10234.6 10276.2 43101.4 43446.6 43815.6 44055.0 45116.1 53647.5 54413.5 54619.7 55067.7 55589.7 14038.7 14236.0 14241.5 14272.3 14465.0 17559.0 17596.1 17671.2 17785.5 18000.4 14307.9 14424.2 14474.3 14695.9 14944.8 14458.4 14648.9 14734.4 14778.8 14812.3 15387.3 15659.5 15675.1 15755.5 15814.1 10686.9 10901.2 10950.6 11230.7 11261.4 11948.5 11985.3 12117.5 12284.6 12533.1 16:03:06 INFO - PID 31580 | -------- Summary: end -------- 16:03:06 INFO - PID 31580 | 16:03:06 INFO - TEST-INFO | 31580: exit 0 16:03:06 INFO - TEST-OK | dromaeo_css | took 1113119ms 16:03:06 INFO - TEST-START | kraken 16:03:06 INFO - Initialising browser for kraken test... 16:03:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47012/getInfo.html -profile /tmp/tmpREX5n9/profile 16:03:06 INFO - TEST-INFO | started process 31962 (/builds/slave/test/build/application/firefox/firefox http://localhost:47012/getInfo.html) 16:03:12 INFO - TEST-INFO | 31962: exit 0 16:03:12 INFO - Browser initialized. 16:03:12 INFO - Running cycle 1/1 for kraken test... 16:03:12 INFO - Using env: {'DISPLAY': ':0', 16:03:12 INFO - 'HOME': '/home/cltbld', 16:03:12 INFO - 'JSGC_DISABLE_POISONING': '1', 16:03:12 INFO - 'LANG': 'en_US.UTF-8', 16:03:12 INFO - 'LANGUAGE': 'en_US:en', 16:03:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:03:12 INFO - 'LOGNAME': 'cltbld', 16:03:12 INFO - 'MAIL': '/var/mail/cltbld', 16:03:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:12 INFO - 'MOZ_ACCELERATED': '1', 16:03:12 INFO - 'MOZ_CRASHREPORTER': '1', 16:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:03:12 INFO - 'MOZ_NO_REMOTE': '1', 16:03:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:12 INFO - 'MOZ_WEBRENDER': '1', 16:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:12 INFO - 'NO_EM_RESTART': '1', 16:03:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:12 INFO - 'PWD': '/builds/slave/test', 16:03:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:12 INFO - 'RUST_BACKTRACE': 'full', 16:03:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:03:12 INFO - 'SHELL': '/bin/bash', 16:03:12 INFO - 'SHLVL': '1', 16:03:12 INFO - 'TERM': 'linux', 16:03:12 INFO - 'TMOUT': '86400', 16:03:12 INFO - 'USER': 'cltbld', 16:03:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892', 16:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:12 INFO - '_': '/tools/buildbot/bin/python'} 16:03:12 INFO - TEST-INFO | started process 32212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpREX5n9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:13 INFO - PID 32212 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:03:13 INFO - PID 32212 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:03:13 INFO - PID 32212 | 16:03:13 INFO - PID 32212 | (/builds/slave/test/build/application/firefox/firefox:32271): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:03:13 INFO - PID 32212 | 16:03:24 INFO - PID 32212 | RSS: Main: 210501632 16:03:24 INFO - PID 32212 | 16:03:27 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:28 INFO - PID 32212 | RSS: Main: 208687104 16:03:28 INFO - PID 32212 | 16:03:30 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-dft) 16:03:31 INFO - PID 32212 | RSS: Main: 208965632 16:03:31 INFO - PID 32212 | 16:03:34 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-fft) 16:03:34 INFO - PID 32212 | RSS: Main: 205910016 16:03:34 INFO - PID 32212 | 16:03:37 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47012/tests/kraken/driver.html?testName=audio-oscillator) 16:03:37 INFO - PID 32212 | RSS: Main: 206544896 16:03:37 INFO - PID 32212 | 16:03:39 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:40 INFO - PID 32212 | RSS: Main: 206594048 16:03:40 INFO - PID 32212 | 16:03:43 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:44 INFO - PID 32212 | RSS: Main: 210132992 16:03:44 INFO - PID 32212 | 16:03:48 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47012/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:48 INFO - PID 32212 | RSS: Main: 209985536 16:03:48 INFO - PID 32212 | 16:03:51 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47012/tests/kraken/driver.html?testName=json-parse-financial) 16:03:52 INFO - PID 32212 | RSS: Main: 210104320 16:03:52 INFO - PID 32212 | 16:03:53 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:54 INFO - PID 32212 | RSS: Main: 209833984 16:03:54 INFO - PID 32212 | 16:03:56 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:56 INFO - PID 32212 | RSS: Main: 206966784 16:03:56 INFO - PID 32212 | 16:03:58 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:59 INFO - PID 32212 | RSS: Main: 206221312 16:03:59 INFO - PID 32212 | 16:04:02 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:02 INFO - PID 32212 | RSS: Main: 206860288 16:04:02 INFO - PID 32212 | 16:04:05 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:06 INFO - PID 32212 | RSS: Main: 206692352 16:04:06 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | Cycle 1(1): loaded http://localhost:47012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47012/tests/kraken/driver.html?testName=ai-astar) 16:04:08 INFO - PID 32212 | RSS: Main: 208748544 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | __start_tp_report 16:04:08 INFO - PID 32212 | _x_x_mozilla_page_load 16:04:08 INFO - PID 32212 | _x_x_mozilla_page_load_details 16:04:08 INFO - PID 32212 | |i|pagename|runs| 16:04:08 INFO - PID 32212 | |0;ai-astar;112;111;115;134;116;107;116;106;112;107 16:04:08 INFO - PID 32212 | |1;audio-beat-detection;118;125;127;117;116;118;125;149;119;122 16:04:08 INFO - PID 32212 | |2;audio-dft;165;161;163;165;162;167;175;164;166;163 16:04:08 INFO - PID 32212 | |3;audio-fft;83;80;74;74;77;74;84;85;80;74 16:04:08 INFO - PID 32212 | |4;audio-oscillator;85;82;88;80;82;83;83;84;84;80 16:04:08 INFO - PID 32212 | |5;imaging-gaussian-blur;117;114;113;116;119;129;116;116;115;115 16:04:08 INFO - PID 32212 | |6;imaging-darkroom;151;149;148;147;148;152;149;149;155;153 16:04:08 INFO - PID 32212 | |7;imaging-desaturate;94;96;94;95;95;95;95;96;100;95 16:04:08 INFO - PID 32212 | |8;json-parse-financial;58;56;53;53;55;57;58;55;55;54 16:04:08 INFO - PID 32212 | |9;json-stringify-tinderbox;39;38;45;46;39;39;47;43;49;40 16:04:08 INFO - PID 32212 | |10;stanford-crypto-aes;73;74;73;82;80;84;82;83;79;79 16:04:08 INFO - PID 32212 | |11;stanford-crypto-ccm;112;115;121;114;122;115;121;115;117;107 16:04:08 INFO - PID 32212 | |12;stanford-crypto-pbkdf2;171;173;169;170;169;170;168;184;168;171 16:04:08 INFO - PID 32212 | |13;stanford-crypto-sha256-iterative;66;66;65;73;67;66;69;70;65;63 16:04:08 INFO - PID 32212 | __end_tp_report 16:04:08 INFO - PID 32212 | __start_cc_report 16:04:08 INFO - PID 32212 | _x_x_mozilla_cycle_collect,767 16:04:08 INFO - PID 32212 | __end_cc_report 16:04:08 INFO - PID 32212 | __startTimestamp1506294248562__endTimestamp 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | ------- Summary: start ------- 16:04:08 INFO - PID 32212 | Number of tests: 14 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:8.07 (7.1%) stddev-sans-first:8.54 16:04:08 INFO - PID 32212 | Values: 112.0 111.0 115.0 134.0 116.0 107.0 116.0 106.0 112.0 107.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:123.50 stddev:9.71 (7.9%) stddev-sans-first:10.08 16:04:08 INFO - PID 32212 | Values: 118.0 125.0 127.0 117.0 116.0 118.0 125.0 149.0 119.0 122.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.93 (2.4%) stddev-sans-first:4.17 16:04:08 INFO - PID 32212 | Values: 165.0 161.0 163.0 165.0 162.0 167.0 175.0 164.0 166.0 163.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#3] audio-fft Cycles:10 Average:78.50 Median:80.00 stddev:4.48 (5.6%) stddev-sans-first:4.44 16:04:08 INFO - PID 32212 | Values: 83.0 80.0 74.0 74.0 77.0 74.0 84.0 85.0 80.0 74.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:83.50 stddev:2.38 (2.8%) stddev-sans-first:2.42 16:04:08 INFO - PID 32212 | Values: 85.0 82.0 88.0 80.0 82.0 83.0 83.0 84.0 84.0 80.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:116.00 stddev:4.52 (3.9%) stddev-sans-first:4.80 16:04:08 INFO - PID 32212 | Values: 117.0 114.0 113.0 116.0 119.0 129.0 116.0 116.0 115.0 115.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:2.56 (1.7%) stddev-sans-first:2.69 16:04:08 INFO - PID 32212 | Values: 151.0 149.0 148.0 147.0 148.0 152.0 149.0 149.0 155.0 153.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.72 (1.8%) stddev-sans-first:1.73 16:04:08 INFO - PID 32212 | Values: 94.0 96.0 94.0 95.0 95.0 95.0 95.0 96.0 100.0 95.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.84 (3.3%) stddev-sans-first:1.69 16:04:08 INFO - PID 32212 | Values: 58.0 56.0 53.0 53.0 55.0 57.0 58.0 55.0 55.0 54.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#9] json-stringify-tinderbox Cycles:10 Average:42.50 Median:44.00 stddev:4.01 (9.1%) stddev-sans-first:4.04 16:04:08 INFO - PID 32212 | Values: 39.0 38.0 45.0 46.0 39.0 39.0 47.0 43.0 49.0 40.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:81.00 stddev:4.18 (5.2%) stddev-sans-first:3.84 16:04:08 INFO - PID 32212 | Values: 73.0 74.0 73.0 82.0 80.0 84.0 82.0 83.0 79.0 79.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:116.00 stddev:4.61 (4.0%) stddev-sans-first:4.66 16:04:08 INFO - PID 32212 | Values: 112.0 115.0 121.0 114.0 122.0 115.0 121.0 115.0 117.0 107.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:170.50 stddev:4.72 (2.8%) stddev-sans-first:5.00 16:04:08 INFO - PID 32212 | Values: 171.0 173.0 169.0 170.0 169.0 170.0 168.0 184.0 168.0 171.0 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:2.91 (4.4%) stddev-sans-first:3.06 16:04:08 INFO - PID 32212 | Values: 66.0 66.0 65.0 73.0 67.0 66.0 69.0 70.0 65.0 63.0 16:04:08 INFO - PID 32212 | -------- Summary: end -------- 16:04:08 INFO - PID 32212 | 16:04:08 INFO - PID 32212 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:04:09 INFO - TEST-INFO | 32212: exit 0 16:04:09 INFO - TEST-OK | kraken | took 62494ms 16:04:09 INFO - SUITE-END | took 1175s 16:04:09 INFO - Completed test suite (00:19:35) 16:04:09 INFO - javascript benchmark 16:04:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8502.053507074237, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.875764969401, 3141.4659507883666, 3153.76346773992, 3157.352742687749, 3177.888773892913, 6271.498280137589, 6354.428101470867, 6442.0, 6453.935460645392, 6487.837804054895, 6320.304766475696, 6339.11252424661, 6393.968030159855, 6427.068075129115, 6455.322191169918, 5862.912056319158, 5922.111683247525, 5950.523958083365, 5959.821205363846, 5969.283685957691, 5747.33905600855, 5876.823695289148, 5894.351621321673, 5934.406559344075, 5983.970080149593, 5803.274590676166, 5874.706264686792, 5907.6750778707365, 5916.201312822757, 5974.22335096439, 5635.154726790973, 5764.654120752768, 5776.335721392052, 5787.768489260467, 5792.131180322943, 5681.892031053946, 5730.885382292373, 5750.482456578928, 5775.624584402, 5776.566757493205, 6228.314885362606, 6306.558540902139, 6325.272593651743, 6341.112244285804, 6366.822137904503, 6778.423833974118, 6789.35501127397, 6876.518643694943, 6879.449644028466, 6879.931200687979, 6717.059611654372, 6867.07294515239, 6878.8624227515165, 6978.057962175092, 6995.510314278003, 6206.813795586139, 6269.2476902771505, 6292.622442653455, 6315.842103947392, 6317.3366796486625, 6960.721571137098, 6987.650617469208, 6999.930000700029, 7015.0, 7020.719171233196, 6623.370779775913, 6626.668666566652, 6642.7342906284175, 6714.429273511709, 6752.932470675329, 6899.517033807686, 6918.06606108179, 6953.130858642669, 6966.651667416609, 6987.755428559976, 6816.522843400914, 6858.897116543256, 6865.931340686529, 6910.896336554955, 6940.861182776316, 6738.629375384401, 6780.491463140185, 6783.59298442095, 6837.0, 6884.690188941509, 5395.136778115482, 5402.270693456333, 5414.485623865727, 5424.701641409761, 5442.836714898559, 4648.48866624671, 4704.9059018819435, 4714.528547145258, 4721.291806229025, 4748.881277968078, 5801.82594522165, 5829.09649004405, 5843.2695913010875, 5866.384029676822, 5869.354371019184, 6693.933060669331, 6810.148731408574, 6841.863162736718, 6847.315268473113, 6921.688524016431, 5696.3449203341315, 5709.229254050733, 5765.567582431335, 5767.8558036049435, 5768.048272035151, 5743.0, 5818.0, 5819.709014549256, 5828.591998560145, 5864.0031194697, 6592.17597800275, 6631.436327912182, 6662.86674266512, 6686.565373250821, 6700.961350990604, 6817.181938167451, 6867.107276054081, 6880.965595172092, 6949.339812717783, 6960.0, 6376.840578985377, 6575.80272591823, 6586.571872828251, 6602.273749887412, 6603.372679595431, 6714.496412769159, 6714.966425167843, 6725.798226053226, 6734.595924244561, 6735.25912149673, 6899.275576064441, 6924.307569243036, 6929.1684997800585, 6931.445484361138, 6931.549449285781, 6706.362895524917, 6709.094272273181, 6714.966425167843, 6722.092517510074, 6734.057231987624, 6514.54398192141, 6529.804105876831, 6578.309277525791, 6618.404343609098, 6707.865842683216, 6518.902216466662, 6595.142631457879, 6600.207975043026, 6618.371254730793, 6633.402993730588, 6657.467402607683, 6740.292269311652, 6744.5616034957575, 6801.5238933274195, 6819.454443644596, 6302.243730752339, 6415.71129299192, 6514.446272066738, 6535.901961470487, 6589.4069533742195], "value": 6212.0609378441495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.0407353947428, 896.3008853094589, 901.3780491460891, 903.0382642485754, 903.6837107012542, 39002.21995560087, 42351.94120146994, 42492.36261456081, 42617.360739588934, 42656.78671606642, 39078.609213907854, 39597.60402395975, 39633.80183099081, 39634.603653963524, 39684.60315396845, 7223.458240631948, 7247.492675512716, 7297.89053164203, 7299.598522081284, 7360.411167106646, 7140.321669441395, 7248.311410416002, 7288.234735352791, 7327.157376901671, 7327.377172940306, 7239.312265334811, 7268.6729097190755, 7284.344409003189, 7285.417166626684, 7320.780376588684, 7191.496595238335, 7837.529748215097, 8098.75703728889, 8145.3483721302155, 8157.714479993172, 7995.2804247618, 8081.111077781439, 8089.635966381527, 8106.878396824052, 8110.878336824952, 37464.812675936715, 37817.62182378196, 37858.0, 37928.0, 37936.241275174616, 3553.8045407502577, 3581.426971684518, 3582.5342705448124, 3586.6951309138753, 3593.443016332473, 30755.538666920012, 30961.535576966362, 31224.37551248985, 31266.531002034986, 31346.902858400073, 5097.949020509822, 5115.667481613683, 5136.948630513722, 5154.871128221787, 5229.973850130725, 177100.0, 178236.0, 179899.0, 180497.0, 180881.0, 42388.576114238465, 43182.784086079366, 47666.76166619144, 47971.0, 48050.0, 52207.73896130495, 52638.73680631573, 52752.47247527476, 53001.46998529966, 53092.46907530953, 15708.450204242796, 15714.528564143095, 15834.208289585475, 15857.207139642971, 15879.52361429159, 12761.425735841909, 12790.10469267161, 12896.226226426445, 12914.483420663257, 12924.095313328166, 14195.219262940638, 14232.217228052557, 14272.21502817355, 14290.499832505813, 14360.210188439736, 5618.690971996498, 5667.348254950651, 5738.713064346766, 5795.88408231833, 5890.350701803502, 989.6783545347647, 989.747614358334, 1006.8439391894268, 1007.6120693533043, 1022.754538910656, 22422.887885560467, 22829.885850570972, 22968.196113136295, 23037.884810576175, 23099.53800923972, 1082.0856376361962, 1102.2284400919389, 1104.917131215162, 1114.1087130295732, 1128.1764312052248, 12024.939875300568, 12215.144939854124, 12281.508739650313, 12291.56979505713, 12295.754084918251, 218622.0, 218682.0, 218695.0, 219457.0, 219508.0, 52146.47853521492, 52406.475935240924, 52513.0, 52638.21042684363, 52959.73520132375, 1430.5064752660317, 1472.4846303793802, 1474.8820094392422, 1483.5475180069966, 1486.323722706166, 22356.329310120724, 22374.440638984157, 22445.77554224437, 22563.887180563994, 22830.54338913179, 37920.051998700255, 37962.43056354102, 38014.049648759, 38039.0, 38049.239015218984, 183184.0, 185677.0, 186144.0, 186623.0, 187041.0, 32812.17969550685, 33316.83341583374, 33628.159296017795, 34090.318193635496, 34167.97496075122, 43056.56943430525, 43262.134757305306, 43270.350944736485, 43584.78207608942, 43605.78197109121, 31248.0, 31563.21091972719, 31802.681973179973, 31884.362312754078, 31905.361892762478, 30652.693473064985, 31055.0, 31163.37673246477, 31202.687973120886, 31470.842645786626, 34854.30291394208, 35530.28939421249, 35777.46333804943, 35784.642153578134, 35850.4622430669, 30270.697293027668, 30314.0, 30985.0, 31209.0, 31998.52002220015, 22750.0, 22832.200872969366, 23075.538489229784, 23155.0, 23351.76648233564], "value": 16937.430337912818, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8494991302263, 586.1998372221918, 591.3317950715691, 605.300877486503, 607.3410349770501, 21875.453113672145, 22400.663990040164, 22463.887680561595, 22618.66072008921, 22698.319050428494, 23487.76512234877, 24020.639690404616, 25067.498650026988, 25268.115615953444, 25829.095981640647, 6476.643784591857, 6677.332266773333, 6679.6994135263785, 6688.799336019927, 6707.295733947938, 6510.08858759774, 6582.3417658234275, 6623.2052153741615, 6625.801225963229, 6663.267040625527, 6457.225132984048, 6685.8662826743675, 6698.732050717966, 6703.061571380011, 6726.125603671516, 6631.502637302197, 6749.865002699968, 6751.831204219885, 6754.696038678271, 6787.864242715167, 6252.030935205005, 6304.527160462938, 6314.084457753646, 6318.178636777189, 6319.273283572356, 28779.56830647542, 29623.407531849458, 30071.09786706402, 30602.54096188559, 30661.693383066107, 2003.24878170686, 2032.4918770307422, 2032.7967203279554, 2035.3588619584932, 2036.4603380104284, 19829.9008504958, 20240.696389554167, 20543.691844622343, 20551.075201615964, 20570.897145514326, 2399.9040038398443, 2457.8033757299554, 2526.4441822798954, 2527.949441011188, 2539.0351666366846, 118612.0, 125544.37227813802, 139933.0, 146453.0, 147636.0, 14592.45796462375, 14796.112233266038, 15017.70578921882, 15075.0, 15352.616184595474, 23744.168954086523, 23796.643050354258, 23841.046358145828, 23956.0, 23990.760092398854, 9938.850917236246, 9971.650992215238, 10001.24990625706, 10035.498225088862, 10197.847032294521, 9324.0, 9333.439993600407, 9343.392679475812, 9418.434893906388, 9440.57517411718, 9015.14356136166, 9102.271818254523, 9157.587908543997, 9442.48066356357, 9457.101575350469, 2701.8784154713085, 2758.5586306191312, 2837.929051773722, 2859.442408730319, 2959.674435812059, 953.1707414549248, 965.7826988927435, 966.1111777165025, 971.7279161834698, 974.8196583632051, 19055.61888762217, 19406.12672429716, 19625.705614415794, 19817.30639427642, 19830.603387932162, 988.3871999360299, 1029.552144817007, 1039.599754094664, 1042.801867645145, 1053.4785281285813, 10645.20160987929, 10879.12966962641, 10963.725906852393, 10989.6153634624, 11124.55501779936, 451103.0, 458771.0, 460137.0, 475703.0, 477953.0, 109180.454097729, 110609.0, 111062.0, 111273.0, 111930.44034779775, 1134.773045390925, 1139.0432037088885, 1151.758130792543, 1153.6193056291404, 1156.4738044190042, 16982.74525882088, 17343.826561734222, 17626.5593360167, 17852.928824270584, 17874.46376608704, 55467.44532554623, 55834.720826395605, 55846.720766395905, 57498.7125064372, 58252.70873645604, 70798.64600676963, 71145.6442717783, 71750.64124679343, 72527.0, 72923.0, 14483.348249329016, 14684.118952862862, 14844.777328339867, 14864.108153510824, 14882.330295136528, 22674.546509070056, 22781.31656050321, 23100.653490197325, 23138.3058508245, 23581.056757730184, 17498.650026999643, 17561.473155805346, 18114.27542898269, 18420.539486512946, 18457.630847383247, 15683.686326273639, 16368.590785229988, 16749.413770517975, 16814.411495597597, 17069.82930170732, 18730.906345468185, 18968.810311897258, 18979.24083036663, 19224.423267301445, 19236.519087022938, 13617.65955851072, 14481.348339324966, 14485.637859053608, 14512.782308265596, 14741.631459213606, 18064.277428902697, 18127.184276707845, 18175.45473635793, 18212.45362639123, 18225.635487289914], "value": 11983.309663234204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.544214966911, 1376.2430663135278, 1399.0766094377714, 1400.9509667161649, 1407.1064873805137, 14843.851561484382, 15452.30464629093, 15513.301901414436, 15520.068795872256, 15535.456259030936, 15169.317380717866, 15232.923835380807, 15301.846981530209, 15333.539993800205, 15343.0, 2789.623400840891, 2807.270109771464, 2842.7157284271616, 2843.2607522044314, 2855.129185598392, 2767.114523352528, 2825.293676580855, 2839.6308479897584, 2845.8007939444246, 2850.957235641467, 2745.862706864659, 2759.310172456886, 2766.585012248159, 2774.1261502626608, 2781.680106787725, 2323.512062466884, 2409.2170044735444, 2761.9723802761914, 2861.3275880168144, 2866.584345269924, 2664.521190739139, 2686.6910305314946, 2709.1195361507393, 2715.5383584790634, 2719.0, 14666.19335936523, 14716.33776480061, 14783.260836958108, 14795.0, 14849.628759281104, 8045.919540804575, 8307.916920830774, 8317.625706843206, 8355.791105222357, 8394.24451799341, 5158.40678321994, 5353.892922141575, 5355.143177091647, 5505.03661859177, 5508.173773933902, 1873.0541076756151, 1900.4773687235981, 1905.4664693885734, 1932.6424611446928, 1946.698261769428, 26303.342416439744, 26726.19821405361, 26912.59631105535, 26973.055943042094, 27448.588271175948, 6893.172819261721, 7028.964855175794, 7136.857262854714, 7154.35610795031, 7181.461390395742, 16705.248263828158, 16724.0, 16785.83214167867, 16807.41174058902, 16887.831121688872, 7720.7683769487, 8004.0, 8039.598020099089, 8108.5945702714625, 8160.836783264302, 7400.0, 7468.5145465544565, 7500.249975002456, 7509.66206520697, 7552.811179720551, 5274.182501712241, 5293.761780719877, 5386.703731294817, 5417.241586177938, 5420.810271640474, 1565.2078370266208, 1567.615934096131, 1570.2227397438112, 1583.6595132046666, 1596.9840301597067, 851.4635779458902, 857.34413173922, 872.7643536245305, 873.366809063424, 882.0, 7248.710051597983, 7275.636218189069, 7363.190049094595, 7385.29839665231, 7524.134724506752, 693.6913073682264, 708.0794966543473, 725.1942662769666, 744.2706147975015, 756.5158298688843, 4386.605205531518, 4440.2007638625355, 4448.243798554254, 4452.176347375681, 4475.283954567253, 21692.674609880865, 21968.121275149133, 22254.0, 22466.32601021972, 22726.772732272795, 20636.0, 21330.466738331666, 21646.458838529164, 21703.34889953304, 21874.453138671342, 9601.37591056593, 9954.900450995543, 11251.549938002388, 11862.822057669142, 11883.821742673867, 8243.134470880472, 8835.425697329652, 8855.070217627057, 8915.28677705769, 9007.324450666358, 18453.261869525606, 18618.627627447106, 18797.718034229772, 18865.24539018424, 18918.14868330956, 18858.434246972614, 19735.0, 19899.701504477154, 19939.601207976048, 20117.49706257355, 10162.0, 10422.062014418738, 10569.63006294776, 10587.311824731369, 10605.151587873106, 13209.207447553177, 13297.069205155933, 13298.135621184592, 13312.866871331164, 13330.066895317623, 10837.024667779622, 10880.891191087987, 11137.498812553617, 11179.10567154642, 11388.772224555296, 10081.0, 10418.374897506174, 10619.734506637396, 10763.838542422027, 10823.188260880308, 9876.35803672759, 10037.949810250902, 10062.69811905644, 10064.39613623185, 10064.496775161359, 6714.462842972453, 6792.626405547742, 6802.557833740791, 6973.442124629916, 6992.895106573507, 6716.731330746716, 6813.7955861324235, 6842.247352791289, 6865.656717164222, 6874.896876546756], "value": 6573.497089256175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.6564234783866, 520.6719766547076, 538.5772168847456, 549.066586802436, 555.96664200148, 6011.278646562413, 6134.846628834276, 6155.446009859112, 6197.907031394533, 6314.747904829005, 6119.602225855328, 6183.25800903891, 6215.254169499655, 6228.968855155729, 6271.404216599427, 5165.76754046067, 5186.273921650972, 5213.843584692465, 5250.6587071840395, 5254.238135470355, 5064.366954130734, 5172.482751724835, 5236.842894713165, 5265.183127027041, 5281.8943621127555, 5186.5850731941355, 5219.556337711299, 5256.500632439912, 5263.736813159327, 5284.075286824809, 5180.300659410969, 5181.81863634771, 5204.9479505204845, 5224.537129603717, 5283.762230699608, 4812.181929072031, 4827.227643577046, 4855.393075865517, 4864.537868902484, 4931.926021109686, 6184.19605451293, 6193.473554747807, 6199.907001394983, 6212.502999760053, 6238.532110091761, 5997.73010214537, 6003.699815009232, 6028.156058151862, 6097.69511524422, 6141.846453838645, 6599.406053455212, 6617.338266173392, 6639.668016599151, 6646.435053020499, 6666.966530228734, 5254.133068043769, 5299.49654782795, 5306.469353064701, 5318.25544423781, 5353.38436079848, 6878.209005964328, 7018.824529386755, 7034.331738484836, 7064.999999999948, 7071.646417679095, 5513.117901135799, 5526.143447765603, 5546.861328466821, 5585.804496842591, 5614.9438505615235, 5558.944410555923, 5639.0, 5639.746211420496, 5657.32112146545, 5681.34664513578, 6066.423689749467, 6082.817515474454, 6104.175936248638, 6122.54080943931, 6137.0, 6743.123393958754, 6782.118324617768, 6792.524523283323, 6794.3545363190415, 6801.829954251183, 1834.4313262888547, 1852.9629407411776, 1854.8052454492354, 1896.3741965151467, 1905.4664693885734, 1433.5341014170435, 1450.9637259068397, 1458.3874772595536, 1465.6116129225763, 1490.5304828978838, 5567.805126820542, 5634.154876768435, 5640.605157638925, 5641.858953526113, 5652.802151924663, 6542.509311801634, 6623.271440141581, 6648.767293144717, 6704.396604305636, 6713.899291510631, 5628.831135065954, 5664.1874600128385, 5676.943230567642, 5720.256366672306, 5731.942680573141, 3492.231709024011, 3511.3328467591587, 3537.858485660545, 3544.680978711928, 3598.892033239007, 6349.8730025400155, 6357.427831495188, 6399.360063993563, 6558.540902136805, 6581.934180658132, 6707.0, 6768.052472653832, 6822.147231596051, 6927.480438966997, 7005.124359455068, 6505.479561635152, 6515.674216289071, 6520.771772987922, 6557.114789503451, 6590.340965903467, 6689.866202676017, 6750.527463077734, 6767.796966091025, 6836.453083753188, 6850.21222559412, 6696.229933557508, 6728.865422691617, 6744.055832183596, 6769.830754230987, 6785.5250132490255, 6391.808245752635, 6392.712327945346, 6401.295857455583, 6465.935340646722, 6470.22357317125, 4950.504949505164, 4977.527134922177, 5018.673786203885, 5027.874303142451, 5086.109930762028, 6456.483481321389, 6690.632015239208, 6716.1940567130305, 6824.0, 6834.658267086526, 6222.315545289924, 6271.278802937538, 6358.77744278948, 6491.285958544462, 6585.670716464062, 6417.839554011187, 6430.356964303533, 6510.0, 6582.670866456754, 6595.647892182187, 6367.662790813795, 6448.161738973903, 6450.838729031811, 6506.479481641362, 6537.084808126961, 6314.916492223804, 6423.678816059271, 6603.669816509251, 6690.866182676222, 6691.230508491391, 6336.94049433945, 6393.488520918222, 6398.936010639834, 6399.680015999088, 6472.676366181578], "value": 5197.052908088368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.3045593980755, 904.3353135445446, 905.8233644439333, 915.7939463620686, 927.0914503786287, 18952.147153378097, 19724.112414941344, 19737.309194178208, 19761.604767904635, 19812.801871981275, 16475.752863707054, 16585.170741462938, 16956.49130526083, 17752.911235443837, 17824.554386140353, 945.8723072385243, 954.8233576788316, 955.1928620315857, 957.5403806173041, 961.4952150121208, 965.377331621104, 978.9461579613119, 980.039561229995, 980.8038392321529, 988.940663560185, 986.6004268271362, 1014.8122597319519, 1018.1294992781177, 1018.5365658625345, 1047.08903254169, 982.1160955140359, 998.6055508074306, 998.9550470228858, 1001.62439085343, 1002.6190047781832, 744.9180590135081, 747.0661672908864, 748.4386709967524, 754.0988518720131, 756.9016027916391, 19787.406377808544, 20104.39686809398, 20229.696554551694, 20386.69419958702, 20408.489787755276, 21934.232301869517, 21992.0, 22324.776752232432, 22345.441363965867, 22404.66393004106, 17272.740908886375, 17390.0, 17462.738058929128, 17686.646267074586, 17689.911550442295, 3790.336691079078, 3790.3935370340614, 3808.923821523582, 3834.2523207974455, 3838.5777564467885, 124117.0, 125653.37173314167, 128159.0, 130342.0, 130807.0, 16897.98612083279, 16919.91540042292, 16979.49061528156, 17094.57263568396, 17152.31390744381, 30435.695643043287, 30784.0, 31049.223769405493, 31198.220044498616, 31324.843375783432, 8250.587470626444, 8340.457870238415, 8363.790905227417, 8370.707025254087, 8383.664653413916, 4353.521112677603, 4442.0, 4457.955420445754, 4471.8434854779925, 4474.261746811805, 5281.603879709037, 5356.812511562077, 5499.395066542677, 5506.559475241971, 5535.114381698909, 976.8046390721884, 981.3621146254849, 986.7138529826414, 992.6972273456665, 993.279872092727, 689.9793006209821, 695.7112798188695, 704.3132945378215, 712.6828561290176, 716.2300526933567, 12032.81950770739, 12156.817647735292, 12184.939075304566, 12745.362731863555, 12939.02957278208, 656.9737210511622, 657.0571230284557, 667.4927055437902, 675.2943174382782, 677.5155763628931, 5256.92114618281, 5296.172108155544, 5306.734663266821, 5335.439778823167, 5373.328333958255, 115091.42454287675, 115826.42086789681, 117507.0, 119400.40299798445, 122101.0, 107240.46379768051, 109479.45260273648, 109794.45102774435, 112137.43931280292, 113693.0, 89458.0, 90016.54991725131, 91580.0, 91810.54094729618, 92382.53808730913, 9914.603415863285, 9966.750831229278, 10137.949310253402, 10234.590616375559, 10276.22928280367, 43101.3534796972, 43446.56553434425, 43815.56184438115, 44055.0, 45116.0976780456, 53647.463525365805, 54413.45586544084, 54619.72690136524, 55067.72466137644, 55589.7220513911, 14038.719225615227, 14236.0, 14241.50154744579, 14272.286385680882, 14465.0, 17559.0, 17596.120193990504, 17671.204795784477, 17785.46643600694, 18000.369987050915, 14307.926905481921, 14424.206668633326, 14474.34865431037, 14695.92652036733, 14944.7758283628, 14458.421663133777, 14648.853511465175, 14734.410623574937, 14778.778318325449, 14812.259387030821, 15387.307571159101, 15659.451919182773, 15675.137867416945, 15755.527334179993, 15814.130222837854, 10686.946565267124, 10901.182411319025, 10950.616728414467, 11230.719232019264, 11261.380624065756, 11948.522059117886, 11985.34080625574, 12117.515299387926, 12284.570040048555, 12533.060020498317], "value": 8768.088253460546, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 115.0, 134.0, 116.0, 107.0, 116.0, 106.0, 112.0, 107.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 125.0, 127.0, 117.0, 116.0, 118.0, 125.0, 149.0, 119.0, 122.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 163.0, 165.0, 162.0, 167.0, 175.0, 164.0, 166.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 74.0, 74.0, 77.0, 74.0, 84.0, 85.0, 80.0, 74.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 88.0, 80.0, 82.0, 83.0, 83.0, 84.0, 84.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 116.0, 119.0, 129.0, 116.0, 116.0, 115.0, 115.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 147.0, 148.0, 152.0, 149.0, 149.0, 155.0, 153.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 100.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 53.0, 53.0, 55.0, 57.0, 58.0, 55.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 45.0, 46.0, 39.0, 39.0, 47.0, 43.0, 49.0, 40.0], "value": 42.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 82.0, 80.0, 84.0, 82.0, 83.0, 79.0, 79.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 121.0, 114.0, 122.0, 115.0, 121.0, 115.0, 117.0, 107.0], "value": 115.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 169.0, 170.0, 169.0, 170.0, 168.0, 184.0, 168.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 73.0, 67.0, 66.0, 69.0, 70.0, 65.0, 63.0], "value": 67.0, "unit": "score"}]}]} 16:04:09 INFO - Return code: 0 16:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:09 INFO - # TBPL SUCCESS # 16:04:09 INFO - Running post-action listener: _package_coverage_data 16:04:09 INFO - Running post-action listener: _resource_record_post_action 16:04:09 INFO - [mozharness: 2017-09-24 23:04:09.839555Z] Finished run-tests step (success) 16:04:09 INFO - Running post-run listener: _resource_record_post_run 16:04:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 340484096; Read time: 260; Write time: 179000 16:04:09 INFO - TinderboxPrint: CPU usage
13.3% 16:04:09 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 260 16:04:09 INFO - TinderboxPrint: I/O write bytes / time
340,484,096 / 179,000 16:04:09 INFO - TinderboxPrint: CPU idle
8,251.2 (86.7%) 16:04:09 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 16:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 16:04:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10145792; Read time: 0; Write time: 1352 16:04:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:04:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 330338304; Read time: 248; Write time: 177648 16:04:10 INFO - Running post-run listener: _upload_blobber_files 16:04:10 INFO - Blob upload gear active. 16:04:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:17 INFO - (blobuploader) - INFO - Done attempting. 16:04:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:04:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:04:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:18 INFO - (blobuploader) - INFO - Done attempting. 16:04:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:04:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:04:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:19 INFO - (blobuploader) - INFO - Done attempting. 16:04:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:20 INFO - (blobuploader) - INFO - Done attempting. 16:04:20 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:20 INFO - Return code: 0 16:04:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ec0ae1482ef819c9f052131c8e127c67f240611b0d33c47f68c8b2f11503cf6f2dbc0f25749bc743f3703a51dfd3b489e3c6d3b6a77895888b065ffc838b7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0f9912dfef500b7e2a4b3b2ab72eadf0b2ab7cf76798f730c7ae7ff683158ffba51f046410d58e2c5e12a7f7b2ab0ea4432a5b8e834242324705aa98f4f2e2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d3dedabe04e2a41e9a70478afd85e20797df82fa23999cdf57965c74700bcf387b504fb2e0045caa8660949239d956290c727daf5d3f4a5140d98c036fcdf40", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df71ebc5511175e9fa82ba3ff6952b32bd209c1372753906a15783bc432ec61f73226b0045af5f5374a7ad347fa2ae1bf0ad130fd1ac6b684898374c896d6cf7"} 16:04:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:20 INFO - Contents: 16:04:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ec0ae1482ef819c9f052131c8e127c67f240611b0d33c47f68c8b2f11503cf6f2dbc0f25749bc743f3703a51dfd3b489e3c6d3b6a77895888b065ffc838b7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0f9912dfef500b7e2a4b3b2ab72eadf0b2ab7cf76798f730c7ae7ff683158ffba51f046410d58e2c5e12a7f7b2ab0ea4432a5b8e834242324705aa98f4f2e2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d3dedabe04e2a41e9a70478afd85e20797df82fa23999cdf57965c74700bcf387b504fb2e0045caa8660949239d956290c727daf5d3f4a5140d98c036fcdf40", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df71ebc5511175e9fa82ba3ff6952b32bd209c1372753906a15783bc432ec61f73226b0045af5f5374a7ad347fa2ae1bf0ad130fd1ac6b684898374c896d6cf7"} 16:04:20 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:20 INFO - Copying logs to upload dir... 16:04:20 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.563220 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-24 16:04:20.673282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:20.677322) ========= 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=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ec0ae1482ef819c9f052131c8e127c67f240611b0d33c47f68c8b2f11503cf6f2dbc0f25749bc743f3703a51dfd3b489e3c6d3b6a77895888b065ffc838b7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0f9912dfef500b7e2a4b3b2ab72eadf0b2ab7cf76798f730c7ae7ff683158ffba51f046410d58e2c5e12a7f7b2ab0ea4432a5b8e834242324705aa98f4f2e2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d3dedabe04e2a41e9a70478afd85e20797df82fa23999cdf57965c74700bcf387b504fb2e0045caa8660949239d956290c727daf5d3f4a5140d98c036fcdf40", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df71ebc5511175e9fa82ba3ff6952b32bd209c1372753906a15783bc432ec61f73226b0045af5f5374a7ad347fa2ae1bf0ad130fd1ac6b684898374c896d6cf7"} build_url:https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/B7iTL-CwQoyRUaZIwcocAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ec0ae1482ef819c9f052131c8e127c67f240611b0d33c47f68c8b2f11503cf6f2dbc0f25749bc743f3703a51dfd3b489e3c6d3b6a77895888b065ffc838b7a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0f9912dfef500b7e2a4b3b2ab72eadf0b2ab7cf76798f730c7ae7ff683158ffba51f046410d58e2c5e12a7f7b2ab0ea4432a5b8e834242324705aa98f4f2e2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d3dedabe04e2a41e9a70478afd85e20797df82fa23999cdf57965c74700bcf387b504fb2e0045caa8660949239d956290c727daf5d3f4a5140d98c036fcdf40", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df71ebc5511175e9fa82ba3ff6952b32bd209c1372753906a15783bc432ec61f73226b0045af5f5374a7ad347fa2ae1bf0ad130fd1ac6b684898374c896d6cf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:20.705266) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:20.705579) ========= 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=32c5991c409366f7fec8a718000001d2-1506290254.783009-1963632892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:04:20.789903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:20.790208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:04:20.790482) ========= ========= Total master_lag: 0.22 =========