builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-013 starttime: 1505326413.29 results: success (0) revision: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.291701) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.292160) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.292425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.310012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.310290) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 11:13:33-- 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% 107M=0s 2017-09-13 11:13:33 (107 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.408337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.408641) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014361 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:33.458843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 11:13:33.462221) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e5f80a639bfe68b68693a5be610f9d36b6c5ad00 --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 e5f80a639bfe68b68693a5be610f9d36b6c5ad00 --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=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 11:13:33,430 truncating revision to first 12 chars 2017-09-13 11:13:33,430 Setting DEBUG logging. 2017-09-13 11:13:33,430 attempt 1/10 2017-09-13 11:13:33,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e5f80a639bfe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 11:13:34,510 unpacking tar archive at: mozilla-central-e5f80a639bfe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.400007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 11:13:34.881313) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:34.881625) ========= script_repo_revision: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:34.882013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:34.882269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 11:13:34.895263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 11:13:34.895563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:34 INFO - MultiFileLogger online at 20170913 11:13:34 in /builds/slave/test 11:13:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:13:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:13:34 INFO - {'append_to_log': False, 11:13:34 INFO - 'base_work_dir': '/builds/slave/test', 11:13:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:13:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:13:34 INFO - 'branch': 'Firefox-Non-PGO', 11:13:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:34 INFO - 'code_coverage': False, 11:13:34 INFO - 'config_files': ('talos/linux_config.py',), 11:13:34 INFO - 'default_actions': ('clobber', 11:13:34 INFO - 'read-buildbot-config', 11:13:34 INFO - 'download-and-extract', 11:13:35 INFO - 'populate-webroot', 11:13:35 INFO - 'create-virtualenv', 11:13:35 INFO - 'install', 11:13:35 INFO - 'setup-mitmproxy', 11:13:35 INFO - 'run-tests'), 11:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:35 INFO - 'disable_ccov_upload': False, 11:13:35 INFO - 'disable_stylo': False, 11:13:35 INFO - 'download_minidump_stackwalk': True, 11:13:35 INFO - 'download_symbols': 'ondemand', 11:13:35 INFO - 'enable_stylo': False, 11:13:35 INFO - 'enable_webrender': False, 11:13:35 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:35 INFO - 'gecko_profile': False, 11:13:35 INFO - 'gecko_profile_interval': 0, 11:13:35 INFO - 'installer_path': 'installer.exe', 11:13:35 INFO - 'log_level': 'info', 11:13:35 INFO - 'log_name': 'talos', 11:13:35 INFO - 'log_to_console': True, 11:13:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:35 INFO - 'opt_config_files': (), 11:13:35 INFO - 'pip_index': False, 11:13:35 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:13:35 INFO - 'system_bits': '32', 11:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:35 INFO - 'title': 'talos-linux64-ix-013', 11:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:35 INFO - 'use_talos_json': True, 11:13:35 INFO - 'verify': 'False', 11:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:35 INFO - 'work_dir': 'build'} 11:13:35 INFO - [mozharness: 2017-09-13 18:13:35.008763Z] Running clobber step. 11:13:35 INFO - Running pre-action listener: _resource_record_pre_action 11:13:35 INFO - Running main action method: clobber 11:13:35 INFO - rmtree: /builds/slave/test/build 11:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:13:36 INFO - Running post-action listener: _resource_record_post_action 11:13:36 INFO - [mozharness: 2017-09-13 18:13:36.024578Z] Finished clobber step (success) 11:13:36 INFO - [mozharness: 2017-09-13 18:13:36.024675Z] Running read-buildbot-config step. 11:13:36 INFO - Running pre-action listener: _resource_record_pre_action 11:13:36 INFO - Running main action method: read_buildbot_config 11:13:36 INFO - Using buildbot properties: 11:13:36 INFO - { 11:13:36 INFO - "project": "", 11:13:36 INFO - "product": "firefox", 11:13:36 INFO - "who": "ffxbld@noreply.mozilla.org", 11:13:36 INFO - "installer_path": "public/build/target.tar.bz2", 11:13:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:13:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:13:36 INFO - "stage_platform": "linux64", 11:13:36 INFO - "basedir": "/builds/slave/test", 11:13:36 INFO - "buildnumber": 12, 11:13:36 INFO - "platform": "ubuntu64_hw", 11:13:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:13:36 INFO - "slavebuilddir": "test", 11:13:36 INFO - "taskId": "AsA_XvAXTB6qXs1tl52Ohg", 11:13:36 INFO - "branch": "mozilla-central", 11:13:36 INFO - "script_repo_revision": "production", 11:13:36 INFO - "revision": "e5f80a639bfe68b68693a5be610f9d36b6c5ad00", 11:13:36 INFO - "slavename": "talos-linux64-ix-013", 11:13:36 INFO - "repo_path": "mozilla-central" 11:13:36 INFO - } 11:13:36 INFO - Finding installer, test and symbols from parent task. 11:13:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AsA_XvAXTB6qXs1tl52Ohg'}, attempt #1 11:13:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AsA_XvAXTB6qXs1tl52Ohg'}, attempt #1 11:13:36 INFO - Task dependencies: IX5hDky-TNygwR2FWbgpvQ 11:13:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ'}, attempt #1 11:13:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 11:13:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.test_packages.json 11:13:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.crashreporter-symbols.zip 11:13:37 INFO - Running post-action listener: _resource_record_post_action 11:13:37 INFO - [mozharness: 2017-09-13 18:13:37.538939Z] Finished read-buildbot-config step (success) 11:13:37 INFO - [mozharness: 2017-09-13 18:13:37.539158Z] Running download-and-extract step. 11:13:37 INFO - Running pre-action listener: _resource_record_pre_action 11:13:37 INFO - Running main action method: download_and_extract 11:13:37 INFO - mkdir: /builds/slave/test/build/tests 11:13:37 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:13:37 INFO - trying https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.test_packages.json 11:13:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:13:38 INFO - Downloaded 989 bytes. 11:13:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:13:38 INFO - Using the following test package requirements: 11:13:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:13:38 INFO - u'common': [u'target.common.tests.zip'], 11:13:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:13:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:13:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:13:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:13:38 INFO - u'mozbase': [u'target.common.tests.zip'], 11:13:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:13:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:13:38 INFO - u'web-platform': [u'target.common.tests.zip', 11:13:38 INFO - u'target.web-platform.tests.tar.gz'], 11:13:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:13:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:13:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.common.tests.zip 11:13:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:13:38 INFO - Fetch https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.common.tests.zip into memory 11:13:39 INFO - Content-Length response header: 54566935 11:13:39 INFO - Bytes received: 54566935 11:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.talos.tests.zip 11:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.talos.tests.zip into memory 11:13:50 INFO - Content-Length response header: 14499226 11:13:50 INFO - Bytes received: 14499226 11:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:50 INFO - trying https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 11:13:50 INFO - Downloading https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:13:51 INFO - Downloaded 61347942 bytes. 11:13:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 11:13:52 INFO - mkdir: /builds/slave/test/properties 11:13:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:52 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:52 INFO - Contents: 11:13:52 INFO - build_url:https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 11:13:52 INFO - Running post-action listener: _resource_record_post_action 11:13:52 INFO - Running post-action listener: find_tests_for_verification 11:13:52 INFO - Running post-action listener: set_extra_try_arguments 11:13:52 INFO - [mozharness: 2017-09-13 18:13:52.023443Z] Finished download-and-extract step (success) 11:13:52 INFO - [mozharness: 2017-09-13 18:13:52.023541Z] Running populate-webroot step. 11:13:52 INFO - Running pre-action listener: _resource_record_pre_action 11:13:52 INFO - Running main action method: populate_webroot 11:13:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['tresize', 11:13:52 INFO - 'tcanvasmark']}, 11:13:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['dromaeo_css', 11:13:52 INFO - 'kraken']}, 11:13:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'tests': ['damp', 'tps']}, 11:13:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['damp', 'tps']}, 11:13:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['dromaeo_dom']}, 11:13:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:13:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['basic_compositor_video', 11:13:52 INFO - 'glvideo']}, 11:13:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:13:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['ts_paint_webext', 11:13:52 INFO - 'tp5o_webext']}, 11:13:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:52 INFO - 'ts_paint', 11:13:52 INFO - 'tpaint', 11:13:52 INFO - 'sessionrestore', 11:13:52 INFO - 'sessionrestore_many_windows', 11:13:52 INFO - 'sessionrestore_no_auto_restore', 11:13:52 INFO - 'tabpaint']}, 11:13:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['a11yr', 11:13:52 INFO - 'ts_paint', 11:13:52 INFO - 'tpaint', 11:13:52 INFO - 'sessionrestore', 11:13:52 INFO - 'sessionrestore_many_windows', 11:13:52 INFO - 'sessionrestore_no_auto_restore', 11:13:52 INFO - 'tabpaint']}, 11:13:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:13:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:13:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['bloom_basic_singleton']}, 11:13:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['bloom_basic']}, 11:13:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:52 INFO - 'tsvgr_opacity', 11:13:52 INFO - 'tart', 11:13:52 INFO - 'tscrollx', 11:13:52 INFO - 'tsvg_static']}, 11:13:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['tsvgx', 11:13:52 INFO - 'tsvgr_opacity', 11:13:52 INFO - 'tart', 11:13:52 INFO - 'tscrollx', 11:13:52 INFO - 'tsvg_static']}, 11:13:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:13:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo'], 11:13:52 INFO - 'tests': ['tp5o']}, 11:13:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:52 INFO - 'talos_options': ['--mitmproxy', 11:13:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:52 INFO - '--firstNonBlankPaint'], 11:13:52 INFO - 'tests': ['tp6_google', 11:13:52 INFO - 'tp6_youtube', 11:13:52 INFO - 'tp6_amazon', 11:13:52 INFO - 'tp6_facebook']}, 11:13:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo', 11:13:52 INFO - '--mitmproxy', 11:13:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:52 INFO - '--firstNonBlankPaint'], 11:13:52 INFO - 'tests': ['tp6_google', 11:13:52 INFO - 'tp6_youtube', 11:13:52 INFO - 'tp6_amazon', 11:13:52 INFO - 'tp6_facebook']}, 11:13:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:52 INFO - 'talos_options': ['--stylo-threads=1', 11:13:52 INFO - '--mitmproxy', 11:13:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:52 INFO - '--firstNonBlankPaint'], 11:13:52 INFO - 'tests': ['tp6_google', 11:13:52 INFO - 'tp6_youtube', 11:13:52 INFO - 'tp6_amazon', 11:13:52 INFO - 'tp6_facebook']}, 11:13:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--xperf_path', 11:13:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:52 INFO - 'tests': ['tp5n']}, 11:13:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:52 INFO - 'talos_options': ['--disable-stylo', 11:13:52 INFO - '--xperf_path', 11:13:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:52 INFO - 'tests': ['tp5n']}}} 11:13:52 INFO - Running post-action listener: _resource_record_post_action 11:13:52 INFO - [mozharness: 2017-09-13 18:13:52.043602Z] Finished populate-webroot step (success) 11:13:52 INFO - [mozharness: 2017-09-13 18:13:52.043692Z] Running create-virtualenv step. 11:13:52 INFO - Running pre-action listener: _resource_record_pre_action 11:13:52 INFO - Running main action method: create_virtualenv 11:13:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:13:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:13:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:13:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:52 INFO - Installing pip...............done. 11:13:52 INFO - Return code: 0 11:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:13:53 INFO - Reading from file tmpfile_stdout 11:13:53 INFO - Output received: 11:13:53 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:13:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:53 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:13:53 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:13:53 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:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:13:55 INFO - Downloading/unpacking pip>=1.5 11:13:55 INFO - Running setup.py egg_info for package pip 11:13:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:55 INFO - Installing collected packages: pip 11:13:55 INFO - Found existing installation: pip 1.1 11:13:55 INFO - Uninstalling pip: 11:13:55 INFO - Successfully uninstalled pip 11:13:55 INFO - Running setup.py install for pip 11:13:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:13:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:13:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:13:55 INFO - Successfully installed pip 11:13:55 INFO - Cleaning up... 11:13:55 INFO - Return code: 0 11:13:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:55 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:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:55 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:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:55 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:13:55 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:13:55 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:13:55 INFO - Using env: {'DISPLAY': ':0', 11:13:55 INFO - 'HOME': '/home/cltbld', 11:13:55 INFO - 'LANG': 'en_US.UTF-8', 11:13:55 INFO - 'LANGUAGE': 'en_US:en', 11:13:55 INFO - 'LOGNAME': 'cltbld', 11:13:55 INFO - 'MAIL': '/var/mail/cltbld', 11:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:55 INFO - 'MOZ_NO_REMOTE': '1', 11:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:55 INFO - 'NO_EM_RESTART': '1', 11:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:55 INFO - 'PWD': '/builds/slave/test', 11:13:55 INFO - 'SHELL': '/bin/bash', 11:13:55 INFO - 'SHLVL': '1', 11:13:55 INFO - 'TERM': 'linux', 11:13:55 INFO - 'TMOUT': '86400', 11:13:55 INFO - 'USER': 'cltbld', 11:13:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:55 INFO - '_': '/tools/buildbot/bin/python'} 11:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:55 INFO - Downloading/unpacking psutil>=3.1.1 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:56 INFO - Installing collected packages: psutil 11:13:56 INFO - Running setup.py install for psutil 11:13:56 INFO - building 'psutil._psutil_linux' extension 11:13:56 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:13:56 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:13:56 INFO - building 'psutil._psutil_posix' extension 11:13:56 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:13:57 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:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:57 INFO - Successfully installed psutil 11:13:57 INFO - Cleaning up... 11:13:57 INFO - Return code: 0 11:13:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13: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:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:13:57 INFO - Using env: {'DISPLAY': ':0', 11:13:57 INFO - 'HOME': '/home/cltbld', 11:13:57 INFO - 'LANG': 'en_US.UTF-8', 11:13:57 INFO - 'LANGUAGE': 'en_US:en', 11:13:57 INFO - 'LOGNAME': 'cltbld', 11:13:57 INFO - 'MAIL': '/var/mail/cltbld', 11:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:57 INFO - 'MOZ_NO_REMOTE': '1', 11:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:57 INFO - 'NO_EM_RESTART': '1', 11:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:57 INFO - 'PWD': '/builds/slave/test', 11:13:57 INFO - 'SHELL': '/bin/bash', 11:13:57 INFO - 'SHLVL': '1', 11:13:57 INFO - 'TERM': 'linux', 11:13:57 INFO - 'TMOUT': '86400', 11:13:57 INFO - 'USER': 'cltbld', 11:13:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:57 INFO - '_': '/tools/buildbot/bin/python'} 11:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:58 INFO - Installing collected packages: mozsystemmonitor 11:13:58 INFO - Running setup.py install for mozsystemmonitor 11:13:58 INFO - Successfully installed mozsystemmonitor 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:13:58 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:13:58 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:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:00 INFO - warning: no files found matching '*.txt' 11:14:00 INFO - no previously-included directories found matching 'build' 11:14:00 INFO - no previously-included directories found matching 'dist' 11:14:00 INFO - no previously-included directories found matching '.git*' 11:14:00 INFO - Installing collected packages: jsonschema, functools32 11:14:00 INFO - Running setup.py install for functools32 11:14:00 INFO - warning: no files found matching '*.txt' 11:14:00 INFO - no previously-included directories found matching 'build' 11:14:00 INFO - no previously-included directories found matching 'dist' 11:14:00 INFO - no previously-included directories found matching '.git*' 11:14:00 INFO - Successfully installed jsonschema functools32 11:14:00 INFO - Cleaning up... 11:14:00 INFO - Return code: 0 11:14:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:00 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:00 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:14:00 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:14:00 INFO - Using env: {'DISPLAY': ':0', 11:14:00 INFO - 'HOME': '/home/cltbld', 11:14:00 INFO - 'LANG': 'en_US.UTF-8', 11:14:00 INFO - 'LANGUAGE': 'en_US:en', 11:14:00 INFO - 'LOGNAME': 'cltbld', 11:14:00 INFO - 'MAIL': '/var/mail/cltbld', 11:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:00 INFO - 'MOZ_NO_REMOTE': '1', 11:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:00 INFO - 'NO_EM_RESTART': '1', 11:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:00 INFO - 'PWD': '/builds/slave/test', 11:14:00 INFO - 'SHELL': '/bin/bash', 11:14:00 INFO - 'SHLVL': '1', 11:14:00 INFO - 'TERM': 'linux', 11:14:00 INFO - 'TMOUT': '86400', 11:14:00 INFO - 'USER': 'cltbld', 11:14:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:00 INFO - '_': '/tools/buildbot/bin/python'} 11:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:14:00 INFO - Cleaning up... 11:14:00 INFO - Return code: 0 11:14:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:00 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:00 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:14:00 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:14:00 INFO - Using env: {'DISPLAY': ':0', 11:14:00 INFO - 'HOME': '/home/cltbld', 11:14:00 INFO - 'LANG': 'en_US.UTF-8', 11:14:00 INFO - 'LANGUAGE': 'en_US:en', 11:14:00 INFO - 'LOGNAME': 'cltbld', 11:14:00 INFO - 'MAIL': '/var/mail/cltbld', 11:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:00 INFO - 'MOZ_NO_REMOTE': '1', 11:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:00 INFO - 'NO_EM_RESTART': '1', 11:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:00 INFO - 'PWD': '/builds/slave/test', 11:14:00 INFO - 'SHELL': '/bin/bash', 11:14:00 INFO - 'SHLVL': '1', 11:14:00 INFO - 'TERM': 'linux', 11:14:00 INFO - 'TMOUT': '86400', 11:14:00 INFO - 'USER': 'cltbld', 11:14:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:00 INFO - '_': '/tools/buildbot/bin/python'} 11:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:02 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:14:02 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:14:02 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:14:02 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:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:02 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:14:02 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:14:02 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:14:02 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:14:03 INFO - Downloading docopt-0.6.1.tar.gz 11:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:04 INFO - Running setup.py install for blobuploader 11:14:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:04 INFO - Running setup.py install for requests 11:14:04 INFO - Running setup.py install for docopt 11:14:04 INFO - Successfully installed blobuploader requests docopt 11:14:04 INFO - Cleaning up... 11:14:04 INFO - Return code: 0 11:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:04 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:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:04 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:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:04 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:04 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:14:04 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:14:04 INFO - Using env: {'DISPLAY': ':0', 11:14:04 INFO - 'HOME': '/home/cltbld', 11:14:04 INFO - 'LANG': 'en_US.UTF-8', 11:14:04 INFO - 'LANGUAGE': 'en_US:en', 11:14:04 INFO - 'LOGNAME': 'cltbld', 11:14:04 INFO - 'MAIL': '/var/mail/cltbld', 11:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:04 INFO - 'MOZ_NO_REMOTE': '1', 11:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:04 INFO - 'NO_EM_RESTART': '1', 11:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:04 INFO - 'PWD': '/builds/slave/test', 11:14:04 INFO - 'SHELL': '/bin/bash', 11:14:04 INFO - 'SHLVL': '1', 11:14:04 INFO - 'TERM': 'linux', 11:14:04 INFO - 'TMOUT': '86400', 11:14:04 INFO - 'USER': 'cltbld', 11:14:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:04 INFO - '_': '/tools/buildbot/bin/python'} 11:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:04 INFO - Running setup.py (path:/tmp/pip-gAooHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:04 INFO - Running setup.py (path:/tmp/pip-TSAHjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:05 INFO - Running setup.py (path:/tmp/pip-nEWVjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:05 INFO - Running setup.py (path:/tmp/pip-RQaNDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:05 INFO - Running setup.py (path:/tmp/pip-cYnvCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:05 INFO - Running setup.py (path:/tmp/pip-BoJl8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:05 INFO - Running setup.py (path:/tmp/pip-tiknXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:05 INFO - Running setup.py (path:/tmp/pip-7ultzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:05 INFO - Running setup.py (path:/tmp/pip-DLvN0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:05 INFO - Running setup.py (path:/tmp/pip-vRBoP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:05 INFO - Running setup.py (path:/tmp/pip-On_XhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:05 INFO - Running setup.py (path:/tmp/pip-IXDOIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:05 INFO - Running setup.py (path:/tmp/pip-U4hLiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:05 INFO - Running setup.py (path:/tmp/pip-3iD2js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:05 INFO - Running setup.py (path:/tmp/pip-pwOAi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:05 INFO - Running setup.py (path:/tmp/pip-wqFQeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:06 INFO - Running setup.py (path:/tmp/pip-H4n2Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:06 INFO - Running setup.py install for manifestparser 11:14:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Running setup.py install for mozcrash 11:14:06 INFO - Running setup.py install for mozdebug 11:14:06 INFO - Running setup.py install for mozdevice 11:14:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Running setup.py install for mozfile 11:14:06 INFO - Running setup.py install for mozhttpd 11:14:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Running setup.py install for mozinfo 11:14:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Running setup.py install for mozInstall 11:14:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:06 INFO - Running setup.py install for mozleak 11:14:06 INFO - Running setup.py install for mozlog 11:14:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Running setup.py install for moznetwork 11:14:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Running setup.py install for mozprocess 11:14:07 INFO - Running setup.py install for mozprofile 11:14:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Running setup.py install for mozrunner 11:14:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Running setup.py install for mozscreenshot 11:14:07 INFO - Running setup.py install for moztest 11:14:07 INFO - Running setup.py install for mozversion 11:14:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:07 INFO - Cleaning up... 11:14:07 INFO - Return code: 0 11:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:07 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:07 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:14:07 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:14:07 INFO - Using env: {'DISPLAY': ':0', 11:14:07 INFO - 'HOME': '/home/cltbld', 11:14:07 INFO - 'LANG': 'en_US.UTF-8', 11:14:07 INFO - 'LANGUAGE': 'en_US:en', 11:14:07 INFO - 'LOGNAME': 'cltbld', 11:14:07 INFO - 'MAIL': '/var/mail/cltbld', 11:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:07 INFO - 'MOZ_NO_REMOTE': '1', 11:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:07 INFO - 'NO_EM_RESTART': '1', 11:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:07 INFO - 'PWD': '/builds/slave/test', 11:14:07 INFO - 'SHELL': '/bin/bash', 11:14:07 INFO - 'SHLVL': '1', 11:14:07 INFO - 'TERM': 'linux', 11:14:07 INFO - 'TMOUT': '86400', 11:14:07 INFO - 'USER': 'cltbld', 11:14:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:07 INFO - '_': '/tools/buildbot/bin/python'} 11:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:08 INFO - Running setup.py (path:/tmp/pip-gzOYCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:08 INFO - Running setup.py (path:/tmp/pip-NyjGQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:08 INFO - Running setup.py (path:/tmp/pip-ELP8KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:08 INFO - Running setup.py (path:/tmp/pip-WELzKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:08 INFO - Running setup.py (path:/tmp/pip-KEMMqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:08 INFO - Running setup.py (path:/tmp/pip-qWXbS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:08 INFO - Running setup.py (path:/tmp/pip-yWPZH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:08 INFO - Running setup.py (path:/tmp/pip-7oaEeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:08 INFO - Running setup.py (path:/tmp/pip-vQ_NrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:08 INFO - Running setup.py (path:/tmp/pip-piIGUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:08 INFO - Running setup.py (path:/tmp/pip-j_DlQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:08 INFO - Running setup.py (path:/tmp/pip-FRNrDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:08 INFO - Running setup.py (path:/tmp/pip-uFAO41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:08 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:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:09 INFO - Running setup.py (path:/tmp/pip-97dtgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:09 INFO - Running setup.py (path:/tmp/pip-CqIcqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:09 INFO - Running setup.py (path:/tmp/pip-G3ldpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:09 INFO - Running setup.py (path:/tmp/pip-rklFCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:09 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:14:09 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:14:09 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:14:09 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:14:09 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:14:09 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:14:09 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:14:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14: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:14: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:14: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:14: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:14:10 INFO - Downloading blessings-1.6.tar.gz 11:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:10 INFO - Installing collected packages: blessings 11:14:10 INFO - Running setup.py install for blessings 11:14:10 INFO - Successfully installed blessings 11:14:10 INFO - Cleaning up... 11:14:10 INFO - Return code: 0 11:14:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:10 INFO - Reading from file tmpfile_stdout 11:14:10 INFO - Current package versions: 11:14:10 INFO - argparse == 1.2.1 11:14:10 INFO - blessings == 1.6 11:14:10 INFO - blobuploader == 1.2.4 11:14:10 INFO - docopt == 0.6.1 11:14:10 INFO - functools32 == 3.2.3-2 11:14:10 INFO - jsonschema == 2.5.1 11:14:10 INFO - manifestparser == 1.1 11:14:10 INFO - mozInstall == 1.13 11:14:10 INFO - mozcrash == 1.0 11:14:10 INFO - mozdebug == 0.1 11:14:10 INFO - mozdevice == 0.51 11:14:10 INFO - mozfile == 1.2 11:14:10 INFO - mozhttpd == 0.7 11:14:10 INFO - mozinfo == 0.10 11:14:10 INFO - mozleak == 0.1 11:14:10 INFO - mozlog == 3.5 11:14:10 INFO - moznetwork == 0.27 11:14:10 INFO - mozprocess == 0.25 11:14:10 INFO - mozprofile == 0.28 11:14:10 INFO - mozrunner == 6.13 11:14:10 INFO - mozscreenshot == 0.1 11:14:10 INFO - mozsystemmonitor == 0.3 11:14:10 INFO - moztest == 0.8 11:14:10 INFO - mozversion == 1.4 11:14:10 INFO - psutil == 3.1.1 11:14:10 INFO - requests == 1.2.3 11:14:10 INFO - wsgiref == 0.1.2 11:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:10 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:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:10 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:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:10 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:10 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:14:10 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:14:10 INFO - Using env: {'DISPLAY': ':0', 11:14:10 INFO - 'HOME': '/home/cltbld', 11:14:10 INFO - 'LANG': 'en_US.UTF-8', 11:14:10 INFO - 'LANGUAGE': 'en_US:en', 11:14:10 INFO - 'LOGNAME': 'cltbld', 11:14:10 INFO - 'MAIL': '/var/mail/cltbld', 11:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:10 INFO - 'MOZ_NO_REMOTE': '1', 11:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:10 INFO - 'NO_EM_RESTART': '1', 11:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:10 INFO - 'PWD': '/builds/slave/test', 11:14:10 INFO - 'SHELL': '/bin/bash', 11:14:10 INFO - 'SHLVL': '1', 11:14:10 INFO - 'TERM': 'linux', 11:14:10 INFO - 'TMOUT': '86400', 11:14:10 INFO - 'USER': 'cltbld', 11:14:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:10 INFO - '_': '/tools/buildbot/bin/python'} 11:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:11 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:14:11 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:14:11 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:14:11 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:14:11 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:14:11 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:14:11 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:14:11 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:14:11 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:14:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:14: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:14: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:14: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:14: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:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:14:12 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:14:12 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:14:12 INFO - Installing collected packages: simplejson 11:14:12 INFO - Running setup.py install for simplejson 11:14:12 INFO - building 'simplejson._speedups' extension 11:14:12 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:14:13 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:14:13 INFO - Successfully installed simplejson 11:14:13 INFO - Cleaning up... 11:14:13 INFO - Return code: 0 11:14:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:13 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', '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:14:13 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:14:13 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:14:13 INFO - Using env: {'DISPLAY': ':0', 11:14:13 INFO - 'HOME': '/home/cltbld', 11:14:13 INFO - 'LANG': 'en_US.UTF-8', 11:14:13 INFO - 'LANGUAGE': 'en_US:en', 11:14:13 INFO - 'LOGNAME': 'cltbld', 11:14:13 INFO - 'MAIL': '/var/mail/cltbld', 11:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:13 INFO - 'MOZ_NO_REMOTE': '1', 11:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:13 INFO - 'NO_EM_RESTART': '1', 11:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:13 INFO - 'PWD': '/builds/slave/test', 11:14:13 INFO - 'SHELL': '/bin/bash', 11:14:13 INFO - 'SHLVL': '1', 11:14:13 INFO - 'TERM': 'linux', 11:14:13 INFO - 'TMOUT': '86400', 11:14:13 INFO - 'USER': 'cltbld', 11:14:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:13 INFO - '_': '/tools/buildbot/bin/python'} 11:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:13 INFO - Cleaning up... 11:14:13 INFO - Return code: 0 11:14:13 INFO - Running post-action listener: _resource_record_post_action 11:14:13 INFO - Running post-action listener: _start_resource_monitoring 11:14:13 INFO - Starting resource monitoring. 11:14:13 INFO - [mozharness: 2017-09-13 18:14:13.528850Z] Finished create-virtualenv step (success) 11:14:13 INFO - [mozharness: 2017-09-13 18:14:13.529360Z] Running install step. 11:14:13 INFO - Running pre-action listener: _resource_record_pre_action 11:14:13 INFO - Running main action method: install 11:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:13 INFO - Reading from file tmpfile_stdout 11:14:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:13 INFO - Reading from file tmpfile_stdout 11:14:13 INFO - Output received: 11:14:13 INFO - Usage: mozinstall [options] installer 11:14:13 INFO - Options: 11:14:13 INFO - -h, --help show this help message and exit 11:14:13 INFO - -d DEST, --destination=DEST 11:14:13 INFO - Directory to install application into. [default: 11:14:13 INFO - "/builds/slave/test"] 11:14:13 INFO - --app=APP Application being installed. [default: firefox] 11:14:13 INFO - mkdir: /builds/slave/test/build/application 11:14:13 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:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:14:31 INFO - Reading from file tmpfile_stdout 11:14:31 INFO - Output received: 11:14:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:14:31 INFO - Running post-action listener: _resource_record_post_action 11:14:31 INFO - [mozharness: 2017-09-13 18:14:31.590627Z] Finished install step (success) 11:14:31 INFO - [mozharness: 2017-09-13 18:14:31.590880Z] Running setup-mitmproxy step. 11:14:31 INFO - Running pre-action listener: _resource_record_pre_action 11:14:31 INFO - Running main action method: setup_mitmproxy 11:14:31 INFO - Skipping: mitmproxy is not required 11:14:31 INFO - Running post-action listener: _resource_record_post_action 11:14:31 INFO - [mozharness: 2017-09-13 18:14:31.592056Z] Finished setup-mitmproxy step (success) 11:14:31 INFO - [mozharness: 2017-09-13 18:14:31.592279Z] Running run-tests step. 11:14:31 INFO - Running pre-action listener: _resource_record_pre_action 11:14:31 INFO - Running pre-action listener: _set_gcov_prefix 11:14:31 INFO - Running main action method: run_tests 11:14:31 WARNING - Try message not found. 11:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:31 INFO - Python 2.7.3 11:14:31 INFO - Return code: 0 11:14:31 INFO - grabbing minidump binary from tooltool 11:14:31 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:14:31 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 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:31 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:14:31 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:14:31 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:14:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:31 INFO - Return code: 0 11:14:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:14:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:31 INFO - ENV: RUST_BACKTRACE is now full 11:14:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:14:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 11:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 11:14:31 INFO - Using env: {'DISPLAY': ':0', 11:14:31 INFO - 'HOME': '/home/cltbld', 11:14:31 INFO - 'LANG': 'en_US.UTF-8', 11:14:31 INFO - 'LANGUAGE': 'en_US:en', 11:14:31 INFO - 'LOGNAME': 'cltbld', 11:14:31 INFO - 'MAIL': '/var/mail/cltbld', 11:14:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:31 INFO - 'MOZ_NO_REMOTE': '1', 11:14:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:31 INFO - 'NO_EM_RESTART': '1', 11:14:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:31 INFO - 'PWD': '/builds/slave/test', 11:14:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:31 INFO - 'RUST_BACKTRACE': 'full', 11:14:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:14:31 INFO - 'SHELL': '/bin/bash', 11:14:31 INFO - 'SHLVL': '1', 11:14:31 INFO - 'TERM': 'linux', 11:14:31 INFO - 'TMOUT': '86400', 11:14:31 INFO - 'USER': 'cltbld', 11:14:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:31 INFO - '_': '/tools/buildbot/bin/python'} 11:14:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 11:14:31 INFO - mozversion application_buildid: 20170913172324 11:14:31 INFO - mozversion application_changeset: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 11:14:31 INFO - mozversion application_display_name: Nightly 11:14:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:31 INFO - mozversion application_name: Firefox 11:14:31 INFO - mozversion application_remotingname: firefox 11:14:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:14:31 INFO - mozversion application_vendor: Mozilla 11:14:31 INFO - mozversion application_version: 57.0a1 11:14:31 INFO - mozversion platform_buildid: 20170913172324 11:14:31 INFO - mozversion platform_changeset: e5f80a639bfe68b68693a5be610f9d36b6c5ad00 11:14:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:14:31 INFO - mozversion platform_version: 57.0a1 11:14:31 INFO - using testdate: 1505326471 11:14:31 INFO - actual date: 1505326471 11:14:31 INFO - starting webserver on 'localhost:35180' 11:14:31 INFO - SUITE-START | Running 2 tests 11:14:31 INFO - TEST-START | dromaeo_css 11:14:31 INFO - Initialising browser for dromaeo_css test... 11:14:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35180/getInfo.html -profile /tmp/tmpHULI4C/profile 11:14:31 INFO - TEST-INFO | started process 5164 (/builds/slave/test/build/application/firefox/firefox http://localhost:35180/getInfo.html) 11:14:37 INFO - TEST-INFO | 5164: exit 0 11:14:37 INFO - Browser initialized. 11:14:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:37 INFO - Using env: {'DISPLAY': ':0', 11:14:37 INFO - 'HOME': '/home/cltbld', 11:14:37 INFO - 'JSGC_DISABLE_POISONING': '1', 11:14:37 INFO - 'LANG': 'en_US.UTF-8', 11:14:37 INFO - 'LANGUAGE': 'en_US:en', 11:14:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:14:37 INFO - 'LOGNAME': 'cltbld', 11:14:37 INFO - 'MAIL': '/var/mail/cltbld', 11:14:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:14:37 INFO - 'MOZ_NO_REMOTE': '1', 11:14:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:37 INFO - 'NO_EM_RESTART': '1', 11:14:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:37 INFO - 'PWD': '/builds/slave/test', 11:14:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:37 INFO - 'RUST_BACKTRACE': 'full', 11:14:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:14:37 INFO - 'SHELL': '/bin/bash', 11:14:37 INFO - 'SHLVL': '1', 11:14:37 INFO - 'STYLO_FORCE_DISABLED': '1', 11:14:37 INFO - 'TERM': 'linux', 11:14:37 INFO - 'TMOUT': '86400', 11:14:37 INFO - 'USER': 'cltbld', 11:14:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:37 INFO - '_': '/tools/buildbot/bin/python'} 11:14:37 INFO - TEST-INFO | started process 5348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHULI4C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:38 INFO - PID 5348 | 11:14:38 INFO - PID 5348 | (/builds/slave/test/build/application/firefox/firefox:5398): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:14:38 INFO - PID 5348 | 11:14:49 INFO - PID 5348 | RSS: Main: 173568000 11:14:49 INFO - PID 5348 | 11:17:46 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35180/tests/dromaeo/cssquery-ext.html) 11:17:47 INFO - PID 5348 | RSS: Main: 176742400 11:17:47 INFO - PID 5348 | 11:20:49 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-ext.html (next: http://localhost:35180/tests/dromaeo/cssquery-jquery.html) 11:20:50 INFO - PID 5348 | RSS: Main: 171970560 11:20:50 INFO - PID 5348 | 11:23:51 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35180/tests/dromaeo/cssquery-mootools.html) 11:23:52 INFO - PID 5348 | RSS: Main: 174768128 11:23:52 INFO - PID 5348 | 11:26:53 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35180/tests/dromaeo/cssquery-prototype.html) 11:26:54 INFO - PID 5348 | RSS: Main: 172879872 11:26:54 INFO - PID 5348 | 11:29:57 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35180/tests/dromaeo/cssquery-yui.html) 11:29:58 INFO - PID 5348 | RSS: Main: 174473216 11:29:58 INFO - PID 5348 | 11:32:59 INFO - PID 5348 | Cycle 1(1): loaded http://localhost:35180/tests/dromaeo/cssquery-yui.html (next: http://localhost:35180/tests/dromaeo/cssquery-dojo.html) 11:33:00 INFO - PID 5348 | RSS: Main: 177602560 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | __start_tp_report 11:33:00 INFO - PID 5348 | _x_x_mozilla_page_load 11:33:00 INFO - PID 5348 | _x_x_mozilla_page_load_details 11:33:00 INFO - PID 5348 | |i|pagename|runs| 11:33:00 INFO - PID 5348 | |0;dojo.html;3143.245621050947;3145.8112513249207;3149.7007784260495;3150.5116706910408;3162.7311678507326;6186.072089186624;6203.131561581382;6231.750729970796;6334.081558174068;6335.334789847069;6242.219722534684;6296.559240853142;6313.558050936436;6320.74717011319;6417.711202995864;5860.238169038019;5898.380670029649;5918.2898052233795;5921.378255283198;5944.494717948979;5704.172894930232;5767.106098554731;5791.884162316751;5855.648661080349;5884.499817515516;5752.741126649311;5797.71011449428;5825.0679891217205;5867.1492633568105;5887.264091988502;5585.1901474286005;5756;5773.88452230953;5815.883682326372;5822.82531524055;5767.798127065575;5768.3654797972185;5797.623154494987;5809.070548712186;5836.620619659709;6228.844278893019;6306.49548036156;6334.683265836736;6388.776392826276;6412.7114279857515;6623.73505059797;6732.124823772927;6737.797866064026;6813.795586132374;6832.59004459729;6777.93222067778;6793.524453288272;6905.861882762367;6930.5148639595245;6933.341332573397;6276.372362763733;6285.340039295854;6337.49300055999;6348.492120630339;6365.777197798055;6924.515283930076;6935.445164386837;6964.303569642995;6991.475639327071;7041.4718896082995;6608.041833934052;6620.933790662128;6629.635370054693;6633.4693224541925;6636.568623039487;6660.700268487833;6670.099536562599;6674.16572928384;6753.763618273337;6771.085903402977;6585.506087043395;6588.670566471657;6653.334666533405;6712.194536655633;6728.058071869942;6666.533342666064;6683.097781799492;6686.7993960181275;6687.6321802301345;6688.665566721645;5249.265102885599;5260.105782017066;5271.393789714155;5284.286621306074;5338.3593968724;4612.654050946126;4683.1336202802595;4717.9056418872115;4753.47711751707;4755.215389460769;5779.33537643168;5784.739686714108;5849.298084229919;5854.092615644582;5858.238429004202;6631.834204144935;6735.461163106939;6739.326067393319;6806.5235433520165;6842.794716158523;5771.797987070432;5819.447152520504;5841.357450680422;5845.970770146122;5847.502962248256;5778.451047150514;5781.71091445426;5796.362400136066;5857.033589457692;5857.824265272048;6297.275813281532;6410.55126141175;6449.226092868886;6510.056041873996;6582.44049255809;6751.898721519279;6774.187097548326;6807.89788153188;6840.623765692934;6879.174499060145;6508.60948343101;6523.24982627004;6589.769358072444;6602.834929126618;6612.933870661424;6662;6668.466522678271;6681.665916704048;6756.121704178426;6757.763478278237;6618.70215840298;6722.361375669304;6727.495437842279;6738.66306684654;6748.460123190232;6444.548881578245;6447.0651755494255;6447.387498187664;6447.709853056717;6449.5485316027425;6390.105385246162;6415.486761059011;6511.47908167336;6523.24982627004;6537.019447082976;6486.254080780582;6500.6424646643;6553.639549824615;6574.0796288520605;6580.045893345342;6571.507136964651;6596;6631.602103873783;6688.598684078971;6709.798706038827;6203.751849925952;6318.6840657965995;6339.2392912850755;6462.838429039123;6470.48236141117 11:33:00 INFO - PID 5348 | |1;ext.html;855.512357955965;866.1252135343303;893.4326702543884;896.9910300896993;900.8423525882977;40191.598084019184;40699.59300406995;42017.57982420175;42070;42134.157316853685;41915.79042104785;42273;42281;42324.78837605807;42427.151456970845;7825.373970082408;7934.920650793476;7940.722074727386;7955.761327160194;7957.403194760387;7854.136045035041;7940.325072368855;7969.083555391117;7992.20077992199;8015.599220039004;7959.840803183933;7989.760307190764;7993.2806047455715;8005.279524842763;8011.399145064114;7927.04875414951;7944.721934732314;7970.2428269314905;7975.7607271781935;7977.760667179994;7773.416993725436;7849.529028258323;7853;7858.882116768253;7865.410094242898;38343.616563834286;38366;38487;38683.41974870379;38710;3573.338932297507;3613.277344531078;3616.385214513539;3617.565892092966;3622.7645203061716;31651.05046848598;31724.206894827585;31769.364612707846;31780.841095794374;31793.6820631793;5272.736363181825;5278;5287.021900948337;5329.120695085307;5336.893262134774;185321;185748;186343.06828465906;186348;186568;46658;47103;47149;49380;49972.50027499751;52588.47411525912;52843.20735188975;52886.47113528816;52908.735456323244;52982.47017529853;15862.603434913988;16007.119608421415;16037.919810400874;16334.918325408296;16344.34622615106;13046.217226966412;13146.60560183196;13148.342582870819;13151;13153.60539183807;14895.255237238094;14906.552803415914;14956.551303460914;15028.849711502746;15101.244937753068;5848.8537786554825;6075.149479072933;6075.75696972125;6096.085587161872;6140.815775526741;1001.3641337750581;1017.7455636090978;1024.3085917005992;1031.7523794289316;1032.6953548703;23164.65253021206;23376;23398.18106366269;23546.64680029801;23756.406089847547;1072.340510585984;1116.503884794363;1122.9719257018476;1131.1968502363413;1131.6831287239586;12367.010639148846;12470.81293780594;12506.062045346453;12543.93728031354;12548.121631485708;227921;229816;229977;231383;231965;45344;46014.539854601695;52290.738546307024;52604;53220.201696974575;1452.5932738833144;1457.511733569245;1458.8687018168202;1461.9634509137356;1467.6844478437188;27385.45229095447;27453.450930981668;27475.587866182424;27840;27916;37646.24707505889;37687.2462550742;37763.81118094392;37803.24393512059;37807.24385512329;190124;190530.04734976238;190749;190968;191334;35075.29849403049;35303.470447943815;35630.465543017395;35798.4630230552;35909.64090359063;42415.7879210602;43464.34803478014;43470.56529434665;43792.12415751731;43875.12249754923;31498.52752208673;31842.6815731849;31887.6811231894;31917.20206994844;32091.518627220143;31031.68968310288;31223;31245.37509249757;31364;31537.684623154393;35303;35437;35440;35569.82215088908;35632.46551301681;30638.540421894137;30939.535906961864;31210.21974450566;31698;31730;23143.421414464774;23402.882985585646;23457.765422345557;23822;24065.398365041015 11:33:00 INFO - PID 5348 | |2;jquery.html;576.5042063825111;582.947534721875;583.1806312131457;583.9416058394161;584.7748616782538;22549.77450225497;23108.65337019942;23371.298861034153;23414.88292558537;23465.648015279785;25839;26216.47567048658;26287.86856065717;26302.868485657593;26423.603645945324;6542.280349161577;6674.098996635465;6685.331466853324;6685.966570167142;6687.364700353459;6462.5153113516435;6523.9673801630925;6707.128073350457;6709.664516774166;6711.228208755982;6658.467322614203;6658.9001164982565;6672.76645317414;6681.8329541761605;6685.331466853324;6675.065490831264;6687.431568316699;6690.83272918176;6691.26396096429;6693.464522838161;6207.782727604557;6215.56491045627;6225.377462253784;6227.346128656471;6227.906581401283;28842.423151537063;30035;30163.69836301631;30412.239694007607;30533.847330763205;1983.4347211044928;2002.2491565662876;2002.3092033248506;2011.5474018345901;2011.8189362957257;19249.422517324503;20000.699989500023;20023.799762002483;20026.499337516532;20033;2379.762023797606;2385.1294277588554;2431.294924471901;2435.1598698449006;2488.726240113586;128005;129801;133587;133916.33041834825;134139;14568.198749068692;14603.634909127357;15145;15179.848201518063;15239.923800380928;22132.33602991913;23117.537649246922;23270.65094023591;23410;23465.41336466602;9994.800103998024;10021.29850910444;10072.093511583993;10122.949385253027;10158.492075396201;9124.178823905748;9211.95394023039;9293.070692930789;9296.628134874665;9403.952980235192;8843.60203790831;9054.81890362189;9098.681546145854;9115.954420227856;9406.764830879283;2587.197968629731;2610.9347266318114;2651.68179818423;2694.326418395401;2720.319920019995;953.4660590069583;966.5360626899128;980.367662857453;988.3427520698655;990.9504524773732;19379.903100484407;19519;19733.60532789336;19785.307514236934;19916.103775330146;1035.808375450544;1036.8652075230323;1037.5434808684306;1043.2175868098925;1054.8681414823147;10717.78564428707;10805.621803237007;10850.240483166102;10855.348679079281;10915.890841091647;426558;434948;441914;442213;459658;109599.9999999984;114221;115390.4230478859;115815;116681;1143.5825923538016;1163.953441862333;1179.6107284595892;1184.7452797648548;1188.7979043562616;17132.828671713123;17414.303427862742;17611;17614.678899082362;18044.729329059814;55929.881402372535;56727.14909276447;56830.147547785986;57305.71347143238;57936.42063579479;67685.3231467679;68396.6580167096;68931.65534172297;69155;69564.65217674081;14112.647183820487;14249.928750356183;14324.928375358057;14377.353019113956;14469.059511131743;22640.886795565915;22644.66033009473;22753.203637872593;22974.081036758344;23066;17893.642127157644;18108.094595270446;18115.184816683017;18360.90819545894;18628.720569191744;15805;16369.345226191295;16575.502734917973;16690.4158354457;16945.66108677844;16592.83407165961;16768.24542895548;17070.317187312867;18526.722099168794;18707.25170993145;14153;14159;14254.928725356307;14256.144631322153;14346.067505612102;17748.733768993734;17748.91125544364;17914.283428662708;17967.460976170736;18093.36673216431 11:33:00 INFO - PID 5348 | |3;mootools.html;1314.7699152648288;1355.681414867506;1371.53124376123;1372.3961456958937;1387.2508845223579;14932;15532.767008494853;15561.299741511632;15579.376824926989;15584.454544090959;15235.085894846317;15280.08319500828;15324.08055516667;15375.538733837975;15413.768793468107;2596.9610455843176;2687.207273854208;2701.3381721478268;2705.6212130301774;2710.0785732850827;2749.257700420885;2751.55975043993;2772.1960631416864;2773.1126039667315;2773.251222170023;2562.4362640219124;2653.0714250012534;2784.860756962154;2785.5403858363347;2787.0245414105;2683.5840444731;2693.380522479821;2719.5376785946437;2721.3876877702555;2721.6597925259343;2580.1614475295605;2711.539038363483;2795.7204279572084;2806.733360330765;2808.6208361871295;14793.334299956528;14924.403023879031;14943.850561494355;14947.40210391583;15014.399424023026;7828.5694286814205;8095.2309530595085;8101.392395570297;8105.878411823827;8120.675172993073;4862.756862156878;5002.9499705002845;5112.18205087188;5119.641625086246;5119.846404607868;1687.8480936715632;1744.5464179313342;1748.7551742756025;1755.0785837435321;1789.2127463915836;26361;27037.864810676016;27038.864805676043;27045.188644340506;27061;7258.782236532912;7434.516756410816;7434.702611895464;7573.886391704129;7663.655135518804;15731.134787586792;17734.11329433523;20411.795882041286;20421;20442.693359599616;7872.645730942121;8111.472754270953;8132.105468398471;8134.389920755967;8136.796580085427;7358.1538123116525;7445.627718614048;7472.140703819022;7480.401567874557;7486.401087912954;5314.813981510706;5488.313960754906;5503.449655034465;5519.116941289374;5556.555475561945;1481.888858335629;1485.6657252118403;1501.3018946190075;1505.52575938579;1519.948070105371;892.7411050795326;910.2172131966504;914.4741773480275;922.2022950148207;927.2859897878595;7499.362554182846;7544.471886967969;7593.848123037508;7613.695452181851;7663.31030207284;685.0717278088218;707.1125737199782;713.7573225103386;722.7723267170825;732.7508647059918;4532;5087.745612719349;5167.1474206755465;5213.504717051874;5306.124489459273;20850.374488765363;21451;21490.355289341343;21504.677429838564;21793.67309490359;20418.69371959422;20834.27080052191;21116.47208819792;21594;21615.891920540296;11251.549938002388;11294.54821807135;11315.717107072225;11355;11437.71405714847;8126.187381261827;8143.67425303005;8227.83544329098;8560.91439085601;8676.956615216883;18012.189451474453;18593.81406185975;18714.15786289593;18733.625327493646;18819;18705.34531291398;18727.250909963448;18784.62430751405;18864.717029244846;19071.713924291424;11156.776864462827;11188.1608879336;11214.719632009264;11238.10095192399;11302.152338574804;13376.464941402624;13585.252811095485;13686.315684215948;13737.793933091212;13756.312184390941;11267.718307042389;11277.661670149908;11285.097192224439;11368.147388945697;11569.132315076235;10934.835977460503;11019.889801101886;11115.499802508744;11118.666440006813;11244.775104498029;9921.702348929544;10059.094681478702;10090.899091009289;10101.898981010096;10151.7462063449;7434.814129646802;7458.73894413693;7459.142198647225;7473.177950425557;7508.549487030796;7581.279778421042;7644.885326720215;7653.693852245848;7724.536527808349;7761 11:33:00 INFO - PID 5348 | |4;prototype.html;494.3326273684805;509.51850501276283;511.5830598062579;516.9819056333027;527.3171243240004;6388.818068657296;6459.870802583945;6471.191101112367;6518.28298887122;6527.80416587502;6371.4584260337815;6424.421802037816;6430.131932189153;6434.517411194168;6461.6446095464735;5316.3354580677415;5331.2003199519995;5333.6530727457;5349.384820745625;5350.705711185883;5129.846104616868;5266.367426097902;5293.735313234342;5346.1713434417725;5359.839204823861;5270.5520030797425;5285.286486324355;5297.311349524556;5312.6281160318795;5316.707581083039;5208.687478751287;5251.842444726626;5261.947380526222;5272.472752724716;5291.3385826771655;4776.259679749644;4835.830745923911;4912.336834527365;4948.752562371867;4957.677750946213;6176.0118381059265;6189.473894718954;6196.938030619681;6237.688115594202;6254.562180647356;5959.255093113361;6014.78948236814;6039.245094363205;6061.333253342129;6147.479533391333;6587.3083326250535;6591.6704164792045;6672.432843208333;6711.261761206263;6728.39444449997;5089.592832573385;5307.761150748225;5343.225232341289;5344.652597581145;5428.83713488596;6910.343517365842;6936.2948450104495;6963.895541566881;6976.511644184859;7029.648517574101;5504.623844038991;5507.944920550824;5511.751971161308;5514.641548299428;5537.972310138423;5554.250176226238;5591.860203494945;5614;5625.54995600351;5648.378678345379;5958.493528050164;6008.609440386361;6034.909476357858;6062.514998800086;6066.696665166813;6745.6289904054765;6747.932520674829;6765.9661701691175;6791.524593278423;6812.4550035997;1962.6761584338424;1963.9198440857472;1966.9311574094838;1966.9409917702492;1976.8633036004355;1388.6042477893955;1410.4851729118798;1423.7935499352536;1441.344188394299;1464.9414023439156;5443.673379597237;5605.887882242332;5643.379228284885;5644.774209031592;5676.545876329884;6708.83227919306;6716.205343980635;6716.5634233774645;6717.16035495563;6789.422899053636;5610.438956104357;5670.603057785916;5706.885862282731;5716.828495145152;5765.1928729977835;3525.7003154731624;3540.150363912694;3567.375709250871;3608.80151591665;3619.656132667445;6365.893998371025;6415.935840641627;6452.4515416189215;6484.837879053061;6522.586642942142;6859.348361905611;6862.965685171642;6904.861902761917;6922.307769223037;6949.339812717783;6505.902411463831;6512.934870651327;6560.147180866456;6594.241662208811;6624.503162262753;6576.243731970884;6676.365745254193;6687.164104486939;6717.496187785838;6815.659217039029;6590.670466476561;6637.900431493435;6650.567713098633;6662.800115996528;6665.400113989765;6495.805125846232;6557.753796962506;6601.702923368556;6619.238787539302;6641.402273795382;5518.668879867221;5524.254225679482;5564.329122021533;5575.860603484945;5580.86047848807;6538.1827271591055;6671.299513551201;6724.697388617426;6856.382925536725;6880.65596720172;6478.416942475012;6631.767888124085;6640.701168447335;6668.566543174678;6689.933100668931;6584.901226481511;6644.7009884554345;6654.500912431684;6669.533132680665;6694.83262918431;6350.555461117678;6540.967295163494;6550.967245163743;6585.967070164618;6593.80218593443;6452.903206452001;6485.573173901923;6566.606003639797;6578.625214232482;6649.301823308483;6290.748370065146;6385.45723613498;6433.453156481564;6473.158489396348;6476.287608363171 11:33:00 INFO - PID 5348 | |5;yui.html;918.5590916360147;938.1416004356018;939.1031564855564;940.9670661526848;956.3018996132823;19016;19336.516587085312;19801.108950097245;19802.10890509927;19819.900900495497;17896.64206715865;17918.10409479527;17974.460766177002;18008.909955450203;18029;959.5202398800582;971.946542940138;974.9512524373788;975.0736800039955;975.2149519636689;958.4441024205944;990.8365119755232;998.5506522065064;998.5706146357063;998.8851282102579;1004.3371374892572;1051.2010871737496;1051.279873286801;1051.7160366700987;1063.5852017713098;1024.4109636958742;1034.5396298647142;1035.0580971316142;1035.3632516002679;1036.4765793274348;748.3788455581908;748.5733132114697;748.6780684305746;750.2684882239827;753.581762122022;18922.90538547312;18932.10191210143;19183.808161918343;19187.040647967686;19190.52023699405;21415.250466233763;21739.891300543397;21808.781912180835;21818.127274908984;21831.45421364463;14876;15076.472323468626;15163.317650705634;15214.087154770748;15221;3765.3787125124322;3804.695624350073;3808;3810.7141964352786;3815.8473661053804;141603;141862.58137418597;142167;143125.2843735785;144743;16625.08562029076;17064.146792660566;17204.1397930103;17265.050422226646;17281.481555553353;31352.37295254082;31787.84106079501;31940;32032;32115.197120072185;8031.317338026216;8276.420650554524;8385.413021088587;8386.245237928615;8389.286910612665;4231.9576804231565;4337.652987760972;4344.608985191285;4348.239058164809;4350.825966961286;5224.085784987612;5327.147656374961;5327.573794096463;5352.090144675414;5355.812546560929;892.7455675132557;902.6208992223281;907.7049958763429;909.9636014559476;910.4719262827545;689.648279377511;708.674009955416;715.3311653603897;724.2504008351436;732.5018987088831;10925.672229833117;12019.399030048637;12023.27860328383;12352.62942111738;12416.81374779379;666.8032930285577;671.771597656799;675.7128220506265;678.2132726037772;684.6302996381997;5390.100671140945;5394.811181608703;5457;5468.808591699351;5585.106382978704;117300.41349793196;123137.38431307786;123354.38322808329;123579;123999;90169.09830901607;95409.5229523848;108000.45999770108;108300;114299.42850285696;94342;97044.51477742707;98344.50827745958;99297;99493;11423.771524569296;11504.53981840717;11683.766324673628;12041.217320874115;12179.269243845398;41046;42502.57497424986;42857.78571107124;43518.347224792284;45021.32468013048;51393;53126;54928.72535637296;55489;58768.70615646894;18578;18830.24679012879;18835.152418140944;18957.90521047441;19024.334148304744;16561.17194140312;16949.406770762966;16954.830451695325;17018.744718829475;20417;15958.840411595735;16039.8396016043;17941.73087403664;18687.813121868607;18917.621647566695;17209.397671081453;17515.386961456286;18261;18382;18608.44174674762;16811.41160059392;17171;17184.054876981885;17449.38927137544;18071.909640451715;11500.597479088192;11763.411829408666;11767.588134415255;12181.147319687538;12303.93848030754;11763.117766167401;11797.469113889723;12702.936485317514;13239.13945593572;13407.86592134066 11:33:00 INFO - PID 5348 | __end_tp_report 11:33:00 INFO - PID 5348 | __start_cc_report 11:33:00 INFO - PID 5348 | _x_x_mozilla_cycle_collect,396 11:33:00 INFO - PID 5348 | __end_cc_report 11:33:00 INFO - PID 5348 | __startTimestamp1505327580168__endTimestamp 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | ------- Summary: start ------- 11:33:00 INFO - PID 5348 | Number of tests: 6 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#0] dojo.html Cycles:165 Average:6200.81 Median:6444.55 stddev:736.33 (11.4%) stddev-sans-first:698.43 11:33:00 INFO - PID 5348 | Values: 3143.2 3145.8 3149.7 3150.5 3162.7 6186.1 6203.1 6231.8 6334.1 6335.3 6242.2 6296.6 6313.6 6320.7 6417.7 5860.2 5898.4 5918.3 5921.4 5944.5 5704.2 5767.1 5791.9 5855.6 5884.5 5752.7 5797.7 5825.1 5867.1 5887.3 5585.2 5756.0 5773.9 5815.9 5822.8 5767.8 5768.4 5797.6 5809.1 5836.6 6228.8 6306.5 6334.7 6388.8 6412.7 6623.7 6732.1 6737.8 6813.8 6832.6 6777.9 6793.5 6905.9 6930.5 6933.3 6276.4 6285.3 6337.5 6348.5 6365.8 6924.5 6935.4 6964.3 6991.5 7041.5 6608.0 6620.9 6629.6 6633.5 6636.6 6660.7 6670.1 6674.2 6753.8 6771.1 6585.5 6588.7 6653.3 6712.2 6728.1 6666.5 6683.1 6686.8 6687.6 6688.7 5249.3 5260.1 5271.4 5284.3 5338.4 4612.7 4683.1 4717.9 4753.5 4755.2 5779.3 5784.7 5849.3 5854.1 5858.2 6631.8 6735.5 6739.3 6806.5 6842.8 5771.8 5819.4 5841.4 5846.0 5847.5 5778.5 5781.7 5796.4 5857.0 5857.8 6297.3 6410.6 6449.2 6510.1 6582.4 6751.9 6774.2 6807.9 6840.6 6879.2 6508.6 6523.2 6589.8 6602.8 6612.9 6662.0 6668.5 6681.7 6756.1 6757.8 6618.7 6722.4 6727.5 6738.7 6748.5 6444.5 6447.1 6447.4 6447.7 6449.5 6390.1 6415.5 6511.5 6523.2 6537.0 6486.3 6500.6 6553.6 6574.1 6580.0 6571.5 6596.0 6631.6 6688.6 6709.8 6203.8 6318.7 6339.2 6462.8 6470.5 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#1] ext.html Cycles:180 Average:37464.69 Median:35600.14 stddev:52572.98 (147.7%) stddev-sans-first:52648.60 11:33:00 INFO - PID 5348 | Values: 855.5 866.1 893.4 897.0 900.8 40191.6 40699.6 42017.6 42070.0 42134.2 41915.8 42273.0 42281.0 42324.8 42427.2 7825.4 7934.9 7940.7 7955.8 7957.4 7854.1 7940.3 7969.1 7992.2 8015.6 7959.8 7989.8 7993.3 8005.3 8011.4 7927.0 7944.7 7970.2 7975.8 7977.8 7773.4 7849.5 7853.0 7858.9 7865.4 38343.6 38366.0 38487.0 38683.4 38710.0 3573.3 3613.3 3616.4 3617.6 3622.8 31651.1 31724.2 31769.4 31780.8 31793.7 5272.7 5278.0 5287.0 5329.1 5336.9 185321.0 185748.0 186343.1 186348.0 186568.0 46658.0 47103.0 47149.0 49380.0 49972.5 52588.5 52843.2 52886.5 52908.7 52982.5 15862.6 16007.1 16037.9 16334.9 16344.3 13046.2 13146.6 13148.3 13151.0 13153.6 14895.3 14906.6 14956.6 15028.8 15101.2 5848.9 6075.1 6075.8 6096.1 6140.8 1001.4 1017.7 1024.3 1031.8 1032.7 23164.7 23376.0 23398.2 23546.6 23756.4 1072.3 1116.5 1123.0 1131.2 1131.7 12367.0 12470.8 12506.1 12543.9 12548.1 227921.0 229816.0 229977.0 231383.0 231965.0 45344.0 46014.5 52290.7 52604.0 53220.2 1452.6 1457.5 1458.9 1462.0 1467.7 27385.5 27453.5 27475.6 27840.0 27916.0 37646.2 37687.2 37763.8 37803.2 37807.2 190124.0 190530.0 190749.0 190968.0 191334.0 35075.3 35303.5 35630.5 35798.5 35909.6 42415.8 43464.3 43470.6 43792.1 43875.1 31498.5 31842.7 31887.7 31917.2 32091.5 31031.7 31223.0 31245.4 31364.0 31537.7 35303.0 35437.0 35440.0 35569.8 35632.5 30638.5 30939.5 31210.2 31698.0 31730.0 23143.4 23402.9 23457.8 23822.0 24065.4 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#2] jquery.html Cycles:180 Average:33110.09 Median:23087.33 stddev:74816.83 (324.1%) stddev-sans-first:74986.83 11:33:00 INFO - PID 5348 | Values: 576.5 582.9 583.2 583.9 584.8 22549.8 23108.7 23371.3 23414.9 23465.6 25839.0 26216.5 26287.9 26302.9 26423.6 6542.3 6674.1 6685.3 6686.0 6687.4 6462.5 6524.0 6707.1 6709.7 6711.2 6658.5 6658.9 6672.8 6681.8 6685.3 6675.1 6687.4 6690.8 6691.3 6693.5 6207.8 6215.6 6225.4 6227.3 6227.9 28842.4 30035.0 30163.7 30412.2 30533.8 1983.4 2002.2 2002.3 2011.5 2011.8 19249.4 20000.7 20023.8 20026.5 20033.0 2379.8 2385.1 2431.3 2435.2 2488.7 128005.0 129801.0 133587.0 133916.3 134139.0 14568.2 14603.6 15145.0 15179.8 15239.9 22132.3 23117.5 23270.7 23410.0 23465.4 9994.8 10021.3 10072.1 10122.9 10158.5 9124.2 9212.0 9293.1 9296.6 9404.0 8843.6 9054.8 9098.7 9116.0 9406.8 2587.2 2610.9 2651.7 2694.3 2720.3 953.5 966.5 980.4 988.3 991.0 19379.9 19519.0 19733.6 19785.3 19916.1 1035.8 1036.9 1037.5 1043.2 1054.9 10717.8 10805.6 10850.2 10855.3 10915.9 426558.0 434948.0 441914.0 442213.0 459658.0 109600.0 114221.0 115390.4 115815.0 116681.0 1143.6 1164.0 1179.6 1184.7 1188.8 17132.8 17414.3 17611.0 17614.7 18044.7 55929.9 56727.1 56830.1 57305.7 57936.4 67685.3 68396.7 68931.7 69155.0 69564.7 14112.6 14249.9 14324.9 14377.4 14469.1 22640.9 22644.7 22753.2 22974.1 23066.0 17893.6 18108.1 18115.2 18360.9 18628.7 15805.0 16369.3 16575.5 16690.4 16945.7 16592.8 16768.2 17070.3 18526.7 18707.3 14153.0 14159.0 14254.9 14256.1 14346.1 17748.7 17748.9 17914.3 17967.5 18093.4 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#3] mootools.html Cycles:180 Average:9380.75 Median:2690.29 stddev:6732.59 (250.3%) stddev-sans-first:6724.20 11:33:00 INFO - PID 5348 | Values: 1314.8 1355.7 1371.5 1372.4 1387.3 14932.0 15532.8 15561.3 15579.4 15584.5 15235.1 15280.1 15324.1 15375.5 15413.8 2597.0 2687.2 2701.3 2705.6 2710.1 2749.3 2751.6 2772.2 2773.1 2773.3 2562.4 2653.1 2784.9 2785.5 2787.0 2683.6 2693.4 2719.5 2721.4 2721.7 2580.2 2711.5 2795.7 2806.7 2808.6 14793.3 14924.4 14943.9 14947.4 15014.4 7828.6 8095.2 8101.4 8105.9 8120.7 4862.8 5002.9 5112.2 5119.6 5119.8 1687.8 1744.5 1748.8 1755.1 1789.2 26361.0 27037.9 27038.9 27045.2 27061.0 7258.8 7434.5 7434.7 7573.9 7663.7 15731.1 17734.1 20411.8 20421.0 20442.7 7872.6 8111.5 8132.1 8134.4 8136.8 7358.2 7445.6 7472.1 7480.4 7486.4 5314.8 5488.3 5503.4 5519.1 5556.6 1481.9 1485.7 1501.3 1505.5 1519.9 892.7 910.2 914.5 922.2 927.3 7499.4 7544.5 7593.8 7613.7 7663.3 685.1 707.1 713.8 722.8 732.8 4532.0 5087.7 5167.1 5213.5 5306.1 20850.4 21451.0 21490.4 21504.7 21793.7 20418.7 20834.3 21116.5 21594.0 21615.9 11251.5 11294.5 11315.7 11355.0 11437.7 8126.2 8143.7 8227.8 8560.9 8677.0 18012.2 18593.8 18714.2 18733.6 18819.0 18705.3 18727.3 18784.6 18864.7 19071.7 11156.8 11188.2 11214.7 11238.1 11302.2 13376.5 13585.3 13686.3 13737.8 13756.3 11267.7 11277.7 11285.1 11368.1 11569.1 10934.8 11019.9 11115.5 11118.7 11244.8 9921.7 10059.1 10090.9 10101.9 10151.7 7434.8 7458.7 7459.1 7473.2 7508.5 7581.3 7644.9 7653.7 7724.5 7761.0 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#4] prototype.html Cycles:180 Average:5678.51 Median:6320.65 stddev:1511.15 (23.9%) stddev-sans-first:1464.44 11:33:00 INFO - PID 5348 | Values: 494.3 509.5 511.6 517.0 527.3 6388.8 6459.9 6471.2 6518.3 6527.8 6371.5 6424.4 6430.1 6434.5 6461.6 5316.3 5331.2 5333.7 5349.4 5350.7 5129.8 5266.4 5293.7 5346.2 5359.8 5270.6 5285.3 5297.3 5312.6 5316.7 5208.7 5251.8 5261.9 5272.5 5291.3 4776.3 4835.8 4912.3 4948.8 4957.7 6176.0 6189.5 6196.9 6237.7 6254.6 5959.3 6014.8 6039.2 6061.3 6147.5 6587.3 6591.7 6672.4 6711.3 6728.4 5089.6 5307.8 5343.2 5344.7 5428.8 6910.3 6936.3 6963.9 6976.5 7029.6 5504.6 5507.9 5511.8 5514.6 5538.0 5554.3 5591.9 5614.0 5625.5 5648.4 5958.5 6008.6 6034.9 6062.5 6066.7 6745.6 6747.9 6766.0 6791.5 6812.5 1962.7 1963.9 1966.9 1966.9 1976.9 1388.6 1410.5 1423.8 1441.3 1464.9 5443.7 5605.9 5643.4 5644.8 5676.5 6708.8 6716.2 6716.6 6717.2 6789.4 5610.4 5670.6 5706.9 5716.8 5765.2 3525.7 3540.2 3567.4 3608.8 3619.7 6365.9 6415.9 6452.5 6484.8 6522.6 6859.3 6863.0 6904.9 6922.3 6949.3 6505.9 6512.9 6560.1 6594.2 6624.5 6576.2 6676.4 6687.2 6717.5 6815.7 6590.7 6637.9 6650.6 6662.8 6665.4 6495.8 6557.8 6601.7 6619.2 6641.4 5518.7 5524.3 5564.3 5575.9 5580.9 6538.2 6671.3 6724.7 6856.4 6880.7 6478.4 6631.8 6640.7 6668.6 6689.9 6584.9 6644.7 6654.5 6669.5 6694.8 6350.6 6541.0 6551.0 6586.0 6593.8 6452.9 6485.6 6566.6 6578.6 6649.3 6290.7 6385.5 6433.5 6473.2 6476.3 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | [#5] yui.html Cycles:180 Average:24408.22 Median:19811.00 stddev:35232.48 (177.8%) stddev-sans-first:35287.17 11:33:00 INFO - PID 5348 | Values: 918.6 938.1 939.1 941.0 956.3 19016.0 19336.5 19801.1 19802.1 19819.9 17896.6 17918.1 17974.5 18008.9 18029.0 959.5 971.9 975.0 975.1 975.2 958.4 990.8 998.6 998.6 998.9 1004.3 1051.2 1051.3 1051.7 1063.6 1024.4 1034.5 1035.1 1035.4 1036.5 748.4 748.6 748.7 750.3 753.6 18922.9 18932.1 19183.8 19187.0 19190.5 21415.3 21739.9 21808.8 21818.1 21831.5 14876.0 15076.5 15163.3 15214.1 15221.0 3765.4 3804.7 3808.0 3810.7 3815.8 141603.0 141862.6 142167.0 143125.3 144743.0 16625.1 17064.1 17204.1 17265.1 17281.5 31352.4 31787.8 31940.0 32032.0 32115.2 8031.3 8276.4 8385.4 8386.2 8389.3 4232.0 4337.7 4344.6 4348.2 4350.8 5224.1 5327.1 5327.6 5352.1 5355.8 892.7 902.6 907.7 910.0 910.5 689.6 708.7 715.3 724.3 732.5 10925.7 12019.4 12023.3 12352.6 12416.8 666.8 671.8 675.7 678.2 684.6 5390.1 5394.8 5457.0 5468.8 5585.1 117300.4 123137.4 123354.4 123579.0 123999.0 90169.1 95409.5 108000.5 108300.0 114299.4 94342.0 97044.5 98344.5 99297.0 99493.0 11423.8 11504.5 11683.8 12041.2 12179.3 41046.0 42502.6 42857.8 43518.3 45021.3 51393.0 53126.0 54928.7 55489.0 58768.7 18578.0 18830.2 18835.2 18957.9 19024.3 16561.2 16949.4 16954.8 17018.7 20417.0 15958.8 16039.8 17941.7 18687.8 18917.6 17209.4 17515.4 18261.0 18382.0 18608.4 16811.4 17171.0 17184.1 17449.4 18071.9 11500.6 11763.4 11767.6 12181.1 12303.9 11763.1 11797.5 12702.9 13239.1 13407.9 11:33:00 INFO - PID 5348 | -------- Summary: end -------- 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | 11:33:00 INFO - PID 5348 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 11:33:00 INFO - PID 5348 | 11:33:00 INFO - TEST-INFO | 5348: exit 0 11:33:00 INFO - TEST-OK | dromaeo_css | took 1108951ms 11:33:00 INFO - TEST-START | kraken 11:33:00 INFO - Initialising browser for kraken test... 11:33:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35180/getInfo.html -profile /tmp/tmp5zSS_A/profile 11:33:00 INFO - TEST-INFO | started process 5709 (/builds/slave/test/build/application/firefox/firefox http://localhost:35180/getInfo.html) 11:33:06 INFO - TEST-INFO | 5709: exit 0 11:33:06 INFO - Browser initialized. 11:33:06 INFO - Running cycle 1/1 for kraken test... 11:33:06 INFO - Using env: {'DISPLAY': ':0', 11:33:06 INFO - 'HOME': '/home/cltbld', 11:33:06 INFO - 'JSGC_DISABLE_POISONING': '1', 11:33:06 INFO - 'LANG': 'en_US.UTF-8', 11:33:06 INFO - 'LANGUAGE': 'en_US:en', 11:33:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:33:06 INFO - 'LOGNAME': 'cltbld', 11:33:06 INFO - 'MAIL': '/var/mail/cltbld', 11:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:06 INFO - 'MOZ_CRASHREPORTER': '1', 11:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:33:06 INFO - 'MOZ_NO_REMOTE': '1', 11:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:06 INFO - 'NO_EM_RESTART': '1', 11:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:06 INFO - 'PWD': '/builds/slave/test', 11:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:06 INFO - 'RUST_BACKTRACE': 'full', 11:33:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:33:06 INFO - 'SHELL': '/bin/bash', 11:33:06 INFO - 'SHLVL': '1', 11:33:06 INFO - 'STYLO_FORCE_DISABLED': '1', 11:33:06 INFO - 'TERM': 'linux', 11:33:06 INFO - 'TMOUT': '86400', 11:33:06 INFO - 'USER': 'cltbld', 11:33:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062', 11:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:06 INFO - '_': '/tools/buildbot/bin/python'} 11:33:06 INFO - TEST-INFO | started process 5893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5zSS_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:07 INFO - PID 5893 | 11:33:07 INFO - PID 5893 | (/builds/slave/test/build/application/firefox/firefox:5944): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:33:07 INFO - PID 5893 | 11:33:17 INFO - PID 5893 | RSS: Main: 173699072 11:33:17 INFO - PID 5893 | 11:33:20 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:21 INFO - PID 5893 | RSS: Main: 178843648 11:33:21 INFO - PID 5893 | 11:33:24 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-dft) 11:33:24 INFO - PID 5893 | RSS: Main: 178737152 11:33:24 INFO - PID 5893 | 11:33:27 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-fft) 11:33:28 INFO - PID 5893 | RSS: Main: 174813184 11:33:28 INFO - PID 5893 | 11:33:30 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35180/tests/kraken/driver.html?testName=audio-oscillator) 11:33:30 INFO - PID 5893 | RSS: Main: 175370240 11:33:30 INFO - PID 5893 | 11:33:33 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:33 INFO - PID 5893 | RSS: Main: 175681536 11:33:33 INFO - PID 5893 | 11:33:36 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:37 INFO - PID 5893 | RSS: Main: 177922048 11:33:37 INFO - PID 5893 | 11:33:41 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35180/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:41 INFO - PID 5893 | RSS: Main: 177266688 11:33:41 INFO - PID 5893 | 11:33:44 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35180/tests/kraken/driver.html?testName=json-parse-financial) 11:33:45 INFO - PID 5893 | RSS: Main: 178012160 11:33:45 INFO - PID 5893 | 11:33:47 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:47 INFO - PID 5893 | RSS: Main: 178053120 11:33:47 INFO - PID 5893 | 11:33:49 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:49 INFO - PID 5893 | RSS: Main: 178278400 11:33:49 INFO - PID 5893 | 11:33:51 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:52 INFO - PID 5893 | RSS: Main: 175132672 11:33:52 INFO - PID 5893 | 11:33:55 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:55 INFO - PID 5893 | RSS: Main: 175501312 11:33:55 INFO - PID 5893 | 11:33:58 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:59 INFO - PID 5893 | RSS: Main: 175828992 11:33:59 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | Cycle 1(1): loaded http://localhost:35180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35180/tests/kraken/driver.html?testName=ai-astar) 11:34:01 INFO - PID 5893 | RSS: Main: 177381376 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | __start_tp_report 11:34:01 INFO - PID 5893 | _x_x_mozilla_page_load 11:34:01 INFO - PID 5893 | _x_x_mozilla_page_load_details 11:34:01 INFO - PID 5893 | |i|pagename|runs| 11:34:01 INFO - PID 5893 | |0;ai-astar;108;108;107;107;109;109;109;106;107;107 11:34:01 INFO - PID 5893 | |1;audio-beat-detection;117;116;115;115;118;115;138;125;116;116 11:34:01 INFO - PID 5893 | |2;audio-dft;163;162;162;162;162;161;164;166;167;166 11:34:01 INFO - PID 5893 | |3;audio-fft;73;74;74;73;74;73;73;73;75;74 11:34:01 INFO - PID 5893 | |4;audio-oscillator;79;78;79;78;79;79;79;79;78;80 11:34:01 INFO - PID 5893 | |5;imaging-gaussian-blur;113;114;113;114;114;110;114;114;113;114 11:34:01 INFO - PID 5893 | |6;imaging-darkroom;148;148;148;149;148;148;148;148;149;149 11:34:01 INFO - PID 5893 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;95;95 11:34:01 INFO - PID 5893 | |8;json-parse-financial;55;52;52;53;53;53;53;54;52;54 11:34:01 INFO - PID 5893 | |9;json-stringify-tinderbox;39;38;38;38;38;38;38;38;38;41 11:34:01 INFO - PID 5893 | |10;stanford-crypto-aes;74;73;74;75;82;73;73;74;73;74 11:34:01 INFO - PID 5893 | |11;stanford-crypto-ccm;118;112;115;118;119;115;111;113;125;116 11:34:01 INFO - PID 5893 | |12;stanford-crypto-pbkdf2;171;165;164;163;169;169;174;172;164;172 11:34:01 INFO - PID 5893 | |13;stanford-crypto-sha256-iterative;66;63;65;66;67;64;66;68;65;65 11:34:01 INFO - PID 5893 | __end_tp_report 11:34:01 INFO - PID 5893 | __start_cc_report 11:34:01 INFO - PID 5893 | _x_x_mozilla_cycle_collect,989 11:34:01 INFO - PID 5893 | __end_cc_report 11:34:01 INFO - PID 5893 | __startTimestamp1505327641498__endTimestamp 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | ------- Summary: start ------- 11:34:01 INFO - PID 5893 | Number of tests: 14 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:1.06 (1.0%) stddev-sans-first:1.12 11:34:01 INFO - PID 5893 | Values: 108.0 108.0 107.0 107.0 109.0 109.0 109.0 106.0 107.0 107.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:116.50 stddev:7.28 (6.2%) stddev-sans-first:7.68 11:34:01 INFO - PID 5893 | Values: 117.0 116.0 115.0 115.0 118.0 115.0 138.0 125.0 116.0 116.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 11:34:01 INFO - PID 5893 | Values: 163.0 162.0 162.0 162.0 162.0 161.0 164.0 166.0 167.0 166.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#3] audio-fft Cycles:10 Average:73.60 Median:74.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 11:34:01 INFO - PID 5893 | Values: 73.0 74.0 74.0 73.0 74.0 73.0 73.0 73.0 75.0 74.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 11:34:01 INFO - PID 5893 | Values: 79.0 78.0 79.0 78.0 79.0 79.0 79.0 79.0 78.0 80.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 11:34:01 INFO - PID 5893 | Values: 113.0 114.0 113.0 114.0 114.0 110.0 114.0 114.0 113.0 114.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:34:01 INFO - PID 5893 | Values: 148.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 149.0 149.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:34:01 INFO - PID 5893 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:0.78 11:34:01 INFO - PID 5893 | Values: 55.0 52.0 52.0 53.0 53.0 53.0 53.0 54.0 52.0 54.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:0.97 (2.5%) stddev-sans-first:1.00 11:34:01 INFO - PID 5893 | Values: 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 41.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.72 (3.7%) stddev-sans-first:2.88 11:34:01 INFO - PID 5893 | Values: 74.0 73.0 74.0 75.0 82.0 73.0 73.0 74.0 73.0 74.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.00 stddev:4.08 (3.5%) stddev-sans-first:4.27 11:34:01 INFO - PID 5893 | Values: 118.0 112.0 115.0 118.0 119.0 115.0 111.0 113.0 125.0 116.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:170.00 stddev:4.00 (2.4%) stddev-sans-first:4.12 11:34:01 INFO - PID 5893 | Values: 171.0 165.0 164.0 163.0 169.0 169.0 174.0 172.0 164.0 172.0 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 11:34:01 INFO - PID 5893 | Values: 66.0 63.0 65.0 66.0 67.0 64.0 66.0 68.0 65.0 65.0 11:34:01 INFO - PID 5893 | -------- Summary: end -------- 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 11:34:01 INFO - PID 5893 | 11:34:01 INFO - PID 5893 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:34:02 INFO - TEST-INFO | 5893: exit 0 11:34:02 INFO - TEST-OK | kraken | took 61355ms 11:34:02 INFO - SUITE-END | took 1170s 11:34:02 INFO - Completed test suite (00:19:30) 11:34:02 INFO - javascript benchmark 11:34:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8579.169623768992, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.245621050947, 3145.8112513249207, 3149.7007784260495, 3150.5116706910408, 3162.7311678507326, 6186.072089186624, 6203.131561581382, 6231.750729970796, 6334.081558174068, 6335.334789847069, 6242.219722534684, 6296.559240853142, 6313.558050936436, 6320.74717011319, 6417.711202995864, 5860.238169038019, 5898.380670029649, 5918.2898052233795, 5921.378255283198, 5944.494717948979, 5704.172894930232, 5767.106098554731, 5791.884162316751, 5855.648661080349, 5884.499817515516, 5752.741126649311, 5797.71011449428, 5825.0679891217205, 5867.1492633568105, 5887.264091988502, 5585.1901474286005, 5756.0, 5773.88452230953, 5815.883682326372, 5822.82531524055, 5767.798127065575, 5768.3654797972185, 5797.623154494987, 5809.070548712186, 5836.620619659709, 6228.844278893019, 6306.49548036156, 6334.683265836736, 6388.776392826276, 6412.7114279857515, 6623.73505059797, 6732.124823772927, 6737.797866064026, 6813.795586132374, 6832.59004459729, 6777.93222067778, 6793.524453288272, 6905.861882762367, 6930.5148639595245, 6933.341332573397, 6276.372362763733, 6285.340039295854, 6337.49300055999, 6348.492120630339, 6365.777197798055, 6924.515283930076, 6935.445164386837, 6964.303569642995, 6991.475639327071, 7041.4718896082995, 6608.041833934052, 6620.933790662128, 6629.635370054693, 6633.4693224541925, 6636.568623039487, 6660.700268487833, 6670.099536562599, 6674.16572928384, 6753.763618273337, 6771.085903402977, 6585.506087043395, 6588.670566471657, 6653.334666533405, 6712.194536655633, 6728.058071869942, 6666.533342666064, 6683.097781799492, 6686.7993960181275, 6687.6321802301345, 6688.665566721645, 5249.265102885599, 5260.105782017066, 5271.393789714155, 5284.286621306074, 5338.3593968724, 4612.654050946126, 4683.1336202802595, 4717.9056418872115, 4753.47711751707, 4755.215389460769, 5779.33537643168, 5784.739686714108, 5849.298084229919, 5854.092615644582, 5858.238429004202, 6631.834204144935, 6735.461163106939, 6739.326067393319, 6806.5235433520165, 6842.794716158523, 5771.797987070432, 5819.447152520504, 5841.357450680422, 5845.970770146122, 5847.502962248256, 5778.451047150514, 5781.71091445426, 5796.362400136066, 5857.033589457692, 5857.824265272048, 6297.275813281532, 6410.55126141175, 6449.226092868886, 6510.056041873996, 6582.44049255809, 6751.898721519279, 6774.187097548326, 6807.89788153188, 6840.623765692934, 6879.174499060145, 6508.60948343101, 6523.24982627004, 6589.769358072444, 6602.834929126618, 6612.933870661424, 6662.0, 6668.466522678271, 6681.665916704048, 6756.121704178426, 6757.763478278237, 6618.70215840298, 6722.361375669304, 6727.495437842279, 6738.66306684654, 6748.460123190232, 6444.548881578245, 6447.0651755494255, 6447.387498187664, 6447.709853056717, 6449.5485316027425, 6390.105385246162, 6415.486761059011, 6511.47908167336, 6523.24982627004, 6537.019447082976, 6486.254080780582, 6500.6424646643, 6553.639549824615, 6574.0796288520605, 6580.045893345342, 6571.507136964651, 6596.0, 6631.602103873783, 6688.598684078971, 6709.798706038827, 6203.751849925952, 6318.6840657965995, 6339.2392912850755, 6462.838429039123, 6470.48236141117], "value": 6144.888753769513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.512357955965, 866.1252135343303, 893.4326702543884, 896.9910300896993, 900.8423525882977, 40191.598084019184, 40699.59300406995, 42017.57982420175, 42070.0, 42134.157316853685, 41915.79042104785, 42273.0, 42281.0, 42324.78837605807, 42427.151456970845, 7825.373970082408, 7934.920650793476, 7940.722074727386, 7955.761327160194, 7957.403194760387, 7854.136045035041, 7940.325072368855, 7969.083555391117, 7992.20077992199, 8015.599220039004, 7959.840803183933, 7989.760307190764, 7993.2806047455715, 8005.279524842763, 8011.399145064114, 7927.04875414951, 7944.721934732314, 7970.2428269314905, 7975.7607271781935, 7977.760667179994, 7773.416993725436, 7849.529028258323, 7853.0, 7858.882116768253, 7865.410094242898, 38343.616563834286, 38366.0, 38487.0, 38683.41974870379, 38710.0, 3573.338932297507, 3613.277344531078, 3616.385214513539, 3617.565892092966, 3622.7645203061716, 31651.05046848598, 31724.206894827585, 31769.364612707846, 31780.841095794374, 31793.6820631793, 5272.736363181825, 5278.0, 5287.021900948337, 5329.120695085307, 5336.893262134774, 185321.0, 185748.0, 186343.06828465906, 186348.0, 186568.0, 46658.0, 47103.0, 47149.0, 49380.0, 49972.50027499751, 52588.47411525912, 52843.20735188975, 52886.47113528816, 52908.735456323244, 52982.47017529853, 15862.603434913988, 16007.119608421415, 16037.919810400874, 16334.918325408296, 16344.34622615106, 13046.217226966412, 13146.60560183196, 13148.342582870819, 13151.0, 13153.60539183807, 14895.255237238094, 14906.552803415914, 14956.551303460914, 15028.849711502746, 15101.244937753068, 5848.8537786554825, 6075.149479072933, 6075.75696972125, 6096.085587161872, 6140.815775526741, 1001.3641337750581, 1017.7455636090978, 1024.3085917005992, 1031.7523794289316, 1032.6953548703, 23164.65253021206, 23376.0, 23398.18106366269, 23546.64680029801, 23756.406089847547, 1072.340510585984, 1116.503884794363, 1122.9719257018476, 1131.1968502363413, 1131.6831287239586, 12367.010639148846, 12470.81293780594, 12506.062045346453, 12543.93728031354, 12548.121631485708, 227921.0, 229816.0, 229977.0, 231383.0, 231965.0, 45344.0, 46014.539854601695, 52290.738546307024, 52604.0, 53220.201696974575, 1452.5932738833144, 1457.511733569245, 1458.8687018168202, 1461.9634509137356, 1467.6844478437188, 27385.45229095447, 27453.450930981668, 27475.587866182424, 27840.0, 27916.0, 37646.24707505889, 37687.2462550742, 37763.81118094392, 37803.24393512059, 37807.24385512329, 190124.0, 190530.04734976238, 190749.0, 190968.0, 191334.0, 35075.29849403049, 35303.470447943815, 35630.465543017395, 35798.4630230552, 35909.64090359063, 42415.7879210602, 43464.34803478014, 43470.56529434665, 43792.12415751731, 43875.12249754923, 31498.52752208673, 31842.6815731849, 31887.6811231894, 31917.20206994844, 32091.518627220143, 31031.68968310288, 31223.0, 31245.37509249757, 31364.0, 31537.684623154393, 35303.0, 35437.0, 35440.0, 35569.82215088908, 35632.46551301681, 30638.540421894137, 30939.535906961864, 31210.21974450566, 31698.0, 31730.0, 23143.421414464774, 23402.882985585646, 23457.765422345557, 23822.0, 24065.398365041015], "value": 17403.999450173244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.5042063825111, 582.947534721875, 583.1806312131457, 583.9416058394161, 584.7748616782538, 22549.77450225497, 23108.65337019942, 23371.298861034153, 23414.88292558537, 23465.648015279785, 25839.0, 26216.47567048658, 26287.86856065717, 26302.868485657593, 26423.603645945324, 6542.280349161577, 6674.098996635465, 6685.331466853324, 6685.966570167142, 6687.364700353459, 6462.5153113516435, 6523.9673801630925, 6707.128073350457, 6709.664516774166, 6711.228208755982, 6658.467322614203, 6658.9001164982565, 6672.76645317414, 6681.8329541761605, 6685.331466853324, 6675.065490831264, 6687.431568316699, 6690.83272918176, 6691.26396096429, 6693.464522838161, 6207.782727604557, 6215.56491045627, 6225.377462253784, 6227.346128656471, 6227.906581401283, 28842.423151537063, 30035.0, 30163.69836301631, 30412.239694007607, 30533.847330763205, 1983.4347211044928, 2002.2491565662876, 2002.3092033248506, 2011.5474018345901, 2011.8189362957257, 19249.422517324503, 20000.699989500023, 20023.799762002483, 20026.499337516532, 20033.0, 2379.762023797606, 2385.1294277588554, 2431.294924471901, 2435.1598698449006, 2488.726240113586, 128005.0, 129801.0, 133587.0, 133916.33041834825, 134139.0, 14568.198749068692, 14603.634909127357, 15145.0, 15179.848201518063, 15239.923800380928, 22132.33602991913, 23117.537649246922, 23270.65094023591, 23410.0, 23465.41336466602, 9994.800103998024, 10021.29850910444, 10072.093511583993, 10122.949385253027, 10158.492075396201, 9124.178823905748, 9211.95394023039, 9293.070692930789, 9296.628134874665, 9403.952980235192, 8843.60203790831, 9054.81890362189, 9098.681546145854, 9115.954420227856, 9406.764830879283, 2587.197968629731, 2610.9347266318114, 2651.68179818423, 2694.326418395401, 2720.319920019995, 953.4660590069583, 966.5360626899128, 980.367662857453, 988.3427520698655, 990.9504524773732, 19379.903100484407, 19519.0, 19733.60532789336, 19785.307514236934, 19916.103775330146, 1035.808375450544, 1036.8652075230323, 1037.5434808684306, 1043.2175868098925, 1054.8681414823147, 10717.78564428707, 10805.621803237007, 10850.240483166102, 10855.348679079281, 10915.890841091647, 426558.0, 434948.0, 441914.0, 442213.0, 459658.0, 109599.9999999984, 114221.0, 115390.4230478859, 115815.0, 116681.0, 1143.5825923538016, 1163.953441862333, 1179.6107284595892, 1184.7452797648548, 1188.7979043562616, 17132.828671713123, 17414.303427862742, 17611.0, 17614.678899082362, 18044.729329059814, 55929.881402372535, 56727.14909276447, 56830.147547785986, 57305.71347143238, 57936.42063579479, 67685.3231467679, 68396.6580167096, 68931.65534172297, 69155.0, 69564.65217674081, 14112.647183820487, 14249.928750356183, 14324.928375358057, 14377.353019113956, 14469.059511131743, 22640.886795565915, 22644.66033009473, 22753.203637872593, 22974.081036758344, 23066.0, 17893.642127157644, 18108.094595270446, 18115.184816683017, 18360.90819545894, 18628.720569191744, 15805.0, 16369.345226191295, 16575.502734917973, 16690.4158354457, 16945.66108677844, 16592.83407165961, 16768.24542895548, 17070.317187312867, 18526.722099168794, 18707.25170993145, 14153.0, 14159.0, 14254.928725356307, 14256.144631322153, 14346.067505612102, 17748.733768993734, 17748.91125544364, 17914.283428662708, 17967.460976170736, 18093.36673216431], "value": 11882.250037646934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.7699152648288, 1355.681414867506, 1371.53124376123, 1372.3961456958937, 1387.2508845223579, 14932.0, 15532.767008494853, 15561.299741511632, 15579.376824926989, 15584.454544090959, 15235.085894846317, 15280.08319500828, 15324.08055516667, 15375.538733837975, 15413.768793468107, 2596.9610455843176, 2687.207273854208, 2701.3381721478268, 2705.6212130301774, 2710.0785732850827, 2749.257700420885, 2751.55975043993, 2772.1960631416864, 2773.1126039667315, 2773.251222170023, 2562.4362640219124, 2653.0714250012534, 2784.860756962154, 2785.5403858363347, 2787.0245414105, 2683.5840444731, 2693.380522479821, 2719.5376785946437, 2721.3876877702555, 2721.6597925259343, 2580.1614475295605, 2711.539038363483, 2795.7204279572084, 2806.733360330765, 2808.6208361871295, 14793.334299956528, 14924.403023879031, 14943.850561494355, 14947.40210391583, 15014.399424023026, 7828.5694286814205, 8095.2309530595085, 8101.392395570297, 8105.878411823827, 8120.675172993073, 4862.756862156878, 5002.9499705002845, 5112.18205087188, 5119.641625086246, 5119.846404607868, 1687.8480936715632, 1744.5464179313342, 1748.7551742756025, 1755.0785837435321, 1789.2127463915836, 26361.0, 27037.864810676016, 27038.864805676043, 27045.188644340506, 27061.0, 7258.782236532912, 7434.516756410816, 7434.702611895464, 7573.886391704129, 7663.655135518804, 15731.134787586792, 17734.11329433523, 20411.795882041286, 20421.0, 20442.693359599616, 7872.645730942121, 8111.472754270953, 8132.105468398471, 8134.389920755967, 8136.796580085427, 7358.1538123116525, 7445.627718614048, 7472.140703819022, 7480.401567874557, 7486.401087912954, 5314.813981510706, 5488.313960754906, 5503.449655034465, 5519.116941289374, 5556.555475561945, 1481.888858335629, 1485.6657252118403, 1501.3018946190075, 1505.52575938579, 1519.948070105371, 892.7411050795326, 910.2172131966504, 914.4741773480275, 922.2022950148207, 927.2859897878595, 7499.362554182846, 7544.471886967969, 7593.848123037508, 7613.695452181851, 7663.31030207284, 685.0717278088218, 707.1125737199782, 713.7573225103386, 722.7723267170825, 732.7508647059918, 4532.0, 5087.745612719349, 5167.1474206755465, 5213.504717051874, 5306.124489459273, 20850.374488765363, 21451.0, 21490.355289341343, 21504.677429838564, 21793.67309490359, 20418.69371959422, 20834.27080052191, 21116.47208819792, 21594.0, 21615.891920540296, 11251.549938002388, 11294.54821807135, 11315.717107072225, 11355.0, 11437.71405714847, 8126.187381261827, 8143.67425303005, 8227.83544329098, 8560.91439085601, 8676.956615216883, 18012.189451474453, 18593.81406185975, 18714.15786289593, 18733.625327493646, 18819.0, 18705.34531291398, 18727.250909963448, 18784.62430751405, 18864.717029244846, 19071.713924291424, 11156.776864462827, 11188.1608879336, 11214.719632009264, 11238.10095192399, 11302.152338574804, 13376.464941402624, 13585.252811095485, 13686.315684215948, 13737.793933091212, 13756.312184390941, 11267.718307042389, 11277.661670149908, 11285.097192224439, 11368.147388945697, 11569.132315076235, 10934.835977460503, 11019.889801101886, 11115.499802508744, 11118.666440006813, 11244.775104498029, 9921.702348929544, 10059.094681478702, 10090.899091009289, 10101.898981010096, 10151.7462063449, 7434.814129646802, 7458.73894413693, 7459.142198647225, 7473.177950425557, 7508.549487030796, 7581.279778421042, 7644.885326720215, 7653.693852245848, 7724.536527808349, 7761.0], "value": 6640.646813330839, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.3326273684805, 509.51850501276283, 511.5830598062579, 516.9819056333027, 527.3171243240004, 6388.818068657296, 6459.870802583945, 6471.191101112367, 6518.28298887122, 6527.80416587502, 6371.4584260337815, 6424.421802037816, 6430.131932189153, 6434.517411194168, 6461.6446095464735, 5316.3354580677415, 5331.2003199519995, 5333.6530727457, 5349.384820745625, 5350.705711185883, 5129.846104616868, 5266.367426097902, 5293.735313234342, 5346.1713434417725, 5359.839204823861, 5270.5520030797425, 5285.286486324355, 5297.311349524556, 5312.6281160318795, 5316.707581083039, 5208.687478751287, 5251.842444726626, 5261.947380526222, 5272.472752724716, 5291.3385826771655, 4776.259679749644, 4835.830745923911, 4912.336834527365, 4948.752562371867, 4957.677750946213, 6176.0118381059265, 6189.473894718954, 6196.938030619681, 6237.688115594202, 6254.562180647356, 5959.255093113361, 6014.78948236814, 6039.245094363205, 6061.333253342129, 6147.479533391333, 6587.3083326250535, 6591.6704164792045, 6672.432843208333, 6711.261761206263, 6728.39444449997, 5089.592832573385, 5307.761150748225, 5343.225232341289, 5344.652597581145, 5428.83713488596, 6910.343517365842, 6936.2948450104495, 6963.895541566881, 6976.511644184859, 7029.648517574101, 5504.623844038991, 5507.944920550824, 5511.751971161308, 5514.641548299428, 5537.972310138423, 5554.250176226238, 5591.860203494945, 5614.0, 5625.54995600351, 5648.378678345379, 5958.493528050164, 6008.609440386361, 6034.909476357858, 6062.514998800086, 6066.696665166813, 6745.6289904054765, 6747.932520674829, 6765.9661701691175, 6791.524593278423, 6812.4550035997, 1962.6761584338424, 1963.9198440857472, 1966.9311574094838, 1966.9409917702492, 1976.8633036004355, 1388.6042477893955, 1410.4851729118798, 1423.7935499352536, 1441.344188394299, 1464.9414023439156, 5443.673379597237, 5605.887882242332, 5643.379228284885, 5644.774209031592, 5676.545876329884, 6708.83227919306, 6716.205343980635, 6716.5634233774645, 6717.16035495563, 6789.422899053636, 5610.438956104357, 5670.603057785916, 5706.885862282731, 5716.828495145152, 5765.1928729977835, 3525.7003154731624, 3540.150363912694, 3567.375709250871, 3608.80151591665, 3619.656132667445, 6365.893998371025, 6415.935840641627, 6452.4515416189215, 6484.837879053061, 6522.586642942142, 6859.348361905611, 6862.965685171642, 6904.861902761917, 6922.307769223037, 6949.339812717783, 6505.902411463831, 6512.934870651327, 6560.147180866456, 6594.241662208811, 6624.503162262753, 6576.243731970884, 6676.365745254193, 6687.164104486939, 6717.496187785838, 6815.659217039029, 6590.670466476561, 6637.900431493435, 6650.567713098633, 6662.800115996528, 6665.400113989765, 6495.805125846232, 6557.753796962506, 6601.702923368556, 6619.238787539302, 6641.402273795382, 5518.668879867221, 5524.254225679482, 5564.329122021533, 5575.860603484945, 5580.86047848807, 6538.1827271591055, 6671.299513551201, 6724.697388617426, 6856.382925536725, 6880.65596720172, 6478.416942475012, 6631.767888124085, 6640.701168447335, 6668.566543174678, 6689.933100668931, 6584.901226481511, 6644.7009884554345, 6654.500912431684, 6669.533132680665, 6694.83262918431, 6350.555461117678, 6540.967295163494, 6550.967245163743, 6585.967070164618, 6593.80218593443, 6452.903206452001, 6485.573173901923, 6566.606003639797, 6578.625214232482, 6649.301823308483, 6290.748370065146, 6385.45723613498, 6433.453156481564, 6473.158489396348, 6476.287608363171], "value": 5240.4384570178645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.5590916360147, 938.1416004356018, 939.1031564855564, 940.9670661526848, 956.3018996132823, 19016.0, 19336.516587085312, 19801.108950097245, 19802.10890509927, 19819.900900495497, 17896.64206715865, 17918.10409479527, 17974.460766177002, 18008.909955450203, 18029.0, 959.5202398800582, 971.946542940138, 974.9512524373788, 975.0736800039955, 975.2149519636689, 958.4441024205944, 990.8365119755232, 998.5506522065064, 998.5706146357063, 998.8851282102579, 1004.3371374892572, 1051.2010871737496, 1051.279873286801, 1051.7160366700987, 1063.5852017713098, 1024.4109636958742, 1034.5396298647142, 1035.0580971316142, 1035.3632516002679, 1036.4765793274348, 748.3788455581908, 748.5733132114697, 748.6780684305746, 750.2684882239827, 753.581762122022, 18922.90538547312, 18932.10191210143, 19183.808161918343, 19187.040647967686, 19190.52023699405, 21415.250466233763, 21739.891300543397, 21808.781912180835, 21818.127274908984, 21831.45421364463, 14876.0, 15076.472323468626, 15163.317650705634, 15214.087154770748, 15221.0, 3765.3787125124322, 3804.695624350073, 3808.0, 3810.7141964352786, 3815.8473661053804, 141603.0, 141862.58137418597, 142167.0, 143125.2843735785, 144743.0, 16625.08562029076, 17064.146792660566, 17204.1397930103, 17265.050422226646, 17281.481555553353, 31352.37295254082, 31787.84106079501, 31940.0, 32032.0, 32115.197120072185, 8031.317338026216, 8276.420650554524, 8385.413021088587, 8386.245237928615, 8389.286910612665, 4231.9576804231565, 4337.652987760972, 4344.608985191285, 4348.239058164809, 4350.825966961286, 5224.085784987612, 5327.147656374961, 5327.573794096463, 5352.090144675414, 5355.812546560929, 892.7455675132557, 902.6208992223281, 907.7049958763429, 909.9636014559476, 910.4719262827545, 689.648279377511, 708.674009955416, 715.3311653603897, 724.2504008351436, 732.5018987088831, 10925.672229833117, 12019.399030048637, 12023.27860328383, 12352.62942111738, 12416.81374779379, 666.8032930285577, 671.771597656799, 675.7128220506265, 678.2132726037772, 684.6302996381997, 5390.100671140945, 5394.811181608703, 5457.0, 5468.808591699351, 5585.106382978704, 117300.41349793196, 123137.38431307786, 123354.38322808329, 123579.0, 123999.0, 90169.09830901607, 95409.5229523848, 108000.45999770108, 108300.0, 114299.42850285696, 94342.0, 97044.51477742707, 98344.50827745958, 99297.0, 99493.0, 11423.771524569296, 11504.53981840717, 11683.766324673628, 12041.217320874115, 12179.269243845398, 41046.0, 42502.57497424986, 42857.78571107124, 43518.347224792284, 45021.32468013048, 51393.0, 53126.0, 54928.72535637296, 55489.0, 58768.70615646894, 18578.0, 18830.24679012879, 18835.152418140944, 18957.90521047441, 19024.334148304744, 16561.17194140312, 16949.406770762966, 16954.830451695325, 17018.744718829475, 20417.0, 15958.840411595735, 16039.8396016043, 17941.73087403664, 18687.813121868607, 18917.621647566695, 17209.397671081453, 17515.386961456286, 18261.0, 18382.0, 18608.44174674762, 16811.41160059392, 17171.0, 17184.054876981885, 17449.38927137544, 18071.909640451715, 11500.597479088192, 11763.411829408666, 11767.588134415255, 12181.147319687538, 12303.93848030754, 11763.117766167401, 11797.469113889723, 12702.936485317514, 13239.13945593572, 13407.86592134066], "value": 9015.853834142345, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1414.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 107.0, 107.0, 109.0, 109.0, 109.0, 106.0, 107.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 115.0, 115.0, 118.0, 115.0, 138.0, 125.0, 116.0, 116.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 164.0, 166.0, 167.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 74.0, 73.0, 73.0, 73.0, 75.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 78.0, 80.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 110.0, 114.0, 114.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 54.0, 52.0, 54.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 41.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 75.0, 82.0, 73.0, 73.0, 74.0, 73.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 112.0, 115.0, 118.0, 119.0, 115.0, 111.0, 113.0, 125.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 164.0, 163.0, 169.0, 169.0, 174.0, 172.0, 164.0, 172.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 66.0, 67.0, 64.0, 66.0, 68.0, 65.0, 65.0], "value": 65.5, "unit": "score"}]}]} 11:34:02 INFO - Return code: 0 11:34:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:34:02 INFO - # TBPL SUCCESS # 11:34:02 INFO - Running post-action listener: _package_coverage_data 11:34:02 INFO - Running post-action listener: _resource_record_post_action 11:34:02 INFO - [mozharness: 2017-09-13 18:34:02.766522Z] Finished run-tests step (success) 11:34:02 INFO - Running post-run listener: _resource_record_post_run 11:34:02 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 336531456; Read time: 20; Write time: 323824 11:34:02 INFO - TinderboxPrint: CPU usage
13.1% 11:34:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 11:34:02 INFO - TinderboxPrint: I/O write bytes / time
336,531,456 / 323,824 11:34:02 INFO - TinderboxPrint: CPU idle
8,236.3 (86.9%) 11:34:02 INFO - TinderboxPrint: CPU user
1,192.7 (12.6%) 11:34:02 INFO - TinderboxPrint: Swap in / out
0 / 0 11:34:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 3969024; Read time: 0; Write time: 236 11:34:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:34:02 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331567104; Read time: 12; Write time: 323576 11:34:03 INFO - Running post-run listener: _upload_blobber_files 11:34:03 INFO - Blob upload gear active. 11:34:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:03 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 11:34:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:34:03 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:04 INFO - (blobuploader) - INFO - Done attempting. 11:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:05 INFO - (blobuploader) - INFO - Done attempting. 11:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:13 INFO - (blobuploader) - INFO - Done attempting. 11:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:14 INFO - (blobuploader) - INFO - Done attempting. 11:34:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:14 INFO - Return code: 0 11:34:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86e476c6958f4b25015472f5d8d8428448816e01779729a324910abdd6715321b7496ccbca7ca4333184fa16c3be29b382e7b7d4e528d12321ae34acbefd12c4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ccef5037092afc4903829e8fb1f9b66c0b546fcea17f8537317fd3093b789c617c6e38ca34c98de24f40b396e61549b2e54e173729d575400bd4ec3faa93470", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a27fb63c31f96ff7bec15698d3d40076476a9518521a1941d7702ce74fbbc296bb7d59c2c833163cd6cd240d7aa7e95e50814a4d3a9942ac71c1b76ee1a389e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74ea9aeb04a842974d1b87115a88bb556ae71d1ed72f3883f71f616003eeedc4cc9e290b39bbe5bd998568d98559322885d68cc08207ec4170a3d5b4a1189c3b"} 11:34:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:14 INFO - Contents: 11:34:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86e476c6958f4b25015472f5d8d8428448816e01779729a324910abdd6715321b7496ccbca7ca4333184fa16c3be29b382e7b7d4e528d12321ae34acbefd12c4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ccef5037092afc4903829e8fb1f9b66c0b546fcea17f8537317fd3093b789c617c6e38ca34c98de24f40b396e61549b2e54e173729d575400bd4ec3faa93470", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a27fb63c31f96ff7bec15698d3d40076476a9518521a1941d7702ce74fbbc296bb7d59c2c833163cd6cd240d7aa7e95e50814a4d3a9942ac71c1b76ee1a389e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74ea9aeb04a842974d1b87115a88bb556ae71d1ed72f3883f71f616003eeedc4cc9e290b39bbe5bd998568d98559322885d68cc08207ec4170a3d5b4a1189c3b"} 11:34:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:14 INFO - Copying logs to upload dir... 11:34:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.453522 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 11:34:14.350119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 11:34:14.354367) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86e476c6958f4b25015472f5d8d8428448816e01779729a324910abdd6715321b7496ccbca7ca4333184fa16c3be29b382e7b7d4e528d12321ae34acbefd12c4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ccef5037092afc4903829e8fb1f9b66c0b546fcea17f8537317fd3093b789c617c6e38ca34c98de24f40b396e61549b2e54e173729d575400bd4ec3faa93470", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a27fb63c31f96ff7bec15698d3d40076476a9518521a1941d7702ce74fbbc296bb7d59c2c833163cd6cd240d7aa7e95e50814a4d3a9942ac71c1b76ee1a389e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74ea9aeb04a842974d1b87115a88bb556ae71d1ed72f3883f71f616003eeedc4cc9e290b39bbe5bd998568d98559322885d68cc08207ec4170a3d5b4a1189c3b"} build_url:https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/IX5hDky-TNygwR2FWbgpvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86e476c6958f4b25015472f5d8d8428448816e01779729a324910abdd6715321b7496ccbca7ca4333184fa16c3be29b382e7b7d4e528d12321ae34acbefd12c4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ccef5037092afc4903829e8fb1f9b66c0b546fcea17f8537317fd3093b789c617c6e38ca34c98de24f40b396e61549b2e54e173729d575400bd4ec3faa93470", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0a27fb63c31f96ff7bec15698d3d40076476a9518521a1941d7702ce74fbbc296bb7d59c2c833163cd6cd240d7aa7e95e50814a4d3a9942ac71c1b76ee1a389e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/74ea9aeb04a842974d1b87115a88bb556ae71d1ed72f3883f71f616003eeedc4cc9e290b39bbe5bd998568d98559322885d68cc08207ec4170a3d5b4a1189c3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 11:34:14.385093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:34:14.385402) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1505326412.121658-1246022062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 11:34:14.467615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 11:34:14.467917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 11:34:14.471211) ========= ========= Total master_lag: 0.17 =========