builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-042 starttime: 1506279925.71 results: success (0) revision: 877c02446745576ac97f181dd9eeec78ef605451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.714253) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.714703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.715001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.815489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.815778) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 12:05:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.9M=0s 2017-09-24 12:05:25 (69.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.985420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:25.985698) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016826 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.061315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.061650) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 877c02446745576ac97f181dd9eeec78ef605451 --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 877c02446745576ac97f181dd9eeec78ef605451 --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=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 12:05:26,028 truncating revision to first 12 chars 2017-09-24 12:05:26,028 Setting DEBUG logging. 2017-09-24 12:05:26,028 attempt 1/10 2017-09-24 12:05:26,028 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/877c02446745?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 12:05:26,380 unpacking tar archive at: mozilla-central-877c02446745/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649591 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.743870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.744183) ========= script_repo_revision: 877c02446745576ac97f181dd9eeec78ef605451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.744574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.744834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 12:05:26.779863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-24 12:05:26.780155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:26 INFO - MultiFileLogger online at 20170924 12:05:26 in /builds/slave/test 12:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:05:26 INFO - {'append_to_log': False, 12:05:26 INFO - 'base_work_dir': '/builds/slave/test', 12:05:26 INFO - 'blob_upload_branch': 'Firefox', 12:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:05:26 INFO - 'branch': 'Firefox', 12:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:26 INFO - 'code_coverage': False, 12:05:26 INFO - 'config_files': ('talos/linux_config.py',), 12:05:26 INFO - 'default_actions': ('clobber', 12:05:26 INFO - 'read-buildbot-config', 12:05:26 INFO - 'download-and-extract', 12:05:26 INFO - 'populate-webroot', 12:05:26 INFO - 'create-virtualenv', 12:05:26 INFO - 'install', 12:05:26 INFO - 'setup-mitmproxy', 12:05:26 INFO - 'run-tests'), 12:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:26 INFO - 'disable_ccov_upload': False, 12:05:26 INFO - 'disable_stylo': False, 12:05:26 INFO - 'download_minidump_stackwalk': True, 12:05:26 INFO - 'download_symbols': 'ondemand', 12:05:26 INFO - 'enable_stylo': False, 12:05:26 INFO - 'enable_webrender': False, 12:05:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:26 INFO - 'gecko_profile': False, 12:05:26 INFO - 'gecko_profile_interval': 0, 12:05:26 INFO - 'installer_path': 'installer.exe', 12:05:26 INFO - 'log_level': 'info', 12:05:26 INFO - 'log_name': 'talos', 12:05:26 INFO - 'log_to_console': True, 12:05:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:26 INFO - 'opt_config_files': (), 12:05:26 INFO - 'pip_index': False, 12:05:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:05:26 INFO - 'system_bits': '32', 12:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:26 INFO - 'title': 'talos-linux64-ix-042', 12:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:26 INFO - 'use_talos_json': True, 12:05:26 INFO - 'verify': 'False', 12:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:26 INFO - 'work_dir': 'build'} 12:05:26 INFO - [mozharness: 2017-09-24 19:05:26.892754Z] Running clobber step. 12:05:26 INFO - Running pre-action listener: _resource_record_pre_action 12:05:26 INFO - Running main action method: clobber 12:05:26 INFO - rmtree: /builds/slave/test/build 12:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:05:27 INFO - Running post-action listener: _resource_record_post_action 12:05:27 INFO - [mozharness: 2017-09-24 19:05:27.887253Z] Finished clobber step (success) 12:05:27 INFO - [mozharness: 2017-09-24 19:05:27.887361Z] Running read-buildbot-config step. 12:05:27 INFO - Running pre-action listener: _resource_record_pre_action 12:05:27 INFO - Running main action method: read_buildbot_config 12:05:27 INFO - Using buildbot properties: 12:05:27 INFO - { 12:05:27 INFO - "project": "", 12:05:27 INFO - "product": "firefox", 12:05:27 INFO - "who": "ffxbld@noreply.mozilla.org", 12:05:27 INFO - "installer_path": "public/build/target.tar.bz2", 12:05:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:05:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:05:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:05:27 INFO - "stage_platform": "linux64-pgo", 12:05:27 INFO - "basedir": "/builds/slave/test", 12:05:27 INFO - "buildnumber": 54, 12:05:27 INFO - "platform": "ubuntu64_hw", 12:05:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:05:27 INFO - "slavebuilddir": "test", 12:05:27 INFO - "taskId": "eTZ41oQcR0SKkiagioLSmw", 12:05:27 INFO - "branch": "mozilla-central", 12:05:27 INFO - "script_repo_revision": "production", 12:05:27 INFO - "revision": "877c02446745576ac97f181dd9eeec78ef605451", 12:05:27 INFO - "slavename": "talos-linux64-ix-042", 12:05:27 INFO - "repo_path": "mozilla-central" 12:05:27 INFO - } 12:05:27 INFO - Finding installer, test and symbols from parent task. 12:05:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTZ41oQcR0SKkiagioLSmw'}, attempt #1 12:05:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTZ41oQcR0SKkiagioLSmw'}, attempt #1 12:05:28 INFO - Task dependencies: GuT1PCFFRDO-QtxXURDi3Q 12:05:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q'}, attempt #1 12:05:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 12:05:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.test_packages.json 12:05:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.crashreporter-symbols.zip 12:05:29 INFO - Running post-action listener: _resource_record_post_action 12:05:29 INFO - [mozharness: 2017-09-24 19:05:29.236737Z] Finished read-buildbot-config step (success) 12:05:29 INFO - [mozharness: 2017-09-24 19:05:29.236943Z] Running download-and-extract step. 12:05:29 INFO - Running pre-action listener: _resource_record_pre_action 12:05:29 INFO - Running main action method: download_and_extract 12:05:29 INFO - mkdir: /builds/slave/test/build/tests 12:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:29 INFO - trying https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.test_packages.json 12:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:05:29 INFO - Downloaded 989 bytes. 12:05:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:05:29 INFO - Using the following test package requirements: 12:05:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:05:29 INFO - u'common': [u'target.common.tests.zip'], 12:05:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:05:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:05:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:05:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:05:29 INFO - u'mozbase': [u'target.common.tests.zip'], 12:05:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:05:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:05:29 INFO - u'web-platform': [u'target.common.tests.zip', 12:05:29 INFO - u'target.web-platform.tests.tar.gz'], 12:05:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:05:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:05:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.common.tests.zip 12:05:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:05:29 INFO - Fetch https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.common.tests.zip into memory 12:05:31 INFO - Content-Length response header: 55342846 12:05:31 INFO - Bytes received: 55342846 12:05:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.talos.tests.zip 12:05:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:05:42 INFO - Fetch https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.talos.tests.zip into memory 12:05:44 INFO - Content-Length response header: 14513823 12:05:44 INFO - Bytes received: 14513823 12:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:44 INFO - trying https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 12:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:05:47 INFO - Downloaded 62437120 bytes. 12:05:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 12:05:47 INFO - mkdir: /builds/slave/test/properties 12:05:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:05:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:05:47 INFO - Contents: 12:05:47 INFO - build_url:https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 12:05:47 INFO - Running post-action listener: _resource_record_post_action 12:05:47 INFO - Running post-action listener: find_tests_for_verification 12:05:47 INFO - Running post-action listener: set_extra_try_arguments 12:05:47 INFO - [mozharness: 2017-09-24 19:05:47.397662Z] Finished download-and-extract step (success) 12:05:47 INFO - [mozharness: 2017-09-24 19:05:47.398012Z] Running populate-webroot step. 12:05:47 INFO - Running pre-action listener: _resource_record_pre_action 12:05:47 INFO - Running main action method: populate_webroot 12:05:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:05:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['tresize', 12:05:47 INFO - 'tcanvasmark']}, 12:05:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:05:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['dromaeo_css', 12:05:47 INFO - 'kraken']}, 12:05:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'tests': ['damp', 'tps']}, 12:05:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['damp', 'tps']}, 12:05:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['dromaeo_dom']}, 12:05:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:05:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['basic_compositor_video', 12:05:47 INFO - 'glvideo']}, 12:05:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:05:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['ts_paint_webext', 12:05:47 INFO - 'tp5o_webext']}, 12:05:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:05:47 INFO - 'ts_paint', 12:05:47 INFO - 'tpaint', 12:05:47 INFO - 'sessionrestore', 12:05:47 INFO - 'sessionrestore_many_windows', 12:05:47 INFO - 'sessionrestore_no_auto_restore', 12:05:47 INFO - 'tabpaint']}, 12:05:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['a11yr', 12:05:47 INFO - 'ts_paint', 12:05:47 INFO - 'tpaint', 12:05:47 INFO - 'sessionrestore', 12:05:47 INFO - 'sessionrestore_many_windows', 12:05:47 INFO - 'sessionrestore_no_auto_restore', 12:05:47 INFO - 'tabpaint']}, 12:05:47 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:05:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:05:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['perf_reftest_singletons']}, 12:05:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['perf_reftest']}, 12:05:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:05:47 INFO - 'tsvgr_opacity', 12:05:47 INFO - 'tart', 12:05:47 INFO - 'tscrollx', 12:05:47 INFO - 'tsvg_static']}, 12:05:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['tsvgx', 12:05:47 INFO - 'tsvgr_opacity', 12:05:47 INFO - 'tart', 12:05:47 INFO - 'tscrollx', 12:05:47 INFO - 'tsvg_static']}, 12:05:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:05:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--disable-stylo'], 12:05:47 INFO - 'tests': ['tp5o']}, 12:05:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:05:47 INFO - 'talos_options': ['--mitmproxy', 12:05:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:47 INFO - '--firstNonBlankPaint'], 12:05:47 INFO - 'tests': ['tp6_google', 12:05:47 INFO - 'tp6_youtube', 12:05:47 INFO - 'tp6_amazon', 12:05:47 INFO - 'tp6_facebook']}, 12:05:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:05:47 INFO - 'talos_options': ['--disable-stylo', 12:05:47 INFO - '--mitmproxy', 12:05:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:47 INFO - '--firstNonBlankPaint'], 12:05:47 INFO - 'tests': ['tp6_google', 12:05:47 INFO - 'tp6_youtube', 12:05:47 INFO - 'tp6_amazon', 12:05:47 INFO - 'tp6_facebook']}, 12:05:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:47 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:05:47 INFO - 'talos_options': ['--stylo-threads=1', 12:05:47 INFO - '--mitmproxy', 12:05:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:47 INFO - '--firstNonBlankPaint'], 12:05:47 INFO - 'tests': ['tp6_google', 12:05:47 INFO - 'tp6_youtube', 12:05:47 INFO - 'tp6_amazon', 12:05:47 INFO - 'tp6_facebook']}, 12:05:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--xperf_path', 12:05:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:47 INFO - 'tests': ['tp5n']}, 12:05:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:47 INFO - 'talos_options': ['--disable-stylo', 12:05:47 INFO - '--xperf_path', 12:05:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:47 INFO - 'tests': ['tp5n']}}} 12:05:47 INFO - Running post-action listener: _resource_record_post_action 12:05:47 INFO - [mozharness: 2017-09-24 19:05:47.809202Z] Finished populate-webroot step (success) 12:05:47 INFO - [mozharness: 2017-09-24 19:05:47.809425Z] Running create-virtualenv step. 12:05:47 INFO - Running pre-action listener: _resource_record_pre_action 12:05:47 INFO - Running main action method: create_virtualenv 12:05:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:05:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:05:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:05:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:05:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:05:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:05:48 INFO - Installing pip...............done. 12:05:48 INFO - Return code: 0 12:05:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:05:48 INFO - Reading from file tmpfile_stdout 12:05:48 INFO - Output received: 12:05:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:05:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:05:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:05:48 INFO - Using env: {'DISPLAY': ':0', 12:05:48 INFO - 'HOME': '/home/cltbld', 12:05:48 INFO - 'LANG': 'en_US.UTF-8', 12:05:48 INFO - 'LANGUAGE': 'en_US:en', 12:05:48 INFO - 'LOGNAME': 'cltbld', 12:05:48 INFO - 'MAIL': '/var/mail/cltbld', 12:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:48 INFO - 'MOZ_NO_REMOTE': '1', 12:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:48 INFO - 'NO_EM_RESTART': '1', 12:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:48 INFO - 'PWD': '/builds/slave/test', 12:05:48 INFO - 'SHELL': '/bin/bash', 12:05:48 INFO - 'SHLVL': '1', 12:05:48 INFO - 'TERM': 'linux', 12:05:48 INFO - 'TMOUT': '86400', 12:05:48 INFO - 'USER': 'cltbld', 12:05:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:48 INFO - '_': '/tools/buildbot/bin/python'} 12:05:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:05:49 INFO - Downloading/unpacking pip>=1.5 12:05:49 INFO - Running setup.py egg_info for package pip 12:05:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:05:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:05:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:05:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:05:49 INFO - Installing collected packages: pip 12:05:49 INFO - Found existing installation: pip 1.1 12:05:49 INFO - Uninstalling pip: 12:05:49 INFO - Successfully uninstalled pip 12:05:49 INFO - Running setup.py install for pip 12:05:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:05:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:05:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:05:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:05:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:05:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:05:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:05:49 INFO - Successfully installed pip 12:05:49 INFO - Cleaning up... 12:05:49 INFO - Return code: 0 12:05:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:50 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05:50 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 12:05:50 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 12:05:50 INFO - Using env: {'DISPLAY': ':0', 12:05:50 INFO - 'HOME': '/home/cltbld', 12:05:50 INFO - 'LANG': 'en_US.UTF-8', 12:05:50 INFO - 'LANGUAGE': 'en_US:en', 12:05:50 INFO - 'LOGNAME': 'cltbld', 12:05:50 INFO - 'MAIL': '/var/mail/cltbld', 12:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:50 INFO - 'MOZ_NO_REMOTE': '1', 12:05:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:50 INFO - 'NO_EM_RESTART': '1', 12:05:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:50 INFO - 'PWD': '/builds/slave/test', 12:05:50 INFO - 'SHELL': '/bin/bash', 12:05:50 INFO - 'SHLVL': '1', 12:05:50 INFO - 'TERM': 'linux', 12:05:50 INFO - 'TMOUT': '86400', 12:05:50 INFO - 'USER': 'cltbld', 12:05:50 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:50 INFO - '_': '/tools/buildbot/bin/python'} 12:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:50 INFO - Downloading/unpacking psutil>=3.1.1 12:05:50 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 12:05:50 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 12:05:50 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 12:05:50 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 12:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:51 INFO - Installing collected packages: psutil 12:05:51 INFO - Running setup.py install for psutil 12:05:51 INFO - building 'psutil._psutil_linux' extension 12:05:51 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 12:05:51 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 12:05:51 INFO - building 'psutil._psutil_posix' extension 12:05:51 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 12:05:51 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 12:05:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:51 INFO - Successfully installed psutil 12:05:51 INFO - Cleaning up... 12:05:51 INFO - Return code: 0 12:05:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:05:52 INFO - Using env: {'DISPLAY': ':0', 12:05:52 INFO - 'HOME': '/home/cltbld', 12:05:52 INFO - 'LANG': 'en_US.UTF-8', 12:05:52 INFO - 'LANGUAGE': 'en_US:en', 12:05:52 INFO - 'LOGNAME': 'cltbld', 12:05:52 INFO - 'MAIL': '/var/mail/cltbld', 12:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:52 INFO - 'MOZ_NO_REMOTE': '1', 12:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:52 INFO - 'NO_EM_RESTART': '1', 12:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:52 INFO - 'PWD': '/builds/slave/test', 12:05:52 INFO - 'SHELL': '/bin/bash', 12:05:52 INFO - 'SHLVL': '1', 12:05:52 INFO - 'TERM': 'linux', 12:05:52 INFO - 'TMOUT': '86400', 12:05:52 INFO - 'USER': 'cltbld', 12:05:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:52 INFO - '_': '/tools/buildbot/bin/python'} 12:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:05:53 INFO - Installing collected packages: mozsystemmonitor 12:05:53 INFO - Running setup.py install for mozsystemmonitor 12:05:53 INFO - Successfully installed mozsystemmonitor 12:05:53 INFO - Cleaning up... 12:05:54 INFO - Return code: 0 12:05:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:54 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05:54 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 12:05:54 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 12:05:54 INFO - Using env: {'DISPLAY': ':0', 12:05:54 INFO - 'HOME': '/home/cltbld', 12:05:54 INFO - 'LANG': 'en_US.UTF-8', 12:05:54 INFO - 'LANGUAGE': 'en_US:en', 12:05:54 INFO - 'LOGNAME': 'cltbld', 12:05:54 INFO - 'MAIL': '/var/mail/cltbld', 12:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:54 INFO - 'MOZ_NO_REMOTE': '1', 12:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:54 INFO - 'NO_EM_RESTART': '1', 12:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:54 INFO - 'PWD': '/builds/slave/test', 12:05:54 INFO - 'SHELL': '/bin/bash', 12:05:54 INFO - 'SHLVL': '1', 12:05:54 INFO - 'TERM': 'linux', 12:05:54 INFO - 'TMOUT': '86400', 12:05:54 INFO - 'USER': 'cltbld', 12:05:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:54 INFO - '_': '/tools/buildbot/bin/python'} 12:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:54 INFO - Downloading/unpacking jsonschema==2.5.1 12:05:54 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 12:05:54 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 12:05:54 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 12:05:54 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 12:05:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:05:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:05:55 INFO - warning: no files found matching '*.txt' 12:05:55 INFO - no previously-included directories found matching 'build' 12:05:55 INFO - no previously-included directories found matching 'dist' 12:05:55 INFO - no previously-included directories found matching '.git*' 12:05:55 INFO - Installing collected packages: jsonschema, functools32 12:05:56 INFO - Running setup.py install for functools32 12:05:56 INFO - warning: no files found matching '*.txt' 12:05:56 INFO - no previously-included directories found matching 'build' 12:05:56 INFO - no previously-included directories found matching 'dist' 12:05:56 INFO - no previously-included directories found matching '.git*' 12:05:56 INFO - Successfully installed jsonschema functools32 12:05:56 INFO - Cleaning up... 12:05:56 INFO - Return code: 0 12:05:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05: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')]} 12:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05: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', '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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:05: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 functools32==3.2.3-2 12:05:56 INFO - Using env: {'DISPLAY': ':0', 12:05:56 INFO - 'HOME': '/home/cltbld', 12:05:56 INFO - 'LANG': 'en_US.UTF-8', 12:05:56 INFO - 'LANGUAGE': 'en_US:en', 12:05:56 INFO - 'LOGNAME': 'cltbld', 12:05:56 INFO - 'MAIL': '/var/mail/cltbld', 12:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:56 INFO - 'MOZ_NO_REMOTE': '1', 12:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:56 INFO - 'NO_EM_RESTART': '1', 12:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:56 INFO - 'PWD': '/builds/slave/test', 12:05:56 INFO - 'SHELL': '/bin/bash', 12:05:56 INFO - 'SHLVL': '1', 12:05:56 INFO - 'TERM': 'linux', 12:05:56 INFO - 'TMOUT': '86400', 12:05:56 INFO - 'USER': 'cltbld', 12:05:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:56 INFO - '_': '/tools/buildbot/bin/python'} 12:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:05:56 INFO - Cleaning up... 12:05:56 INFO - Return code: 0 12:05:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05: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')]} 12:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05: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', '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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:05: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 blobuploader==1.2.4 12:05:56 INFO - Using env: {'DISPLAY': ':0', 12:05:56 INFO - 'HOME': '/home/cltbld', 12:05:56 INFO - 'LANG': 'en_US.UTF-8', 12:05:56 INFO - 'LANGUAGE': 'en_US:en', 12:05:56 INFO - 'LOGNAME': 'cltbld', 12:05:56 INFO - 'MAIL': '/var/mail/cltbld', 12:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:56 INFO - 'MOZ_NO_REMOTE': '1', 12:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:56 INFO - 'NO_EM_RESTART': '1', 12:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:56 INFO - 'PWD': '/builds/slave/test', 12:05:56 INFO - 'SHELL': '/bin/bash', 12:05:56 INFO - 'SHLVL': '1', 12:05:56 INFO - 'TERM': 'linux', 12:05:56 INFO - 'TMOUT': '86400', 12:05:56 INFO - 'USER': 'cltbld', 12:05:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:56 INFO - '_': '/tools/buildbot/bin/python'} 12:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:05:56 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 12:05:56 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 12:05:56 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 12:05:56 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 12:05:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:05:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:05: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 12:05: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 12:05: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 12:05: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 12:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:05:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:58 INFO - Downloading docopt-0.6.1.tar.gz 12:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:05:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:05:58 INFO - Running setup.py install for blobuploader 12:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:05:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:05:58 INFO - Running setup.py install for requests 12:05:58 INFO - Running setup.py install for docopt 12:05:58 INFO - Successfully installed blobuploader requests docopt 12:05:58 INFO - Cleaning up... 12:05:58 INFO - Return code: 0 12:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:05:58 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')]} 12:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:58 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')]} 12:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:58 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:05:58 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 12:05:58 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 12:05:58 INFO - Using env: {'DISPLAY': ':0', 12:05:58 INFO - 'HOME': '/home/cltbld', 12:05:58 INFO - 'LANG': 'en_US.UTF-8', 12:05:58 INFO - 'LANGUAGE': 'en_US:en', 12:05:58 INFO - 'LOGNAME': 'cltbld', 12:05:58 INFO - 'MAIL': '/var/mail/cltbld', 12:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:58 INFO - 'MOZ_NO_REMOTE': '1', 12:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:58 INFO - 'NO_EM_RESTART': '1', 12:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:58 INFO - 'PWD': '/builds/slave/test', 12:05:58 INFO - 'SHELL': '/bin/bash', 12:05:58 INFO - 'SHLVL': '1', 12:05:58 INFO - 'TERM': 'linux', 12:05:58 INFO - 'TMOUT': '86400', 12:05:58 INFO - 'USER': 'cltbld', 12:05:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:58 INFO - '_': '/tools/buildbot/bin/python'} 12:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:05:59 INFO - Running setup.py (path:/tmp/pip-lu7LDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:05:59 INFO - Running setup.py (path:/tmp/pip-3xB1Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:05:59 INFO - Running setup.py (path:/tmp/pip-iB771s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:05:59 INFO - Running setup.py (path:/tmp/pip-jlxmID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:05:59 INFO - Running setup.py (path:/tmp/pip-LFIib1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:05:59 INFO - Running setup.py (path:/tmp/pip-uklD5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:05:59 INFO - Running setup.py (path:/tmp/pip-Is1WiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:05:59 INFO - Running setup.py (path:/tmp/pip-OOUeHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:05:59 INFO - Running setup.py (path:/tmp/pip-I1iHua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:05:59 INFO - Running setup.py (path:/tmp/pip-tbOmiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:05:59 INFO - Running setup.py (path:/tmp/pip-4mV77N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:05:59 INFO - Running setup.py (path:/tmp/pip-CQjRLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:05:59 INFO - Running setup.py (path:/tmp/pip-iMYKvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:00 INFO - Running setup.py (path:/tmp/pip-bgVkSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:00 INFO - Running setup.py (path:/tmp/pip-KAkSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:00 INFO - Running setup.py (path:/tmp/pip-IR7Hge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:00 INFO - Running setup.py (path:/tmp/pip-AJLgq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:00 INFO - Running setup.py install for manifestparser 12:06:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:00 INFO - Running setup.py install for mozcrash 12:06:00 INFO - Running setup.py install for mozdebug 12:06:00 INFO - Running setup.py install for mozdevice 12:06:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:00 INFO - Running setup.py install for mozfile 12:06:00 INFO - Running setup.py install for mozhttpd 12:06:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:00 INFO - Running setup.py install for mozinfo 12:06:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for mozInstall 12:06:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for mozleak 12:06:01 INFO - Running setup.py install for mozlog 12:06:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for moznetwork 12:06:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for mozprocess 12:06:01 INFO - Running setup.py install for mozprofile 12:06:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for mozrunner 12:06:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:01 INFO - Running setup.py install for mozscreenshot 12:06:01 INFO - Running setup.py install for moztest 12:06:01 INFO - Running setup.py install for mozversion 12:06:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:02 INFO - Cleaning up... 12:06:02 INFO - Return code: 0 12:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:02 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:06:02 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 12:06:02 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 12:06:02 INFO - Using env: {'DISPLAY': ':0', 12:06:02 INFO - 'HOME': '/home/cltbld', 12:06:02 INFO - 'LANG': 'en_US.UTF-8', 12:06:02 INFO - 'LANGUAGE': 'en_US:en', 12:06:02 INFO - 'LOGNAME': 'cltbld', 12:06:02 INFO - 'MAIL': '/var/mail/cltbld', 12:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:02 INFO - 'MOZ_NO_REMOTE': '1', 12:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:02 INFO - 'NO_EM_RESTART': '1', 12:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:02 INFO - 'PWD': '/builds/slave/test', 12:06:02 INFO - 'SHELL': '/bin/bash', 12:06:02 INFO - 'SHLVL': '1', 12:06:02 INFO - 'TERM': 'linux', 12:06:02 INFO - 'TMOUT': '86400', 12:06:02 INFO - 'USER': 'cltbld', 12:06:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:02 INFO - '_': '/tools/buildbot/bin/python'} 12:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:02 INFO - Running setup.py (path:/tmp/pip-z1OL43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:02 INFO - Running setup.py (path:/tmp/pip-ystWLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:02 INFO - Running setup.py (path:/tmp/pip-0uwNH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:02 INFO - Running setup.py (path:/tmp/pip-5aIVqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:02 INFO - Running setup.py (path:/tmp/pip-fRvPWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:02 INFO - Running setup.py (path:/tmp/pip-qEkqf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:02 INFO - Running setup.py (path:/tmp/pip-E7SGk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:02 INFO - Running setup.py (path:/tmp/pip-Diazbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:02 INFO - Running setup.py (path:/tmp/pip-ngqb7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:02 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)) 12:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:02 INFO - Running setup.py (path:/tmp/pip-Z8j3jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:03 INFO - Running setup.py (path:/tmp/pip-rqS1fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:03 INFO - Running setup.py (path:/tmp/pip-iGw2eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:03 INFO - Running setup.py (path:/tmp/pip-vIXdjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:03 INFO - Running setup.py (path:/tmp/pip-C9humg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:03 INFO - Running setup.py (path:/tmp/pip-pdXa0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:03 INFO - Running setup.py (path:/tmp/pip-nltpOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:03 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)) 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:03 INFO - Running setup.py (path:/tmp/pip-iA0YCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:03 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)) 12:06:03 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)) 12:06:03 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)) 12:06:03 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)) 12:06:03 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)) 12:06:03 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)) 12:06:03 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)) 12:06:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06: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 12:06: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 12:06: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 12:06: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 12:06:04 INFO - Downloading blessings-1.6.tar.gz 12:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:04 INFO - Installing collected packages: blessings 12:06:04 INFO - Running setup.py install for blessings 12:06:04 INFO - Successfully installed blessings 12:06:04 INFO - Cleaning up... 12:06:04 INFO - Return code: 0 12:06:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:05 INFO - Reading from file tmpfile_stdout 12:06:05 INFO - Current package versions: 12:06:05 INFO - argparse == 1.2.1 12:06:05 INFO - blessings == 1.6 12:06:05 INFO - blobuploader == 1.2.4 12:06:05 INFO - docopt == 0.6.1 12:06:05 INFO - functools32 == 3.2.3-2 12:06:05 INFO - jsonschema == 2.5.1 12:06:05 INFO - manifestparser == 1.1 12:06:05 INFO - mozInstall == 1.13 12:06:05 INFO - mozcrash == 1.0 12:06:05 INFO - mozdebug == 0.1 12:06:05 INFO - mozdevice == 0.51 12:06:05 INFO - mozfile == 1.2 12:06:05 INFO - mozhttpd == 0.7 12:06:05 INFO - mozinfo == 0.10 12:06:05 INFO - mozleak == 0.1 12:06:05 INFO - mozlog == 3.5 12:06:05 INFO - moznetwork == 0.27 12:06:05 INFO - mozprocess == 0.25 12:06:05 INFO - mozprofile == 0.28 12:06:05 INFO - mozrunner == 6.13 12:06:05 INFO - mozscreenshot == 0.1 12:06:05 INFO - mozsystemmonitor == 0.3 12:06:05 INFO - moztest == 0.8 12:06:05 INFO - mozversion == 1.4 12:06:05 INFO - psutil == 3.1.1 12:06:05 INFO - requests == 1.2.3 12:06:05 INFO - wsgiref == 0.1.2 12:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:05 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:06:05 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 12:06:05 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 12:06:05 INFO - Using env: {'DISPLAY': ':0', 12:06:05 INFO - 'HOME': '/home/cltbld', 12:06:05 INFO - 'LANG': 'en_US.UTF-8', 12:06:05 INFO - 'LANGUAGE': 'en_US:en', 12:06:05 INFO - 'LOGNAME': 'cltbld', 12:06:05 INFO - 'MAIL': '/var/mail/cltbld', 12:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:05 INFO - 'MOZ_NO_REMOTE': '1', 12:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:05 INFO - 'NO_EM_RESTART': '1', 12:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:05 INFO - 'PWD': '/builds/slave/test', 12:06:05 INFO - 'SHELL': '/bin/bash', 12:06:05 INFO - 'SHLVL': '1', 12:06:05 INFO - 'TERM': 'linux', 12:06:05 INFO - 'TMOUT': '86400', 12:06:05 INFO - 'USER': 'cltbld', 12:06:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:05 INFO - '_': '/tools/buildbot/bin/python'} 12:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 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)) 12:06:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:06: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 12:06: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 12:06: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 12:06: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 12:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:06:06 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)) 12:06:06 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)) 12:06:06 INFO - Installing collected packages: simplejson 12:06:06 INFO - Running setup.py install for simplejson 12:06:06 INFO - building 'simplejson._speedups' extension 12:06:06 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 12:06:07 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 12:06:07 INFO - Successfully installed simplejson 12:06:07 INFO - Cleaning up... 12:06:07 INFO - Return code: 0 12:06:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:07 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')]} 12:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:07 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')]} 12:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:07 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 0x11cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1394b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', '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 12:06:07 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 12:06:07 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 12:06:07 INFO - Using env: {'DISPLAY': ':0', 12:06:07 INFO - 'HOME': '/home/cltbld', 12:06:07 INFO - 'LANG': 'en_US.UTF-8', 12:06:07 INFO - 'LANGUAGE': 'en_US:en', 12:06:07 INFO - 'LOGNAME': 'cltbld', 12:06:07 INFO - 'MAIL': '/var/mail/cltbld', 12:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:07 INFO - 'MOZ_NO_REMOTE': '1', 12:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:07 INFO - 'NO_EM_RESTART': '1', 12:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:07 INFO - 'PWD': '/builds/slave/test', 12:06:07 INFO - 'SHELL': '/bin/bash', 12:06:07 INFO - 'SHLVL': '1', 12:06:07 INFO - 'TERM': 'linux', 12:06:07 INFO - 'TMOUT': '86400', 12:06:07 INFO - 'USER': 'cltbld', 12:06:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:07 INFO - '_': '/tools/buildbot/bin/python'} 12:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:06:07 INFO - Cleaning up... 12:06:07 INFO - Return code: 0 12:06:07 INFO - Running post-action listener: _resource_record_post_action 12:06:07 INFO - Running post-action listener: _start_resource_monitoring 12:06:07 INFO - Starting resource monitoring. 12:06:07 INFO - [mozharness: 2017-09-24 19:06:07.785384Z] Finished create-virtualenv step (success) 12:06:07 INFO - [mozharness: 2017-09-24 19:06:07.785862Z] Running install step. 12:06:07 INFO - Running pre-action listener: _resource_record_pre_action 12:06:07 INFO - Running main action method: install 12:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:08 INFO - Reading from file tmpfile_stdout 12:06:08 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:08 INFO - Reading from file tmpfile_stdout 12:06:08 INFO - Output received: 12:06:08 INFO - Usage: mozinstall [options] installer 12:06:08 INFO - Options: 12:06:08 INFO - -h, --help show this help message and exit 12:06:08 INFO - -d DEST, --destination=DEST 12:06:08 INFO - Directory to install application into. [default: 12:06:08 INFO - "/builds/slave/test"] 12:06:08 INFO - --app=APP Application being installed. [default: firefox] 12:06:08 INFO - mkdir: /builds/slave/test/build/application 12:06:08 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'] 12:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:06:25 INFO - Reading from file tmpfile_stdout 12:06:25 INFO - Output received: 12:06:25 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:25 INFO - Running post-action listener: _resource_record_post_action 12:06:25 INFO - [mozharness: 2017-09-24 19:06:25.733754Z] Finished install step (success) 12:06:25 INFO - [mozharness: 2017-09-24 19:06:25.733900Z] Running setup-mitmproxy step. 12:06:25 INFO - Running pre-action listener: _resource_record_pre_action 12:06:25 INFO - Running main action method: setup_mitmproxy 12:06:25 INFO - Skipping: mitmproxy is not required 12:06:25 INFO - Running post-action listener: _resource_record_post_action 12:06:25 INFO - [mozharness: 2017-09-24 19:06:25.734433Z] Finished setup-mitmproxy step (success) 12:06:25 INFO - [mozharness: 2017-09-24 19:06:25.734537Z] Running run-tests step. 12:06:25 INFO - Running pre-action listener: _resource_record_pre_action 12:06:25 INFO - Running pre-action listener: _set_gcov_prefix 12:06:25 INFO - Running main action method: run_tests 12:06:25 WARNING - Try message not found. 12:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:25 INFO - Python 2.7.3 12:06:25 INFO - Return code: 0 12:06:25 INFO - grabbing minidump binary from tooltool 12:06:25 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')]} 12:06:25 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 0x1536d60>, '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 0x1537a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1537ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:25 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 12:06:25 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 12:06:25 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 12:06:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:25 INFO - Return code: 0 12:06:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:25 INFO - ENV: RUST_BACKTRACE is now full 12:06:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:06:25 INFO - Using env: {'DISPLAY': ':0', 12:06:25 INFO - 'HOME': '/home/cltbld', 12:06:25 INFO - 'LANG': 'en_US.UTF-8', 12:06:25 INFO - 'LANGUAGE': 'en_US:en', 12:06:25 INFO - 'LOGNAME': 'cltbld', 12:06:25 INFO - 'MAIL': '/var/mail/cltbld', 12:06:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:25 INFO - 'MOZ_NO_REMOTE': '1', 12:06:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:25 INFO - 'NO_EM_RESTART': '1', 12:06:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:25 INFO - 'PWD': '/builds/slave/test', 12:06:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:25 INFO - 'RUST_BACKTRACE': 'full', 12:06:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:06:25 INFO - 'SHELL': '/bin/bash', 12:06:25 INFO - 'SHLVL': '1', 12:06:25 INFO - 'TERM': 'linux', 12:06:25 INFO - 'TMOUT': '86400', 12:06:25 INFO - 'USER': 'cltbld', 12:06:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:25 INFO - '_': '/tools/buildbot/bin/python'} 12:06:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:06:26 INFO - mozversion application_buildid: 20170924174343 12:06:26 INFO - mozversion application_changeset: 877c02446745576ac97f181dd9eeec78ef605451 12:06:26 INFO - mozversion application_display_name: Nightly 12:06:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:26 INFO - mozversion application_name: Firefox 12:06:26 INFO - mozversion application_remotingname: firefox 12:06:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:06:26 INFO - mozversion application_vendor: Mozilla 12:06:26 INFO - mozversion application_version: 58.0a1 12:06:26 INFO - mozversion platform_buildid: 20170924174343 12:06:26 INFO - mozversion platform_changeset: 877c02446745576ac97f181dd9eeec78ef605451 12:06:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:06:26 INFO - mozversion platform_version: 58.0a1 12:06:26 INFO - using testdate: 1506279986 12:06:26 INFO - actual date: 1506279986 12:06:26 INFO - starting webserver on 'localhost:45264' 12:06:26 INFO - SUITE-START | Running 2 tests 12:06:26 INFO - TEST-START | dromaeo_css 12:06:26 INFO - Initialising browser for dromaeo_css test... 12:06:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45264/getInfo.html -profile /tmp/tmpyKFBcO/profile 12:06:26 INFO - TEST-INFO | started process 25901 (/builds/slave/test/build/application/firefox/firefox http://localhost:45264/getInfo.html) 12:06:31 INFO - TEST-INFO | 25901: exit 0 12:06:31 INFO - Browser initialized. 12:06:31 INFO - Running cycle 1/1 for dromaeo_css test... 12:06:31 INFO - Using env: {'DISPLAY': ':0', 12:06:31 INFO - 'HOME': '/home/cltbld', 12:06:31 INFO - 'JSGC_DISABLE_POISONING': '1', 12:06:31 INFO - 'LANG': 'en_US.UTF-8', 12:06:31 INFO - 'LANGUAGE': 'en_US:en', 12:06:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:06:31 INFO - 'LOGNAME': 'cltbld', 12:06:31 INFO - 'MAIL': '/var/mail/cltbld', 12:06:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:31 INFO - 'MOZ_CRASHREPORTER': '1', 12:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:06:31 INFO - 'MOZ_NO_REMOTE': '1', 12:06:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:31 INFO - 'NO_EM_RESTART': '1', 12:06:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:31 INFO - 'PWD': '/builds/slave/test', 12:06:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:31 INFO - 'RUST_BACKTRACE': 'full', 12:06:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:06:31 INFO - 'SHELL': '/bin/bash', 12:06:31 INFO - 'SHLVL': '1', 12:06:31 INFO - 'STYLO_FORCE_DISABLED': '1', 12:06:31 INFO - 'TERM': 'linux', 12:06:31 INFO - 'TMOUT': '86400', 12:06:31 INFO - 'USER': 'cltbld', 12:06:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:31 INFO - '_': '/tools/buildbot/bin/python'} 12:06:31 INFO - TEST-INFO | started process 26137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyKFBcO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:32 INFO - PID 26137 | 12:06:32 INFO - PID 26137 | (/builds/slave/test/build/application/firefox/firefox:26187): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:06:32 INFO - PID 26137 | 12:06:42 INFO - PID 26137 | RSS: Main: 146944000 12:06:42 INFO - PID 26137 | 12:09:39 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45264/tests/dromaeo/cssquery-ext.html) 12:09:40 INFO - PID 26137 | RSS: Main: 147185664 12:09:40 INFO - PID 26137 | 12:12:42 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-ext.html (next: http://localhost:45264/tests/dromaeo/cssquery-jquery.html) 12:12:42 INFO - PID 26137 | RSS: Main: 147300352 12:12:42 INFO - PID 26137 | 12:15:44 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45264/tests/dromaeo/cssquery-mootools.html) 12:15:45 INFO - PID 26137 | RSS: Main: 149536768 12:15:45 INFO - PID 26137 | 12:18:46 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45264/tests/dromaeo/cssquery-prototype.html) 12:18:47 INFO - PID 26137 | RSS: Main: 147374080 12:18:47 INFO - PID 26137 | 12:21:50 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45264/tests/dromaeo/cssquery-yui.html) 12:21:51 INFO - PID 26137 | RSS: Main: 148557824 12:21:51 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | Cycle 1(1): loaded http://localhost:45264/tests/dromaeo/cssquery-yui.html (next: http://localhost:45264/tests/dromaeo/cssquery-dojo.html) 12:24:52 INFO - PID 26137 | RSS: Main: 151613440 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | __start_tp_report 12:24:52 INFO - PID 26137 | _x_x_mozilla_page_load 12:24:52 INFO - PID 26137 | _x_x_mozilla_page_load_details 12:24:52 INFO - PID 26137 | |i|pagename|runs| 12:24:52 INFO - PID 26137 | |0;dojo.html;3870.709696772742;3878;3925.489686340777;3925.5485619153787;3929.5088113985753;6282.9685851570675;6322.0832979217985;6358.237011558608;6368.1721376221085;6411.487081033518;6380.4257616814475;6406.391392817675;6435.452986496141;6435.581687190329;6447.419732224099;5604.60767746259;5630.15547667851;5682.545396368301;5735.541156707453;5736.1682556029355;5665.8583535411535;5770;5771.336296325913;5785.987452195849;5791.623544469617;165.55743187311685;5631.746571404276;5656.123300888348;5671.262735844355;5761.798337058204;5659.660420374791;5690.60165788395;5723.027085395493;5754.654720716729;5760.308762948473;5634.211210430502;5659.943400566024;5715.971420142914;5743.052396354597;5752.36723960364;6290.842728931813;6291.622502649856;6292.244930608356;6307.180066591313;6400.807975760735;6886.793396198122;6890.966355046733;6970.44236461087;6975.965120174366;6999.405050570707;6781.152355955505;6898.0687607172895;6947.826304342381;6982.1970473395195;6989.196242432135;6382;6415.454686351665;6465.450436712838;6466.224053113657;6480.125183100268;7022.6488675566015;7061;7131.465140114512;7136.072310599693;7189.5686258824635;6718.899216511756;6803.387695107464;6806.693698783567;6824.556403833735;6834.316568343126;6965.616891070938;6966.164060312693;6994.650267486605;7005.509614326948;7062.894056589155;6880.071190389233;6887.380135787803;6895.724171033203;6921.8961715574305;6957.234704182536;6847.623380714109;6860.5197636164985;6863.10779598659;6959;6967.024616553686;4966.553010229097;4990.351254336985;5000.474950130257;5056.924146137811;5110.97444512775;4596.310553416947;4624.861254162381;4672.6261899047995;4680.040591678698;4699.624030077585;6253.280872699606;6323.462505686976;6403.295637479873;6415.326390728999;6421.646809425433;6653.9667301663185;6858.1084459021;6873.278305777922;6945.722171113099;6953.687084081229;6315.684215789192;6330.588511746721;6334.651594162366;6336.271328797156;6341.936580634135;5515.917261241085;5635.492805647511;5641.097424412074;5644.209810626516;5645.774169033275;7068.151821781419;7093.1488221413765;7144.249853765384;7160.462965277625;7262.527935684164;6899.344562266577;6935.826604334831;6965.65171741421;6971.058907047483;6982;7141.928580714126;7143.571385716874;7224.74713385029;7241.275872412716;7247.383972362408;6731.730730770714;6790.151231096113;6818.318168183142;6883.208431030295;6885.345892140239;6905.75829845953;6919.584824910521;6997.860042799217;6998.475114366341;7012.158540975116;6665.700043497957;6681.365270299314;6685.364890335411;6733;6768.7292508299115;6349.206349206349;6472.4174824264155;6483.059956306215;6489.967550162219;6642.4021838034805;6584.868302633825;6587.341265873374;6676.632785196861;6682.164729408824;6698.631575263213;6595.571287866273;6687.732490700318;6699.631520266432;6744.22441419243;6767.1879374475375;6512.706928188338;6548.410643042149;6558.639274839929;6646.4350530205475;6652.101966234496 12:24:52 INFO - PID 26137 | |1;ext.html;931.459753343061;945.4469135555695;961.2166084641017;989.722877594273;990.6483198464545;43023.78488107559;44452.33321500172;44472.77763611185;44514.33228501575;44527.33209001867;40549.59450405495;41045;41048;41063.79468102656;41398.379024314585;7616.6191690415535;7709.151993280735;7719.189485104067;7776.416768742339;7785.727499537517;7613.619319034026;7615.390768738515;7632.122305934833;7632.427567932399;7692.576908270043;8235.752927412188;8475.618597163142;8480.78798030048;8483.575821208946;8488;8359.498430094183;8408.789780255482;8426.452280601741;8434.325253979698;8435.873461898076;7959.681612735483;8205;8205.343572514244;8213.712520061768;8221.958890205571;39757.20485590301;40055.79972100121;40088.79955600233;40153.39769903454;40203;3684.060564556021;3737.103095257146;3746.718996075278;3748.987773301221;3755.042464171646;32697.182570435692;32775.18062048444;32815.179620509676;32886.83556582226;32904.34191316184;5416.241726158341;5480.123180291174;5506.091494903336;5506.311711036121;5545.611807173499;233498.9999999983;233809;233997;234219;234777;52204.47795522072;52347.214791778155;52352.47647523552;52357.47642523526;52371.47628523742;54811.17783233255;55179;55196.72401637966;55513.61215969633;55545;16439;16969.660606788042;16986.490405287863;16988.405405810983;16994.915025424794;13724;13783.241921694202;13817;13820.723585528232;13850.584482465541;15215.239238038053;15454.536363909101;15490.605845473961;15553.611159720871;15563.144027078619;6076.453119219292;6140.539459540552;6158.258141231227;6173.444390004921;6328.651924144124;1087.374759513283;1110.744528758374;1114.2256131988352;1119.47944205943;1120.5965852293168;25468.617970730455;25534.872325638255;25558.48883022329;25563.23310300694;25563.61654575183;1190.1668831817763;1194.5818963362926;1197.3175290084569;1217.719924417389;1219.7987332090106;13468;13593.59219223425;13624.386902589407;13628.795568066487;13707;289679;291126;291481;292087;292887;50099;50682.74658626757;56113.7194314034;56735.43264567384;57553;1514.9697006059816;1523.1394262241797;1525.3288553036627;1525.8016457860185;1543.5678010157174;29970.550441742955;30186.698133018388;30260.84869575638;30340.696593033786;30344;37230;37318.440223397214;37351;37391.81304093462;37423;244615;247737;247770;248028;248070;35092.64907350894;35222.11944701301;35292.64707352893;35668.286634267686;35709.1072723184;43700.78149609231;44721.10557788761;44857.32714009358;44860.10279794451;45111.774441127585;33626.83186584051;34006.65993340134;34123.65876341205;34215.65784342125;34444.48333274953;33948.49077263794;33950.49074263839;34248.31503369869;34529.136771579906;34794.304113918086;40153.19693606053;40244.79877600593;40484.19031619292;40494.392584111854;40637.79681101575;32563.421814215584;32608.673913260565;32787.67212327846;33037.17407064843;33263.33473330471;25162.24513264605;25190.24429267125;25468.363290917874;25598.872005639852;25668.61497077508 12:24:52 INFO - PID 26137 | |2;jquery.html;609.8475381154711;612.1399433795516;613.1630324606913;614.9631022138672;636.7739452494365;22898.427539311524;23701.881490592565;23728.76271237287;23860.88069559654;23909.521809563797;21936.89031554844;22450.43873903153;22582.66126008107;22593.209237676685;22646.547069058608;5559.749811258483;5593.468620481048;5600.467955544217;5712.8857422851515;5831.6209446386065;6378.266499352564;6649.634270115142;6664.100346453215;6695.627396383729;6762.628055456948;6574.605523668595;6585.868282634345;6603.80188594343;6605.57063790852;6607.669616519179;6560.573562718456;6563.310852360529;6597.769078082268;6605.372489613479;6609.306022867602;6355.269144048401;6369.6496692681885;6374.394432528902;6394.616323020634;6399.968000160016;31080.844595777104;31549.842250788828;31566.210844729067;31582.842085789423;31619.36761264785;2169.143188440557;2239.731232252124;2262;2271.7955384015354;2273.5566564519927;20615.484612884797;21223.151073957022;21767.45581360463;21939;21947.122115115377;2589.5468293048643;2594.299539124445;2632.8288661236957;2639.973600263992;2654.3098794313423;132519.33740331235;139908;144407.27796361057;151793.24103379413;152002.23998879935;15555;16321.694264458814;16538.338466461206;16583.585410364594;16650.918635170605;26338.604920926202;26356.209313720618;26409.603855942176;26413.811378488015;26464.206073817815;11050.834237486444;11073.778524429628;11133.165012623924;11134.276272042453;11347.432628368548;10004.49977501122;10071.848922266172;10104.797904041878;10114.696559103239;10258.076773090457;9694.709158725109;9697.369670971364;10007;10158.339707918962;10191.337563058378;2881.03485332416;2888.8411137387225;3000.4149190907565;3048.161755517206;3102.844857757103;1030;1039.5685790396901;1041.4792603698152;1043.6555936541074;1048.5176818663347;21472.892635536722;21598.676019859715;21643.891780541;21653.35039948804;21919.452013699465;1090.8036553420302;1120.590984290728;1127.4588197665166;1127.5285752093432;1129.7796929598649;11612.88387116118;11687.649370518899;11719.531218751154;11873.228240164362;11954.462049207807;581834;591336;603005;613250;613659;124517;129386.35306823405;130082.34958825145;134299;136404.31797840947;1111.0833562311125;1165.0659904558393;1213.7572485502935;1249.9187552809037;1257.8176164456286;21786.346409607737;22149.335519934426;22675.773242268027;23050;23244.070237190324;61349.38650613615;62080;62461.68769156125;62945;65286.673566631864;75776.62111689406;76417.61791191009;76575;76853;77196.61401692955;21005;21330.89334553317;21686;21717.239896603543;21770.12919483203;24236.87881560581;24368.63447048331;24417.877910611045;24431.14490992807;24479.755202447748;19804.50488737793;19995.900020500387;20008.099635516726;20086;20152.49618759484;16969.745453817955;17112.828871711125;17573.121343932497;17964.91017544956;18171.636567268844;19698.50753731168;19788.307409241184;19928.800711992695;20278.79721202769;20363.59272814565;20779;20832;21042;21090.261840835497;21248.15007399687;19388.903055484632;19683.409497715093;19857.900710496357;19928.402147935583;19945.501362466053 12:24:52 INFO - PID 26137 | |3;mootools.html;1338.4980632262902;1476.5791749351438;1478.7929689843425;1482.525591810621;1490.3219035338923;16358.83641163588;17736;17749.91125044373;17753.28986840528;17762.378316758917;17566.385176518823;17874.10629468528;17875.642487150282;17879.19543620537;17903;2476.4304210031705;2581.4320849413193;2650.09896635144;2689.542777727791;2700.9324766880886;2727.3454370950926;2748.7938404619636;2750.8487033213164;2751.119641714652;2755.586662000696;2671.105179764781;2681.919542413721;2701.8378897266225;2718.687350954636;2732.303262668017;2534.6958364996226;2553.69355677319;2560.4495033567778;2561.743825617442;2567.82025258232;2539.162076514746;2566.332753484108;2580.1614475295414;2584.612308153773;2595.9091431799798;16555.91722041382;16561.751573726404;16760.497185084467;16772.32910683571;16784.664306713796;7197.100362454693;7362.079740032496;7389.556626602421;7400.592967386791;7403;5104.872378190538;5224.164133738584;5267.683938963674;5323.361196656426;5346.866328341823;2115.4922818523596;2124.5857057873723;2136.75427325858;2150.709654196679;2165.469459982314;30036.24909377261;30193.547096793565;30219.395612087636;30268.24329391783;30298.545521817192;6786.287439818748;6841;6886.8622627547165;6937.9653101735175;7085.82285442868;19186.232550698096;19337.51656208578;19461.31885384033;19474.610507789766;19495;7756.92243077562;7861.449698521049;7909.367250619936;7916.920830791733;7929.841403171904;5919.970400147971;6766.72933082681;7263.128424589083;7609.391248700091;7624.733134340271;5351.357837059578;5486.807961721321;5503.944960550423;5508.6970216637665;5528.55771538276;1510.637447012731;1525.0414196458835;1527.0532269992675;1530.1048886401356;1540.4223416218917;948.1229862377411;968.5738275158908;976.0532283684814;987.896270891546;990.3859607043535;8253.422260441832;8428.241458268663;8463.915360846437;8477.406581539357;8538;811.3711873298241;822.6298165825283;828.9171082891662;829.3199576347458;836.4186890111314;5021.14640511114;5400.459954004568;5870.647761134345;5883.3234178069215;5963.016102343065;23980.160694375612;24066.63900041501;24765.62851557228;24890.128845490322;24891.128810491547;24777.25668229956;24856.5028699425;25050.12324568668;25093.87453062723;25138.12016579411;11521.769564608661;12481.313527756061;12501.249925004347;12669.93665031669;12706.174098683741;9096.863547046933;9119.589618467053;9130.543472826199;9160.175584197454;9327.440353578808;20489.180432782523;20691.586168276852;20736.478482046383;21049.263275785273;21336.89331553332;21789;21900.671489927983;21919.78080219241;21938.780612193674;22035.11859525601;12109.515619375126;12306.569270075504;12342.444589993293;12414.751704965669;12433.875661243272;15115.622109447351;15129.319180636678;15249.542513724606;15300.311485982935;15345.6163595911;11926.344051077274;12077.214981026205;12207;12335.3832308386;12376.75246495047;11378.829317560409;11506.252093613888;11532.538698452303;11629.127815413709;11808.291502509877;10563.52464139131;10770.461476926279;10794.082502987334;10817.405042722727;10829.187810914056;8300.54347010896;8316.209960053786;8384.245417912418;8463.873041904253;8620;8191.385646076449;8383.119772424052;8385.496870187808;8455.830883382421;8492 12:24:52 INFO - PID 26137 | |4;prototype.html;557.436988641472;559.983200503985;575.5309422820402;582.8863371642532;594.5719082260773;6269.373062693734;6288.717007734652;6299.803037422892;6316;6370.203724534434;6182.474489668383;6199.473044791187;6201.348858369874;6233.283172435172;6268.435840774329;4868.97565512172;5125.256837758541;5126.487351264881;5148.5623721983675;5149.124648809692;4988.925166122493;5014.548690617844;5035.093683137034;5038.168702164138;5047.419546752134;4974.776135073912;4975.561974632422;4989.151844186479;4990.351254336949;5002.1746411842005;4961.975190124044;4972.6270529710055;4990.775415106329;4997.100521906055;5010.824621138243;4598.977005114986;4601.3558101865765;4606.401167848158;4607.608353289975;4608.400907881954;6112.847178820521;6201.534884883652;6205;6225.657588832612;6228.470580000705;5760.654360738369;5830.825075247707;5840.474357307863;5868.76524939002;5887.293524777011;6577;6597.868042639168;6598.7030583623855;6602.580445204304;6677.93322066778;4870.4155501340065;5102.872428189288;5112.2076078207565;5113.309703190096;5133.563647089964;6601.207855057424;6743.15710536183;6778.661066946633;6847.452203823732;6872.312768723138;5612.400465867208;5640.464155905182;5686.658800471985;5742.425757424307;5755.194272801811;5686.545076393879;5742.54059675225;5792.275965504312;5814.592978491465;5822.7088645567555;6111.816645500642;6173.59871608344;6187.504999600022;6202.131701561785;6219.191505104398;6658.833529161713;6716.194056713226;6775.3902148805855;6779.49153813466;6787.966060169766;1955.2276850643916;1974.3385965701364;1994.0428594274829;1994.8330226817475;2003.9499012524805;1465.3332733606183;1518.574799056266;1519.8100237470317;1526.7175572518897;1527.2821773766311;6050.515958723292;6083.452489275986;6084.178635884187;6085.8436896990315;6125.908111378333;6616.801495955129;6621.205455345389;6632;6668.966655166693;6737.494687898427;5974.640017193271;6023.216981792427;6055.969720151459;6112.724927378279;6128.938710612837;3535.7701749386206;3542.362374772514;3559.8964321060553;3567.6253993330847;3577.0878426001723;6832.1305051878335;6915.550489218184;6996.6851491683;7022.4733145014325;7033.366996970297;6704.731810727614;6756.695948682321;6781.42357899584;6831.180258368928;6871.518993670495;6813.284605116491;6904.827379315457;6927.411170050602;6974.849149890414;6986.580805151707;6552.213734351718;6557.311482294291;6583.835404114935;6598.406143447113;6656.400923916871;6602.1747281589805;6612.685560053943;6658.866822663423;6682.599044057372;6691.297413771484;6957.478189135733;6964.616946068015;7007.194172670004;7008.474364422586;7016.438684905297;5623.8875222496135;5627.606067575231;5642.746076426489;5679.9148012779015;5715.799947001835;6391.58454700443;6412.326705696021;6665.766698165541;6685.832854178684;6728.865422691617;6431.871362572816;6491.48068154537;6499.870002599827;6518.348165183634;6587.4071333580205;6296.496280297657;6359.046143078575;6424.646644434414;6433.228012638513;6506.73973041092;6241.750329986931;6390.52071094679;6450.580712253689;6472.482201423781;6508.15393998796;6549.7380104795275;6576.2766095730385;6582.663154580247;6610.735570577123;6618.569792963442;6307.337729538516;6321.399467050623;6362.45919096882;6364.64994425311;6467.579607325509 12:24:52 INFO - PID 26137 | |5;yui.html;959.8704174936383;961.8268711631907;966.9564869580868;981.3866333541537;990.0643891522512;19054.42836714899;19502.317418890343;19545;19558.902205488987;19617.705734413994;13869.791953120712;13931.582052538415;13962.930185349085;13968.231747253896;14105.435782568686;1058.6506452870553;1075.688050465368;1081.124289325645;1082;1082.1667316166547;1059.390850261099;1060.173065009294;1061.2677252695653;1061.984070238947;1063.2450959818539;1073.5920350266927;1100.9724756881103;1100.9889901101008;1102.3330884814693;1110.5779803674593;1109.1958330210614;1113.0705860606404;1114.0307932099045;1114.6934592986913;1116.1851848150814;789.4907784479036;793.9007624046994;798.8242586630931;800.1438460846896;801.7915342011061;20292.289769858133;20663.966801659855;20753.481162970897;20761.896190519103;20789.27237546694;23595.52808943829;23722;23866.88066559656;24293.635595466083;24393;16697.749533757004;16873.987560746395;17048.14759262032;17197.054162021082;17350.913245433818;3981.203759248133;4001.0397504598977;4014.6788256939376;4034.4150098235887;4036.6568841648495;131069;150661.24669376694;156571;159880;164691;18710.71933920992;18958;19170.329038483866;19312.4206273812;19313.8068619312;34376.82811585976;34484.137896552784;34619.65380346215;34724.30551389009;34761.82619086889;10003;10166;10193.541290641939;10216.335938163995;10242.180625550087;4714.905701885943;4754.477007529169;4789.736564488987;4796.136695394863;4803.879903002453;6006.819795406145;6089.908651370233;6133.0800379942475;6136.8772624547255;6142.6314421134875;1233.210745123122;1259.6787819106069;1268.7462507498537;1277.6869666931475;1278.4886045581657;737.2848337112991;743.9814004649927;746.0636900689708;765.5636287316288;766.4787944197888;13084.542041028519;14140.292985350692;14192.574222773334;14441.422343106158;14705.529447055209;731.0934441292759;747.2266204478339;747.8242612985944;760.4182800157884;761.37186820873;6088.995315772936;6249.6875156242;6324.778632747923;6341.587796793194;6348.460380867678;152192.2390388041;153147;153704.2314788419;153762;158197;105616;131342;132149.33925330313;135353.32323338516;135917;108994.45502772435;109022.99999999841;111038;111396;111626;14321.28393580296;14607.342669580106;14630.195339256017;14748.410063597335;14769.630759230675;51653.741731291106;52161.04618030104;52222.47777522176;53161.7341913288;53670.194947076605;66755.66622166858;67439.66280168567;67457.3254267451;68260.31739682738;70201.29798702152;20192.192312307343;20510.69233961462;20592.691109633666;20686.896565517076;20698.689519657517;22758.20346287938;22920.312390628307;22966.655500167177;23068.653970190797;23142.768572314733;18249.81750182481;18283;18431.723524147415;18498.537536561693;18571.628567428845;20640.27759028427;20726.274580390218;20746.377608671763;20970.16119355209;21130.260440884496;17442.127893605524;18171.636567268317;18414.35549755752;18466;18660.253589856253;14281.42874285017;14404.279786010447;14439.133651980916;14528.782068268772;14560.854391456374;14856.851431485979;15199;15230.46693365727;15245.695086097994;15288.318284988865 12:24:52 INFO - PID 26137 | __end_tp_report 12:24:52 INFO - PID 26137 | __start_cc_report 12:24:52 INFO - PID 26137 | _x_x_mozilla_cycle_collect,278 12:24:52 INFO - PID 26137 | __end_cc_report 12:24:52 INFO - PID 26137 | __startTimestamp1506281092755__endTimestamp 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | ------- Summary: start ------- 12:24:52 INFO - PID 26137 | Number of tests: 6 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#0] dojo.html Cycles:165 Average:6318.11 Median:6584.87 stddev:895.79 (13.6%) stddev-sans-first:877.72 12:24:52 INFO - PID 26137 | Values: 3870.7 3878.0 3925.5 3925.5 3929.5 6283.0 6322.1 6358.2 6368.2 6411.5 6380.4 6406.4 6435.5 6435.6 6447.4 5604.6 5630.2 5682.5 5735.5 5736.2 5665.9 5770.0 5771.3 5786.0 5791.6 165.6 5631.7 5656.1 5671.3 5761.8 5659.7 5690.6 5723.0 5754.7 5760.3 5634.2 5659.9 5716.0 5743.1 5752.4 6290.8 6291.6 6292.2 6307.2 6400.8 6886.8 6891.0 6970.4 6976.0 6999.4 6781.2 6898.1 6947.8 6982.2 6989.2 6382.0 6415.5 6465.5 6466.2 6480.1 7022.6 7061.0 7131.5 7136.1 7189.6 6718.9 6803.4 6806.7 6824.6 6834.3 6965.6 6966.2 6994.7 7005.5 7062.9 6880.1 6887.4 6895.7 6921.9 6957.2 6847.6 6860.5 6863.1 6959.0 6967.0 4966.6 4990.4 5000.5 5056.9 5111.0 4596.3 4624.9 4672.6 4680.0 4699.6 6253.3 6323.5 6403.3 6415.3 6421.6 6654.0 6858.1 6873.3 6945.7 6953.7 6315.7 6330.6 6334.7 6336.3 6341.9 5515.9 5635.5 5641.1 5644.2 5645.8 7068.2 7093.1 7144.2 7160.5 7262.5 6899.3 6935.8 6965.7 6971.1 6982.0 7141.9 7143.6 7224.7 7241.3 7247.4 6731.7 6790.2 6818.3 6883.2 6885.3 6905.8 6919.6 6997.9 6998.5 7012.2 6665.7 6681.4 6685.4 6733.0 6768.7 6349.2 6472.4 6483.1 6490.0 6642.4 6584.9 6587.3 6676.6 6682.2 6698.6 6595.6 6687.7 6699.6 6744.2 6767.2 6512.7 6548.4 6558.6 6646.4 6652.1 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#1] ext.html Cycles:180 Average:43143.31 Median:20457.03 stddev:67295.98 (329.0%) stddev-sans-first:67410.13 12:24:52 INFO - PID 26137 | Values: 931.5 945.4 961.2 989.7 990.6 43023.8 44452.3 44472.8 44514.3 44527.3 40549.6 41045.0 41048.0 41063.8 41398.4 7616.6 7709.2 7719.2 7776.4 7785.7 7613.6 7615.4 7632.1 7632.4 7692.6 8235.8 8475.6 8480.8 8483.6 8488.0 8359.5 8408.8 8426.5 8434.3 8435.9 7959.7 8205.0 8205.3 8213.7 8222.0 39757.2 40055.8 40088.8 40153.4 40203.0 3684.1 3737.1 3746.7 3749.0 3755.0 32697.2 32775.2 32815.2 32886.8 32904.3 5416.2 5480.1 5506.1 5506.3 5545.6 233499.0 233809.0 233997.0 234219.0 234777.0 52204.5 52347.2 52352.5 52357.5 52371.5 54811.2 55179.0 55196.7 55513.6 55545.0 16439.0 16969.7 16986.5 16988.4 16994.9 13724.0 13783.2 13817.0 13820.7 13850.6 15215.2 15454.5 15490.6 15553.6 15563.1 6076.5 6140.5 6158.3 6173.4 6328.7 1087.4 1110.7 1114.2 1119.5 1120.6 25468.6 25534.9 25558.5 25563.2 25563.6 1190.2 1194.6 1197.3 1217.7 1219.8 13468.0 13593.6 13624.4 13628.8 13707.0 289679.0 291126.0 291481.0 292087.0 292887.0 50099.0 50682.7 56113.7 56735.4 57553.0 1515.0 1523.1 1525.3 1525.8 1543.6 29970.6 30186.7 30260.8 30340.7 30344.0 37230.0 37318.4 37351.0 37391.8 37423.0 244615.0 247737.0 247770.0 248028.0 248070.0 35092.6 35222.1 35292.6 35668.3 35709.1 43700.8 44721.1 44857.3 44860.1 45111.8 33626.8 34006.7 34123.7 34215.7 34444.5 33948.5 33950.5 34248.3 34529.1 34794.3 40153.2 40244.8 40484.2 40494.4 40637.8 32563.4 32608.7 32787.7 33037.2 33263.3 25162.2 25190.2 25468.4 25598.9 25668.6 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#2] jquery.html Cycles:180 Average:39776.59 Median:22048.23 stddev:100263.01 (454.7%) stddev-sans-first:100501.15 12:24:52 INFO - PID 26137 | Values: 609.8 612.1 613.2 615.0 636.8 22898.4 23701.9 23728.8 23860.9 23909.5 21936.9 22450.4 22582.7 22593.2 22646.5 5559.7 5593.5 5600.5 5712.9 5831.6 6378.3 6649.6 6664.1 6695.6 6762.6 6574.6 6585.9 6603.8 6605.6 6607.7 6560.6 6563.3 6597.8 6605.4 6609.3 6355.3 6369.6 6374.4 6394.6 6400.0 31080.8 31549.8 31566.2 31582.8 31619.4 2169.1 2239.7 2262.0 2271.8 2273.6 20615.5 21223.2 21767.5 21939.0 21947.1 2589.5 2594.3 2632.8 2640.0 2654.3 132519.3 139908.0 144407.3 151793.2 152002.2 15555.0 16321.7 16538.3 16583.6 16650.9 26338.6 26356.2 26409.6 26413.8 26464.2 11050.8 11073.8 11133.2 11134.3 11347.4 10004.5 10071.8 10104.8 10114.7 10258.1 9694.7 9697.4 10007.0 10158.3 10191.3 2881.0 2888.8 3000.4 3048.2 3102.8 1030.0 1039.6 1041.5 1043.7 1048.5 21472.9 21598.7 21643.9 21653.4 21919.5 1090.8 1120.6 1127.5 1127.5 1129.8 11612.9 11687.6 11719.5 11873.2 11954.5 581834.0 591336.0 603005.0 613250.0 613659.0 124517.0 129386.4 130082.3 134299.0 136404.3 1111.1 1165.1 1213.8 1249.9 1257.8 21786.3 22149.3 22675.8 23050.0 23244.1 61349.4 62080.0 62461.7 62945.0 65286.7 75776.6 76417.6 76575.0 76853.0 77196.6 21005.0 21330.9 21686.0 21717.2 21770.1 24236.9 24368.6 24417.9 24431.1 24479.8 19804.5 19995.9 20008.1 20086.0 20152.5 16969.7 17112.8 17573.1 17964.9 18171.6 19698.5 19788.3 19928.8 20278.8 20363.6 20779.0 20832.0 21042.0 21090.3 21248.2 19388.9 19683.4 19857.9 19928.4 19945.5 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#3] mootools.html Cycles:180 Average:10231.32 Median:2564.04 stddev:7736.16 (301.7%) stddev-sans-first:7729.02 12:24:52 INFO - PID 26137 | Values: 1338.5 1476.6 1478.8 1482.5 1490.3 16358.8 17736.0 17749.9 17753.3 17762.4 17566.4 17874.1 17875.6 17879.2 17903.0 2476.4 2581.4 2650.1 2689.5 2700.9 2727.3 2748.8 2750.8 2751.1 2755.6 2671.1 2681.9 2701.8 2718.7 2732.3 2534.7 2553.7 2560.4 2561.7 2567.8 2539.2 2566.3 2580.2 2584.6 2595.9 16555.9 16561.8 16760.5 16772.3 16784.7 7197.1 7362.1 7389.6 7400.6 7403.0 5104.9 5224.2 5267.7 5323.4 5346.9 2115.5 2124.6 2136.8 2150.7 2165.5 30036.2 30193.5 30219.4 30268.2 30298.5 6786.3 6841.0 6886.9 6938.0 7085.8 19186.2 19337.5 19461.3 19474.6 19495.0 7756.9 7861.4 7909.4 7916.9 7929.8 5920.0 6766.7 7263.1 7609.4 7624.7 5351.4 5486.8 5503.9 5508.7 5528.6 1510.6 1525.0 1527.1 1530.1 1540.4 948.1 968.6 976.1 987.9 990.4 8253.4 8428.2 8463.9 8477.4 8538.0 811.4 822.6 828.9 829.3 836.4 5021.1 5400.5 5870.6 5883.3 5963.0 23980.2 24066.6 24765.6 24890.1 24891.1 24777.3 24856.5 25050.1 25093.9 25138.1 11521.8 12481.3 12501.2 12669.9 12706.2 9096.9 9119.6 9130.5 9160.2 9327.4 20489.2 20691.6 20736.5 21049.3 21336.9 21789.0 21900.7 21919.8 21938.8 22035.1 12109.5 12306.6 12342.4 12414.8 12433.9 15115.6 15129.3 15249.5 15300.3 15345.6 11926.3 12077.2 12207.0 12335.4 12376.8 11378.8 11506.3 11532.5 11629.1 11808.3 10563.5 10770.5 10794.1 10817.4 10829.2 8300.5 8316.2 8384.2 8463.9 8620.0 8191.4 8383.1 8385.5 8455.8 8492.0 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#4] prototype.html Cycles:180 Average:5664.14 Median:6222.42 stddev:1517.18 (24.4%) stddev-sans-first:1472.22 12:24:52 INFO - PID 26137 | Values: 557.4 560.0 575.5 582.9 594.6 6269.4 6288.7 6299.8 6316.0 6370.2 6182.5 6199.5 6201.3 6233.3 6268.4 4869.0 5125.3 5126.5 5148.6 5149.1 4988.9 5014.5 5035.1 5038.2 5047.4 4974.8 4975.6 4989.2 4990.4 5002.2 4962.0 4972.6 4990.8 4997.1 5010.8 4599.0 4601.4 4606.4 4607.6 4608.4 6112.8 6201.5 6205.0 6225.7 6228.5 5760.7 5830.8 5840.5 5868.8 5887.3 6577.0 6597.9 6598.7 6602.6 6677.9 4870.4 5102.9 5112.2 5113.3 5133.6 6601.2 6743.2 6778.7 6847.5 6872.3 5612.4 5640.5 5686.7 5742.4 5755.2 5686.5 5742.5 5792.3 5814.6 5822.7 6111.8 6173.6 6187.5 6202.1 6219.2 6658.8 6716.2 6775.4 6779.5 6788.0 1955.2 1974.3 1994.0 1994.8 2003.9 1465.3 1518.6 1519.8 1526.7 1527.3 6050.5 6083.5 6084.2 6085.8 6125.9 6616.8 6621.2 6632.0 6669.0 6737.5 5974.6 6023.2 6056.0 6112.7 6128.9 3535.8 3542.4 3559.9 3567.6 3577.1 6832.1 6915.6 6996.7 7022.5 7033.4 6704.7 6756.7 6781.4 6831.2 6871.5 6813.3 6904.8 6927.4 6974.8 6986.6 6552.2 6557.3 6583.8 6598.4 6656.4 6602.2 6612.7 6658.9 6682.6 6691.3 6957.5 6964.6 7007.2 7008.5 7016.4 5623.9 5627.6 5642.7 5679.9 5715.8 6391.6 6412.3 6665.8 6685.8 6728.9 6431.9 6491.5 6499.9 6518.3 6587.4 6296.5 6359.0 6424.6 6433.2 6506.7 6241.8 6390.5 6450.6 6472.5 6508.2 6549.7 6576.3 6582.7 6610.7 6618.6 6307.3 6321.4 6362.5 6364.6 6467.6 12:24:52 INFO - PID 26137 | 12:24:52 INFO - PID 26137 | [#5] yui.html Cycles:180 Average:28171.11 Median:18834.36 stddev:41382.35 (219.7%) stddev-sans-first:41448.00 12:24:52 INFO - PID 26137 | Values: 959.9 961.8 967.0 981.4 990.1 19054.4 19502.3 19545.0 19558.9 19617.7 13869.8 13931.6 13962.9 13968.2 14105.4 1058.7 1075.7 1081.1 1082.0 1082.2 1059.4 1060.2 1061.3 1062.0 1063.2 1073.6 1101.0 1101.0 1102.3 1110.6 1109.2 1113.1 1114.0 1114.7 1116.2 789.5 793.9 798.8 800.1 801.8 20292.3 20664.0 20753.5 20761.9 20789.3 23595.5 23722.0 23866.9 24293.6 24393.0 16697.7 16874.0 17048.1 17197.1 17350.9 3981.2 4001.0 4014.7 4034.4 4036.7 131069.0 150661.2 156571.0 159880.0 164691.0 18710.7 18958.0 19170.3 19312.4 19313.8 34376.8 34484.1 34619.7 34724.3 34761.8 10003.0 10166.0 10193.5 10216.3 10242.2 4714.9 4754.5 4789.7 4796.1 4803.9 6006.8 6089.9 6133.1 6136.9 6142.6 1233.2 1259.7 1268.7 1277.7 1278.5 737.3 744.0 746.1 765.6 766.5 13084.5 14140.3 14192.6 14441.4 14705.5 731.1 747.2 747.8 760.4 761.4 6089.0 6249.7 6324.8 6341.6 6348.5 152192.2 153147.0 153704.2 153762.0 158197.0 105616.0 131342.0 132149.3 135353.3 135917.0 108994.5 109023.0 111038.0 111396.0 111626.0 14321.3 14607.3 14630.2 14748.4 14769.6 51653.7 52161.0 52222.5 53161.7 53670.2 66755.7 67439.7 67457.3 68260.3 70201.3 20192.2 20510.7 20592.7 20686.9 20698.7 22758.2 22920.3 22966.7 23068.7 23142.8 18249.8 18283.0 18431.7 18498.5 18571.6 20640.3 20726.3 20746.4 20970.2 21130.3 17442.1 18171.6 18414.4 18466.0 18660.3 14281.4 14404.3 14439.1 14528.8 14560.9 14856.9 15199.0 15230.5 15245.7 15288.3 12:24:52 INFO - PID 26137 | -------- Summary: end -------- 12:24:52 INFO - PID 26137 | 12:24:53 INFO - TEST-INFO | 26137: exit 0 12:24:53 INFO - TEST-OK | dromaeo_css | took 1107344ms 12:24:53 INFO - TEST-START | kraken 12:24:53 INFO - Initialising browser for kraken test... 12:24:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45264/getInfo.html -profile /tmp/tmpwkssc1/profile 12:24:53 INFO - TEST-INFO | started process 26509 (/builds/slave/test/build/application/firefox/firefox http://localhost:45264/getInfo.html) 12:24:58 INFO - TEST-INFO | 26509: exit 0 12:24:58 INFO - Browser initialized. 12:24:58 INFO - Running cycle 1/1 for kraken test... 12:24:58 INFO - Using env: {'DISPLAY': ':0', 12:24:58 INFO - 'HOME': '/home/cltbld', 12:24:58 INFO - 'JSGC_DISABLE_POISONING': '1', 12:24:58 INFO - 'LANG': 'en_US.UTF-8', 12:24:58 INFO - 'LANGUAGE': 'en_US:en', 12:24:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:24:58 INFO - 'LOGNAME': 'cltbld', 12:24:58 INFO - 'MAIL': '/var/mail/cltbld', 12:24:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:24:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:24:58 INFO - 'MOZ_CRASHREPORTER': '1', 12:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:24:58 INFO - 'MOZ_NO_REMOTE': '1', 12:24:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:58 INFO - 'NO_EM_RESTART': '1', 12:24:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:58 INFO - 'PWD': '/builds/slave/test', 12:24:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:24:58 INFO - 'RUST_BACKTRACE': 'full', 12:24:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:24:58 INFO - 'SHELL': '/bin/bash', 12:24:58 INFO - 'SHLVL': '1', 12:24:58 INFO - 'STYLO_FORCE_DISABLED': '1', 12:24:58 INFO - 'TERM': 'linux', 12:24:58 INFO - 'TMOUT': '86400', 12:24:58 INFO - 'USER': 'cltbld', 12:24:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683', 12:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:58 INFO - '_': '/tools/buildbot/bin/python'} 12:24:58 INFO - TEST-INFO | started process 26750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkssc1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:24:59 INFO - PID 26750 | 12:24:59 INFO - PID 26750 | (/builds/slave/test/build/application/firefox/firefox:26799): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:24:59 INFO - PID 26750 | 12:25:10 INFO - PID 26750 | RSS: Main: 141164544 12:25:10 INFO - PID 26750 | 12:25:12 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45264/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:13 INFO - PID 26750 | RSS: Main: 147886080 12:25:13 INFO - PID 26750 | 12:25:16 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45264/tests/kraken/driver.html?testName=audio-dft) 12:25:16 INFO - PID 26750 | RSS: Main: 148197376 12:25:16 INFO - PID 26750 | 12:25:19 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45264/tests/kraken/driver.html?testName=audio-fft) 12:25:20 INFO - PID 26750 | RSS: Main: 144609280 12:25:20 INFO - PID 26750 | 12:25:22 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45264/tests/kraken/driver.html?testName=audio-oscillator) 12:25:22 INFO - PID 26750 | RSS: Main: 146112512 12:25:22 INFO - PID 26750 | 12:25:24 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:25:25 INFO - PID 26750 | RSS: Main: 145256448 12:25:25 INFO - PID 26750 | 12:25:28 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45264/tests/kraken/driver.html?testName=imaging-darkroom) 12:25:29 INFO - PID 26750 | RSS: Main: 145563648 12:25:29 INFO - PID 26750 | 12:25:32 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45264/tests/kraken/driver.html?testName=imaging-desaturate) 12:25:33 INFO - PID 26750 | RSS: Main: 146636800 12:25:33 INFO - PID 26750 | 12:25:36 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45264/tests/kraken/driver.html?testName=json-parse-financial) 12:25:36 INFO - PID 26750 | RSS: Main: 148058112 12:25:36 INFO - PID 26750 | 12:25:38 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:25:38 INFO - PID 26750 | RSS: Main: 147968000 12:25:38 INFO - PID 26750 | 12:25:40 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:25:41 INFO - PID 26750 | RSS: Main: 148353024 12:25:41 INFO - PID 26750 | 12:25:43 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:25:43 INFO - PID 26750 | RSS: Main: 148480000 12:25:43 INFO - PID 26750 | 12:25:46 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:25:46 INFO - PID 26750 | RSS: Main: 148463616 12:25:46 INFO - PID 26750 | 12:25:49 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:25:50 INFO - PID 26750 | RSS: Main: 148770816 12:25:50 INFO - PID 26750 | 12:25:51 INFO - PID 26750 | Cycle 1(1): loaded http://localhost:45264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45264/tests/kraken/driver.html?testName=ai-astar) 12:25:51 INFO - PID 26750 | RSS: Main: 150261760 12:25:51 INFO - PID 26750 | 12:25:51 INFO - PID 26750 | __start_tp_report 12:25:51 INFO - PID 26750 | _x_x_mozilla_page_load 12:25:51 INFO - PID 26750 | _x_x_mozilla_page_load_details 12:25:51 INFO - PID 26750 | |i|pagename|runs| 12:25:51 INFO - PID 26750 | |0;ai-astar;105;104;105;104;106;111;108;107;108;106 12:25:51 INFO - PID 26750 | |1;audio-beat-detection;113;122;113;112;112;115;112;113;112;112 12:25:51 INFO - PID 26750 | |2;audio-dft;163;162;162;162;162;161;163;163;166;166 12:25:51 INFO - PID 26750 | |3;audio-fft;78;76;76;75;75;74;73;74;73;73 12:25:51 INFO - PID 26750 | |4;audio-oscillator;79;79;78;77;77;77;77;78;78;78 12:25:51 INFO - PID 26750 | |5;imaging-gaussian-blur;114;113;113;113;114;113;113;115;113;114 12:25:51 INFO - PID 26750 | |6;imaging-darkroom;150;152;150;151;150;150;149;151;151;150 12:25:51 INFO - PID 26750 | |7;imaging-desaturate;94;95;94;95;94;94;94;94;94;95 12:25:51 INFO - PID 26750 | |8;json-parse-financial;47;55;48;45;45;43;44;43;48;51 12:25:51 INFO - PID 26750 | |9;json-stringify-tinderbox;39;40;40;40;40;40;43;40;40;40 12:25:51 INFO - PID 26750 | |10;stanford-crypto-aes;75;74;76;78;71;72;69;70;72;72 12:25:51 INFO - PID 26750 | |11;stanford-crypto-ccm;108;103;111;104;108;104;114;119;102;103 12:25:51 INFO - PID 26750 | |12;stanford-crypto-pbkdf2;155;154;154;155;158;151;149;148;160;150 12:25:51 INFO - PID 26750 | |13;stanford-crypto-sha256-iterative;62;60;59;59;68;64;62;64;59;65 12:25:51 INFO - PID 26750 | __end_tp_report 12:25:51 INFO - PID 26750 | __start_cc_report 12:25:51 INFO - PID 26750 | _x_x_mozilla_cycle_collect,702 12:25:51 INFO - PID 26750 | __end_cc_report 12:25:51 INFO - PID 26750 | __startTimestamp1506281151989__endTimestamp 12:25:51 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | ------- Summary: start ------- 12:25:52 INFO - PID 26750 | Number of tests: 14 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#0] ai-astar Cycles:10 Average:106.40 Median:106.50 stddev:2.17 (2.0%) stddev-sans-first:2.24 12:25:52 INFO - PID 26750 | Values: 105.0 104.0 105.0 104.0 106.0 111.0 108.0 107.0 108.0 106.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#1] audio-beat-detection Cycles:10 Average:113.60 Median:113.00 stddev:3.10 (2.7%) stddev-sans-first:3.28 12:25:52 INFO - PID 26750 | Values: 113.0 122.0 113.0 112.0 112.0 115.0 112.0 113.0 112.0 112.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.70 (1.0%) stddev-sans-first:1.80 12:25:52 INFO - PID 26750 | Values: 163.0 162.0 162.0 162.0 162.0 161.0 163.0 163.0 166.0 166.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#3] audio-fft Cycles:10 Average:74.70 Median:75.00 stddev:1.64 (2.2%) stddev-sans-first:1.22 12:25:52 INFO - PID 26750 | Values: 78.0 76.0 76.0 75.0 75.0 74.0 73.0 74.0 73.0 73.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 12:25:52 INFO - PID 26750 | Values: 79.0 79.0 78.0 77.0 77.0 77.0 77.0 78.0 78.0 78.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 12:25:52 INFO - PID 26750 | Values: 114.0 113.0 113.0 113.0 114.0 113.0 113.0 115.0 113.0 114.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 12:25:52 INFO - PID 26750 | Values: 150.0 152.0 150.0 151.0 150.0 150.0 149.0 151.0 151.0 150.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:25:52 INFO - PID 26750 | Values: 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.50 stddev:3.81 (8.0%) stddev-sans-first:4.04 12:25:52 INFO - PID 26750 | Values: 47.0 55.0 48.0 45.0 45.0 43.0 44.0 43.0 48.0 51.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#9] json-stringify-tinderbox Cycles:10 Average:40.20 Median:40.00 stddev:1.03 (2.6%) stddev-sans-first:1.00 12:25:52 INFO - PID 26750 | Values: 39.0 40.0 40.0 40.0 40.0 40.0 43.0 40.0 40.0 40.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.00 stddev:2.81 (3.8%) stddev-sans-first:2.87 12:25:52 INFO - PID 26750 | Values: 75.0 74.0 76.0 78.0 71.0 72.0 69.0 70.0 72.0 72.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#11] stanford-crypto-ccm Cycles:10 Average:107.60 Median:108.00 stddev:5.60 (5.2%) stddev-sans-first:5.94 12:25:52 INFO - PID 26750 | Values: 108.0 103.0 111.0 104.0 108.0 104.0 114.0 119.0 102.0 103.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:3.89 (2.5%) stddev-sans-first:4.09 12:25:52 INFO - PID 26750 | Values: 155.0 154.0 154.0 155.0 158.0 151.0 149.0 148.0 160.0 150.0 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:63.00 stddev:3.05 (4.8%) stddev-sans-first:3.23 12:25:52 INFO - PID 26750 | Values: 62.0 60.0 59.0 59.0 68.0 64.0 62.0 64.0 59.0 65.0 12:25:52 INFO - PID 26750 | -------- Summary: end -------- 12:25:52 INFO - PID 26750 | 12:25:52 INFO - PID 26750 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:25:52 INFO - TEST-INFO | 26750: exit 0 12:25:52 INFO - TEST-OK | kraken | took 59186ms 12:25:52 INFO - SUITE-END | took 1166s 12:25:52 INFO - Completed test suite (00:19:26) 12:25:52 INFO - javascript benchmark 12:25:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9097.765964989192, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3870.709696772742, 3878.0, 3925.489686340777, 3925.5485619153787, 3929.5088113985753, 6282.9685851570675, 6322.0832979217985, 6358.237011558608, 6368.1721376221085, 6411.487081033518, 6380.4257616814475, 6406.391392817675, 6435.452986496141, 6435.581687190329, 6447.419732224099, 5604.60767746259, 5630.15547667851, 5682.545396368301, 5735.541156707453, 5736.1682556029355, 5665.8583535411535, 5770.0, 5771.336296325913, 5785.987452195849, 5791.623544469617, 165.55743187311685, 5631.746571404276, 5656.123300888348, 5671.262735844355, 5761.798337058204, 5659.660420374791, 5690.60165788395, 5723.027085395493, 5754.654720716729, 5760.308762948473, 5634.211210430502, 5659.943400566024, 5715.971420142914, 5743.052396354597, 5752.36723960364, 6290.842728931813, 6291.622502649856, 6292.244930608356, 6307.180066591313, 6400.807975760735, 6886.793396198122, 6890.966355046733, 6970.44236461087, 6975.965120174366, 6999.405050570707, 6781.152355955505, 6898.0687607172895, 6947.826304342381, 6982.1970473395195, 6989.196242432135, 6382.0, 6415.454686351665, 6465.450436712838, 6466.224053113657, 6480.125183100268, 7022.6488675566015, 7061.0, 7131.465140114512, 7136.072310599693, 7189.5686258824635, 6718.899216511756, 6803.387695107464, 6806.693698783567, 6824.556403833735, 6834.316568343126, 6965.616891070938, 6966.164060312693, 6994.650267486605, 7005.509614326948, 7062.894056589155, 6880.071190389233, 6887.380135787803, 6895.724171033203, 6921.8961715574305, 6957.234704182536, 6847.623380714109, 6860.5197636164985, 6863.10779598659, 6959.0, 6967.024616553686, 4966.553010229097, 4990.351254336985, 5000.474950130257, 5056.924146137811, 5110.97444512775, 4596.310553416947, 4624.861254162381, 4672.6261899047995, 4680.040591678698, 4699.624030077585, 6253.280872699606, 6323.462505686976, 6403.295637479873, 6415.326390728999, 6421.646809425433, 6653.9667301663185, 6858.1084459021, 6873.278305777922, 6945.722171113099, 6953.687084081229, 6315.684215789192, 6330.588511746721, 6334.651594162366, 6336.271328797156, 6341.936580634135, 5515.917261241085, 5635.492805647511, 5641.097424412074, 5644.209810626516, 5645.774169033275, 7068.151821781419, 7093.1488221413765, 7144.249853765384, 7160.462965277625, 7262.527935684164, 6899.344562266577, 6935.826604334831, 6965.65171741421, 6971.058907047483, 6982.0, 7141.928580714126, 7143.571385716874, 7224.74713385029, 7241.275872412716, 7247.383972362408, 6731.730730770714, 6790.151231096113, 6818.318168183142, 6883.208431030295, 6885.345892140239, 6905.75829845953, 6919.584824910521, 6997.860042799217, 6998.475114366341, 7012.158540975116, 6665.700043497957, 6681.365270299314, 6685.364890335411, 6733.0, 6768.7292508299115, 6349.206349206349, 6472.4174824264155, 6483.059956306215, 6489.967550162219, 6642.4021838034805, 6584.868302633825, 6587.341265873374, 6676.632785196861, 6682.164729408824, 6698.631575263213, 6595.571287866273, 6687.732490700318, 6699.631520266432, 6744.22441419243, 6767.1879374475375, 6512.706928188338, 6548.410643042149, 6558.639274839929, 6646.4350530205475, 6652.101966234496], "value": 6258.946567132378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.459753343061, 945.4469135555695, 961.2166084641017, 989.722877594273, 990.6483198464545, 43023.78488107559, 44452.33321500172, 44472.77763611185, 44514.33228501575, 44527.33209001867, 40549.59450405495, 41045.0, 41048.0, 41063.79468102656, 41398.379024314585, 7616.6191690415535, 7709.151993280735, 7719.189485104067, 7776.416768742339, 7785.727499537517, 7613.619319034026, 7615.390768738515, 7632.122305934833, 7632.427567932399, 7692.576908270043, 8235.752927412188, 8475.618597163142, 8480.78798030048, 8483.575821208946, 8488.0, 8359.498430094183, 8408.789780255482, 8426.452280601741, 8434.325253979698, 8435.873461898076, 7959.681612735483, 8205.0, 8205.343572514244, 8213.712520061768, 8221.958890205571, 39757.20485590301, 40055.79972100121, 40088.79955600233, 40153.39769903454, 40203.0, 3684.060564556021, 3737.103095257146, 3746.718996075278, 3748.987773301221, 3755.042464171646, 32697.182570435692, 32775.18062048444, 32815.179620509676, 32886.83556582226, 32904.34191316184, 5416.241726158341, 5480.123180291174, 5506.091494903336, 5506.311711036121, 5545.611807173499, 233498.9999999983, 233809.0, 233997.0, 234219.0, 234777.0, 52204.47795522072, 52347.214791778155, 52352.47647523552, 52357.47642523526, 52371.47628523742, 54811.17783233255, 55179.0, 55196.72401637966, 55513.61215969633, 55545.0, 16439.0, 16969.660606788042, 16986.490405287863, 16988.405405810983, 16994.915025424794, 13724.0, 13783.241921694202, 13817.0, 13820.723585528232, 13850.584482465541, 15215.239238038053, 15454.536363909101, 15490.605845473961, 15553.611159720871, 15563.144027078619, 6076.453119219292, 6140.539459540552, 6158.258141231227, 6173.444390004921, 6328.651924144124, 1087.374759513283, 1110.744528758374, 1114.2256131988352, 1119.47944205943, 1120.5965852293168, 25468.617970730455, 25534.872325638255, 25558.48883022329, 25563.23310300694, 25563.61654575183, 1190.1668831817763, 1194.5818963362926, 1197.3175290084569, 1217.719924417389, 1219.7987332090106, 13468.0, 13593.59219223425, 13624.386902589407, 13628.795568066487, 13707.0, 289679.0, 291126.0, 291481.0, 292087.0, 292887.0, 50099.0, 50682.74658626757, 56113.7194314034, 56735.43264567384, 57553.0, 1514.9697006059816, 1523.1394262241797, 1525.3288553036627, 1525.8016457860185, 1543.5678010157174, 29970.550441742955, 30186.698133018388, 30260.84869575638, 30340.696593033786, 30344.0, 37230.0, 37318.440223397214, 37351.0, 37391.81304093462, 37423.0, 244615.0, 247737.0, 247770.0, 248028.0, 248070.0, 35092.64907350894, 35222.11944701301, 35292.64707352893, 35668.286634267686, 35709.1072723184, 43700.78149609231, 44721.10557788761, 44857.32714009358, 44860.10279794451, 45111.774441127585, 33626.83186584051, 34006.65993340134, 34123.65876341205, 34215.65784342125, 34444.48333274953, 33948.49077263794, 33950.49074263839, 34248.31503369869, 34529.136771579906, 34794.304113918086, 40153.19693606053, 40244.79877600593, 40484.19031619292, 40494.392584111854, 40637.79681101575, 32563.421814215584, 32608.673913260565, 32787.67212327846, 33037.17407064843, 33263.33473330471, 25162.24513264605, 25190.24429267125, 25468.363290917874, 25598.872005639852, 25668.61497077508], "value": 18567.118690958872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.8475381154711, 612.1399433795516, 613.1630324606913, 614.9631022138672, 636.7739452494365, 22898.427539311524, 23701.881490592565, 23728.76271237287, 23860.88069559654, 23909.521809563797, 21936.89031554844, 22450.43873903153, 22582.66126008107, 22593.209237676685, 22646.547069058608, 5559.749811258483, 5593.468620481048, 5600.467955544217, 5712.8857422851515, 5831.6209446386065, 6378.266499352564, 6649.634270115142, 6664.100346453215, 6695.627396383729, 6762.628055456948, 6574.605523668595, 6585.868282634345, 6603.80188594343, 6605.57063790852, 6607.669616519179, 6560.573562718456, 6563.310852360529, 6597.769078082268, 6605.372489613479, 6609.306022867602, 6355.269144048401, 6369.6496692681885, 6374.394432528902, 6394.616323020634, 6399.968000160016, 31080.844595777104, 31549.842250788828, 31566.210844729067, 31582.842085789423, 31619.36761264785, 2169.143188440557, 2239.731232252124, 2262.0, 2271.7955384015354, 2273.5566564519927, 20615.484612884797, 21223.151073957022, 21767.45581360463, 21939.0, 21947.122115115377, 2589.5468293048643, 2594.299539124445, 2632.8288661236957, 2639.973600263992, 2654.3098794313423, 132519.33740331235, 139908.0, 144407.27796361057, 151793.24103379413, 152002.23998879935, 15555.0, 16321.694264458814, 16538.338466461206, 16583.585410364594, 16650.918635170605, 26338.604920926202, 26356.209313720618, 26409.603855942176, 26413.811378488015, 26464.206073817815, 11050.834237486444, 11073.778524429628, 11133.165012623924, 11134.276272042453, 11347.432628368548, 10004.49977501122, 10071.848922266172, 10104.797904041878, 10114.696559103239, 10258.076773090457, 9694.709158725109, 9697.369670971364, 10007.0, 10158.339707918962, 10191.337563058378, 2881.03485332416, 2888.8411137387225, 3000.4149190907565, 3048.161755517206, 3102.844857757103, 1030.0, 1039.5685790396901, 1041.4792603698152, 1043.6555936541074, 1048.5176818663347, 21472.892635536722, 21598.676019859715, 21643.891780541, 21653.35039948804, 21919.452013699465, 1090.8036553420302, 1120.590984290728, 1127.4588197665166, 1127.5285752093432, 1129.7796929598649, 11612.88387116118, 11687.649370518899, 11719.531218751154, 11873.228240164362, 11954.462049207807, 581834.0, 591336.0, 603005.0, 613250.0, 613659.0, 124517.0, 129386.35306823405, 130082.34958825145, 134299.0, 136404.31797840947, 1111.0833562311125, 1165.0659904558393, 1213.7572485502935, 1249.9187552809037, 1257.8176164456286, 21786.346409607737, 22149.335519934426, 22675.773242268027, 23050.0, 23244.070237190324, 61349.38650613615, 62080.0, 62461.68769156125, 62945.0, 65286.673566631864, 75776.62111689406, 76417.61791191009, 76575.0, 76853.0, 77196.61401692955, 21005.0, 21330.89334553317, 21686.0, 21717.239896603543, 21770.12919483203, 24236.87881560581, 24368.63447048331, 24417.877910611045, 24431.14490992807, 24479.755202447748, 19804.50488737793, 19995.900020500387, 20008.099635516726, 20086.0, 20152.49618759484, 16969.745453817955, 17112.828871711125, 17573.121343932497, 17964.91017544956, 18171.636567268844, 19698.50753731168, 19788.307409241184, 19928.800711992695, 20278.79721202769, 20363.59272814565, 20779.0, 20832.0, 21042.0, 21090.261840835497, 21248.15007399687, 19388.903055484632, 19683.409497715093, 19857.900710496357, 19928.402147935583, 19945.501362466053], "value": 13014.635736336848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.4980632262902, 1476.5791749351438, 1478.7929689843425, 1482.525591810621, 1490.3219035338923, 16358.83641163588, 17736.0, 17749.91125044373, 17753.28986840528, 17762.378316758917, 17566.385176518823, 17874.10629468528, 17875.642487150282, 17879.19543620537, 17903.0, 2476.4304210031705, 2581.4320849413193, 2650.09896635144, 2689.542777727791, 2700.9324766880886, 2727.3454370950926, 2748.7938404619636, 2750.8487033213164, 2751.119641714652, 2755.586662000696, 2671.105179764781, 2681.919542413721, 2701.8378897266225, 2718.687350954636, 2732.303262668017, 2534.6958364996226, 2553.69355677319, 2560.4495033567778, 2561.743825617442, 2567.82025258232, 2539.162076514746, 2566.332753484108, 2580.1614475295414, 2584.612308153773, 2595.9091431799798, 16555.91722041382, 16561.751573726404, 16760.497185084467, 16772.32910683571, 16784.664306713796, 7197.100362454693, 7362.079740032496, 7389.556626602421, 7400.592967386791, 7403.0, 5104.872378190538, 5224.164133738584, 5267.683938963674, 5323.361196656426, 5346.866328341823, 2115.4922818523596, 2124.5857057873723, 2136.75427325858, 2150.709654196679, 2165.469459982314, 30036.24909377261, 30193.547096793565, 30219.395612087636, 30268.24329391783, 30298.545521817192, 6786.287439818748, 6841.0, 6886.8622627547165, 6937.9653101735175, 7085.82285442868, 19186.232550698096, 19337.51656208578, 19461.31885384033, 19474.610507789766, 19495.0, 7756.92243077562, 7861.449698521049, 7909.367250619936, 7916.920830791733, 7929.841403171904, 5919.970400147971, 6766.72933082681, 7263.128424589083, 7609.391248700091, 7624.733134340271, 5351.357837059578, 5486.807961721321, 5503.944960550423, 5508.6970216637665, 5528.55771538276, 1510.637447012731, 1525.0414196458835, 1527.0532269992675, 1530.1048886401356, 1540.4223416218917, 948.1229862377411, 968.5738275158908, 976.0532283684814, 987.896270891546, 990.3859607043535, 8253.422260441832, 8428.241458268663, 8463.915360846437, 8477.406581539357, 8538.0, 811.3711873298241, 822.6298165825283, 828.9171082891662, 829.3199576347458, 836.4186890111314, 5021.14640511114, 5400.459954004568, 5870.647761134345, 5883.3234178069215, 5963.016102343065, 23980.160694375612, 24066.63900041501, 24765.62851557228, 24890.128845490322, 24891.128810491547, 24777.25668229956, 24856.5028699425, 25050.12324568668, 25093.87453062723, 25138.12016579411, 11521.769564608661, 12481.313527756061, 12501.249925004347, 12669.93665031669, 12706.174098683741, 9096.863547046933, 9119.589618467053, 9130.543472826199, 9160.175584197454, 9327.440353578808, 20489.180432782523, 20691.586168276852, 20736.478482046383, 21049.263275785273, 21336.89331553332, 21789.0, 21900.671489927983, 21919.78080219241, 21938.780612193674, 22035.11859525601, 12109.515619375126, 12306.569270075504, 12342.444589993293, 12414.751704965669, 12433.875661243272, 15115.622109447351, 15129.319180636678, 15249.542513724606, 15300.311485982935, 15345.6163595911, 11926.344051077274, 12077.214981026205, 12207.0, 12335.3832308386, 12376.75246495047, 11378.829317560409, 11506.252093613888, 11532.538698452303, 11629.127815413709, 11808.291502509877, 10563.52464139131, 10770.461476926279, 10794.082502987334, 10817.405042722727, 10829.187810914056, 8300.54347010896, 8316.209960053786, 8384.245417912418, 8463.873041904253, 8620.0, 8191.385646076449, 8383.119772424052, 8385.496870187808, 8455.830883382421, 8492.0], "value": 7062.32345155394, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.436988641472, 559.983200503985, 575.5309422820402, 582.8863371642532, 594.5719082260773, 6269.373062693734, 6288.717007734652, 6299.803037422892, 6316.0, 6370.203724534434, 6182.474489668383, 6199.473044791187, 6201.348858369874, 6233.283172435172, 6268.435840774329, 4868.97565512172, 5125.256837758541, 5126.487351264881, 5148.5623721983675, 5149.124648809692, 4988.925166122493, 5014.548690617844, 5035.093683137034, 5038.168702164138, 5047.419546752134, 4974.776135073912, 4975.561974632422, 4989.151844186479, 4990.351254336949, 5002.1746411842005, 4961.975190124044, 4972.6270529710055, 4990.775415106329, 4997.100521906055, 5010.824621138243, 4598.977005114986, 4601.3558101865765, 4606.401167848158, 4607.608353289975, 4608.400907881954, 6112.847178820521, 6201.534884883652, 6205.0, 6225.657588832612, 6228.470580000705, 5760.654360738369, 5830.825075247707, 5840.474357307863, 5868.76524939002, 5887.293524777011, 6577.0, 6597.868042639168, 6598.7030583623855, 6602.580445204304, 6677.93322066778, 4870.4155501340065, 5102.872428189288, 5112.2076078207565, 5113.309703190096, 5133.563647089964, 6601.207855057424, 6743.15710536183, 6778.661066946633, 6847.452203823732, 6872.312768723138, 5612.400465867208, 5640.464155905182, 5686.658800471985, 5742.425757424307, 5755.194272801811, 5686.545076393879, 5742.54059675225, 5792.275965504312, 5814.592978491465, 5822.7088645567555, 6111.816645500642, 6173.59871608344, 6187.504999600022, 6202.131701561785, 6219.191505104398, 6658.833529161713, 6716.194056713226, 6775.3902148805855, 6779.49153813466, 6787.966060169766, 1955.2276850643916, 1974.3385965701364, 1994.0428594274829, 1994.8330226817475, 2003.9499012524805, 1465.3332733606183, 1518.574799056266, 1519.8100237470317, 1526.7175572518897, 1527.2821773766311, 6050.515958723292, 6083.452489275986, 6084.178635884187, 6085.8436896990315, 6125.908111378333, 6616.801495955129, 6621.205455345389, 6632.0, 6668.966655166693, 6737.494687898427, 5974.640017193271, 6023.216981792427, 6055.969720151459, 6112.724927378279, 6128.938710612837, 3535.7701749386206, 3542.362374772514, 3559.8964321060553, 3567.6253993330847, 3577.0878426001723, 6832.1305051878335, 6915.550489218184, 6996.6851491683, 7022.4733145014325, 7033.366996970297, 6704.731810727614, 6756.695948682321, 6781.42357899584, 6831.180258368928, 6871.518993670495, 6813.284605116491, 6904.827379315457, 6927.411170050602, 6974.849149890414, 6986.580805151707, 6552.213734351718, 6557.311482294291, 6583.835404114935, 6598.406143447113, 6656.400923916871, 6602.1747281589805, 6612.685560053943, 6658.866822663423, 6682.599044057372, 6691.297413771484, 6957.478189135733, 6964.616946068015, 7007.194172670004, 7008.474364422586, 7016.438684905297, 5623.8875222496135, 5627.606067575231, 5642.746076426489, 5679.9148012779015, 5715.799947001835, 6391.58454700443, 6412.326705696021, 6665.766698165541, 6685.832854178684, 6728.865422691617, 6431.871362572816, 6491.48068154537, 6499.870002599827, 6518.348165183634, 6587.4071333580205, 6296.496280297657, 6359.046143078575, 6424.646644434414, 6433.228012638513, 6506.73973041092, 6241.750329986931, 6390.52071094679, 6450.580712253689, 6472.482201423781, 6508.15393998796, 6549.7380104795275, 6576.2766095730385, 6582.663154580247, 6610.735570577123, 6618.569792963442, 6307.337729538516, 6321.399467050623, 6362.45919096882, 6364.64994425311, 6467.579607325509], "value": 5243.980431001696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [959.8704174936383, 961.8268711631907, 966.9564869580868, 981.3866333541537, 990.0643891522512, 19054.42836714899, 19502.317418890343, 19545.0, 19558.902205488987, 19617.705734413994, 13869.791953120712, 13931.582052538415, 13962.930185349085, 13968.231747253896, 14105.435782568686, 1058.6506452870553, 1075.688050465368, 1081.124289325645, 1082.0, 1082.1667316166547, 1059.390850261099, 1060.173065009294, 1061.2677252695653, 1061.984070238947, 1063.2450959818539, 1073.5920350266927, 1100.9724756881103, 1100.9889901101008, 1102.3330884814693, 1110.5779803674593, 1109.1958330210614, 1113.0705860606404, 1114.0307932099045, 1114.6934592986913, 1116.1851848150814, 789.4907784479036, 793.9007624046994, 798.8242586630931, 800.1438460846896, 801.7915342011061, 20292.289769858133, 20663.966801659855, 20753.481162970897, 20761.896190519103, 20789.27237546694, 23595.52808943829, 23722.0, 23866.88066559656, 24293.635595466083, 24393.0, 16697.749533757004, 16873.987560746395, 17048.14759262032, 17197.054162021082, 17350.913245433818, 3981.203759248133, 4001.0397504598977, 4014.6788256939376, 4034.4150098235887, 4036.6568841648495, 131069.0, 150661.24669376694, 156571.0, 159880.0, 164691.0, 18710.71933920992, 18958.0, 19170.329038483866, 19312.4206273812, 19313.8068619312, 34376.82811585976, 34484.137896552784, 34619.65380346215, 34724.30551389009, 34761.82619086889, 10003.0, 10166.0, 10193.541290641939, 10216.335938163995, 10242.180625550087, 4714.905701885943, 4754.477007529169, 4789.736564488987, 4796.136695394863, 4803.879903002453, 6006.819795406145, 6089.908651370233, 6133.0800379942475, 6136.8772624547255, 6142.6314421134875, 1233.210745123122, 1259.6787819106069, 1268.7462507498537, 1277.6869666931475, 1278.4886045581657, 737.2848337112991, 743.9814004649927, 746.0636900689708, 765.5636287316288, 766.4787944197888, 13084.542041028519, 14140.292985350692, 14192.574222773334, 14441.422343106158, 14705.529447055209, 731.0934441292759, 747.2266204478339, 747.8242612985944, 760.4182800157884, 761.37186820873, 6088.995315772936, 6249.6875156242, 6324.778632747923, 6341.587796793194, 6348.460380867678, 152192.2390388041, 153147.0, 153704.2314788419, 153762.0, 158197.0, 105616.0, 131342.0, 132149.33925330313, 135353.32323338516, 135917.0, 108994.45502772435, 109022.99999999841, 111038.0, 111396.0, 111626.0, 14321.28393580296, 14607.342669580106, 14630.195339256017, 14748.410063597335, 14769.630759230675, 51653.741731291106, 52161.04618030104, 52222.47777522176, 53161.7341913288, 53670.194947076605, 66755.66622166858, 67439.66280168567, 67457.3254267451, 68260.31739682738, 70201.29798702152, 20192.192312307343, 20510.69233961462, 20592.691109633666, 20686.896565517076, 20698.689519657517, 22758.20346287938, 22920.312390628307, 22966.655500167177, 23068.653970190797, 23142.768572314733, 18249.81750182481, 18283.0, 18431.723524147415, 18498.537536561693, 18571.628567428845, 20640.27759028427, 20726.274580390218, 20746.377608671763, 20970.16119355209, 21130.260440884496, 17442.127893605524, 18171.636567268317, 18414.35549755752, 18466.0, 18660.253589856253, 14281.42874285017, 14404.279786010447, 14439.133651980916, 14528.782068268772, 14560.854391456374, 14856.851431485979, 15199.0, 15230.46693365727, 15245.695086097994, 15288.318284988865], "value": 10122.67243347888, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 105.0, 104.0, 106.0, 111.0, 108.0, 107.0, 108.0, 106.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 122.0, 113.0, 112.0, 112.0, 115.0, 112.0, 113.0, 112.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 163.0, 166.0, 166.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 75.0, 75.0, 74.0, 73.0, 74.0, 73.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 78.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 115.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 151.0, 150.0, 150.0, 149.0, 151.0, 151.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 55.0, 48.0, 45.0, 45.0, 43.0, 44.0, 43.0, 48.0, 51.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 40.0, 40.0, 40.0, 40.0, 40.0, 43.0, 40.0, 40.0, 40.0], "value": 40.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 78.0, 71.0, 72.0, 69.0, 70.0, 72.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 111.0, 104.0, 108.0, 104.0, 114.0, 119.0, 102.0, 103.0], "value": 107.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 154.0, 155.0, 158.0, 151.0, 149.0, 148.0, 160.0, 150.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 59.0, 68.0, 64.0, 62.0, 64.0, 59.0, 65.0], "value": 62.2, "unit": "score"}]}]} 12:25:52 INFO - Return code: 0 12:25:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:25:52 INFO - # TBPL SUCCESS # 12:25:52 INFO - Running post-action listener: _package_coverage_data 12:25:52 INFO - Running post-action listener: _resource_record_post_action 12:25:52 INFO - [mozharness: 2017-09-24 19:25:52.760880Z] Finished run-tests step (success) 12:25:52 INFO - Running post-run listener: _resource_record_post_run 12:25:52 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 330076160; Read time: 0; Write time: 192472 12:25:52 INFO - TinderboxPrint: CPU usage
13.1% 12:25:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:25:52 INFO - TinderboxPrint: I/O write bytes / time
330,076,160 / 192,472 12:25:52 INFO - TinderboxPrint: CPU idle
8,204.9 (86.9%) 12:25:52 INFO - TinderboxPrint: CPU user
1,187.5 (12.6%) 12:25:52 INFO - TinderboxPrint: Swap in / out
0 / 0 12:25:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12623872; Read time: 0; Write time: 996 12:25:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:25:52 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 316837888; Read time: 0; Write time: 191476 12:25:53 INFO - Running post-run listener: _upload_blobber_files 12:25:53 INFO - Blob upload gear active. 12:25:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:25:53 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 12:25:53 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'] 12:25:53 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 12:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:55 INFO - (blobuploader) - INFO - Done attempting. 12:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:56 INFO - (blobuploader) - INFO - Done attempting. 12:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:25:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:25:56 INFO - (blobuploader) - INFO - Done attempting. 12:25:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:00 INFO - (blobuploader) - INFO - Done attempting. 12:26:00 INFO - (blobuploader) - INFO - Iteration through files over. 12:26:00 INFO - Return code: 0 12:26:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:26:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:26:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b715f936d217b2384f61c4c2f7392d4b71276900bf5ddf4933bd2fbe94c2eb47f40be0f0929038780157e15700bc273f7060383fd86b7f3b0fd03a4c48441cb5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d51275cb0af6d9148f6220e174c234445df2279f7214b2f7619d2a415253c780fc96a1354d5c627ade82edbd0d65efc0441588a088e60e07b755cfb03f9e823", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df712ee732b79bb03b4709506928c5da3c7b0aa9080fea86e9d4941bfd45955e74f813aba3b03556d2bc93673b02303d86427e9ac87fa6f568b22657367e78c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f605e894145322664a40c029bc219ed946b60dccb606bd00698e254d85f143e7b31c6ca91c201814d25bcc364757ab094a77b38e15da0083d14d42714a8dce0c"} 12:26:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:26:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:26:00 INFO - Contents: 12:26:00 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b715f936d217b2384f61c4c2f7392d4b71276900bf5ddf4933bd2fbe94c2eb47f40be0f0929038780157e15700bc273f7060383fd86b7f3b0fd03a4c48441cb5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d51275cb0af6d9148f6220e174c234445df2279f7214b2f7619d2a415253c780fc96a1354d5c627ade82edbd0d65efc0441588a088e60e07b755cfb03f9e823", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df712ee732b79bb03b4709506928c5da3c7b0aa9080fea86e9d4941bfd45955e74f813aba3b03556d2bc93673b02303d86427e9ac87fa6f568b22657367e78c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f605e894145322664a40c029bc219ed946b60dccb606bd00698e254d85f143e7b31c6ca91c201814d25bcc364757ab094a77b38e15da0083d14d42714a8dce0c"} 12:26:00 INFO - Running post-run listener: copy_logs_to_upload_dir 12:26:00 INFO - Copying logs to upload dir... 12:26:00 INFO - mkdir: /builds/slave/test/build/upload/logs 12:26:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.715782 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-24 12:26:00.589113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 12:26:00.593683) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b715f936d217b2384f61c4c2f7392d4b71276900bf5ddf4933bd2fbe94c2eb47f40be0f0929038780157e15700bc273f7060383fd86b7f3b0fd03a4c48441cb5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d51275cb0af6d9148f6220e174c234445df2279f7214b2f7619d2a415253c780fc96a1354d5c627ade82edbd0d65efc0441588a088e60e07b755cfb03f9e823", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df712ee732b79bb03b4709506928c5da3c7b0aa9080fea86e9d4941bfd45955e74f813aba3b03556d2bc93673b02303d86427e9ac87fa6f568b22657367e78c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f605e894145322664a40c029bc219ed946b60dccb606bd00698e254d85f143e7b31c6ca91c201814d25bcc364757ab094a77b38e15da0083d14d42714a8dce0c"} build_url:https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/GuT1PCFFRDO-QtxXURDi3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b715f936d217b2384f61c4c2f7392d4b71276900bf5ddf4933bd2fbe94c2eb47f40be0f0929038780157e15700bc273f7060383fd86b7f3b0fd03a4c48441cb5", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d51275cb0af6d9148f6220e174c234445df2279f7214b2f7619d2a415253c780fc96a1354d5c627ade82edbd0d65efc0441588a088e60e07b755cfb03f9e823", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df712ee732b79bb03b4709506928c5da3c7b0aa9080fea86e9d4941bfd45955e74f813aba3b03556d2bc93673b02303d86427e9ac87fa6f568b22657367e78c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f605e894145322664a40c029bc219ed946b60dccb606bd00698e254d85f143e7b31c6ca91c201814d25bcc364757ab094a77b38e15da0083d14d42714a8dce0c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 12:26:00.630535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:26:00.631001) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1506279407.91745-1816112683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 12:26:00.716298) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 12:26:00.716650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 12:26:00.717043) ========= ========= Total master_lag: 0.31 =========