builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1505415519.16 results: success (0) revision: 593158cd491002031b4527a95d9bfac79c0cdcef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.160724) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.161146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.161418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.321363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.326648) ========= 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=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 11:58:39-- 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% 33.1M=0s 2017-09-14 11:58:39 (33.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.340080 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.774483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.774781) ========= 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=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019233 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:39.846610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 11:58:39.846908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 593158cd491002031b4527a95d9bfac79c0cdcef --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 593158cd491002031b4527a95d9bfac79c0cdcef --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=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 11:58:40,077 truncating revision to first 12 chars 2017-09-14 11:58:40,077 Setting DEBUG logging. 2017-09-14 11:58:40,078 attempt 1/10 2017-09-14 11:58:40,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/593158cd4910?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 11:58:41,075 unpacking tar archive at: mozilla-central-593158cd4910/testing/mozharness/ program finished with exit code 0 elapsedTime=1.496336 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-14 11:58:41.407750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:41.408051) ========= script_repo_revision: 593158cd491002031b4527a95d9bfac79c0cdcef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:41.408420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:41.408690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 11:58:41.421740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-14 11:58:41.422006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:58:41 INFO - MultiFileLogger online at 20170914 11:58:41 in /builds/slave/test 11:58:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:58:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:41 INFO - {'append_to_log': False, 11:58:41 INFO - 'base_work_dir': '/builds/slave/test', 11:58:41 INFO - 'blob_upload_branch': 'Firefox', 11:58:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:41 INFO - 'branch': 'Firefox', 11:58:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:41 INFO - 'code_coverage': False, 11:58:41 INFO - 'config_files': ('talos/linux_config.py',), 11:58:41 INFO - 'default_actions': ('clobber', 11:58:41 INFO - 'read-buildbot-config', 11:58:41 INFO - 'download-and-extract', 11:58:41 INFO - 'populate-webroot', 11:58:41 INFO - 'create-virtualenv', 11:58:41 INFO - 'install', 11:58:41 INFO - 'setup-mitmproxy', 11:58:41 INFO - 'run-tests'), 11:58:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:41 INFO - 'disable_ccov_upload': False, 11:58:41 INFO - 'disable_stylo': False, 11:58:41 INFO - 'download_minidump_stackwalk': True, 11:58:41 INFO - 'download_symbols': 'ondemand', 11:58:41 INFO - 'enable_stylo': False, 11:58:41 INFO - 'enable_webrender': False, 11:58:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:58:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:41 INFO - 'gecko_profile': False, 11:58:41 INFO - 'gecko_profile_interval': 0, 11:58:41 INFO - 'installer_path': 'installer.exe', 11:58:41 INFO - 'log_level': 'info', 11:58:41 INFO - 'log_name': 'talos', 11:58:41 INFO - 'log_to_console': True, 11:58:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:58:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:58:41 INFO - 'opt_config_files': (), 11:58:41 INFO - 'pip_index': False, 11:58:41 INFO - 'suite': 'dromaeojs-e10s', 11:58:41 INFO - 'system_bits': '32', 11:58:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:41 INFO - 'title': 'talos-linux64-ix-048', 11:58:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:41 INFO - 'use_talos_json': True, 11:58:41 INFO - 'verify': 'False', 11:58:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:41 INFO - 'work_dir': 'build'} 11:58:41 INFO - [mozharness: 2017-09-14 18:58:41.751944Z] Running clobber step. 11:58:41 INFO - Running pre-action listener: _resource_record_pre_action 11:58:41 INFO - Running main action method: clobber 11:58:41 INFO - rmtree: /builds/slave/test/build 11:58:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:42 INFO - Running post-action listener: _resource_record_post_action 11:58:42 INFO - [mozharness: 2017-09-14 18:58:42.770173Z] Finished clobber step (success) 11:58:42 INFO - [mozharness: 2017-09-14 18:58:42.770269Z] Running read-buildbot-config step. 11:58:42 INFO - Running pre-action listener: _resource_record_pre_action 11:58:42 INFO - Running main action method: read_buildbot_config 11:58:42 INFO - Using buildbot properties: 11:58:42 INFO - { 11:58:42 INFO - "project": "", 11:58:42 INFO - "product": "firefox", 11:58:42 INFO - "who": "ffxbld@noreply.mozilla.org", 11:58:42 INFO - "installer_path": "public/build/target.tar.bz2", 11:58:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:58:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:58:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:58:42 INFO - "stage_platform": "linux64-pgo", 11:58:42 INFO - "basedir": "/builds/slave/test", 11:58:42 INFO - "buildnumber": 159, 11:58:42 INFO - "platform": "ubuntu64_hw", 11:58:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:58:42 INFO - "slavebuilddir": "test", 11:58:42 INFO - "taskId": "EIG1wpxyQXacIsa7XG33lQ", 11:58:42 INFO - "branch": "mozilla-central", 11:58:42 INFO - "script_repo_revision": "production", 11:58:42 INFO - "revision": "593158cd491002031b4527a95d9bfac79c0cdcef", 11:58:42 INFO - "slavename": "talos-linux64-ix-048", 11:58:42 INFO - "repo_path": "mozilla-central" 11:58:42 INFO - } 11:58:42 INFO - Finding installer, test and symbols from parent task. 11:58:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EIG1wpxyQXacIsa7XG33lQ'}, attempt #1 11:58:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EIG1wpxyQXacIsa7XG33lQ'}, attempt #1 11:58:43 INFO - Task dependencies: O2IBbQo6SfSfBf03JQSl2A 11:58:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A'}, attempt #1 11:58:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 11:58:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.test_packages.json 11:58:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.crashreporter-symbols.zip 11:58:44 INFO - Running post-action listener: _resource_record_post_action 11:58:44 INFO - [mozharness: 2017-09-14 18:58:44.131323Z] Finished read-buildbot-config step (success) 11:58:44 INFO - [mozharness: 2017-09-14 18:58:44.131581Z] Running download-and-extract step. 11:58:44 INFO - Running pre-action listener: _resource_record_pre_action 11:58:44 INFO - Running main action method: download_and_extract 11:58:44 INFO - mkdir: /builds/slave/test/build/tests 11:58: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')]} 11:58:44 INFO - trying https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.test_packages.json 11:58:44 INFO - Downloading https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:58:44 INFO - Downloaded 989 bytes. 11:58:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:58:44 INFO - Using the following test package requirements: 11:58:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:58:44 INFO - u'common': [u'target.common.tests.zip'], 11:58:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:58:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:58:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:58:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:58:44 INFO - u'mozbase': [u'target.common.tests.zip'], 11:58:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:58:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:58:44 INFO - u'web-platform': [u'target.common.tests.zip', 11:58:44 INFO - u'target.web-platform.tests.tar.gz'], 11:58:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:58:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.common.tests.zip 11:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:58:44 INFO - Fetch https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.common.tests.zip into memory 11:58:45 INFO - Content-Length response header: 55193750 11:58:45 INFO - Bytes received: 55193750 11:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.talos.tests.zip 11:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.talos.tests.zip into memory 11:58:57 INFO - Content-Length response header: 14500356 11:58:57 INFO - Bytes received: 14500356 11:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:57 INFO - trying https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 11:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:58:58 INFO - Downloaded 62170127 bytes. 11:58:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 11:58:58 INFO - mkdir: /builds/slave/test/properties 11:58:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:58 INFO - Contents: 11:58:58 INFO - build_url:https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 11:58:58 INFO - Running post-action listener: _resource_record_post_action 11:58:58 INFO - Running post-action listener: find_tests_for_verification 11:58:58 INFO - Running post-action listener: set_extra_try_arguments 11:58:58 INFO - [mozharness: 2017-09-14 18:58:58.806127Z] Finished download-and-extract step (success) 11:58:58 INFO - [mozharness: 2017-09-14 18:58:58.806223Z] Running populate-webroot step. 11:58:58 INFO - Running pre-action listener: _resource_record_pre_action 11:58:58 INFO - Running main action method: populate_webroot 11:58:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['tresize', 11:58:58 INFO - 'tcanvasmark']}, 11:58:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['dromaeo_css', 11:58:58 INFO - 'kraken']}, 11:58:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'tests': ['damp', 'tps']}, 11:58:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['damp', 'tps']}, 11:58:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['dromaeo_dom']}, 11:58:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:58:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['basic_compositor_video', 11:58:58 INFO - 'glvideo']}, 11:58:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:58:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['ts_paint_webext', 11:58:58 INFO - 'tp5o_webext']}, 11:58:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:58 INFO - 'ts_paint', 11:58:58 INFO - 'tpaint', 11:58:58 INFO - 'sessionrestore', 11:58:58 INFO - 'sessionrestore_many_windows', 11:58:58 INFO - 'sessionrestore_no_auto_restore', 11:58:58 INFO - 'tabpaint']}, 11:58:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['a11yr', 11:58:58 INFO - 'ts_paint', 11:58:58 INFO - 'tpaint', 11:58:58 INFO - 'sessionrestore', 11:58:58 INFO - 'sessionrestore_many_windows', 11:58:58 INFO - 'sessionrestore_no_auto_restore', 11:58:58 INFO - 'tabpaint']}, 11:58:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:58:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:58:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['bloom_basic_singleton']}, 11:58:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['bloom_basic']}, 11:58:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:58 INFO - 'tsvgr_opacity', 11:58:58 INFO - 'tart', 11:58:58 INFO - 'tscrollx', 11:58:58 INFO - 'tsvg_static']}, 11:58:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['tsvgx', 11:58:58 INFO - 'tsvgr_opacity', 11:58:58 INFO - 'tart', 11:58:58 INFO - 'tscrollx', 11:58:58 INFO - 'tsvg_static']}, 11:58:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:58:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo'], 11:58:58 INFO - 'tests': ['tp5o']}, 11:58:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:58 INFO - 'talos_options': ['--mitmproxy', 11:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:58 INFO - '--firstNonBlankPaint'], 11:58:58 INFO - 'tests': ['tp6_google', 11:58:58 INFO - 'tp6_youtube', 11:58:58 INFO - 'tp6_amazon', 11:58:58 INFO - 'tp6_facebook']}, 11:58:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo', 11:58:58 INFO - '--mitmproxy', 11:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:58 INFO - '--firstNonBlankPaint'], 11:58:58 INFO - 'tests': ['tp6_google', 11:58:58 INFO - 'tp6_youtube', 11:58:58 INFO - 'tp6_amazon', 11:58:58 INFO - 'tp6_facebook']}, 11:58:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:58:58 INFO - 'talos_options': ['--stylo-threads=1', 11:58:58 INFO - '--mitmproxy', 11:58:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:58:58 INFO - '--firstNonBlankPaint'], 11:58:58 INFO - 'tests': ['tp6_google', 11:58:58 INFO - 'tp6_youtube', 11:58:58 INFO - 'tp6_amazon', 11:58:58 INFO - 'tp6_facebook']}, 11:58:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--xperf_path', 11:58:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:58 INFO - 'tests': ['tp5n']}, 11:58:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:58:58 INFO - 'talos_options': ['--disable-stylo', 11:58:58 INFO - '--xperf_path', 11:58:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:58 INFO - 'tests': ['tp5n']}}} 11:58:58 INFO - Running post-action listener: _resource_record_post_action 11:58:58 INFO - [mozharness: 2017-09-14 18:58:58.822151Z] Finished populate-webroot step (success) 11:58:58 INFO - [mozharness: 2017-09-14 18:58:58.822278Z] Running create-virtualenv step. 11:58:58 INFO - Running pre-action listener: _resource_record_pre_action 11:58:58 INFO - Running main action method: create_virtualenv 11:58:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:58:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:58:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:58:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:59:01 INFO - Installing pip...............done. 11:59:01 INFO - Return code: 0 11:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:59:02 INFO - Reading from file tmpfile_stdout 11:59:02 INFO - Output received: 11:59:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:59:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59: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')]} 11:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:59:02 INFO - Using env: {'DISPLAY': ':0', 11:59:02 INFO - 'HOME': '/home/cltbld', 11:59:02 INFO - 'LANG': 'en_US.UTF-8', 11:59:02 INFO - 'LANGUAGE': 'en_US:en', 11:59:02 INFO - 'LOGNAME': 'cltbld', 11:59:02 INFO - 'MAIL': '/var/mail/cltbld', 11:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:02 INFO - 'MOZ_NO_REMOTE': '1', 11:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:02 INFO - 'NO_EM_RESTART': '1', 11:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:02 INFO - 'PWD': '/builds/slave/test', 11:59:02 INFO - 'SHELL': '/bin/bash', 11:59:02 INFO - 'SHLVL': '1', 11:59:02 INFO - 'TERM': 'linux', 11:59:02 INFO - 'TMOUT': '86400', 11:59:02 INFO - 'USER': 'cltbld', 11:59:02 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:02 INFO - '_': '/tools/buildbot/bin/python'} 11:59:03 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:59:03 INFO - Downloading/unpacking pip>=1.5 11:59:03 INFO - Running setup.py egg_info for package pip 11:59:03 INFO - warning: no files found matching 'pip/cacert.pem' 11:59:03 INFO - warning: no files found matching '*.html' under directory 'docs' 11:59:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:59:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:59:03 INFO - Installing collected packages: pip 11:59:03 INFO - Found existing installation: pip 1.1 11:59:03 INFO - Uninstalling pip: 11:59:03 INFO - Successfully uninstalled pip 11:59:03 INFO - Running setup.py install for pip 11:59:03 INFO - warning: no files found matching 'pip/cacert.pem' 11:59:03 INFO - warning: no files found matching '*.html' under directory 'docs' 11:59:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:59:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:59:03 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:59:03 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:59:03 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:59:03 INFO - Successfully installed pip 11:59:03 INFO - Cleaning up... 11:59:03 INFO - Return code: 0 11:59:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:59:03 INFO - Using env: {'DISPLAY': ':0', 11:59:03 INFO - 'HOME': '/home/cltbld', 11:59:03 INFO - 'LANG': 'en_US.UTF-8', 11:59:03 INFO - 'LANGUAGE': 'en_US:en', 11:59:03 INFO - 'LOGNAME': 'cltbld', 11:59:03 INFO - 'MAIL': '/var/mail/cltbld', 11:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:03 INFO - 'MOZ_NO_REMOTE': '1', 11:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:03 INFO - 'NO_EM_RESTART': '1', 11:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:03 INFO - 'PWD': '/builds/slave/test', 11:59:03 INFO - 'SHELL': '/bin/bash', 11:59:03 INFO - 'SHLVL': '1', 11:59:03 INFO - 'TERM': 'linux', 11:59:03 INFO - 'TMOUT': '86400', 11:59:03 INFO - 'USER': 'cltbld', 11:59:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:03 INFO - '_': '/tools/buildbot/bin/python'} 11:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:03 INFO - Downloading/unpacking psutil>=3.1.1 11:59: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 11:59: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 11:59: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 11:59: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 11:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:59:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:04 INFO - Installing collected packages: psutil 11:59:04 INFO - Running setup.py install for psutil 11:59:04 INFO - building 'psutil._psutil_linux' extension 11:59:04 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 11:59:04 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 11:59:04 INFO - building 'psutil._psutil_posix' extension 11:59:04 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 11:59:05 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 11:59:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:05 INFO - Successfully installed psutil 11:59:05 INFO - Cleaning up... 11:59:05 INFO - Return code: 0 11:59:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:59: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')]} 11:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59: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')]} 11:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:05 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:05 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 11:59:05 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 11:59:05 INFO - Using env: {'DISPLAY': ':0', 11:59:05 INFO - 'HOME': '/home/cltbld', 11:59:05 INFO - 'LANG': 'en_US.UTF-8', 11:59:05 INFO - 'LANGUAGE': 'en_US:en', 11:59:05 INFO - 'LOGNAME': 'cltbld', 11:59:05 INFO - 'MAIL': '/var/mail/cltbld', 11:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:05 INFO - 'MOZ_NO_REMOTE': '1', 11:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:05 INFO - 'NO_EM_RESTART': '1', 11:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:05 INFO - 'PWD': '/builds/slave/test', 11:59:05 INFO - 'SHELL': '/bin/bash', 11:59:05 INFO - 'SHLVL': '1', 11:59:05 INFO - 'TERM': 'linux', 11:59:05 INFO - 'TMOUT': '86400', 11:59:05 INFO - 'USER': 'cltbld', 11:59:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:05 INFO - '_': '/tools/buildbot/bin/python'} 11:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:59: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 11:59: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 11:59: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 11:59: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 11:59:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:59:06 INFO - Installing collected packages: mozsystemmonitor 11:59:06 INFO - Running setup.py install for mozsystemmonitor 11:59:06 INFO - Successfully installed mozsystemmonitor 11:59:06 INFO - Cleaning up... 11:59:06 INFO - Return code: 0 11:59:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:06 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:06 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 11:59:06 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 11:59:06 INFO - Using env: {'DISPLAY': ':0', 11:59:06 INFO - 'HOME': '/home/cltbld', 11:59:06 INFO - 'LANG': 'en_US.UTF-8', 11:59:06 INFO - 'LANGUAGE': 'en_US:en', 11:59:06 INFO - 'LOGNAME': 'cltbld', 11:59:06 INFO - 'MAIL': '/var/mail/cltbld', 11:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:06 INFO - 'MOZ_NO_REMOTE': '1', 11:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:06 INFO - 'NO_EM_RESTART': '1', 11:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:06 INFO - 'PWD': '/builds/slave/test', 11:59:06 INFO - 'SHELL': '/bin/bash', 11:59:06 INFO - 'SHLVL': '1', 11:59:06 INFO - 'TERM': 'linux', 11:59:06 INFO - 'TMOUT': '86400', 11:59:06 INFO - 'USER': 'cltbld', 11:59:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:06 INFO - '_': '/tools/buildbot/bin/python'} 11:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:06 INFO - Downloading/unpacking jsonschema==2.5.1 11:59:06 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 11:59:06 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 11:59:06 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 11:59:06 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 11:59:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:59:08 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 11:59:08 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 11:59:08 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 11:59:08 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 11:59:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:08 INFO - warning: no files found matching '*.txt' 11:59:08 INFO - no previously-included directories found matching 'build' 11:59:08 INFO - no previously-included directories found matching 'dist' 11:59:08 INFO - no previously-included directories found matching '.git*' 11:59:08 INFO - Installing collected packages: jsonschema, functools32 11:59:08 INFO - Running setup.py install for functools32 11:59:09 INFO - warning: no files found matching '*.txt' 11:59:09 INFO - no previously-included directories found matching 'build' 11:59:09 INFO - no previously-included directories found matching 'dist' 11:59:09 INFO - no previously-included directories found matching '.git*' 11:59:09 INFO - Successfully installed jsonschema functools32 11:59:09 INFO - Cleaning up... 11:59:09 INFO - Return code: 0 11:59:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:09 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:09 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 11:59:09 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 11:59:09 INFO - Using env: {'DISPLAY': ':0', 11:59:09 INFO - 'HOME': '/home/cltbld', 11:59:09 INFO - 'LANG': 'en_US.UTF-8', 11:59:09 INFO - 'LANGUAGE': 'en_US:en', 11:59:09 INFO - 'LOGNAME': 'cltbld', 11:59:09 INFO - 'MAIL': '/var/mail/cltbld', 11:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:09 INFO - 'MOZ_NO_REMOTE': '1', 11:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:09 INFO - 'NO_EM_RESTART': '1', 11:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:09 INFO - 'PWD': '/builds/slave/test', 11:59:09 INFO - 'SHELL': '/bin/bash', 11:59:09 INFO - 'SHLVL': '1', 11:59:09 INFO - 'TERM': 'linux', 11:59:09 INFO - 'TMOUT': '86400', 11:59:09 INFO - 'USER': 'cltbld', 11:59:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:09 INFO - '_': '/tools/buildbot/bin/python'} 11:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:59:09 INFO - Cleaning up... 11:59:09 INFO - Return code: 0 11:59:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:09 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:09 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 11:59:09 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 11:59:09 INFO - Using env: {'DISPLAY': ':0', 11:59:09 INFO - 'HOME': '/home/cltbld', 11:59:09 INFO - 'LANG': 'en_US.UTF-8', 11:59:09 INFO - 'LANGUAGE': 'en_US:en', 11:59:09 INFO - 'LOGNAME': 'cltbld', 11:59:09 INFO - 'MAIL': '/var/mail/cltbld', 11:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:09 INFO - 'MOZ_NO_REMOTE': '1', 11:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:09 INFO - 'NO_EM_RESTART': '1', 11:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:09 INFO - 'PWD': '/builds/slave/test', 11:59:09 INFO - 'SHELL': '/bin/bash', 11:59:09 INFO - 'SHLVL': '1', 11:59:09 INFO - 'TERM': 'linux', 11:59:09 INFO - 'TMOUT': '86400', 11:59:09 INFO - 'USER': 'cltbld', 11:59:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:09 INFO - '_': '/tools/buildbot/bin/python'} 11:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 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 11:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:11 INFO - Downloading docopt-0.6.1.tar.gz 11:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:11 INFO - Running setup.py install for blobuploader 11:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:11 INFO - Running setup.py install for requests 11:59:11 INFO - Running setup.py install for docopt 11:59:11 INFO - Successfully installed blobuploader requests docopt 11:59:11 INFO - Cleaning up... 11:59:11 INFO - Return code: 0 11:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:11 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:11 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 11:59:11 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 11:59:11 INFO - Using env: {'DISPLAY': ':0', 11:59:11 INFO - 'HOME': '/home/cltbld', 11:59:11 INFO - 'LANG': 'en_US.UTF-8', 11:59:11 INFO - 'LANGUAGE': 'en_US:en', 11:59:11 INFO - 'LOGNAME': 'cltbld', 11:59:11 INFO - 'MAIL': '/var/mail/cltbld', 11:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:11 INFO - 'MOZ_NO_REMOTE': '1', 11:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:11 INFO - 'NO_EM_RESTART': '1', 11:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:11 INFO - 'PWD': '/builds/slave/test', 11:59:11 INFO - 'SHELL': '/bin/bash', 11:59:11 INFO - 'SHLVL': '1', 11:59:11 INFO - 'TERM': 'linux', 11:59:11 INFO - 'TMOUT': '86400', 11:59:11 INFO - 'USER': 'cltbld', 11:59:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:11 INFO - '_': '/tools/buildbot/bin/python'} 11:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:12 INFO - Running setup.py (path:/tmp/pip-zgkyvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:12 INFO - Running setup.py (path:/tmp/pip-iTghFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:12 INFO - Running setup.py (path:/tmp/pip-l5Cf_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:12 INFO - Running setup.py (path:/tmp/pip-06kjJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:12 INFO - Running setup.py (path:/tmp/pip-cpab61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:12 INFO - Running setup.py (path:/tmp/pip-D3NKfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:12 INFO - Running setup.py (path:/tmp/pip-ASBcNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:12 INFO - Running setup.py (path:/tmp/pip-A9zXZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:12 INFO - Running setup.py (path:/tmp/pip-mrdi_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:12 INFO - Running setup.py (path:/tmp/pip-KFBqZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:12 INFO - Running setup.py (path:/tmp/pip-JazZcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:12 INFO - Running setup.py (path:/tmp/pip-jZmjgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:12 INFO - Running setup.py (path:/tmp/pip-bv34NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:12 INFO - Running setup.py (path:/tmp/pip-fTbWu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:13 INFO - Running setup.py (path:/tmp/pip-hGm4ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:13 INFO - Running setup.py (path:/tmp/pip-oFerrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:13 INFO - Running setup.py (path:/tmp/pip-bziudQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:13 INFO - Running setup.py install for manifestparser 11:59:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:13 INFO - Running setup.py install for mozcrash 11:59:13 INFO - Running setup.py install for mozdebug 11:59:13 INFO - Running setup.py install for mozdevice 11:59:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:13 INFO - Running setup.py install for mozfile 11:59:13 INFO - Running setup.py install for mozhttpd 11:59:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:13 INFO - Running setup.py install for mozinfo 11:59:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:13 INFO - Running setup.py install for mozInstall 11:59:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozleak 11:59:14 INFO - Running setup.py install for mozlog 11:59:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for moznetwork 11:59:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozprocess 11:59:14 INFO - Running setup.py install for mozprofile 11:59:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozrunner 11:59:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:14 INFO - Running setup.py install for mozscreenshot 11:59:14 INFO - Running setup.py install for moztest 11:59:14 INFO - Running setup.py install for mozversion 11:59:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:15 INFO - Cleaning up... 11:59:15 INFO - Return code: 0 11:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:15 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:15 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 11:59:15 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 11:59:15 INFO - Using env: {'DISPLAY': ':0', 11:59:15 INFO - 'HOME': '/home/cltbld', 11:59:15 INFO - 'LANG': 'en_US.UTF-8', 11:59:15 INFO - 'LANGUAGE': 'en_US:en', 11:59:15 INFO - 'LOGNAME': 'cltbld', 11:59:15 INFO - 'MAIL': '/var/mail/cltbld', 11:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:15 INFO - 'MOZ_NO_REMOTE': '1', 11:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:15 INFO - 'NO_EM_RESTART': '1', 11:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:15 INFO - 'PWD': '/builds/slave/test', 11:59:15 INFO - 'SHELL': '/bin/bash', 11:59:15 INFO - 'SHLVL': '1', 11:59:15 INFO - 'TERM': 'linux', 11:59:15 INFO - 'TMOUT': '86400', 11:59:15 INFO - 'USER': 'cltbld', 11:59:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:15 INFO - '_': '/tools/buildbot/bin/python'} 11:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:15 INFO - Running setup.py (path:/tmp/pip-vlt9Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:15 INFO - Running setup.py (path:/tmp/pip-NCv_Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:15 INFO - Running setup.py (path:/tmp/pip-dS0bLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:15 INFO - Running setup.py (path:/tmp/pip-DlcUhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:15 INFO - Running setup.py (path:/tmp/pip-7WvDcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:15 INFO - Running setup.py (path:/tmp/pip-f68uGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:15 INFO - Running setup.py (path:/tmp/pip-iFRcJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:15 INFO - Running setup.py (path:/tmp/pip-nNZv8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:15 INFO - Running setup.py (path:/tmp/pip-UNaGHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:15 INFO - Running setup.py (path:/tmp/pip-nGD41G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:15 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)) 11:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:15 INFO - Running setup.py (path:/tmp/pip-G6DLIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:16 INFO - Running setup.py (path:/tmp/pip-rRJudX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:16 INFO - Running setup.py (path:/tmp/pip-wNkIsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:16 INFO - Running setup.py (path:/tmp/pip-cddy1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:16 INFO - Running setup.py (path:/tmp/pip-cfK4e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:16 INFO - Running setup.py (path:/tmp/pip-MAE3q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:16 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)) 11:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:16 INFO - Running setup.py (path:/tmp/pip-St9KBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:16 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)) 11:59:16 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)) 11:59:16 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)) 11:59:16 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)) 11:59:16 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)) 11:59:16 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)) 11:59:16 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)) 11:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:17 INFO - Downloading blessings-1.6.tar.gz 11:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:17 INFO - Installing collected packages: blessings 11:59:17 INFO - Running setup.py install for blessings 11:59:17 INFO - Successfully installed blessings 11:59:17 INFO - Cleaning up... 11:59:17 INFO - Return code: 0 11:59:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:17 INFO - Reading from file tmpfile_stdout 11:59:17 INFO - Current package versions: 11:59:17 INFO - argparse == 1.2.1 11:59:17 INFO - blessings == 1.6 11:59:17 INFO - blobuploader == 1.2.4 11:59:17 INFO - docopt == 0.6.1 11:59:17 INFO - functools32 == 3.2.3-2 11:59:17 INFO - jsonschema == 2.5.1 11:59:17 INFO - manifestparser == 1.1 11:59:17 INFO - mozInstall == 1.13 11:59:17 INFO - mozcrash == 1.0 11:59:17 INFO - mozdebug == 0.1 11:59:17 INFO - mozdevice == 0.51 11:59:17 INFO - mozfile == 1.2 11:59:17 INFO - mozhttpd == 0.7 11:59:17 INFO - mozinfo == 0.10 11:59:17 INFO - mozleak == 0.1 11:59:17 INFO - mozlog == 3.5 11:59:17 INFO - moznetwork == 0.27 11:59:17 INFO - mozprocess == 0.25 11:59:17 INFO - mozprofile == 0.28 11:59:17 INFO - mozrunner == 6.13 11:59:18 INFO - mozscreenshot == 0.1 11:59:18 INFO - mozsystemmonitor == 0.3 11:59:18 INFO - moztest == 0.8 11:59:18 INFO - mozversion == 1.4 11:59:18 INFO - psutil == 3.1.1 11:59:18 INFO - requests == 1.2.3 11:59:18 INFO - wsgiref == 0.1.2 11:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:18 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:18 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 11:59:18 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 11:59:18 INFO - Using env: {'DISPLAY': ':0', 11:59:18 INFO - 'HOME': '/home/cltbld', 11:59:18 INFO - 'LANG': 'en_US.UTF-8', 11:59:18 INFO - 'LANGUAGE': 'en_US:en', 11:59:18 INFO - 'LOGNAME': 'cltbld', 11:59:18 INFO - 'MAIL': '/var/mail/cltbld', 11:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:18 INFO - 'MOZ_NO_REMOTE': '1', 11:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:18 INFO - 'NO_EM_RESTART': '1', 11:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:18 INFO - 'PWD': '/builds/slave/test', 11:59:18 INFO - 'SHELL': '/bin/bash', 11:59:18 INFO - 'SHLVL': '1', 11:59:18 INFO - 'TERM': 'linux', 11:59:18 INFO - 'TMOUT': '86400', 11:59:18 INFO - 'USER': 'cltbld', 11:59:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:18 INFO - '_': '/tools/buildbot/bin/python'} 11:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 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)) 11:59:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:59:19 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)) 11:59:19 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)) 11:59:19 INFO - Installing collected packages: simplejson 11:59:19 INFO - Running setup.py install for simplejson 11:59:19 INFO - building 'simplejson._speedups' extension 11:59:19 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 11:59:20 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 11:59:20 INFO - Successfully installed simplejson 11:59:20 INFO - Cleaning up... 11:59:20 INFO - Return code: 0 11:59:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:20 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')]} 11:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:20 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')]} 11:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:20 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 0x1abe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, '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': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', '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 11:59:20 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 11:59:20 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 11:59:20 INFO - Using env: {'DISPLAY': ':0', 11:59:20 INFO - 'HOME': '/home/cltbld', 11:59:20 INFO - 'LANG': 'en_US.UTF-8', 11:59:20 INFO - 'LANGUAGE': 'en_US:en', 11:59:20 INFO - 'LOGNAME': 'cltbld', 11:59:20 INFO - 'MAIL': '/var/mail/cltbld', 11:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:20 INFO - 'MOZ_NO_REMOTE': '1', 11:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:20 INFO - 'NO_EM_RESTART': '1', 11:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:20 INFO - 'PWD': '/builds/slave/test', 11:59:20 INFO - 'SHELL': '/bin/bash', 11:59:20 INFO - 'SHLVL': '1', 11:59:20 INFO - 'TERM': 'linux', 11:59:20 INFO - 'TMOUT': '86400', 11:59:20 INFO - 'USER': 'cltbld', 11:59:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:20 INFO - '_': '/tools/buildbot/bin/python'} 11:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:59:20 INFO - Cleaning up... 11:59:20 INFO - Return code: 0 11:59:20 INFO - Running post-action listener: _resource_record_post_action 11:59:20 INFO - Running post-action listener: _start_resource_monitoring 11:59:20 INFO - Starting resource monitoring. 11:59:20 INFO - [mozharness: 2017-09-14 18:59:20.701454Z] Finished create-virtualenv step (success) 11:59:20 INFO - [mozharness: 2017-09-14 18:59:20.701921Z] Running install step. 11:59:20 INFO - Running pre-action listener: _resource_record_pre_action 11:59:20 INFO - Running main action method: install 11:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:20 INFO - Reading from file tmpfile_stdout 11:59:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:21 INFO - Reading from file tmpfile_stdout 11:59:21 INFO - Output received: 11:59:21 INFO - Usage: mozinstall [options] installer 11:59:21 INFO - Options: 11:59:21 INFO - -h, --help show this help message and exit 11:59:21 INFO - -d DEST, --destination=DEST 11:59:21 INFO - Directory to install application into. [default: 11:59:21 INFO - "/builds/slave/test"] 11:59:21 INFO - --app=APP Application being installed. [default: firefox] 11:59:21 INFO - mkdir: /builds/slave/test/build/application 11:59:21 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'] 11:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:59:38 INFO - Reading from file tmpfile_stdout 11:59:38 INFO - Output received: 11:59:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:59:38 INFO - Running post-action listener: _resource_record_post_action 11:59:38 INFO - [mozharness: 2017-09-14 18:59:38.686220Z] Finished install step (success) 11:59:38 INFO - [mozharness: 2017-09-14 18:59:38.686364Z] Running setup-mitmproxy step. 11:59:38 INFO - Running pre-action listener: _resource_record_pre_action 11:59:38 INFO - Running main action method: setup_mitmproxy 11:59:38 INFO - Skipping: mitmproxy is not required 11:59:38 INFO - Running post-action listener: _resource_record_post_action 11:59:38 INFO - [mozharness: 2017-09-14 18:59:38.686891Z] Finished setup-mitmproxy step (success) 11:59:38 INFO - [mozharness: 2017-09-14 18:59:38.686995Z] Running run-tests step. 11:59:38 INFO - Running pre-action listener: _resource_record_pre_action 11:59:38 INFO - Running pre-action listener: _set_gcov_prefix 11:59:38 INFO - Running main action method: run_tests 11:59:38 WARNING - Try message not found. 11:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:38 INFO - Python 2.7.3 11:59:38 INFO - Return code: 0 11:59:38 INFO - grabbing minidump binary from tooltool 11:59:38 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')]} 11:59:38 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 0x1e2e090>, '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 0x1e2ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:38 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 11:59:38 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 11:59:38 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 11:59:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:38 INFO - Return code: 0 11:59:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:59:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:38 INFO - ENV: RUST_BACKTRACE is now full 11:59:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:59:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:59:38 INFO - Using env: {'DISPLAY': ':0', 11:59:38 INFO - 'HOME': '/home/cltbld', 11:59:38 INFO - 'LANG': 'en_US.UTF-8', 11:59:38 INFO - 'LANGUAGE': 'en_US:en', 11:59:38 INFO - 'LOGNAME': 'cltbld', 11:59:38 INFO - 'MAIL': '/var/mail/cltbld', 11:59:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:38 INFO - 'MOZ_NO_REMOTE': '1', 11:59:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:38 INFO - 'NO_EM_RESTART': '1', 11:59:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:38 INFO - 'PWD': '/builds/slave/test', 11:59:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:38 INFO - 'RUST_BACKTRACE': 'full', 11:59:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:59:38 INFO - 'SHELL': '/bin/bash', 11:59:38 INFO - 'SHLVL': '1', 11:59:38 INFO - 'TERM': 'linux', 11:59:38 INFO - 'TMOUT': '86400', 11:59:38 INFO - 'USER': 'cltbld', 11:59:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:38 INFO - '_': '/tools/buildbot/bin/python'} 11:59:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:59:39 INFO - mozversion application_buildid: 20170914174242 11:59:39 INFO - mozversion application_changeset: 593158cd491002031b4527a95d9bfac79c0cdcef 11:59:39 INFO - mozversion application_display_name: Nightly 11:59:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:39 INFO - mozversion application_name: Firefox 11:59:39 INFO - mozversion application_remotingname: firefox 11:59:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:59:39 INFO - mozversion application_vendor: Mozilla 11:59:39 INFO - mozversion application_version: 57.0a1 11:59:39 INFO - mozversion platform_buildid: 20170914174242 11:59:39 INFO - mozversion platform_changeset: 593158cd491002031b4527a95d9bfac79c0cdcef 11:59:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:59:39 INFO - mozversion platform_version: 57.0a1 11:59:39 INFO - using testdate: 1505415579 11:59:39 INFO - actual date: 1505415579 11:59:39 INFO - starting webserver on 'localhost:43450' 11:59:39 INFO - SUITE-START | Running 2 tests 11:59:39 INFO - TEST-START | dromaeo_css 11:59:39 INFO - Initialising browser for dromaeo_css test... 11:59:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43450/getInfo.html -profile /tmp/tmpEkdHiB/profile 11:59:39 INFO - TEST-INFO | started process 9353 (/builds/slave/test/build/application/firefox/firefox http://localhost:43450/getInfo.html) 11:59:44 INFO - TEST-INFO | 9353: exit 0 11:59:44 INFO - Browser initialized. 11:59:44 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:44 INFO - Using env: {'DISPLAY': ':0', 11:59:44 INFO - 'HOME': '/home/cltbld', 11:59:44 INFO - 'JSGC_DISABLE_POISONING': '1', 11:59:44 INFO - 'LANG': 'en_US.UTF-8', 11:59:44 INFO - 'LANGUAGE': 'en_US:en', 11:59:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:59:44 INFO - 'LOGNAME': 'cltbld', 11:59:44 INFO - 'MAIL': '/var/mail/cltbld', 11:59:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:44 INFO - 'MOZ_CRASHREPORTER': '1', 11:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:59:44 INFO - 'MOZ_NO_REMOTE': '1', 11:59:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:44 INFO - 'NO_EM_RESTART': '1', 11:59:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:44 INFO - 'PWD': '/builds/slave/test', 11:59:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:44 INFO - 'RUST_BACKTRACE': 'full', 11:59:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:59:44 INFO - 'SHELL': '/bin/bash', 11:59:44 INFO - 'SHLVL': '1', 11:59:44 INFO - 'TERM': 'linux', 11:59:44 INFO - 'TMOUT': '86400', 11:59:44 INFO - 'USER': 'cltbld', 11:59:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 11:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:44 INFO - '_': '/tools/buildbot/bin/python'} 11:59:44 INFO - TEST-INFO | started process 9585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEkdHiB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:45 INFO - PID 9585 | 11:59:45 INFO - PID 9585 | (/builds/slave/test/build/application/firefox/firefox:9635): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:59:45 INFO - PID 9585 | 11:59:55 INFO - PID 9585 | RSS: Main: 166346752 11:59:55 INFO - PID 9585 | 12:02:53 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43450/tests/dromaeo/cssquery-ext.html) 12:02:54 INFO - PID 9585 | RSS: Main: 169570304 12:02:54 INFO - PID 9585 | 12:05:56 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-ext.html (next: http://localhost:43450/tests/dromaeo/cssquery-jquery.html) 12:05:57 INFO - PID 9585 | RSS: Main: 165601280 12:05:57 INFO - PID 9585 | 12:08:58 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43450/tests/dromaeo/cssquery-mootools.html) 12:08:59 INFO - PID 9585 | RSS: Main: 168165376 12:08:59 INFO - PID 9585 | 12:12:00 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43450/tests/dromaeo/cssquery-prototype.html) 12:12:01 INFO - PID 9585 | RSS: Main: 166526976 12:12:01 INFO - PID 9585 | 12:15:04 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43450/tests/dromaeo/cssquery-yui.html) 12:15:05 INFO - PID 9585 | RSS: Main: 167780352 12:15:05 INFO - PID 9585 | 12:18:06 INFO - PID 9585 | Cycle 1(1): loaded http://localhost:43450/tests/dromaeo/cssquery-yui.html (next: http://localhost:43450/tests/dromaeo/cssquery-dojo.html) 12:18:07 INFO - PID 9585 | RSS: Main: 170795008 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | __start_tp_report 12:18:07 INFO - PID 9585 | _x_x_mozilla_page_load 12:18:07 INFO - PID 9585 | _x_x_mozilla_page_load_details 12:18:07 INFO - PID 9585 | |i|pagename|runs| 12:18:07 INFO - PID 9585 | |0;dojo.html;3779.376402893522;3789.185325155091;3800.50593422855;3804.543454785426;3858.807059647017;6119.2350956130485;6219.19150510433;6283.151774510439;6329.9683501582485;6337.873242535146;6185.288691800433;6207.5965062270925;6231.283402408724;6263.498920086394;6404.96797516013;5605.7197140142825;5680.460356266148;5710.343310519281;5736.368999410061;5759.5968282220265;5419.105847535152;5665.405132461094;5680.460356266148;5698;5740.311162660487;5248.7889088784195;5632.9436705632825;5705.486506214419;5720.485156335929;5733.541316694655;5642.830715078554;5667.4332566743;5704.629199102045;5711.143328500717;5712.742926568314;5505.394406615269;5524.723763811793;5551.9722401387735;5576.693281869496;5680.176374425727;6165.260168779775;6175.197224360804;6175.5985860919345;6186.041163619646;6238.532110091716;6676.833079173011;6711.597304161766;6715.2277488089;6782.796516104525;6884.724611015554;6839.452843772487;6933.514653974224;6934.861302773917;6941.305869413019;6945.583265004116;6318.4629306509005;6337.936620633781;6339.953907605286;6341.87316253677;6456.644884531349;6813.523053386215;6883.7590684325805;6958.65206739661;7037.8240543985785;7076.0801095857205;6764.154480689914;6794.150731158606;6814.454843612499;6816.795496135124;6825.965870170618;6850.554713943578;6852.349026842542;6922.376986071177;6928.653567321614;6929.237783843773;6606.240282367589;6742.258351581322;6743.123393958754;6795.082663840319;6854.0404343391965;6695.631740254333;6702.329767023259;6708.463322934153;6709.228438729609;6775.62734049632;4975.278584605212;4976.925346119811;4981.825636102719;4986;5003.149464591028;4456.9331460028125;4484.798184081724;4540.387047748512;4543.227651299287;4549.772511374418;6160.507159427235;6313.210848643919;6316.557840951181;6394.712237949303;6400.039994000844;6733.326667333227;6797.184337879387;6817.840967035616;6852.486063545154;6869.347411995853;6267.62394256346;6313.684315784192;6319.462845658079;6324.430801227912;6394.8721025579225;5413.891722165535;5495.313085864267;5553.777848885999;5564.443555644403;5565.693886836182;6818.897716534256;6951.652417379212;6967.7212911482975;6969.47728920333;6970.337817907291;6619.139511863427;6623.105880706043;6803.795886123424;6813.318668133147;6819.863602728017;6934.618595977269;7099.964500177466;7118.537295075804;7123.643817809192;7138.428925686037;6689.397954184147;6730.226024007302;6771.593704377753;6793;6862.107925969592;6647.102641143384;6747.493937954771;6767.221769496571;6770.5599136056;6775.525713200029;6484.902726459012;6501.804945851632;6525.282218956006;6575.145231119924;6634.601923884582;6361.586496877688;6448.1295025171;6532.118164047983;6615.206175259;6628.436582890508;6535.411812936859;6607.47140228771;6632.50256230775;6636.43590294811;6645;6575.736970521317;6646.9002964956535;6686.063951046955;6700.229473610597;6724.058631791651;6273.529485288713;6337.4613157882095;6359.20509936258;6412.326705696021;6515.609063456208 12:18:07 INFO - PID 9585 | |1;ext.html;877.0630240896024;948.8007518421131;954.6133815804598;981.1464026297123;981.4700061966538;45538.999999999956;46439;46467.76766116165;46477.7676111619;46578;43757.12485750291;43766.34350484745;43923;43952.56047439525;43986.120277594426;7336.376408005312;7390.40876729863;7460.253974602523;7472.29013243741;7479.3642540384135;7312.122545294572;7376.077990251219;7376.520526165809;7392.112946446434;7397.667104980289;7438.293362130589;8231;8232.34141268697;8234.876476852853;8238.546879921601;8125.1062383137805;8182.099969003405;8189.467684600482;8196.508209507449;8198.713045043425;7837.177096404853;7989.640466179036;7999.9600001999615;8002.19978002201;8086.433949623529;41026;41438.1712365751;41459.1708165838;41502.377464337755;41542.79228603838;3633.073566240592;3679.4480827875764;3682.042668906077;3683.0608194910396;3684.778913265213;33296.33407331864;33530.83234583836;33532.32935341304;33539.832300838585;33657.831710841536;5408.188771684239;5440.945590544084;5459.617826752129;5495.148252020943;5509.752061157257;210641;218846;218937;219201;219400;48909.266361004615;54237.45762542403;55140;55635.443645563835;55675.16487252695;58098.7095064522;58394.95617653362;58516.414835851945;58612.41387586155;58667.70666146642;16879.83120168807;16919.407820726214;16951;16964.151792410576;16979.575510612332;13401.597952061455;13598;13626.182429054288;13630.22807035099;13672.65818354549;15739.527814165593;15845.128517931624;15900.76148857768;15976.041437513786;16043.518694439186;6105.175801266772;6246.906296405557;6283.748650054038;6289.55973081889;6333.1766870306565;1094.9781004380027;1103.0789290941993;1116.6761639124563;1117.8323251512338;1118.222835129577;25466.74533254681;25578.232653020066;25598;25865.224043278733;26105;1180.7831765753315;1206.8612109607332;1212.5695378140633;1217.4643157010887;1224.302147775777;13343.332833358294;13463.192208467523;13601.591952241448;13640.931795340959;13724;278803;282679;283622;284210;284476;59658;59658.70170649119;60033;60049.699751500964;60163.699181504686;1492;1518.6203449137715;1527.6791873706425;1537.8846586505833;1556.1285680019225;24844.639759222846;24928.62607060932;24955.377900436415;24961.375965601004;25060.749392506572;42019.7899010503;42199.7890010548;42277.78861105798;42327.57672423359;42512.57487425086;234009;234232;234334;235719;235840;34601;36600.08499787527;40232.79883600563;42370.36444453274;42414.78792606017;52361.7381913088;53363.46636533585;53546;53753.46246537485;54087;37184;37321.440178396806;37502;37530;38033.42949855699;37604.623953760114;37876.81061594674;37979;38114.61885381111;38387.232255355295;44010.33984490299;45390;45434.77282613566;45496.54503455055;45497;36349;37110.44334334933;37262.62737372592;37546.249075018895;38051;27009.189724308304;27103.1869043929;27138.32154196161;27273.86363068172;27420.862895685394 12:18:07 INFO - PID 9585 | |2;jquery.html;596.1951365656367;597.6682940967764;606.1090197409808;606.1937622961461;607.2894713185573;23724.288271351867;24441.26676199717;24447;24449.144279950204;24499;24555.14057008005;24768.628470572956;24806;24816.503669926635;24895.37761555962;6537.117489138976;6754.831129221784;6764.59412435253;6766.357196066366;6766.424853887401;6517.511186660996;6574.211094668646;6648.867022659544;6801.625910574917;6828.146481689789;6748.527603067787;6766.188057433115;6767.323267673218;6781.22015968165;6786.762463313785;6440.098386225932;6655.101561289212;6714.19429668438;6719.49603779716;6759.222689390709;6232.9376706232815;6240.5319601030105;6268.467180289681;6272.937270627281;6274.717637706269;30013;30318.84840575805;30359.24101897448;30410.239744006354;30423.69576304231;2321.141177764238;2329.301209637119;2340.8361414700976;2347.178487529351;2350.8001819845335;19321.323753668694;20586.485337866674;20730.378088657366;20747.377578672666;20826.166953322;2524.8737563121954;2528.190978886757;2589.4432696970243;2598.6881574211216;2601.7658410742933;136821;144198;148561;153870;154186;15455.459058932884;15694.215289235493;16109.758353624471;16149.434769783002;16242.187890605423;25353.492930141292;25479.745202547736;25507.617385739228;25551.61672574913;25632.231033069038;10497.422641754776;10540.789184216273;10602.522886470128;10659.335166208448;10740.570377184982;9611.615535378507;9725;9772.16936560386;9775.853362199572;9840.753981150528;9561.187299079516;9726.507191295896;9776.853347199798;9864.605415783431;9885.604575816888;2732.8770205340807;2813.338865366637;2906.694797046322;2907.2731817045737;2934.7212014858555;1054.5360041581832;1056.5140035583718;1059.676798576426;1066.8613080299667;1068.8663917010374;20979.580408391746;21270.042848071873;21309;21491.892540537196;21556.56886862254;1115.2750712037077;1128.1482480727163;1139.2196345503357;1139.9772004560027;1146.3236690352733;11465.942670286595;11823.290602563873;11929.22460040112;12022.519099235933;12022.879771202352;682022;685580;702674;706551;717927;127464;128448.35775821249;129504.35247823888;129619;131400.3429982863;1120.6862078617837;1161.7908776420156;1196;1212.8120141378101;1262.797952327623;21454.892725536898;21774.237901673365;21822.018009189942;21900.780992189873;21985.78014219901;59968;61939.6903015482;62706;62901.37098629138;64304;74720;75717.24282757103;76803.61598191973;80250;81401.59299203467;15250.31373588169;15470;15610.141442220787;15617.297221624827;15631.140287284308;23624.527509450058;24068.87965560161;24247.15134970338;24268.271951841474;24339.75660243375;19478.805211948267;19832.801671983096;19874.70187947153;19910.303139390053;19932;17312.913435432743;17326;17785.110744462985;18072.90963545174;18121.728174077136;19149.234030638618;19391.4182574523;19444;19548.511287217934;20016.399508014783;15086.019408738397;15219.467318643794;15241.542753717406;15265.084094954338;15345.846541534442;18723.344682936033;18800.435986919867;19853.503662408555;19942.90028549848;19986.800131998494 12:18:07 INFO - PID 9585 | |3;mootools.html;1411.6823714664201;1488.3525666335142;1489.7467430536808;1502.579277802215;1504.3380912398543;17021.489355319343;17510.387136450227;17528.649427011453;17530;17554.297828086877;17044.488665340028;17156.884802487828;17229.569260768454;17229.827701722978;17246.482605521855;2827.349709566801;2898.362360280745;2900.1009686996995;2902.3034471726846;2914.985425072882;2860.5566137248657;2876.3096856754332;2882.5820256062857;2883.553049277355;2884.2933481297114;2762.903298384557;2856.7286107819723;2856.9286517555915;2858.628378310827;2859.2137162280437;2823.50588646988;2881.1644623059287;2886.9422611547757;2895.1314605618336;2896.5365541513465;2663.3741070848337;2831.830090194595;2842.3888863894153;2842.8436435996014;2849.088291746642;16615.750763738553;16838.494845154666;16840.831591684047;16845.241964111643;16846.326146954107;8203.876941845878;8541.316694664412;8558.486490810572;8558.61486233121;8566.400351975364;5179.249008893727;5343.225232341328;5351.464853514617;5459.099248624012;5468.808591699271;2105.221068204759;2114.260008996854;2154.8168405685537;2190.452386903274;2193.967090493644;29044.27389315263;29395.70604293951;29412.8529357354;29456.263593410124;29464.410711785644;7090.716371345192;7096.680649370791;7123.821904452327;7325.450591205575;7347.37547308474;19474.707879381822;19527.316543921177;19543;19557.804421955883;19567.60864782725;8078.111407745143;8316.542590157478;8321.334293256525;8329.50022998622;8340.999080110425;7468.365188958891;7579.242075792376;7607.391408687292;7700.152983171846;7824.452288339761;5329.653572517774;5462.8361149165585;5519.69641669704;5545.584081193927;5581.10702287632;1548.8218854831614;1558.859702626769;1559.438602103242;1561.320825440937;1573.9763903541457;963.5471328475605;978.1001478639669;981.5804043033813;986.6201512417628;1008.4856723071287;8620.741377758677;8640.438371505832;8654.95672521646;8695.391322607484;8703.825923481494;751.0799270893222;780.1457404142454;789.534174836849;814.3241109878786;825.7068740597122;5637.943620563742;5805.274340707411;5806.796762113306;5859.946094861188;6050.334463209044;23157;23564.175253866033;23640.88179559091;23877.16429924944;23927;22676.2063327786;23080.192193273157;23568.410789730395;23686.407839804142;23795.881020594785;12079.335636540074;12101.455434505468;12208.023358131328;12261.69345766363;12264.509419623115;9177.449353038839;9232.21526170283;9264.53677316145;9271.165595096474;9304.488253146143;19669.40991770249;19738.901305493957;19899.104540295433;20136.697949531062;20531.794682052987;20716.274930377363;20887;21215.8939205303;21264.893675531523;21395.67906481373;11986.64040078799;12037.217580857216;12173.39133043362;12200;12273.87726122763;14715.337809798799;14969.476068337992;15008.47470338533;15074.54776356711;15079.246037697852;11558.884411155781;11588.6523404298;11642.88357116418;11861.881381186078;11884.702882428008;11016.889831101907;11162.441877906234;11346.659600212008;11439.942800285946;11628.94185529067;9318.906810931803;9470.14768670823;9528.094830991045;9534.141927226583;9536.66621668266;7820.944172536862;7908.960455197917;7933.286004259644;8047.155048720034;8057.637406316847;7832.490888092256;7902;7993.520388776459;8043.3967452442475;8051.154628763896 12:18:07 INFO - PID 9585 | |4;prototype.html;551.5256879083988;563.5773170122408;584.4214227914365;589.6609449566498;593.4510577715612;6186.814395568129;6214.161088253085;6215.5338349623735;6266.248050233972;6269.623822570649;6131.233595800525;6159.291681456634;6172.166757487737;6195.380461953813;6238.750449982007;5091.414487333948;5094.694318340893;5117.771734783643;5132.538071573557;5141.177411614151;5023.572996295319;5033.97282174261;5070.492950704936;5089.618278629117;5095.719735414551;4752.144613969484;4891.975540122312;4909.263610458424;4929.21132618781;4941;4908.239222920453;4933.876653083702;4936.827211047632;4945.950540494603;4980.103581355373;4380.518143004267;4470.642348612103;4497.685162038659;4502.549745025504;4508.391367165424;5971.910421343639;6034.6422055037265;6058.6364818110615;6083.239595050619;6095.329513753483;5804.622699524517;5833.883322333572;5842.707864606795;5843.53251739864;5865.0615901455985;6421.967890160566;6524.902126468107;6538.267359149829;6555.3772391622715;6662.167229096363;4996.350474438336;4996.850094497171;5024.874378140539;5032.572231360339;5045.192769156954;6694.899576506356;6822.727090916407;6867.450603951722;6963.16442026955;7008.894866577006;5095.719735414587;5100.464451232641;5185.948140518622;5190.92213616796;5226.268322434862;5262.973685131627;5267.920981185285;5273;5279.498447647467;5298.205269209572;5801.50687191585;5827.854303642443;5832.241808564944;5850.707464626752;5867.589268751147;6517.51118666102;6521.282658907517;6610.041543976096;6647.933520664828;6687.331266873273;1758.1472985601972;1795.1024487756122;1805.9187336569885;1814.818518148201;1818.1454716283326;1242.2981015726086;1294.5339677716015;1302.4920281090383;1302.8827405533548;1316.3681432912065;6063.514918806485;6081.969590152021;6154.907676384858;6204.534659900525;6219.813405597839;6327.557071004985;6499.805005849832;6518.478521718251;6669.333066693389;6684.766033188815;6017.127516510169;6101.115338275925;6102.481289090389;6112.572119951649;6118.20463339763;3431.4509678451827;3454.1537323355938;3487.459443786217;3488.8081155536183;3508.3334166508794;6786.929986354111;6835.14560679915;6899.896501552481;6982.1272340957385;7003.614801185984;6648.933510664928;6694.631795251211;6714.287856596537;6778;6780.525363224626;6821.54276578745;6877.518573699893;6939.64676888002;6965.721371145098;6979.581225126509;6537;6559.934400655932;6596.60420374779;6609.173853268341;6643.7674681385915;6576.80269591913;6627.4698024158915;6670.866582668416;6672.399484046459;6683.231428385798;6968.077134435892;6977.151054970538;6996.755113571001;7011.404030657452;7020.438364930896;5187.170052791535;5191.948080519146;5200.2719619252575;5205.73971301441;5221.451747566451;6517.641529715911;6690.19717633887;6711.731530738716;6781.559198652072;6814.352636499525;6303.203586977689;6370.649614271259;6413.102165696713;6490.286068532363;6501.154849869676;6342.587731797418;6360.49116070704;6413.775517856852;6523.510736694672;6531.477481801349;6364.204474440695;6370.299267080525;6380.915244408555;6388.936110638834;6454.806355809334;6360.204974378203;6504.804855854332;6522.412982831568;6568.671566421755;6572.474202063919;6207.720652570555;6256.405641464054;6263.467605253604;6315.515853774267;6385.936140638534 12:18:07 INFO - PID 9585 | |5;yui.html;962.2494454325629;987.057360220989;1012.8784545854503;1015.1117771949545;1018.5060245780797;18643;19098;19134.617307653854;19143.712844307345;19146.138423770928;17826.286948522044;18947.715784263248;19055.333063342787;19196.42410727677;19213.903930480363;999.0717914425175;1019.337430670063;1020.1787561013381;1020.6529779874841;1021.7701017271091;1070.5557193764578;1113.6269349767838;1118.5302173087282;1120.9047230985377;1121.899029087382;1165.74353642199;1165.8367828504017;1166;1166.6908269308597;1168.1997831485417;1139.3790384240608;1141.1156353825768;1143.5711608146944;1147.466428110924;1153.0141728821861;811.7970507373157;825.3562221467265;827.4538804389134;827.4704189318841;827.735124760077;18534.165962531584;18743.812561874343;18779.342723004767;18784.62430751391;18784.812151878443;18907.527311817175;19175.90412047945;19203.519912002314;19218.615627687366;19417.320393786293;17524.299028038862;17760.733588996176;17789.822101778947;17840.732389014174;17985.7302140468;3901.200253947934;3914.432407300954;3926.293267211901;3930.862419815293;3949.150932549516;152502;156328;157256;157557;160568;16461.83538164627;16569.502914912573;16706.832931670528;16768.916155419145;16858.40995565174;34038.65961340355;34703.652963470544;34879;34901.82549087238;34902;7838.412119091091;7910.288074073361;7982.560959147303;7989.640466179036;8061.153578874251;4588.082383523309;4700.88247793801;4706.835260765857;4709.95290047102;4720.480747117815;5795.217645617872;5901.0558310670085;6008.849778755479;6014.849628759316;6016.127661489059;1081.5241293830688;1091.47063674118;1115.1079136690614;1116.0959622705634;1119.9216054876244;740.1229542991572;742.3430264216207;750.3134631811831;766.3677466090497;768.9500182488121;13244.006699497384;13246.470141194437;13354.198748075147;13425.865741342657;13431.86568134306;734.5959722152794;748.2069006852754;768.9846203075907;771.0747103475851;776.7164984780514;5924.5852790305125;5951.642901425928;6017.1275165100815;6021.307549631761;6085.66528840918;149212;152759;153034;153260;155504;130644;131438;131820.3408982949;132892;137618;114219.42890285495;114379;116002.41998789951;116045;118118.40940795241;11104.500297486795;11229.831552526555;11263.887361126612;11280.435978200892;11422.885771142515;54495.18257226224;54939;55680.443195567525;57254.14118788305;57496;69508.65245673739;70539.72189177456;70967.9354809668;71018.64490677514;71131.93302100577;16898.831011689726;17132.229049693044;17134.657306853544;17304.394346197823;17422.47732567974;18800.7179892299;18822;18835.71746423832;18990.335338263096;19058.237670493025;18022.639547209244;18043.09784510743;18196;18313;18431.447056588324;15871;16405.507834764976;16515;16717.83282167163;16786.664266714353;16981.066041367845;17082.231299591298;17129.48611541656;17178.742318864977;17315.653686926442;12371.75256494847;12699.238045717286;12863.742725145632;12892.806607900702;13165.144265622705;13070.26390150898;13188.274644894624;13358.732825343244;13374.197548147142;13547 12:18:07 INFO - PID 9585 | __end_tp_report 12:18:07 INFO - PID 9585 | __start_cc_report 12:18:07 INFO - PID 9585 | _x_x_mozilla_cycle_collect,367 12:18:07 INFO - PID 9585 | __end_cc_report 12:18:07 INFO - PID 9585 | __startTimestamp1505416687089__endTimestamp 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | ------- Summary: start ------- 12:18:07 INFO - PID 9585 | Number of tests: 6 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#0] dojo.html Cycles:165 Average:6252.24 Median:6501.80 stddev:746.31 (11.5%) stddev-sans-first:722.94 12:18:07 INFO - PID 9585 | Values: 3779.4 3789.2 3800.5 3804.5 3858.8 6119.2 6219.2 6283.2 6330.0 6337.9 6185.3 6207.6 6231.3 6263.5 6405.0 5605.7 5680.5 5710.3 5736.4 5759.6 5419.1 5665.4 5680.5 5698.0 5740.3 5248.8 5632.9 5705.5 5720.5 5733.5 5642.8 5667.4 5704.6 5711.1 5712.7 5505.4 5524.7 5552.0 5576.7 5680.2 6165.3 6175.2 6175.6 6186.0 6238.5 6676.8 6711.6 6715.2 6782.8 6884.7 6839.5 6933.5 6934.9 6941.3 6945.6 6318.5 6337.9 6340.0 6341.9 6456.6 6813.5 6883.8 6958.7 7037.8 7076.1 6764.2 6794.2 6814.5 6816.8 6826.0 6850.6 6852.3 6922.4 6928.7 6929.2 6606.2 6742.3 6743.1 6795.1 6854.0 6695.6 6702.3 6708.5 6709.2 6775.6 4975.3 4976.9 4981.8 4986.0 5003.1 4456.9 4484.8 4540.4 4543.2 4549.8 6160.5 6313.2 6316.6 6394.7 6400.0 6733.3 6797.2 6817.8 6852.5 6869.3 6267.6 6313.7 6319.5 6324.4 6394.9 5413.9 5495.3 5553.8 5564.4 5565.7 6818.9 6951.7 6967.7 6969.5 6970.3 6619.1 6623.1 6803.8 6813.3 6819.9 6934.6 7100.0 7118.5 7123.6 7138.4 6689.4 6730.2 6771.6 6793.0 6862.1 6647.1 6747.5 6767.2 6770.6 6775.5 6484.9 6501.8 6525.3 6575.1 6634.6 6361.6 6448.1 6532.1 6615.2 6628.4 6535.4 6607.5 6632.5 6636.4 6645.0 6575.7 6646.9 6686.1 6700.2 6724.1 6273.5 6337.5 6359.2 6412.3 6515.6 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#1] ext.html Cycles:180 Average:43396.94 Median:38250.93 stddev:64123.02 (167.6%) stddev-sans-first:64223.42 12:18:07 INFO - PID 9585 | Values: 877.1 948.8 954.6 981.1 981.5 45539.0 46439.0 46467.8 46477.8 46578.0 43757.1 43766.3 43923.0 43952.6 43986.1 7336.4 7390.4 7460.3 7472.3 7479.4 7312.1 7376.1 7376.5 7392.1 7397.7 7438.3 8231.0 8232.3 8234.9 8238.5 8125.1 8182.1 8189.5 8196.5 8198.7 7837.2 7989.6 8000.0 8002.2 8086.4 41026.0 41438.2 41459.2 41502.4 41542.8 3633.1 3679.4 3682.0 3683.1 3684.8 33296.3 33530.8 33532.3 33539.8 33657.8 5408.2 5440.9 5459.6 5495.1 5509.8 210641.0 218846.0 218937.0 219201.0 219400.0 48909.3 54237.5 55140.0 55635.4 55675.2 58098.7 58395.0 58516.4 58612.4 58667.7 16879.8 16919.4 16951.0 16964.2 16979.6 13401.6 13598.0 13626.2 13630.2 13672.7 15739.5 15845.1 15900.8 15976.0 16043.5 6105.2 6246.9 6283.7 6289.6 6333.2 1095.0 1103.1 1116.7 1117.8 1118.2 25466.7 25578.2 25598.0 25865.2 26105.0 1180.8 1206.9 1212.6 1217.5 1224.3 13343.3 13463.2 13601.6 13640.9 13724.0 278803.0 282679.0 283622.0 284210.0 284476.0 59658.0 59658.7 60033.0 60049.7 60163.7 1492.0 1518.6 1527.7 1537.9 1556.1 24844.6 24928.6 24955.4 24961.4 25060.7 42019.8 42199.8 42277.8 42327.6 42512.6 234009.0 234232.0 234334.0 235719.0 235840.0 34601.0 36600.1 40232.8 42370.4 42414.8 52361.7 53363.5 53546.0 53753.5 54087.0 37184.0 37321.4 37502.0 37530.0 38033.4 37604.6 37876.8 37979.0 38114.6 38387.2 44010.3 45390.0 45434.8 45496.5 45497.0 36349.0 37110.4 37262.6 37546.2 38051.0 27009.2 27103.2 27138.3 27273.9 27420.9 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#2] jquery.html Cycles:180 Average:42178.83 Median:23674.41 stddev:115878.84 (489.5%) stddev-sans-first:116161.85 12:18:07 INFO - PID 9585 | Values: 596.2 597.7 606.1 606.2 607.3 23724.3 24441.3 24447.0 24449.1 24499.0 24555.1 24768.6 24806.0 24816.5 24895.4 6537.1 6754.8 6764.6 6766.4 6766.4 6517.5 6574.2 6648.9 6801.6 6828.1 6748.5 6766.2 6767.3 6781.2 6786.8 6440.1 6655.1 6714.2 6719.5 6759.2 6232.9 6240.5 6268.5 6272.9 6274.7 30013.0 30318.8 30359.2 30410.2 30423.7 2321.1 2329.3 2340.8 2347.2 2350.8 19321.3 20586.5 20730.4 20747.4 20826.2 2524.9 2528.2 2589.4 2598.7 2601.8 136821.0 144198.0 148561.0 153870.0 154186.0 15455.5 15694.2 16109.8 16149.4 16242.2 25353.5 25479.7 25507.6 25551.6 25632.2 10497.4 10540.8 10602.5 10659.3 10740.6 9611.6 9725.0 9772.2 9775.9 9840.8 9561.2 9726.5 9776.9 9864.6 9885.6 2732.9 2813.3 2906.7 2907.3 2934.7 1054.5 1056.5 1059.7 1066.9 1068.9 20979.6 21270.0 21309.0 21491.9 21556.6 1115.3 1128.1 1139.2 1140.0 1146.3 11465.9 11823.3 11929.2 12022.5 12022.9 682022.0 685580.0 702674.0 706551.0 717927.0 127464.0 128448.4 129504.4 129619.0 131400.3 1120.7 1161.8 1196.0 1212.8 1262.8 21454.9 21774.2 21822.0 21900.8 21985.8 59968.0 61939.7 62706.0 62901.4 64304.0 74720.0 75717.2 76803.6 80250.0 81401.6 15250.3 15470.0 15610.1 15617.3 15631.1 23624.5 24068.9 24247.2 24268.3 24339.8 19478.8 19832.8 19874.7 19910.3 19932.0 17312.9 17326.0 17785.1 18072.9 18121.7 19149.2 19391.4 19444.0 19548.5 20016.4 15086.0 15219.5 15241.5 15265.1 15345.8 18723.3 18800.4 19853.5 19942.9 19986.8 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#3] mootools.html Cycles:180 Average:10098.19 Median:2857.78 stddev:7400.05 (258.9%) stddev-sans-first:7392.03 12:18:07 INFO - PID 9585 | Values: 1411.7 1488.4 1489.7 1502.6 1504.3 17021.5 17510.4 17528.6 17530.0 17554.3 17044.5 17156.9 17229.6 17229.8 17246.5 2827.3 2898.4 2900.1 2902.3 2915.0 2860.6 2876.3 2882.6 2883.6 2884.3 2762.9 2856.7 2856.9 2858.6 2859.2 2823.5 2881.2 2886.9 2895.1 2896.5 2663.4 2831.8 2842.4 2842.8 2849.1 16615.8 16838.5 16840.8 16845.2 16846.3 8203.9 8541.3 8558.5 8558.6 8566.4 5179.2 5343.2 5351.5 5459.1 5468.8 2105.2 2114.3 2154.8 2190.5 2194.0 29044.3 29395.7 29412.9 29456.3 29464.4 7090.7 7096.7 7123.8 7325.5 7347.4 19474.7 19527.3 19543.0 19557.8 19567.6 8078.1 8316.5 8321.3 8329.5 8341.0 7468.4 7579.2 7607.4 7700.2 7824.5 5329.7 5462.8 5519.7 5545.6 5581.1 1548.8 1558.9 1559.4 1561.3 1574.0 963.5 978.1 981.6 986.6 1008.5 8620.7 8640.4 8655.0 8695.4 8703.8 751.1 780.1 789.5 814.3 825.7 5637.9 5805.3 5806.8 5859.9 6050.3 23157.0 23564.2 23640.9 23877.2 23927.0 22676.2 23080.2 23568.4 23686.4 23795.9 12079.3 12101.5 12208.0 12261.7 12264.5 9177.4 9232.2 9264.5 9271.2 9304.5 19669.4 19738.9 19899.1 20136.7 20531.8 20716.3 20887.0 21215.9 21264.9 21395.7 11986.6 12037.2 12173.4 12200.0 12273.9 14715.3 14969.5 15008.5 15074.5 15079.2 11558.9 11588.7 11642.9 11861.9 11884.7 11016.9 11162.4 11346.7 11439.9 11628.9 9318.9 9470.1 9528.1 9534.1 9536.7 7820.9 7909.0 7933.3 8047.2 8057.6 7832.5 7902.0 7993.5 8043.4 8051.2 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#4] prototype.html Cycles:180 Average:5574.95 Median:6179.49 stddev:1545.97 (25.0%) stddev-sans-first:1503.63 12:18:07 INFO - PID 9585 | Values: 551.5 563.6 584.4 589.7 593.5 6186.8 6214.2 6215.5 6266.2 6269.6 6131.2 6159.3 6172.2 6195.4 6238.8 5091.4 5094.7 5117.8 5132.5 5141.2 5023.6 5034.0 5070.5 5089.6 5095.7 4752.1 4892.0 4909.3 4929.2 4941.0 4908.2 4933.9 4936.8 4946.0 4980.1 4380.5 4470.6 4497.7 4502.5 4508.4 5971.9 6034.6 6058.6 6083.2 6095.3 5804.6 5833.9 5842.7 5843.5 5865.1 6422.0 6524.9 6538.3 6555.4 6662.2 4996.4 4996.9 5024.9 5032.6 5045.2 6694.9 6822.7 6867.5 6963.2 7008.9 5095.7 5100.5 5185.9 5190.9 5226.3 5263.0 5267.9 5273.0 5279.5 5298.2 5801.5 5827.9 5832.2 5850.7 5867.6 6517.5 6521.3 6610.0 6647.9 6687.3 1758.1 1795.1 1805.9 1814.8 1818.1 1242.3 1294.5 1302.5 1302.9 1316.4 6063.5 6082.0 6154.9 6204.5 6219.8 6327.6 6499.8 6518.5 6669.3 6684.8 6017.1 6101.1 6102.5 6112.6 6118.2 3431.5 3454.2 3487.5 3488.8 3508.3 6786.9 6835.1 6899.9 6982.1 7003.6 6648.9 6694.6 6714.3 6778.0 6780.5 6821.5 6877.5 6939.6 6965.7 6979.6 6537.0 6559.9 6596.6 6609.2 6643.8 6576.8 6627.5 6670.9 6672.4 6683.2 6968.1 6977.2 6996.8 7011.4 7020.4 5187.2 5191.9 5200.3 5205.7 5221.5 6517.6 6690.2 6711.7 6781.6 6814.4 6303.2 6370.6 6413.1 6490.3 6501.2 6342.6 6360.5 6413.8 6523.5 6531.5 6364.2 6370.3 6380.9 6388.9 6454.8 6360.2 6504.8 6522.4 6568.7 6572.5 6207.7 6256.4 6263.5 6315.5 6385.9 12:18:07 INFO - PID 9585 | 12:18:07 INFO - PID 9585 | [#5] yui.html Cycles:180 Average:27937.31 Median:17833.51 stddev:42493.45 (238.3%) stddev-sans-first:42564.38 12:18:07 INFO - PID 9585 | Values: 962.2 987.1 1012.9 1015.1 1018.5 18643.0 19098.0 19134.6 19143.7 19146.1 17826.3 18947.7 19055.3 19196.4 19213.9 999.1 1019.3 1020.2 1020.7 1021.8 1070.6 1113.6 1118.5 1120.9 1121.9 1165.7 1165.8 1166.0 1166.7 1168.2 1139.4 1141.1 1143.6 1147.5 1153.0 811.8 825.4 827.5 827.5 827.7 18534.2 18743.8 18779.3 18784.6 18784.8 18907.5 19175.9 19203.5 19218.6 19417.3 17524.3 17760.7 17789.8 17840.7 17985.7 3901.2 3914.4 3926.3 3930.9 3949.2 152502.0 156328.0 157256.0 157557.0 160568.0 16461.8 16569.5 16706.8 16768.9 16858.4 34038.7 34703.7 34879.0 34901.8 34902.0 7838.4 7910.3 7982.6 7989.6 8061.2 4588.1 4700.9 4706.8 4710.0 4720.5 5795.2 5901.1 6008.8 6014.8 6016.1 1081.5 1091.5 1115.1 1116.1 1119.9 740.1 742.3 750.3 766.4 769.0 13244.0 13246.5 13354.2 13425.9 13431.9 734.6 748.2 769.0 771.1 776.7 5924.6 5951.6 6017.1 6021.3 6085.7 149212.0 152759.0 153034.0 153260.0 155504.0 130644.0 131438.0 131820.3 132892.0 137618.0 114219.4 114379.0 116002.4 116045.0 118118.4 11104.5 11229.8 11263.9 11280.4 11422.9 54495.2 54939.0 55680.4 57254.1 57496.0 69508.7 70539.7 70967.9 71018.6 71131.9 16898.8 17132.2 17134.7 17304.4 17422.5 18800.7 18822.0 18835.7 18990.3 19058.2 18022.6 18043.1 18196.0 18313.0 18431.4 15871.0 16405.5 16515.0 16717.8 16786.7 16981.1 17082.2 17129.5 17178.7 17315.7 12371.8 12699.2 12863.7 12892.8 13165.1 13070.3 13188.3 13358.7 13374.2 13547.0 12:18:07 INFO - PID 9585 | -------- Summary: end -------- 12:18:07 INFO - PID 9585 | 12:18:07 INFO - TEST-INFO | 9585: exit 0 12:18:07 INFO - TEST-OK | dromaeo_css | took 1108726ms 12:18:07 INFO - TEST-START | kraken 12:18:07 INFO - Initialising browser for kraken test... 12:18:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43450/getInfo.html -profile /tmp/tmpQ8ETN4/profile 12:18:07 INFO - TEST-INFO | started process 9960 (/builds/slave/test/build/application/firefox/firefox http://localhost:43450/getInfo.html) 12:18:13 INFO - TEST-INFO | 9960: exit 0 12:18:13 INFO - Browser initialized. 12:18:13 INFO - Running cycle 1/1 for kraken test... 12:18:13 INFO - Using env: {'DISPLAY': ':0', 12:18:13 INFO - 'HOME': '/home/cltbld', 12:18:13 INFO - 'JSGC_DISABLE_POISONING': '1', 12:18:13 INFO - 'LANG': 'en_US.UTF-8', 12:18:13 INFO - 'LANGUAGE': 'en_US:en', 12:18:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:18:13 INFO - 'LOGNAME': 'cltbld', 12:18:13 INFO - 'MAIL': '/var/mail/cltbld', 12:18:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:13 INFO - 'MOZ_CRASHREPORTER': '1', 12:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:18:13 INFO - 'MOZ_NO_REMOTE': '1', 12:18:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:13 INFO - 'NO_EM_RESTART': '1', 12:18:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:13 INFO - 'PWD': '/builds/slave/test', 12:18:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:13 INFO - 'RUST_BACKTRACE': 'full', 12:18:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:18:13 INFO - 'SHELL': '/bin/bash', 12:18:13 INFO - 'SHLVL': '1', 12:18:13 INFO - 'TERM': 'linux', 12:18:13 INFO - 'TMOUT': '86400', 12:18:13 INFO - 'USER': 'cltbld', 12:18:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185', 12:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:13 INFO - '_': '/tools/buildbot/bin/python'} 12:18:13 INFO - TEST-INFO | started process 10199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8ETN4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:14 INFO - PID 10199 | 12:18:14 INFO - PID 10199 | (/builds/slave/test/build/application/firefox/firefox:10248): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:18:14 INFO - PID 10199 | 12:18:25 INFO - PID 10199 | RSS: Main: 164130816 12:18:25 INFO - PID 10199 | 12:18:27 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43450/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:28 INFO - PID 10199 | RSS: Main: 168595456 12:18:28 INFO - PID 10199 | 12:18:31 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43450/tests/kraken/driver.html?testName=audio-dft) 12:18:31 INFO - PID 10199 | RSS: Main: 169426944 12:18:31 INFO - PID 10199 | 12:18:34 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43450/tests/kraken/driver.html?testName=audio-fft) 12:18:35 INFO - PID 10199 | RSS: Main: 164851712 12:18:35 INFO - PID 10199 | 12:18:37 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43450/tests/kraken/driver.html?testName=audio-oscillator) 12:18:37 INFO - PID 10199 | RSS: Main: 166293504 12:18:37 INFO - PID 10199 | 12:18:39 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:18:40 INFO - PID 10199 | RSS: Main: 165957632 12:18:40 INFO - PID 10199 | 12:18:43 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43450/tests/kraken/driver.html?testName=imaging-darkroom) 12:18:44 INFO - PID 10199 | RSS: Main: 169754624 12:18:44 INFO - PID 10199 | 12:18:47 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43450/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:48 INFO - PID 10199 | RSS: Main: 169299968 12:18:48 INFO - PID 10199 | 12:18:51 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43450/tests/kraken/driver.html?testName=json-parse-financial) 12:18:52 INFO - PID 10199 | RSS: Main: 169201664 12:18:52 INFO - PID 10199 | 12:18:53 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:18:54 INFO - PID 10199 | RSS: Main: 168755200 12:18:54 INFO - PID 10199 | 12:18:55 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:18:56 INFO - PID 10199 | RSS: Main: 169476096 12:18:56 INFO - PID 10199 | 12:18:58 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:18:59 INFO - PID 10199 | RSS: Main: 165761024 12:18:59 INFO - PID 10199 | 12:19:01 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:02 INFO - PID 10199 | RSS: Main: 167215104 12:19:02 INFO - PID 10199 | 12:19:05 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:05 INFO - PID 10199 | RSS: Main: 166432768 12:19:05 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | Cycle 1(1): loaded http://localhost:43450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43450/tests/kraken/driver.html?testName=ai-astar) 12:19:07 INFO - PID 10199 | RSS: Main: 168579072 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | __start_tp_report 12:19:07 INFO - PID 10199 | _x_x_mozilla_page_load 12:19:07 INFO - PID 10199 | _x_x_mozilla_page_load_details 12:19:07 INFO - PID 10199 | |i|pagename|runs| 12:19:07 INFO - PID 10199 | |0;ai-astar;108;108;106;108;105;106;110;108;107;105 12:19:07 INFO - PID 10199 | |1;audio-beat-detection;114;117;113;116;112;113;111;114;115;114 12:19:07 INFO - PID 10199 | |2;audio-dft;162;162;161;162;163;162;161;162;162;167 12:19:07 INFO - PID 10199 | |3;audio-fft;73;76;73;72;74;73;73;74;74;77 12:19:07 INFO - PID 10199 | |4;audio-oscillator;79;79;78;82;77;77;76;77;77;78 12:19:07 INFO - PID 10199 | |5;imaging-gaussian-blur;117;114;114;114;114;114;110;114;114;114 12:19:07 INFO - PID 10199 | |6;imaging-darkroom;149;150;149;151;150;150;152;149;151;149 12:19:07 INFO - PID 10199 | |7;imaging-desaturate;94;93;94;94;94;94;94;94;93;94 12:19:07 INFO - PID 10199 | |8;json-parse-financial;46;44;44;45;43;43;44;47;45;44 12:19:07 INFO - PID 10199 | |9;json-stringify-tinderbox;37;38;38;38;38;39;38;38;38;38 12:19:07 INFO - PID 10199 | |10;stanford-crypto-aes;72;72;74;75;72;74;74;70;73;72 12:19:07 INFO - PID 10199 | |11;stanford-crypto-ccm;113;107;110;106;117;103;112;107;108;121 12:19:07 INFO - PID 10199 | |12;stanford-crypto-pbkdf2;166;167;157;161;156;157;157;159;168;168 12:19:07 INFO - PID 10199 | |13;stanford-crypto-sha256-iterative;64;62;61;59;60;61;63;64;61;61 12:19:07 INFO - PID 10199 | __end_tp_report 12:19:07 INFO - PID 10199 | __start_cc_report 12:19:07 INFO - PID 10199 | _x_x_mozilla_cycle_collect,908 12:19:07 INFO - PID 10199 | __end_cc_report 12:19:07 INFO - PID 10199 | __startTimestamp1505416747664__endTimestamp 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | ------- Summary: start ------- 12:19:07 INFO - PID 10199 | Number of tests: 14 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#0] ai-astar Cycles:10 Average:107.10 Median:108.00 stddev:1.60 (1.5%) stddev-sans-first:1.66 12:19:07 INFO - PID 10199 | Values: 108.0 108.0 106.0 108.0 105.0 106.0 110.0 108.0 107.0 105.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#1] audio-beat-detection Cycles:10 Average:113.90 Median:114.00 stddev:1.79 (1.6%) stddev-sans-first:1.90 12:19:07 INFO - PID 10199 | Values: 114.0 117.0 113.0 116.0 112.0 113.0 111.0 114.0 115.0 114.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.71 (1.1%) stddev-sans-first:1.81 12:19:07 INFO - PID 10199 | Values: 162.0 162.0 161.0 162.0 163.0 162.0 161.0 162.0 162.0 167.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:1.52 (2.1%) stddev-sans-first:1.58 12:19:07 INFO - PID 10199 | Values: 73.0 76.0 73.0 72.0 74.0 73.0 73.0 74.0 74.0 77.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:1.70 (2.2%) stddev-sans-first:1.76 12:19:07 INFO - PID 10199 | Values: 79.0 79.0 78.0 82.0 77.0 77.0 76.0 77.0 77.0 78.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.66 (1.5%) stddev-sans-first:1.33 12:19:07 INFO - PID 10199 | Values: 117.0 114.0 114.0 114.0 114.0 114.0 110.0 114.0 114.0 114.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 12:19:07 INFO - PID 10199 | Values: 149.0 150.0 149.0 151.0 150.0 150.0 152.0 149.0 151.0 149.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:19:07 INFO - PID 10199 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#8] json-parse-financial Cycles:10 Average:44.50 Median:44.50 stddev:1.27 (2.9%) stddev-sans-first:1.22 12:19:07 INFO - PID 10199 | Values: 46.0 44.0 44.0 45.0 43.0 43.0 44.0 47.0 45.0 44.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.33 12:19:07 INFO - PID 10199 | Values: 37.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 38.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#10] stanford-crypto-aes Cycles:10 Average:72.80 Median:73.50 stddev:1.48 (2.0%) stddev-sans-first:1.54 12:19:07 INFO - PID 10199 | Values: 72.0 72.0 74.0 75.0 72.0 74.0 74.0 70.0 73.0 72.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:111.00 stddev:5.46 (4.9%) stddev-sans-first:5.71 12:19:07 INFO - PID 10199 | Values: 113.0 107.0 110.0 106.0 117.0 103.0 112.0 107.0 108.0 121.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:163.50 stddev:5.08 (3.1%) stddev-sans-first:5.13 12:19:07 INFO - PID 10199 | Values: 166.0 167.0 157.0 161.0 156.0 157.0 157.0 159.0 168.0 168.0 12:19:07 INFO - PID 10199 | 12:19:07 INFO - PID 10199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.50 stddev:1.65 (2.7%) stddev-sans-first:1.50 12:19:07 INFO - PID 10199 | Values: 64.0 62.0 61.0 59.0 60.0 61.0 63.0 64.0 61.0 61.0 12:19:07 INFO - PID 10199 | -------- Summary: end -------- 12:19:07 INFO - PID 10199 | 12:19:08 INFO - PID 10199 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:19:08 INFO - TEST-INFO | 10199: exit 0 12:19:08 INFO - TEST-OK | kraken | took 60615ms 12:19:08 INFO - SUITE-END | took 1169s 12:19:08 INFO - Completed test suite (00:19:29) 12:19:08 INFO - javascript benchmark 12:19:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9007.714093637176, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3779.376402893522, 3789.185325155091, 3800.50593422855, 3804.543454785426, 3858.807059647017, 6119.2350956130485, 6219.19150510433, 6283.151774510439, 6329.9683501582485, 6337.873242535146, 6185.288691800433, 6207.5965062270925, 6231.283402408724, 6263.498920086394, 6404.96797516013, 5605.7197140142825, 5680.460356266148, 5710.343310519281, 5736.368999410061, 5759.5968282220265, 5419.105847535152, 5665.405132461094, 5680.460356266148, 5698.0, 5740.311162660487, 5248.7889088784195, 5632.9436705632825, 5705.486506214419, 5720.485156335929, 5733.541316694655, 5642.830715078554, 5667.4332566743, 5704.629199102045, 5711.143328500717, 5712.742926568314, 5505.394406615269, 5524.723763811793, 5551.9722401387735, 5576.693281869496, 5680.176374425727, 6165.260168779775, 6175.197224360804, 6175.5985860919345, 6186.041163619646, 6238.532110091716, 6676.833079173011, 6711.597304161766, 6715.2277488089, 6782.796516104525, 6884.724611015554, 6839.452843772487, 6933.514653974224, 6934.861302773917, 6941.305869413019, 6945.583265004116, 6318.4629306509005, 6337.936620633781, 6339.953907605286, 6341.87316253677, 6456.644884531349, 6813.523053386215, 6883.7590684325805, 6958.65206739661, 7037.8240543985785, 7076.0801095857205, 6764.154480689914, 6794.150731158606, 6814.454843612499, 6816.795496135124, 6825.965870170618, 6850.554713943578, 6852.349026842542, 6922.376986071177, 6928.653567321614, 6929.237783843773, 6606.240282367589, 6742.258351581322, 6743.123393958754, 6795.082663840319, 6854.0404343391965, 6695.631740254333, 6702.329767023259, 6708.463322934153, 6709.228438729609, 6775.62734049632, 4975.278584605212, 4976.925346119811, 4981.825636102719, 4986.0, 5003.149464591028, 4456.9331460028125, 4484.798184081724, 4540.387047748512, 4543.227651299287, 4549.772511374418, 6160.507159427235, 6313.210848643919, 6316.557840951181, 6394.712237949303, 6400.039994000844, 6733.326667333227, 6797.184337879387, 6817.840967035616, 6852.486063545154, 6869.347411995853, 6267.62394256346, 6313.684315784192, 6319.462845658079, 6324.430801227912, 6394.8721025579225, 5413.891722165535, 5495.313085864267, 5553.777848885999, 5564.443555644403, 5565.693886836182, 6818.897716534256, 6951.652417379212, 6967.7212911482975, 6969.47728920333, 6970.337817907291, 6619.139511863427, 6623.105880706043, 6803.795886123424, 6813.318668133147, 6819.863602728017, 6934.618595977269, 7099.964500177466, 7118.537295075804, 7123.643817809192, 7138.428925686037, 6689.397954184147, 6730.226024007302, 6771.593704377753, 6793.0, 6862.107925969592, 6647.102641143384, 6747.493937954771, 6767.221769496571, 6770.5599136056, 6775.525713200029, 6484.902726459012, 6501.804945851632, 6525.282218956006, 6575.145231119924, 6634.601923884582, 6361.586496877688, 6448.1295025171, 6532.118164047983, 6615.206175259, 6628.436582890508, 6535.411812936859, 6607.47140228771, 6632.50256230775, 6636.43590294811, 6645.0, 6575.736970521317, 6646.9002964956535, 6686.063951046955, 6700.229473610597, 6724.058631791651, 6273.529485288713, 6337.4613157882095, 6359.20509936258, 6412.326705696021, 6515.609063456208], "value": 6201.118901777331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.0630240896024, 948.8007518421131, 954.6133815804598, 981.1464026297123, 981.4700061966538, 45538.999999999956, 46439.0, 46467.76766116165, 46477.7676111619, 46578.0, 43757.12485750291, 43766.34350484745, 43923.0, 43952.56047439525, 43986.120277594426, 7336.376408005312, 7390.40876729863, 7460.253974602523, 7472.29013243741, 7479.3642540384135, 7312.122545294572, 7376.077990251219, 7376.520526165809, 7392.112946446434, 7397.667104980289, 7438.293362130589, 8231.0, 8232.34141268697, 8234.876476852853, 8238.546879921601, 8125.1062383137805, 8182.099969003405, 8189.467684600482, 8196.508209507449, 8198.713045043425, 7837.177096404853, 7989.640466179036, 7999.9600001999615, 8002.19978002201, 8086.433949623529, 41026.0, 41438.1712365751, 41459.1708165838, 41502.377464337755, 41542.79228603838, 3633.073566240592, 3679.4480827875764, 3682.042668906077, 3683.0608194910396, 3684.778913265213, 33296.33407331864, 33530.83234583836, 33532.32935341304, 33539.832300838585, 33657.831710841536, 5408.188771684239, 5440.945590544084, 5459.617826752129, 5495.148252020943, 5509.752061157257, 210641.0, 218846.0, 218937.0, 219201.0, 219400.0, 48909.266361004615, 54237.45762542403, 55140.0, 55635.443645563835, 55675.16487252695, 58098.7095064522, 58394.95617653362, 58516.414835851945, 58612.41387586155, 58667.70666146642, 16879.83120168807, 16919.407820726214, 16951.0, 16964.151792410576, 16979.575510612332, 13401.597952061455, 13598.0, 13626.182429054288, 13630.22807035099, 13672.65818354549, 15739.527814165593, 15845.128517931624, 15900.76148857768, 15976.041437513786, 16043.518694439186, 6105.175801266772, 6246.906296405557, 6283.748650054038, 6289.55973081889, 6333.1766870306565, 1094.9781004380027, 1103.0789290941993, 1116.6761639124563, 1117.8323251512338, 1118.222835129577, 25466.74533254681, 25578.232653020066, 25598.0, 25865.224043278733, 26105.0, 1180.7831765753315, 1206.8612109607332, 1212.5695378140633, 1217.4643157010887, 1224.302147775777, 13343.332833358294, 13463.192208467523, 13601.591952241448, 13640.931795340959, 13724.0, 278803.0, 282679.0, 283622.0, 284210.0, 284476.0, 59658.0, 59658.70170649119, 60033.0, 60049.699751500964, 60163.699181504686, 1492.0, 1518.6203449137715, 1527.6791873706425, 1537.8846586505833, 1556.1285680019225, 24844.639759222846, 24928.62607060932, 24955.377900436415, 24961.375965601004, 25060.749392506572, 42019.7899010503, 42199.7890010548, 42277.78861105798, 42327.57672423359, 42512.57487425086, 234009.0, 234232.0, 234334.0, 235719.0, 235840.0, 34601.0, 36600.08499787527, 40232.79883600563, 42370.36444453274, 42414.78792606017, 52361.7381913088, 53363.46636533585, 53546.0, 53753.46246537485, 54087.0, 37184.0, 37321.440178396806, 37502.0, 37530.0, 38033.42949855699, 37604.623953760114, 37876.81061594674, 37979.0, 38114.61885381111, 38387.232255355295, 44010.33984490299, 45390.0, 45434.77282613566, 45496.54503455055, 45497.0, 36349.0, 37110.44334334933, 37262.62737372592, 37546.249075018895, 38051.0, 27009.189724308304, 27103.1869043929, 27138.32154196161, 27273.86363068172, 27420.862895685394], "value": 18955.977492898197, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1951365656367, 597.6682940967764, 606.1090197409808, 606.1937622961461, 607.2894713185573, 23724.288271351867, 24441.26676199717, 24447.0, 24449.144279950204, 24499.0, 24555.14057008005, 24768.628470572956, 24806.0, 24816.503669926635, 24895.37761555962, 6537.117489138976, 6754.831129221784, 6764.59412435253, 6766.357196066366, 6766.424853887401, 6517.511186660996, 6574.211094668646, 6648.867022659544, 6801.625910574917, 6828.146481689789, 6748.527603067787, 6766.188057433115, 6767.323267673218, 6781.22015968165, 6786.762463313785, 6440.098386225932, 6655.101561289212, 6714.19429668438, 6719.49603779716, 6759.222689390709, 6232.9376706232815, 6240.5319601030105, 6268.467180289681, 6272.937270627281, 6274.717637706269, 30013.0, 30318.84840575805, 30359.24101897448, 30410.239744006354, 30423.69576304231, 2321.141177764238, 2329.301209637119, 2340.8361414700976, 2347.178487529351, 2350.8001819845335, 19321.323753668694, 20586.485337866674, 20730.378088657366, 20747.377578672666, 20826.166953322, 2524.8737563121954, 2528.190978886757, 2589.4432696970243, 2598.6881574211216, 2601.7658410742933, 136821.0, 144198.0, 148561.0, 153870.0, 154186.0, 15455.459058932884, 15694.215289235493, 16109.758353624471, 16149.434769783002, 16242.187890605423, 25353.492930141292, 25479.745202547736, 25507.617385739228, 25551.61672574913, 25632.231033069038, 10497.422641754776, 10540.789184216273, 10602.522886470128, 10659.335166208448, 10740.570377184982, 9611.615535378507, 9725.0, 9772.16936560386, 9775.853362199572, 9840.753981150528, 9561.187299079516, 9726.507191295896, 9776.853347199798, 9864.605415783431, 9885.604575816888, 2732.8770205340807, 2813.338865366637, 2906.694797046322, 2907.2731817045737, 2934.7212014858555, 1054.5360041581832, 1056.5140035583718, 1059.676798576426, 1066.8613080299667, 1068.8663917010374, 20979.580408391746, 21270.042848071873, 21309.0, 21491.892540537196, 21556.56886862254, 1115.2750712037077, 1128.1482480727163, 1139.2196345503357, 1139.9772004560027, 1146.3236690352733, 11465.942670286595, 11823.290602563873, 11929.22460040112, 12022.519099235933, 12022.879771202352, 682022.0, 685580.0, 702674.0, 706551.0, 717927.0, 127464.0, 128448.35775821249, 129504.35247823888, 129619.0, 131400.3429982863, 1120.6862078617837, 1161.7908776420156, 1196.0, 1212.8120141378101, 1262.797952327623, 21454.892725536898, 21774.237901673365, 21822.018009189942, 21900.780992189873, 21985.78014219901, 59968.0, 61939.6903015482, 62706.0, 62901.37098629138, 64304.0, 74720.0, 75717.24282757103, 76803.61598191973, 80250.0, 81401.59299203467, 15250.31373588169, 15470.0, 15610.141442220787, 15617.297221624827, 15631.140287284308, 23624.527509450058, 24068.87965560161, 24247.15134970338, 24268.271951841474, 24339.75660243375, 19478.805211948267, 19832.801671983096, 19874.70187947153, 19910.303139390053, 19932.0, 17312.913435432743, 17326.0, 17785.110744462985, 18072.90963545174, 18121.728174077136, 19149.234030638618, 19391.4182574523, 19444.0, 19548.511287217934, 20016.399508014783, 15086.019408738397, 15219.467318643794, 15241.542753717406, 15265.084094954338, 15345.846541534442, 18723.344682936033, 18800.435986919867, 19853.503662408555, 19942.90028549848, 19986.800131998494], "value": 12826.26122418149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.6823714664201, 1488.3525666335142, 1489.7467430536808, 1502.579277802215, 1504.3380912398543, 17021.489355319343, 17510.387136450227, 17528.649427011453, 17530.0, 17554.297828086877, 17044.488665340028, 17156.884802487828, 17229.569260768454, 17229.827701722978, 17246.482605521855, 2827.349709566801, 2898.362360280745, 2900.1009686996995, 2902.3034471726846, 2914.985425072882, 2860.5566137248657, 2876.3096856754332, 2882.5820256062857, 2883.553049277355, 2884.2933481297114, 2762.903298384557, 2856.7286107819723, 2856.9286517555915, 2858.628378310827, 2859.2137162280437, 2823.50588646988, 2881.1644623059287, 2886.9422611547757, 2895.1314605618336, 2896.5365541513465, 2663.3741070848337, 2831.830090194595, 2842.3888863894153, 2842.8436435996014, 2849.088291746642, 16615.750763738553, 16838.494845154666, 16840.831591684047, 16845.241964111643, 16846.326146954107, 8203.876941845878, 8541.316694664412, 8558.486490810572, 8558.61486233121, 8566.400351975364, 5179.249008893727, 5343.225232341328, 5351.464853514617, 5459.099248624012, 5468.808591699271, 2105.221068204759, 2114.260008996854, 2154.8168405685537, 2190.452386903274, 2193.967090493644, 29044.27389315263, 29395.70604293951, 29412.8529357354, 29456.263593410124, 29464.410711785644, 7090.716371345192, 7096.680649370791, 7123.821904452327, 7325.450591205575, 7347.37547308474, 19474.707879381822, 19527.316543921177, 19543.0, 19557.804421955883, 19567.60864782725, 8078.111407745143, 8316.542590157478, 8321.334293256525, 8329.50022998622, 8340.999080110425, 7468.365188958891, 7579.242075792376, 7607.391408687292, 7700.152983171846, 7824.452288339761, 5329.653572517774, 5462.8361149165585, 5519.69641669704, 5545.584081193927, 5581.10702287632, 1548.8218854831614, 1558.859702626769, 1559.438602103242, 1561.320825440937, 1573.9763903541457, 963.5471328475605, 978.1001478639669, 981.5804043033813, 986.6201512417628, 1008.4856723071287, 8620.741377758677, 8640.438371505832, 8654.95672521646, 8695.391322607484, 8703.825923481494, 751.0799270893222, 780.1457404142454, 789.534174836849, 814.3241109878786, 825.7068740597122, 5637.943620563742, 5805.274340707411, 5806.796762113306, 5859.946094861188, 6050.334463209044, 23157.0, 23564.175253866033, 23640.88179559091, 23877.16429924944, 23927.0, 22676.2063327786, 23080.192193273157, 23568.410789730395, 23686.407839804142, 23795.881020594785, 12079.335636540074, 12101.455434505468, 12208.023358131328, 12261.69345766363, 12264.509419623115, 9177.449353038839, 9232.21526170283, 9264.53677316145, 9271.165595096474, 9304.488253146143, 19669.40991770249, 19738.901305493957, 19899.104540295433, 20136.697949531062, 20531.794682052987, 20716.274930377363, 20887.0, 21215.8939205303, 21264.893675531523, 21395.67906481373, 11986.64040078799, 12037.217580857216, 12173.39133043362, 12200.0, 12273.87726122763, 14715.337809798799, 14969.476068337992, 15008.47470338533, 15074.54776356711, 15079.246037697852, 11558.884411155781, 11588.6523404298, 11642.88357116418, 11861.881381186078, 11884.702882428008, 11016.889831101907, 11162.441877906234, 11346.659600212008, 11439.942800285946, 11628.94185529067, 9318.906810931803, 9470.14768670823, 9528.094830991045, 9534.141927226583, 9536.66621668266, 7820.944172536862, 7908.960455197917, 7933.286004259644, 8047.155048720034, 8057.637406316847, 7832.490888092256, 7902.0, 7993.520388776459, 8043.3967452442475, 8051.154628763896], "value": 7109.696573516419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5256879083988, 563.5773170122408, 584.4214227914365, 589.6609449566498, 593.4510577715612, 6186.814395568129, 6214.161088253085, 6215.5338349623735, 6266.248050233972, 6269.623822570649, 6131.233595800525, 6159.291681456634, 6172.166757487737, 6195.380461953813, 6238.750449982007, 5091.414487333948, 5094.694318340893, 5117.771734783643, 5132.538071573557, 5141.177411614151, 5023.572996295319, 5033.97282174261, 5070.492950704936, 5089.618278629117, 5095.719735414551, 4752.144613969484, 4891.975540122312, 4909.263610458424, 4929.21132618781, 4941.0, 4908.239222920453, 4933.876653083702, 4936.827211047632, 4945.950540494603, 4980.103581355373, 4380.518143004267, 4470.642348612103, 4497.685162038659, 4502.549745025504, 4508.391367165424, 5971.910421343639, 6034.6422055037265, 6058.6364818110615, 6083.239595050619, 6095.329513753483, 5804.622699524517, 5833.883322333572, 5842.707864606795, 5843.53251739864, 5865.0615901455985, 6421.967890160566, 6524.902126468107, 6538.267359149829, 6555.3772391622715, 6662.167229096363, 4996.350474438336, 4996.850094497171, 5024.874378140539, 5032.572231360339, 5045.192769156954, 6694.899576506356, 6822.727090916407, 6867.450603951722, 6963.16442026955, 7008.894866577006, 5095.719735414587, 5100.464451232641, 5185.948140518622, 5190.92213616796, 5226.268322434862, 5262.973685131627, 5267.920981185285, 5273.0, 5279.498447647467, 5298.205269209572, 5801.50687191585, 5827.854303642443, 5832.241808564944, 5850.707464626752, 5867.589268751147, 6517.51118666102, 6521.282658907517, 6610.041543976096, 6647.933520664828, 6687.331266873273, 1758.1472985601972, 1795.1024487756122, 1805.9187336569885, 1814.818518148201, 1818.1454716283326, 1242.2981015726086, 1294.5339677716015, 1302.4920281090383, 1302.8827405533548, 1316.3681432912065, 6063.514918806485, 6081.969590152021, 6154.907676384858, 6204.534659900525, 6219.813405597839, 6327.557071004985, 6499.805005849832, 6518.478521718251, 6669.333066693389, 6684.766033188815, 6017.127516510169, 6101.115338275925, 6102.481289090389, 6112.572119951649, 6118.20463339763, 3431.4509678451827, 3454.1537323355938, 3487.459443786217, 3488.8081155536183, 3508.3334166508794, 6786.929986354111, 6835.14560679915, 6899.896501552481, 6982.1272340957385, 7003.614801185984, 6648.933510664928, 6694.631795251211, 6714.287856596537, 6778.0, 6780.525363224626, 6821.54276578745, 6877.518573699893, 6939.64676888002, 6965.721371145098, 6979.581225126509, 6537.0, 6559.934400655932, 6596.60420374779, 6609.173853268341, 6643.7674681385915, 6576.80269591913, 6627.4698024158915, 6670.866582668416, 6672.399484046459, 6683.231428385798, 6968.077134435892, 6977.151054970538, 6996.755113571001, 7011.404030657452, 7020.438364930896, 5187.170052791535, 5191.948080519146, 5200.2719619252575, 5205.73971301441, 5221.451747566451, 6517.641529715911, 6690.19717633887, 6711.731530738716, 6781.559198652072, 6814.352636499525, 6303.203586977689, 6370.649614271259, 6413.102165696713, 6490.286068532363, 6501.154849869676, 6342.587731797418, 6360.49116070704, 6413.775517856852, 6523.510736694672, 6531.477481801349, 6364.204474440695, 6370.299267080525, 6380.915244408555, 6388.936110638834, 6454.806355809334, 6360.204974378203, 6504.804855854332, 6522.412982831568, 6568.671566421755, 6572.474202063919, 6207.720652570555, 6256.405641464054, 6263.467605253604, 6315.515853774267, 6385.936140638534], "value": 5134.767766000607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [962.2494454325629, 987.057360220989, 1012.8784545854503, 1015.1117771949545, 1018.5060245780797, 18643.0, 19098.0, 19134.617307653854, 19143.712844307345, 19146.138423770928, 17826.286948522044, 18947.715784263248, 19055.333063342787, 19196.42410727677, 19213.903930480363, 999.0717914425175, 1019.337430670063, 1020.1787561013381, 1020.6529779874841, 1021.7701017271091, 1070.5557193764578, 1113.6269349767838, 1118.5302173087282, 1120.9047230985377, 1121.899029087382, 1165.74353642199, 1165.8367828504017, 1166.0, 1166.6908269308597, 1168.1997831485417, 1139.3790384240608, 1141.1156353825768, 1143.5711608146944, 1147.466428110924, 1153.0141728821861, 811.7970507373157, 825.3562221467265, 827.4538804389134, 827.4704189318841, 827.735124760077, 18534.165962531584, 18743.812561874343, 18779.342723004767, 18784.62430751391, 18784.812151878443, 18907.527311817175, 19175.90412047945, 19203.519912002314, 19218.615627687366, 19417.320393786293, 17524.299028038862, 17760.733588996176, 17789.822101778947, 17840.732389014174, 17985.7302140468, 3901.200253947934, 3914.432407300954, 3926.293267211901, 3930.862419815293, 3949.150932549516, 152502.0, 156328.0, 157256.0, 157557.0, 160568.0, 16461.83538164627, 16569.502914912573, 16706.832931670528, 16768.916155419145, 16858.40995565174, 34038.65961340355, 34703.652963470544, 34879.0, 34901.82549087238, 34902.0, 7838.412119091091, 7910.288074073361, 7982.560959147303, 7989.640466179036, 8061.153578874251, 4588.082383523309, 4700.88247793801, 4706.835260765857, 4709.95290047102, 4720.480747117815, 5795.217645617872, 5901.0558310670085, 6008.849778755479, 6014.849628759316, 6016.127661489059, 1081.5241293830688, 1091.47063674118, 1115.1079136690614, 1116.0959622705634, 1119.9216054876244, 740.1229542991572, 742.3430264216207, 750.3134631811831, 766.3677466090497, 768.9500182488121, 13244.006699497384, 13246.470141194437, 13354.198748075147, 13425.865741342657, 13431.86568134306, 734.5959722152794, 748.2069006852754, 768.9846203075907, 771.0747103475851, 776.7164984780514, 5924.5852790305125, 5951.642901425928, 6017.1275165100815, 6021.307549631761, 6085.66528840918, 149212.0, 152759.0, 153034.0, 153260.0, 155504.0, 130644.0, 131438.0, 131820.3408982949, 132892.0, 137618.0, 114219.42890285495, 114379.0, 116002.41998789951, 116045.0, 118118.40940795241, 11104.500297486795, 11229.831552526555, 11263.887361126612, 11280.435978200892, 11422.885771142515, 54495.18257226224, 54939.0, 55680.443195567525, 57254.14118788305, 57496.0, 69508.65245673739, 70539.72189177456, 70967.9354809668, 71018.64490677514, 71131.93302100577, 16898.831011689726, 17132.229049693044, 17134.657306853544, 17304.394346197823, 17422.47732567974, 18800.7179892299, 18822.0, 18835.71746423832, 18990.335338263096, 19058.237670493025, 18022.639547209244, 18043.09784510743, 18196.0, 18313.0, 18431.447056588324, 15871.0, 16405.507834764976, 16515.0, 16717.83282167163, 16786.664266714353, 16981.066041367845, 17082.231299591298, 17129.48611541656, 17178.742318864977, 17315.653686926442, 12371.75256494847, 12699.238045717286, 12863.742725145632, 12892.806607900702, 13165.144265622705, 13070.26390150898, 13188.274644894624, 13358.732825343244, 13374.197548147142, 13547.0], "value": 9704.461227592616, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1381.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 106.0, 108.0, 105.0, 106.0, 110.0, 108.0, 107.0, 105.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 113.0, 116.0, 112.0, 113.0, 111.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 162.0, 161.0, 162.0, 162.0, 167.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 72.0, 74.0, 73.0, 73.0, 74.0, 74.0, 77.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 82.0, 77.0, 77.0, 76.0, 77.0, 77.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 110.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 151.0, 150.0, 150.0, 152.0, 149.0, 151.0, 149.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 44.0, 44.0, 45.0, 43.0, 43.0, 44.0, 47.0, 45.0, 44.0], "value": 44.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 74.0, 75.0, 72.0, 74.0, 74.0, 70.0, 73.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 110.0, 106.0, 117.0, 103.0, 112.0, 107.0, 108.0, 121.0], "value": 110.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 157.0, 161.0, 156.0, 157.0, 157.0, 159.0, 168.0, 168.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 59.0, 60.0, 61.0, 63.0, 64.0, 61.0, 61.0], "value": 61.6, "unit": "score"}]}]} 12:19:08 INFO - Return code: 0 12:19:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:08 INFO - # TBPL SUCCESS # 12:19:08 INFO - Running post-action listener: _package_coverage_data 12:19:08 INFO - Running post-action listener: _resource_record_post_action 12:19:08 INFO - [mozharness: 2017-09-14 19:19:08.969082Z] Finished run-tests step (success) 12:19:08 INFO - Running post-run listener: _resource_record_post_run 12:19:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 57344; Write bytes: 327557120; Read time: 552; Write time: 277180 12:19:09 INFO - TinderboxPrint: CPU usage
13.1% 12:19:09 INFO - TinderboxPrint: I/O read bytes / time
57,344 / 552 12:19:09 INFO - TinderboxPrint: I/O write bytes / time
327,557,120 / 277,180 12:19:09 INFO - TinderboxPrint: CPU idle
8,232.7 (86.9%) 12:19:09 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 12:19:09 INFO - TinderboxPrint: Swap in / out
0 / 0 12:19:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12402688; Read time: 0; Write time: 3592 12:19:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:19:09 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 57344; Write bytes: 314134528; Read time: 552; Write time: 273564 12:19:09 INFO - Running post-run listener: _upload_blobber_files 12:19:09 INFO - Blob upload gear active. 12:19:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:09 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:19:09 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:19:09 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:19:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:25 INFO - (blobuploader) - INFO - Done attempting. 12:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:26 INFO - (blobuploader) - INFO - Done attempting. 12:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:34 INFO - (blobuploader) - INFO - Done attempting. 12:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:35 INFO - (blobuploader) - INFO - Done attempting. 12:19:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:35 INFO - Return code: 0 12:19:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0160630e374bf6a64a787a1b26c0f5db5cdf83ed8e0958cb65427e7959f6e58924a047dd077dcc459742da81d7222d48b4dd6621e60bc2ce7f0dbca227e3c6e5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42dcd4bea54a16390877f25f6bf097f8a06cd8a91ecf5cbdc32d1a6b193d0eacc93352ead4487b37dd502e321537c0f1461839c687657f189df6a6499a29fd1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c82b5071f84f0a39622bf53004593b91383bb6aab4fe63d44b648a8f1aec83a6afea52aabfd4d1169d20400abd59321168d5860960ec7508dc60408e64441117", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc73784fef5ed7ce80bfa4040caf2512ee1b4dffb0fd8b526b33182681be9b21fabdd6ebb8f5b347361ed263f79405fe3efdda8a76ae8f69ecdd1a555a360a7c"} 12:19:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:35 INFO - Contents: 12:19:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0160630e374bf6a64a787a1b26c0f5db5cdf83ed8e0958cb65427e7959f6e58924a047dd077dcc459742da81d7222d48b4dd6621e60bc2ce7f0dbca227e3c6e5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42dcd4bea54a16390877f25f6bf097f8a06cd8a91ecf5cbdc32d1a6b193d0eacc93352ead4487b37dd502e321537c0f1461839c687657f189df6a6499a29fd1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c82b5071f84f0a39622bf53004593b91383bb6aab4fe63d44b648a8f1aec83a6afea52aabfd4d1169d20400abd59321168d5860960ec7508dc60408e64441117", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc73784fef5ed7ce80bfa4040caf2512ee1b4dffb0fd8b526b33182681be9b21fabdd6ebb8f5b347361ed263f79405fe3efdda8a76ae8f69ecdd1a555a360a7c"} 12:19:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:35 INFO - Copying logs to upload dir... 12:19:35 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.854099 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-09-14 12:19:35.323260) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 12:19:35.325984) ========= 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=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0160630e374bf6a64a787a1b26c0f5db5cdf83ed8e0958cb65427e7959f6e58924a047dd077dcc459742da81d7222d48b4dd6621e60bc2ce7f0dbca227e3c6e5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42dcd4bea54a16390877f25f6bf097f8a06cd8a91ecf5cbdc32d1a6b193d0eacc93352ead4487b37dd502e321537c0f1461839c687657f189df6a6499a29fd1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c82b5071f84f0a39622bf53004593b91383bb6aab4fe63d44b648a8f1aec83a6afea52aabfd4d1169d20400abd59321168d5860960ec7508dc60408e64441117", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc73784fef5ed7ce80bfa4040caf2512ee1b4dffb0fd8b526b33182681be9b21fabdd6ebb8f5b347361ed263f79405fe3efdda8a76ae8f69ecdd1a555a360a7c"} build_url:https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/O2IBbQo6SfSfBf03JQSl2A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0160630e374bf6a64a787a1b26c0f5db5cdf83ed8e0958cb65427e7959f6e58924a047dd077dcc459742da81d7222d48b4dd6621e60bc2ce7f0dbca227e3c6e5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d42dcd4bea54a16390877f25f6bf097f8a06cd8a91ecf5cbdc32d1a6b193d0eacc93352ead4487b37dd502e321537c0f1461839c687657f189df6a6499a29fd1", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c82b5071f84f0a39622bf53004593b91383bb6aab4fe63d44b648a8f1aec83a6afea52aabfd4d1169d20400abd59321168d5860960ec7508dc60408e64441117", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc73784fef5ed7ce80bfa4040caf2512ee1b4dffb0fd8b526b33182681be9b21fabdd6ebb8f5b347361ed263f79405fe3efdda8a76ae8f69ecdd1a555a360a7c"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 12:19:35.445346) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 12:19:35.454806) ========= 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=fa44defc139c4ba8574fe040000001db-1505415162.371969-1309156185 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 12:19:35.846074) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 12:19:35.846531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 12:19:35.847001) ========= ========= Total master_lag: 0.77 =========