builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-022 starttime: 1505623230.46 results: success (0) revision: c079f3f1d24a9797205ba210e7f6a5d21d8c609b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.459267) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.459779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.460057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.481926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.482259) ========= 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=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 21:40:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-09-16 21:40:30 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.636413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.636828) ========= 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=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016284 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:30.688483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:40:30.688880) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c079f3f1d24a9797205ba210e7f6a5d21d8c609b --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 c079f3f1d24a9797205ba210e7f6a5d21d8c609b --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=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 21:40:30,740 truncating revision to first 12 chars 2017-09-16 21:40:30,740 Setting DEBUG logging. 2017-09-16 21:40:30,740 attempt 1/10 2017-09-16 21:40:30,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c079f3f1d24a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 21:40:31,521 unpacking tar archive at: mozilla-central-c079f3f1d24a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:40:31.850004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:31.850328) ========= script_repo_revision: c079f3f1d24a9797205ba210e7f6a5d21d8c609b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:31.850710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:31.850979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:40:31.864676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-16 21:40:31.865071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:40:32 INFO - MultiFileLogger online at 20170916 21:40:32 in /builds/slave/test 21:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:32 INFO - {'append_to_log': False, 21:40:32 INFO - 'base_work_dir': '/builds/slave/test', 21:40:32 INFO - 'blob_upload_branch': 'Firefox', 21:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:32 INFO - 'branch': 'Firefox', 21:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:32 INFO - 'code_coverage': False, 21:40:32 INFO - 'config_files': ('talos/linux_config.py',), 21:40:32 INFO - 'default_actions': ('clobber', 21:40:32 INFO - 'read-buildbot-config', 21:40:32 INFO - 'download-and-extract', 21:40:32 INFO - 'populate-webroot', 21:40:32 INFO - 'create-virtualenv', 21:40:32 INFO - 'install', 21:40:32 INFO - 'setup-mitmproxy', 21:40:32 INFO - 'run-tests'), 21:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:32 INFO - 'disable_ccov_upload': False, 21:40:32 INFO - 'disable_stylo': False, 21:40:32 INFO - 'download_minidump_stackwalk': True, 21:40:32 INFO - 'download_symbols': 'ondemand', 21:40:32 INFO - 'enable_stylo': False, 21:40:32 INFO - 'enable_webrender': False, 21:40:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:32 INFO - 'gecko_profile': False, 21:40:32 INFO - 'gecko_profile_interval': 0, 21:40:32 INFO - 'installer_path': 'installer.exe', 21:40:32 INFO - 'log_level': 'info', 21:40:32 INFO - 'log_name': 'talos', 21:40:32 INFO - 'log_to_console': True, 21:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:40:32 INFO - 'opt_config_files': (), 21:40:32 INFO - 'pip_index': False, 21:40:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 21:40:32 INFO - 'system_bits': '32', 21:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:32 INFO - 'title': 'talos-linux64-ix-022', 21:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:32 INFO - 'use_talos_json': True, 21:40:32 INFO - 'verify': 'False', 21:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:32 INFO - 'work_dir': 'build'} 21:40:32 INFO - [mozharness: 2017-09-17 04:40:32.065410Z] Running clobber step. 21:40:32 INFO - Running pre-action listener: _resource_record_pre_action 21:40:32 INFO - Running main action method: clobber 21:40:32 INFO - rmtree: /builds/slave/test/build 21:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:33 INFO - Running post-action listener: _resource_record_post_action 21:40:33 INFO - [mozharness: 2017-09-17 04:40:33.586758Z] Finished clobber step (success) 21:40:33 INFO - [mozharness: 2017-09-17 04:40:33.587430Z] Running read-buildbot-config step. 21:40:33 INFO - Running pre-action listener: _resource_record_pre_action 21:40:33 INFO - Running main action method: read_buildbot_config 21:40:33 INFO - Using buildbot properties: 21:40:33 INFO - { 21:40:33 INFO - "project": "", 21:40:33 INFO - "product": "firefox", 21:40:33 INFO - "who": "ryanvm@gmail.com", 21:40:33 INFO - "installer_path": "public/build/target.tar.bz2", 21:40:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 21:40:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:40:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 21:40:33 INFO - "stage_platform": "linux64-pgo", 21:40:33 INFO - "basedir": "/builds/slave/test", 21:40:33 INFO - "buildnumber": 26, 21:40:33 INFO - "platform": "ubuntu64_hw", 21:40:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:40:33 INFO - "slavebuilddir": "test", 21:40:33 INFO - "taskId": "ROgl21cyRfGnosOtr8IU-g", 21:40:33 INFO - "branch": "mozilla-central", 21:40:33 INFO - "script_repo_revision": "production", 21:40:33 INFO - "revision": "c079f3f1d24a9797205ba210e7f6a5d21d8c609b", 21:40:33 INFO - "slavename": "talos-linux64-ix-022", 21:40:33 INFO - "repo_path": "mozilla-central" 21:40:33 INFO - } 21:40:33 INFO - Finding installer, test and symbols from parent task. 21:40:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROgl21cyRfGnosOtr8IU-g'}, attempt #1 21:40:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROgl21cyRfGnosOtr8IU-g'}, attempt #1 21:40:34 INFO - Task dependencies: GPt6YtBqSMKXuR3LJzkq-A 21:40:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A'}, attempt #1 21:40:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 21:40:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.test_packages.json 21:40:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.crashreporter-symbols.zip 21:40:34 INFO - Running post-action listener: _resource_record_post_action 21:40:34 INFO - [mozharness: 2017-09-17 04:40:34.967181Z] Finished read-buildbot-config step (success) 21:40:34 INFO - [mozharness: 2017-09-17 04:40:34.967398Z] Running download-and-extract step. 21:40:34 INFO - Running pre-action listener: _resource_record_pre_action 21:40:34 INFO - Running main action method: download_and_extract 21:40:34 INFO - mkdir: /builds/slave/test/build/tests 21:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:34 INFO - trying https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.test_packages.json 21:40:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:40:35 INFO - Downloaded 989 bytes. 21:40:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:40:35 INFO - Using the following test package requirements: 21:40:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:40:35 INFO - u'common': [u'target.common.tests.zip'], 21:40:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:40:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:40:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:40:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:40:35 INFO - u'mozbase': [u'target.common.tests.zip'], 21:40:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:40:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:40:35 INFO - u'web-platform': [u'target.common.tests.zip', 21:40:35 INFO - u'target.web-platform.tests.tar.gz'], 21:40:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:40:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.common.tests.zip 21:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.common.tests.zip into memory 21:40:36 INFO - Content-Length response header: 55329941 21:40:36 INFO - Bytes received: 55329941 21:40:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.talos.tests.zip 21:40:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:40:47 INFO - Fetch https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.talos.tests.zip into memory 21:40:48 INFO - Content-Length response header: 14508748 21:40:48 INFO - Bytes received: 14508748 21:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:48 INFO - trying https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 21:40:48 INFO - Downloading https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:40:49 INFO - Downloaded 62262779 bytes. 21:40:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 21:40:49 INFO - mkdir: /builds/slave/test/properties 21:40:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:49 INFO - Contents: 21:40:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 21:40:49 INFO - Running post-action listener: _resource_record_post_action 21:40:49 INFO - Running post-action listener: find_tests_for_verification 21:40:49 INFO - Running post-action listener: set_extra_try_arguments 21:40:49 INFO - [mozharness: 2017-09-17 04:40:49.943751Z] Finished download-and-extract step (success) 21:40:49 INFO - [mozharness: 2017-09-17 04:40:49.943982Z] Running populate-webroot step. 21:40:49 INFO - Running pre-action listener: _resource_record_pre_action 21:40:49 INFO - Running main action method: populate_webroot 21:40:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:40:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['tresize', 21:40:49 INFO - 'tcanvasmark']}, 21:40:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:40:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['dromaeo_css', 21:40:49 INFO - 'kraken']}, 21:40:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'tests': ['damp', 'tps']}, 21:40:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['damp', 'tps']}, 21:40:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['dromaeo_dom']}, 21:40:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:40:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['basic_compositor_video', 21:40:49 INFO - 'glvideo']}, 21:40:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:40:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['ts_paint_webext', 21:40:49 INFO - 'tp5o_webext']}, 21:40:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:40:49 INFO - 'ts_paint', 21:40:49 INFO - 'tpaint', 21:40:49 INFO - 'sessionrestore', 21:40:49 INFO - 'sessionrestore_many_windows', 21:40:49 INFO - 'sessionrestore_no_auto_restore', 21:40:49 INFO - 'tabpaint']}, 21:40:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['a11yr', 21:40:49 INFO - 'ts_paint', 21:40:49 INFO - 'tpaint', 21:40:49 INFO - 'sessionrestore', 21:40:49 INFO - 'sessionrestore_many_windows', 21:40:49 INFO - 'sessionrestore_no_auto_restore', 21:40:49 INFO - 'tabpaint']}, 21:40:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:40:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:40:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['perf_reftest_singletons']}, 21:40:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['bloom_basic']}, 21:40:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:40:49 INFO - 'tsvgr_opacity', 21:40:49 INFO - 'tart', 21:40:49 INFO - 'tscrollx', 21:40:49 INFO - 'tsvg_static']}, 21:40:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['tsvgx', 21:40:49 INFO - 'tsvgr_opacity', 21:40:49 INFO - 'tart', 21:40:49 INFO - 'tscrollx', 21:40:49 INFO - 'tsvg_static']}, 21:40:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:40:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo'], 21:40:49 INFO - 'tests': ['tp5o']}, 21:40:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:40:49 INFO - 'talos_options': ['--mitmproxy', 21:40:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:40:49 INFO - '--firstNonBlankPaint'], 21:40:49 INFO - 'tests': ['tp6_google', 21:40:49 INFO - 'tp6_youtube', 21:40:49 INFO - 'tp6_amazon', 21:40:49 INFO - 'tp6_facebook']}, 21:40:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo', 21:40:49 INFO - '--mitmproxy', 21:40:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:40:49 INFO - '--firstNonBlankPaint'], 21:40:49 INFO - 'tests': ['tp6_google', 21:40:49 INFO - 'tp6_youtube', 21:40:49 INFO - 'tp6_amazon', 21:40:49 INFO - 'tp6_facebook']}, 21:40:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:40:49 INFO - 'talos_options': ['--stylo-threads=1', 21:40:49 INFO - '--mitmproxy', 21:40:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:40:49 INFO - '--firstNonBlankPaint'], 21:40:49 INFO - 'tests': ['tp6_google', 21:40:49 INFO - 'tp6_youtube', 21:40:49 INFO - 'tp6_amazon', 21:40:49 INFO - 'tp6_facebook']}, 21:40:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--xperf_path', 21:40:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:49 INFO - 'tests': ['tp5n']}, 21:40:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:40:49 INFO - 'talos_options': ['--disable-stylo', 21:40:49 INFO - '--xperf_path', 21:40:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:49 INFO - 'tests': ['tp5n']}}} 21:40:49 INFO - Running post-action listener: _resource_record_post_action 21:40:49 INFO - [mozharness: 2017-09-17 04:40:49.965118Z] Finished populate-webroot step (success) 21:40:49 INFO - [mozharness: 2017-09-17 04:40:49.965210Z] Running create-virtualenv step. 21:40:49 INFO - Running pre-action listener: _resource_record_pre_action 21:40:49 INFO - Running main action method: create_virtualenv 21:40:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:40:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:40:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:40:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:50 INFO - Installing pip...............done. 21:40:50 INFO - Return code: 0 21:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:40:51 INFO - Reading from file tmpfile_stdout 21:40:51 INFO - Output received: 21:40:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:40:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:51 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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:40:51 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 21:40:51 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 21:40:51 INFO - Using env: {'DISPLAY': ':0', 21:40:51 INFO - 'HOME': '/home/cltbld', 21:40:51 INFO - 'LANG': 'en_US.UTF-8', 21:40:51 INFO - 'LANGUAGE': 'en_US:en', 21:40:51 INFO - 'LOGNAME': 'cltbld', 21:40:51 INFO - 'MAIL': '/var/mail/cltbld', 21:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:51 INFO - 'MOZ_NO_REMOTE': '1', 21:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:51 INFO - 'NO_EM_RESTART': '1', 21:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:51 INFO - 'PWD': '/builds/slave/test', 21:40:51 INFO - 'SHELL': '/bin/bash', 21:40:51 INFO - 'SHLVL': '1', 21:40:51 INFO - 'TERM': 'linux', 21:40:51 INFO - 'TMOUT': '86400', 21:40:51 INFO - 'USER': 'cltbld', 21:40:51 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:51 INFO - '_': '/tools/buildbot/bin/python'} 21:40:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:40:52 INFO - Downloading/unpacking pip>=1.5 21:40:52 INFO - Running setup.py egg_info for package pip 21:40:52 INFO - warning: no files found matching 'pip/cacert.pem' 21:40:52 INFO - warning: no files found matching '*.html' under directory 'docs' 21:40:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:40:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:40:52 INFO - Installing collected packages: pip 21:40:52 INFO - Found existing installation: pip 1.1 21:40:52 INFO - Uninstalling pip: 21:40:52 INFO - Successfully uninstalled pip 21:40:52 INFO - Running setup.py install for pip 21:40:52 INFO - warning: no files found matching 'pip/cacert.pem' 21:40:52 INFO - warning: no files found matching '*.html' under directory 'docs' 21:40:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:40:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:40:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:40:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:40:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:40:52 INFO - Successfully installed pip 21:40:52 INFO - Cleaning up... 21:40:52 INFO - Return code: 0 21:40:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:40:52 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')]} 21:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:52 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')]} 21:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:40:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:40:52 INFO - Using env: {'DISPLAY': ':0', 21:40:52 INFO - 'HOME': '/home/cltbld', 21:40:52 INFO - 'LANG': 'en_US.UTF-8', 21:40:52 INFO - 'LANGUAGE': 'en_US:en', 21:40:52 INFO - 'LOGNAME': 'cltbld', 21:40:52 INFO - 'MAIL': '/var/mail/cltbld', 21:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:52 INFO - 'MOZ_NO_REMOTE': '1', 21:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:52 INFO - 'NO_EM_RESTART': '1', 21:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:52 INFO - 'PWD': '/builds/slave/test', 21:40:52 INFO - 'SHELL': '/bin/bash', 21:40:52 INFO - 'SHLVL': '1', 21:40:52 INFO - 'TERM': 'linux', 21:40:52 INFO - 'TMOUT': '86400', 21:40:52 INFO - 'USER': 'cltbld', 21:40:52 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:52 INFO - '_': '/tools/buildbot/bin/python'} 21:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:52 INFO - Downloading/unpacking psutil>=3.1.1 21:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:53 INFO - Installing collected packages: psutil 21:40:53 INFO - Running setup.py install for psutil 21:40:53 INFO - building 'psutil._psutil_linux' extension 21:40:53 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 21:40:53 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 21:40:53 INFO - building 'psutil._psutil_posix' extension 21:40:53 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 21:40:54 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 21:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:54 INFO - Successfully installed psutil 21:40:54 INFO - Cleaning up... 21:40:54 INFO - Return code: 0 21:40:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:40:54 INFO - Using env: {'DISPLAY': ':0', 21:40:54 INFO - 'HOME': '/home/cltbld', 21:40:54 INFO - 'LANG': 'en_US.UTF-8', 21:40:54 INFO - 'LANGUAGE': 'en_US:en', 21:40:54 INFO - 'LOGNAME': 'cltbld', 21:40:54 INFO - 'MAIL': '/var/mail/cltbld', 21:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:54 INFO - 'MOZ_NO_REMOTE': '1', 21:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:54 INFO - 'NO_EM_RESTART': '1', 21:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:54 INFO - 'PWD': '/builds/slave/test', 21:40:54 INFO - 'SHELL': '/bin/bash', 21:40:54 INFO - 'SHLVL': '1', 21:40:54 INFO - 'TERM': 'linux', 21:40:54 INFO - 'TMOUT': '86400', 21:40:54 INFO - 'USER': 'cltbld', 21:40:54 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:54 INFO - '_': '/tools/buildbot/bin/python'} 21:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:56 INFO - Installing collected packages: mozsystemmonitor 21:40:56 INFO - Running setup.py install for mozsystemmonitor 21:40:57 INFO - Successfully installed mozsystemmonitor 21:40:57 INFO - Cleaning up... 21:40:58 INFO - Return code: 0 21:40:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40: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')]} 21:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40: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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:40: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 21:40: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 21:40:58 INFO - Using env: {'DISPLAY': ':0', 21:40:58 INFO - 'HOME': '/home/cltbld', 21:40:58 INFO - 'LANG': 'en_US.UTF-8', 21:40:58 INFO - 'LANGUAGE': 'en_US:en', 21:40:58 INFO - 'LOGNAME': 'cltbld', 21:40:58 INFO - 'MAIL': '/var/mail/cltbld', 21:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:58 INFO - 'MOZ_NO_REMOTE': '1', 21:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:58 INFO - 'NO_EM_RESTART': '1', 21:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:58 INFO - 'PWD': '/builds/slave/test', 21:40:58 INFO - 'SHELL': '/bin/bash', 21:40:58 INFO - 'SHLVL': '1', 21:40:58 INFO - 'TERM': 'linux', 21:40:58 INFO - 'TMOUT': '86400', 21:40:58 INFO - 'USER': 'cltbld', 21:40:58 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:58 INFO - '_': '/tools/buildbot/bin/python'} 21:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:58 INFO - Downloading/unpacking jsonschema==2.5.1 21:40: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 21:40: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 21:40: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 21:40: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 21:40:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:59 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:59 INFO - warning: no files found matching '*.txt' 21:40:59 INFO - no previously-included directories found matching 'build' 21:40:59 INFO - no previously-included directories found matching 'dist' 21:40:59 INFO - no previously-included directories found matching '.git*' 21:40:59 INFO - Installing collected packages: jsonschema, functools32 21:40:59 INFO - Running setup.py install for functools32 21:40:59 INFO - warning: no files found matching '*.txt' 21:40:59 INFO - no previously-included directories found matching 'build' 21:40:59 INFO - no previously-included directories found matching 'dist' 21:40:59 INFO - no previously-included directories found matching '.git*' 21:40:59 INFO - Successfully installed jsonschema functools32 21:40:59 INFO - Cleaning up... 21:40:59 INFO - Return code: 0 21:40:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:40:59 INFO - Using env: {'DISPLAY': ':0', 21:40:59 INFO - 'HOME': '/home/cltbld', 21:40:59 INFO - 'LANG': 'en_US.UTF-8', 21:40:59 INFO - 'LANGUAGE': 'en_US:en', 21:40:59 INFO - 'LOGNAME': 'cltbld', 21:40:59 INFO - 'MAIL': '/var/mail/cltbld', 21:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:59 INFO - 'MOZ_NO_REMOTE': '1', 21:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:59 INFO - 'NO_EM_RESTART': '1', 21:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:59 INFO - 'PWD': '/builds/slave/test', 21:40:59 INFO - 'SHELL': '/bin/bash', 21:40:59 INFO - 'SHLVL': '1', 21:40:59 INFO - 'TERM': 'linux', 21:40:59 INFO - 'TMOUT': '86400', 21:40:59 INFO - 'USER': 'cltbld', 21:40:59 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:59 INFO - '_': '/tools/buildbot/bin/python'} 21:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:41:00 INFO - Cleaning up... 21:41:00 INFO - Return code: 0 21:41:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41: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')]} 21:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41: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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:41: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 21:41: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 21:41:00 INFO - Using env: {'DISPLAY': ':0', 21:41:00 INFO - 'HOME': '/home/cltbld', 21:41:00 INFO - 'LANG': 'en_US.UTF-8', 21:41:00 INFO - 'LANGUAGE': 'en_US:en', 21:41:00 INFO - 'LOGNAME': 'cltbld', 21:41:00 INFO - 'MAIL': '/var/mail/cltbld', 21:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:00 INFO - 'MOZ_NO_REMOTE': '1', 21:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:00 INFO - 'NO_EM_RESTART': '1', 21:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:00 INFO - 'PWD': '/builds/slave/test', 21:41:00 INFO - 'SHELL': '/bin/bash', 21:41:00 INFO - 'SHLVL': '1', 21:41:00 INFO - 'TERM': 'linux', 21:41:00 INFO - 'TMOUT': '86400', 21:41:00 INFO - 'USER': 'cltbld', 21:41:00 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:00 INFO - '_': '/tools/buildbot/bin/python'} 21:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:00 INFO - Downloading/unpacking blobuploader==1.2.4 21:41: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 21:41: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 21:41: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 21:41: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 21:41:01 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:01 INFO - Downloading docopt-0.6.1.tar.gz 21:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:02 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:02 INFO - Running setup.py install for blobuploader 21:41:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:02 INFO - Running setup.py install for requests 21:41:02 INFO - Running setup.py install for docopt 21:41:02 INFO - Successfully installed blobuploader requests docopt 21:41:02 INFO - Cleaning up... 21:41:02 INFO - Return code: 0 21:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:02 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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:41:02 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 21:41:02 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 21:41:02 INFO - Using env: {'DISPLAY': ':0', 21:41:02 INFO - 'HOME': '/home/cltbld', 21:41:02 INFO - 'LANG': 'en_US.UTF-8', 21:41:02 INFO - 'LANGUAGE': 'en_US:en', 21:41:02 INFO - 'LOGNAME': 'cltbld', 21:41:02 INFO - 'MAIL': '/var/mail/cltbld', 21:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:02 INFO - 'MOZ_NO_REMOTE': '1', 21:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:02 INFO - 'NO_EM_RESTART': '1', 21:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:02 INFO - 'PWD': '/builds/slave/test', 21:41:02 INFO - 'SHELL': '/bin/bash', 21:41:02 INFO - 'SHLVL': '1', 21:41:02 INFO - 'TERM': 'linux', 21:41:02 INFO - 'TMOUT': '86400', 21:41:02 INFO - 'USER': 'cltbld', 21:41:02 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:02 INFO - '_': '/tools/buildbot/bin/python'} 21:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:02 INFO - Running setup.py (path:/tmp/pip-sShUNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:02 INFO - Running setup.py (path:/tmp/pip-iJiVHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:03 INFO - Running setup.py (path:/tmp/pip-k7VIiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:03 INFO - Running setup.py (path:/tmp/pip-oXx1Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:03 INFO - Running setup.py (path:/tmp/pip-bOvO58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:03 INFO - Running setup.py (path:/tmp/pip-D3DlzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:03 INFO - Running setup.py (path:/tmp/pip-XcOvwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:03 INFO - Running setup.py (path:/tmp/pip-mJf5Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:03 INFO - Running setup.py (path:/tmp/pip-mVnMcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:03 INFO - Running setup.py (path:/tmp/pip-9jarqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:03 INFO - Running setup.py (path:/tmp/pip-fU4r18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:03 INFO - Running setup.py (path:/tmp/pip-0IKSTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:03 INFO - Running setup.py (path:/tmp/pip-JrSyl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:03 INFO - Running setup.py (path:/tmp/pip-x6aOBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:03 INFO - Running setup.py (path:/tmp/pip-5WyqR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:03 INFO - Running setup.py (path:/tmp/pip-1NnESm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:04 INFO - Running setup.py (path:/tmp/pip-dFlKDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:04 INFO - Running setup.py install for manifestparser 21:41:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozcrash 21:41:04 INFO - Running setup.py install for mozdebug 21:41:04 INFO - Running setup.py install for mozdevice 21:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozfile 21:41:04 INFO - Running setup.py install for mozhttpd 21:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozinfo 21:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozInstall 21:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:04 INFO - Running setup.py install for mozleak 21:41:04 INFO - Running setup.py install for mozlog 21:41:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for moznetwork 21:41:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozprocess 21:41:05 INFO - Running setup.py install for mozprofile 21:41:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozrunner 21:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Running setup.py install for mozscreenshot 21:41:05 INFO - Running setup.py install for moztest 21:41:05 INFO - Running setup.py install for mozversion 21:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:05 INFO - Cleaning up... 21:41:05 INFO - Return code: 0 21:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:05 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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:41:05 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 21:41:05 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 21:41:05 INFO - Using env: {'DISPLAY': ':0', 21:41:05 INFO - 'HOME': '/home/cltbld', 21:41:05 INFO - 'LANG': 'en_US.UTF-8', 21:41:05 INFO - 'LANGUAGE': 'en_US:en', 21:41:05 INFO - 'LOGNAME': 'cltbld', 21:41:05 INFO - 'MAIL': '/var/mail/cltbld', 21:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:05 INFO - 'MOZ_NO_REMOTE': '1', 21:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:05 INFO - 'NO_EM_RESTART': '1', 21:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:05 INFO - 'PWD': '/builds/slave/test', 21:41:05 INFO - 'SHELL': '/bin/bash', 21:41:05 INFO - 'SHLVL': '1', 21:41:05 INFO - 'TERM': 'linux', 21:41:05 INFO - 'TMOUT': '86400', 21:41:05 INFO - 'USER': 'cltbld', 21:41:05 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:05 INFO - '_': '/tools/buildbot/bin/python'} 21:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:06 INFO - Running setup.py (path:/tmp/pip-2xplZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:06 INFO - Running setup.py (path:/tmp/pip-GYUmAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:06 INFO - Running setup.py (path:/tmp/pip-sLazok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:06 INFO - Running setup.py (path:/tmp/pip-kEWAzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:06 INFO - Running setup.py (path:/tmp/pip-XjDYY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:06 INFO - Running setup.py (path:/tmp/pip-_UP5hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:06 INFO - Running setup.py (path:/tmp/pip-Jp7Way-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:06 INFO - Running setup.py (path:/tmp/pip-zFzl4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:06 INFO - Running setup.py (path:/tmp/pip-dbzwaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:06 INFO - Running setup.py (path:/tmp/pip-BJdWtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:06 INFO - Running setup.py (path:/tmp/pip-3nqO1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:06 INFO - Running setup.py (path:/tmp/pip-gcROQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:06 INFO - Running setup.py (path:/tmp/pip-0vyQKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:06 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)) 21:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:07 INFO - Running setup.py (path:/tmp/pip-kYbLSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:07 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)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:07 INFO - Running setup.py (path:/tmp/pip-OuDlGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:07 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)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:07 INFO - Running setup.py (path:/tmp/pip-NHDqTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:07 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)) 21:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:07 INFO - Running setup.py (path:/tmp/pip-JDiw3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:07 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)) 21:41:07 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)) 21:41:07 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)) 21:41:07 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)) 21:41:07 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)) 21:41:07 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)) 21:41:07 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)) 21:41:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:07 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 21:41:07 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 21:41:07 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 21:41:07 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 21:41:08 INFO - Downloading blessings-1.6.tar.gz 21:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:08 INFO - Installing collected packages: blessings 21:41:08 INFO - Running setup.py install for blessings 21:41:08 INFO - Successfully installed blessings 21:41:08 INFO - Cleaning up... 21:41:08 INFO - Return code: 0 21:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:08 INFO - Reading from file tmpfile_stdout 21:41:08 INFO - Current package versions: 21:41:08 INFO - argparse == 1.2.1 21:41:08 INFO - blessings == 1.6 21:41:08 INFO - blobuploader == 1.2.4 21:41:08 INFO - docopt == 0.6.1 21:41:08 INFO - functools32 == 3.2.3-2 21:41:08 INFO - jsonschema == 2.5.1 21:41:08 INFO - manifestparser == 1.1 21:41:08 INFO - mozInstall == 1.13 21:41:08 INFO - mozcrash == 1.0 21:41:08 INFO - mozdebug == 0.1 21:41:08 INFO - mozdevice == 0.51 21:41:08 INFO - mozfile == 1.2 21:41:08 INFO - mozhttpd == 0.7 21:41:08 INFO - mozinfo == 0.10 21:41:08 INFO - mozleak == 0.1 21:41:08 INFO - mozlog == 3.5 21:41:08 INFO - moznetwork == 0.27 21:41:08 INFO - mozprocess == 0.25 21:41:08 INFO - mozprofile == 0.28 21:41:08 INFO - mozrunner == 6.13 21:41:08 INFO - mozscreenshot == 0.1 21:41:08 INFO - mozsystemmonitor == 0.3 21:41:08 INFO - moztest == 0.8 21:41:08 INFO - mozversion == 1.4 21:41:08 INFO - psutil == 3.1.1 21:41:08 INFO - requests == 1.2.3 21:41:08 INFO - wsgiref == 0.1.2 21:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:08 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')]} 21:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:08 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')]} 21:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:08 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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:41:08 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 21:41:08 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 21:41:08 INFO - Using env: {'DISPLAY': ':0', 21:41:08 INFO - 'HOME': '/home/cltbld', 21:41:08 INFO - 'LANG': 'en_US.UTF-8', 21:41:08 INFO - 'LANGUAGE': 'en_US:en', 21:41:08 INFO - 'LOGNAME': 'cltbld', 21:41:08 INFO - 'MAIL': '/var/mail/cltbld', 21:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:08 INFO - 'MOZ_NO_REMOTE': '1', 21:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:08 INFO - 'NO_EM_RESTART': '1', 21:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:08 INFO - 'PWD': '/builds/slave/test', 21:41:08 INFO - 'SHELL': '/bin/bash', 21:41:08 INFO - 'SHLVL': '1', 21:41:08 INFO - 'TERM': 'linux', 21:41:08 INFO - 'TMOUT': '86400', 21:41:08 INFO - 'USER': 'cltbld', 21:41:08 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:08 INFO - '_': '/tools/buildbot/bin/python'} 21:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 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)) 21:41:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:41: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 21:41: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 21:41: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 21:41: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 21:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:41:10 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)) 21:41:10 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)) 21:41:10 INFO - Installing collected packages: simplejson 21:41:10 INFO - Running setup.py install for simplejson 21:41:10 INFO - building 'simplejson._speedups' extension 21:41:10 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 21:41:11 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 21:41:11 INFO - Successfully installed simplejson 21:41:11 INFO - Cleaning up... 21:41:11 INFO - Return code: 0 21:41:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:11 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 0x10cf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1298a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, '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': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', '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 21:41:11 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 21:41:11 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 21:41:11 INFO - Using env: {'DISPLAY': ':0', 21:41:11 INFO - 'HOME': '/home/cltbld', 21:41:11 INFO - 'LANG': 'en_US.UTF-8', 21:41:11 INFO - 'LANGUAGE': 'en_US:en', 21:41:11 INFO - 'LOGNAME': 'cltbld', 21:41:11 INFO - 'MAIL': '/var/mail/cltbld', 21:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:11 INFO - 'MOZ_NO_REMOTE': '1', 21:41:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:11 INFO - 'NO_EM_RESTART': '1', 21:41:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:11 INFO - 'PWD': '/builds/slave/test', 21:41:11 INFO - 'SHELL': '/bin/bash', 21:41:11 INFO - 'SHLVL': '1', 21:41:11 INFO - 'TERM': 'linux', 21:41:11 INFO - 'TMOUT': '86400', 21:41:11 INFO - 'USER': 'cltbld', 21:41:11 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:11 INFO - '_': '/tools/buildbot/bin/python'} 21:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:41:11 INFO - Cleaning up... 21:41:11 INFO - Return code: 0 21:41:11 INFO - Running post-action listener: _resource_record_post_action 21:41:11 INFO - Running post-action listener: _start_resource_monitoring 21:41:11 INFO - Starting resource monitoring. 21:41:11 INFO - [mozharness: 2017-09-17 04:41:11.555013Z] Finished create-virtualenv step (success) 21:41:11 INFO - [mozharness: 2017-09-17 04:41:11.555532Z] Running install step. 21:41:11 INFO - Running pre-action listener: _resource_record_pre_action 21:41:11 INFO - Running main action method: install 21:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:11 INFO - Reading from file tmpfile_stdout 21:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:11 INFO - Reading from file tmpfile_stdout 21:41:11 INFO - Output received: 21:41:11 INFO - Usage: mozinstall [options] installer 21:41:11 INFO - Options: 21:41:11 INFO - -h, --help show this help message and exit 21:41:11 INFO - -d DEST, --destination=DEST 21:41:11 INFO - Directory to install application into. [default: 21:41:11 INFO - "/builds/slave/test"] 21:41:11 INFO - --app=APP Application being installed. [default: firefox] 21:41:11 INFO - mkdir: /builds/slave/test/build/application 21:41:11 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'] 21:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:41:29 INFO - Reading from file tmpfile_stdout 21:41:29 INFO - Output received: 21:41:29 INFO - /builds/slave/test/build/application/firefox/firefox 21:41:29 INFO - Running post-action listener: _resource_record_post_action 21:41:29 INFO - [mozharness: 2017-09-17 04:41:29.476918Z] Finished install step (success) 21:41:29 INFO - [mozharness: 2017-09-17 04:41:29.477257Z] Running setup-mitmproxy step. 21:41:29 INFO - Running pre-action listener: _resource_record_pre_action 21:41:29 INFO - Running main action method: setup_mitmproxy 21:41:29 INFO - Skipping: mitmproxy is not required 21:41:29 INFO - Running post-action listener: _resource_record_post_action 21:41:29 INFO - [mozharness: 2017-09-17 04:41:29.478957Z] Finished setup-mitmproxy step (success) 21:41:29 INFO - [mozharness: 2017-09-17 04:41:29.479278Z] Running run-tests step. 21:41:29 INFO - Running pre-action listener: _resource_record_pre_action 21:41:29 INFO - Running pre-action listener: _set_gcov_prefix 21:41:29 INFO - Running main action method: run_tests 21:41:29 WARNING - Try message not found. 21:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:29 INFO - Python 2.7.3 21:41:29 INFO - Return code: 0 21:41:29 INFO - grabbing minidump binary from tooltool 21:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:29 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 0x143f090>, '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 0x143fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:29 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 21:41:29 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 21:41:29 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 21:41:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:29 INFO - Return code: 0 21:41:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:41:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:29 INFO - ENV: RUST_BACKTRACE is now full 21:41:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:41:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 21:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 21:41:29 INFO - Using env: {'DISPLAY': ':0', 21:41:29 INFO - 'HOME': '/home/cltbld', 21:41:29 INFO - 'LANG': 'en_US.UTF-8', 21:41:29 INFO - 'LANGUAGE': 'en_US:en', 21:41:29 INFO - 'LOGNAME': 'cltbld', 21:41:29 INFO - 'MAIL': '/var/mail/cltbld', 21:41:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:29 INFO - 'MOZ_NO_REMOTE': '1', 21:41:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:29 INFO - 'NO_EM_RESTART': '1', 21:41:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:29 INFO - 'PWD': '/builds/slave/test', 21:41:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:29 INFO - 'RUST_BACKTRACE': 'full', 21:41:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:41:29 INFO - 'SHELL': '/bin/bash', 21:41:29 INFO - 'SHLVL': '1', 21:41:29 INFO - 'TERM': 'linux', 21:41:29 INFO - 'TMOUT': '86400', 21:41:29 INFO - 'USER': 'cltbld', 21:41:29 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:29 INFO - '_': '/tools/buildbot/bin/python'} 21:41:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 21:41:29 INFO - mozversion application_buildid: 20170917030923 21:41:29 INFO - mozversion application_changeset: c079f3f1d24a9797205ba210e7f6a5d21d8c609b 21:41:29 INFO - mozversion application_display_name: Nightly 21:41:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:29 INFO - mozversion application_name: Firefox 21:41:29 INFO - mozversion application_remotingname: firefox 21:41:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:41:29 INFO - mozversion application_vendor: Mozilla 21:41:29 INFO - mozversion application_version: 57.0a1 21:41:29 INFO - mozversion platform_buildid: 20170917030923 21:41:29 INFO - mozversion platform_changeset: c079f3f1d24a9797205ba210e7f6a5d21d8c609b 21:41:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:41:29 INFO - mozversion platform_version: 57.0a1 21:41:29 INFO - using testdate: 1505623289 21:41:29 INFO - actual date: 1505623289 21:41:29 INFO - starting webserver on 'localhost:47866' 21:41:29 INFO - SUITE-START | Running 2 tests 21:41:29 INFO - TEST-START | dromaeo_css 21:41:29 INFO - Initialising browser for dromaeo_css test... 21:41:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47866/getInfo.html -profile /tmp/tmpe1atEi/profile 21:41:29 INFO - TEST-INFO | started process 23516 (/builds/slave/test/build/application/firefox/firefox http://localhost:47866/getInfo.html) 21:41:35 INFO - TEST-INFO | 23516: exit 0 21:41:35 INFO - Browser initialized. 21:41:35 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:35 INFO - Using env: {'DISPLAY': ':0', 21:41:35 INFO - 'HOME': '/home/cltbld', 21:41:35 INFO - 'JSGC_DISABLE_POISONING': '1', 21:41:35 INFO - 'LANG': 'en_US.UTF-8', 21:41:35 INFO - 'LANGUAGE': 'en_US:en', 21:41:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:41:35 INFO - 'LOGNAME': 'cltbld', 21:41:35 INFO - 'MAIL': '/var/mail/cltbld', 21:41:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:41:35 INFO - 'MOZ_CRASHREPORTER': '1', 21:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:41:35 INFO - 'MOZ_NO_REMOTE': '1', 21:41:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:35 INFO - 'NO_EM_RESTART': '1', 21:41:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:35 INFO - 'PWD': '/builds/slave/test', 21:41:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:35 INFO - 'RUST_BACKTRACE': 'full', 21:41:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:41:35 INFO - 'SHELL': '/bin/bash', 21:41:35 INFO - 'SHLVL': '1', 21:41:35 INFO - 'STYLO_FORCE_DISABLED': '1', 21:41:35 INFO - 'TERM': 'linux', 21:41:35 INFO - 'TMOUT': '86400', 21:41:35 INFO - 'USER': 'cltbld', 21:41:35 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 21:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:35 INFO - '_': '/tools/buildbot/bin/python'} 21:41:35 INFO - TEST-INFO | started process 23750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe1atEi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:35 INFO - PID 23750 | 21:41:35 INFO - PID 23750 | (/builds/slave/test/build/application/firefox/firefox:23799): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:41:35 INFO - PID 23750 | 21:41:46 INFO - PID 23750 | RSS: Main: 148537344 21:41:46 INFO - PID 23750 | 21:44:43 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47866/tests/dromaeo/cssquery-ext.html) 21:44:44 INFO - PID 23750 | RSS: Main: 149000192 21:44:44 INFO - PID 23750 | 21:47:45 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-ext.html (next: http://localhost:47866/tests/dromaeo/cssquery-jquery.html) 21:47:46 INFO - PID 23750 | RSS: Main: 148451328 21:47:46 INFO - PID 23750 | 21:50:47 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47866/tests/dromaeo/cssquery-mootools.html) 21:50:48 INFO - PID 23750 | RSS: Main: 151547904 21:50:48 INFO - PID 23750 | 21:53:50 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47866/tests/dromaeo/cssquery-prototype.html) 21:53:50 INFO - PID 23750 | RSS: Main: 149475328 21:53:50 INFO - PID 23750 | 21:56:53 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47866/tests/dromaeo/cssquery-yui.html) 21:56:54 INFO - PID 23750 | RSS: Main: 151318528 21:56:54 INFO - PID 23750 | 21:59:55 INFO - PID 23750 | Cycle 1(1): loaded http://localhost:47866/tests/dromaeo/cssquery-yui.html (next: http://localhost:47866/tests/dromaeo/cssquery-dojo.html) 21:59:56 INFO - PID 23750 | RSS: Main: 153858048 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | __start_tp_report 21:59:56 INFO - PID 23750 | _x_x_mozilla_page_load 21:59:56 INFO - PID 23750 | _x_x_mozilla_page_load_details 21:59:56 INFO - PID 23750 | |i|pagename|runs| 21:59:56 INFO - PID 23750 | |0;dojo.html;3849.6535311821935;3857.864974725885;3863.188730366623;3887.14482813781;3891.961080389197;6286.748530058803;6326.145970294009;6373.649449280288;6440.806775796722;6448.548601597884;6385.90421143682;6407.615543067408;6414.262359828621;6422.903656445157;6427.35726427357;5667.376588575254;5716.7141642917895;5723.570732195081;5772;5784.392638772932;5756.913646295309;5808.854778630526;5826.271716035496;5835.649861008332;5842.357340692542;92.54286096128583;5660.490555849972;5687.744051517691;5693.259876216086;5819.941800582003;5667.773289068432;5733.598648094635;5777.45114214149;5780.508656764138;5787.334456537468;5687.488126068673;5701.942980570183;5760.7695692172265;5765.279340082489;5775;6303.936960630381;6321.74713011479;6342.809715708536;6432.5497215194955;6448.580842245286;6945.201301850251;6958.095447591781;7019;7022.964885175541;7052;6802.217744959344;6824.18109826824;6828;6837.965810170967;6948.583085014915;6467.708953097122;6496.577722448073;6524.217093948709;6545.149130613037;6584.242812076624;7141.678624461912;7148.820444626578;7162.677679504435;7245.89131163033;7250.709971601183;6730.865382692319;6821.556598821061;6842.794716158423;6856.108705868205;6949.235584085847;6979.092717946634;6987.336203060701;6997.790066298019;6999.615021173884;7024.5434046786795;6860.622665753432;6887.931120688829;6975.825604359931;6987.231404545496;6994.195667498201;6883.242843287235;6902.068220790229;6970.616616086062;6972.442204623618;6992.79021629352;4911.705297682151;4952.752362381866;4958.975205124024;5007.273945277914;5031.572316353077;4553.59017688403;4587.610053145453;4600.5629465200755;4614.838480653161;4642.141203877293;6260.40526150015;6324;6327.050942358591;6334.904976425358;6407.679616019181;6905.551139175937;6909.619970901548;6936.237013928464;6983.650817459208;7033.191183013917;6346.746130154835;6361.554691171574;6373.0440433934355;6386.744530218739;6403.871922561616;5549.750261238254;5634.97182514093;5636.126400407943;5636.323641163005;5645;7018.227994920555;7034.577925324497;7059.470539709542;7148.678309476086;7158.642067896689;6890.689918953659;6899.793006209822;6969.4424446045205;6972.755953541602;6975.128108986377;7034.894476582753;7037.296270372922;7120.821979450555;7125.07374041392;7134.250903655042;6855.4172895304455;6856.760013399507;6924.757633482804;6943.722251110101;6947.40947019509;6857.897131543131;6943.722251110101;6973.4072603829245;6980.476464265099;7043.788686339418;6684.83287917806;6697.430718388797;6702.731890724316;6713.966430167818;6779.322067793181;6596;6711.362420570038;6765.42493888025;6804.897926531007;6805.149356330458;6630.83422914431;6643.634600096848;6725.19297684281;6734.79795606113;6736.730530778714;6754.6622668865375;6776.119104516579;6781.254062053269;6863.416609588241;6865.588064716133;6471.320511346241;6569.671516424064;6576;6655.933440665725;6672.566283191577 21:59:56 INFO - PID 23750 | |1;ext.html;899.2940541674786;909.8680691299758;926.3006430145241;953.6137864165014;962.3504134709074;43428.13143737123;44004.55995440044;44017;44072;44179.77910110449;41001.38497922534;41120.58879411205;41185.7940710296;41282.17435651285;41375.793121034425;7236.276372362774;7324.780256592284;7364.631768411585;7375.336219740222;7395.445341599401;7262.128544574632;7313.268673132698;7343.485955983083;7356;7367.263273672644;8002.279794818465;8156.510609363428;8158.469699469545;8161.387895907801;8188.2630563249295;8091.4740541864885;8095.473794203417;8136.674533018672;8148.796280092985;8150.592470376458;7864.567448790314;7979.48133371329;8070.354371650254;8082;8083.676652933876;40286.597134028576;40366.59633403658;40669.79665101656;40670.59329406697;40705.38941915874;3683.650053244964;3736.1033351995325;3736.290104880064;3736.9626303736886;3737.103095257146;33876;33907.491387629205;33919.15202119942;33959.32081358359;34019.6598034019;5459.808906688287;5481.150421684605;5541.806036788693;5545.168224766277;5587.552995760329;211698;211868;212516;213082;213885;52171.47828521666;52921;52936.735316323175;52937.735311323966;52988.205176922376;55104.17343739767;55215.72392138094;55256.17115743267;55307;55391;15624.453144139901;15835.524934251991;15852.44516441919;15909.204539772965;15993.520194394187;12882.871171288354;13062.934685326512;13068.150570213096;13068.477260909647;13087.672808179681;15167.772483412758;15272.31274592646;15343.156126413154;15443.845561544465;15662.608434789221;5828.950788857961;5975.7609695612555;6016.639001659914;6066.75732970685;6163.876722465615;1090.1333439915286;1095.5508241620896;1097.8682558092921;1100.6092837042895;1101.553870682375;25366.619500707136;25401.87299063493;25573.74426255751;25651;25773.74226257751;1182.2020136407891;1194.0744429229428;1201.4653479201845;1212.6907638552289;1218.1777300322246;13262.93368533151;13487.797683034762;13545.796813047813;13577.864221357857;13737.450501980009;268069;269183;270582;275653;277863;56510.152347714815;57182.7140864293;57203.14195287074;57244;57273;1514.4320879670124;1541.5914782582624;1542.9151396673292;1554.8911576189785;1566.9921650391675;25348.493030139663;25353.492930140925;25441.872790635927;25500.872495637403;25568.23295301144;40978.385324220755;41074.79462602788;41136.79431602823;41141.58858411378;41176.38235426531;221965;222287;222292;222307;222999;36287;36362.63637363593;36524.81737591401;36722;36787;44603.77698111489;45385.773071134434;45658.315125272486;46020.539794601624;46281.768591156826;34449.48325775166;34489.827550862086;34495.827520862236;34804.65195348014;35223.647763522036;33640.66359336375;34025.149371265914;34122.48816267808;34244.48633270553;34505;39498.60501395064;40379;40448.79775601221;40461.79769101136;40746.38880416737;33584.83207583946;33694.66305336915;33895.66104338925;34174;34683;24917.50164996726;25167;25221.243362699148;25853.741462585134;25963.61054584145 21:59:56 INFO - PID 23750 | |2;jquery.html;586.8268860686097;589.7493565234774;595.934447210807;603.7011679218788;606.1634943777586;23300.18449354273;24007.51984960302;24081.879590602046;24107.517849642998;24137.75862241377;24271.514569708594;25694.871525642346;25825.87087064562;25979.61030584538;25998.22005339843;6641.767538136154;6810.727570897183;6812.182538095435;6815.795526134224;6816.591004539719;6546.149000629912;6745.763898263562;6762.019507171457;6784.389404953553;6850.1779786425695;6696.296888826676;6706.094677218562;6727.394534491895;6746.662666866661;6751.25736169021;6427.260865000515;6607.570507917018;6618.4705223582;6644.800655980328;6654.667266636673;6178.227721534809;6181.979973304445;6184.855801676659;6213.068039794022;6215.28524219716;30091;30568.40168585673;30599.235019124477;30657.846710766527;30669.386612267852;2187.8796666183352;2197.846150769447;2207.6798864164607;2211.4360837986374;2218.8668679879097;19354.903225483922;20117.396478105682;20286.594268114703;20295.492612684655;20302.69545956812;2404.7956965769135;2435.0503303711566;2448.902043918259;2484.0808900706675;2490.651308816767;136252;142616;151429.24285378613;157119;157904.99999999886;15630.609234768994;16083.828683127862;16291.511254662379;16335.59161020984;16501.752473712902;25184.74815251824;25240.36899077501;25262.242132736046;25486;25510.87244563765;10868.663237403996;10945.124390048777;11060.281081729661;11083.334999899871;11219.1585631078;10042.899571004342;10073.1437827784;10097.545610447547;10161.390316581028;10225.795484090277;9652.561714368496;9658.468784216795;9762.411666516726;9835.557399916877;9996.400215987063;2806.0880213930145;2810.578413238031;2871.425714857037;2881.207667891305;3008.217863355543;1028.861103750984;1039.1634734039171;1048.3447845096814;1049.2864851900629;1054.6888667843004;21116.260930867655;21196.576068478545;21270.255541055987;21371.572568548854;21734.45663858416;1115.9776804463866;1120.38938778366;1121.0471099565304;1121.5906194239208;1130.8190689489643;11506.827397589042;11754.588589399329;11863.525458981716;11886.346250956107;11920.821187682192;580486;599346;600081;620053;638576;116111;119705;120560;121128;122457;1098.4672433869566;1151.8963293303643;1228.975420491603;1236.437420973455;1286.6847622332402;21840.23559175421;22253.55492890101;22487.21294754676;22585.887070564542;22665.886670566542;61309.693451532454;61776.382236177065;62450.68774656098;64350.67824660847;64522.67738661277;67653.3234667647;72076.27923720905;76055;76113.23886761062;76812.61593691996;15692;15714.685706286038;15744.212789360257;15885.444009459614;16052.1171335573;20561.48596285105;24621.50756984886;24681.876590616932;24852.37869053288;25139;16339.509814705578;19228.230870765572;19975.20099196016;20169.697454538487;20214.696779548023;16405.343786248417;16568.337266509203;17412.91293543524;18011.909940450212;18289.908550457163;20265.29071482491;20279.4930126748;20568.58862822705;20602.381928541567;20722.171113155306;15404.15277159722;15433.151176685391;15439.536813895602;15455.381784728484;15625.68748625044;15364.231788410758;19660;19692.212311507952;20016.2994295199;20089.899550502152 21:59:56 INFO - PID 23750 | |3;mootools.html;1369.2058606008513;1482.2885015192714;1500.0549653718156;1501.4444655477475;1502.7595584706442;16244;16928;16989.06560139195;17015.31938722451;17024.23390947407;16589.585260368465;16628.66742665146;16655.91672041641;16737;16799.916000420013;2584.030988379358;2588.2623452316093;2638.4195476995033;2645.5105805426056;2650.9337266568295;2782.8886844526296;2808.5646724757594;2814.5637426198973;2817.3520090379225;2829.193679801257;2743.0810678422754;2777.4583956128563;2853.7146285371505;2854.5147324954805;2855.11491437655;2408.8193385496156;2411.686480757499;2430.0158435833514;2433.8174636902213;2436.062116085302;2690.125709144536;2763.6269103671148;2771.2240572639694;2774.1954833098375;2801.80387372884;16504.587385315343;16591.41930032443;16598.170091495496;16613;16676.58308542296;8407.369447291478;8708.912910870873;8712.912870871336;8714.825703485894;8744.344174186961;5522.530584900288;5711.343195532484;5766.538676905838;5861.677607731573;5877.030290002144;1985.3746069987908;2019.8586098973078;2044.6830741235133;2068.9275875344442;2074.408793493847;30032.099037028926;30061.849690751624;30282.84858575715;30297.848510757307;30306.545401818992;6933.861322773516;7085.114360704912;7124.964375178195;7132.4294056475355;7144.8928266076055;19519.121639526256;19525.316613918443;19533.023348832503;19542.9251391172;19689.310874119623;7797.610119494116;8313.542755148525;8331.416800824005;8332.70835520766;8335.708250211213;7571.3564347031115;7628.466007379541;7628.504147230412;7745.8450830983065;7810.648520816577;5445.727713614304;5553.944460555424;5573.359063707644;5604.3835178130375;5675.971620141955;1606.8232494425604;1611.0575313441534;1619.7813295205233;1657.3287818433553;1662.401535447238;983.8376667849868;998.6005597760809;998.650472334677;1018.7707765752647;1021.1065317846884;8683.218510333974;8790.340724445565;8843.60203790831;8901.866472002925;8911.108889111038;792.1998781230998;806.4032615864219;809.7327881798992;813.9743922657376;816.0207750699185;5316.813911513079;5866.472017518444;5954.732037058343;5993.820185394445;6147.108669242934;23978.28065158048;24829.25512234636;24867.129650462146;24922.626160607604;25243.368915777253;23906.880465597907;24173.7582624175;24497.14260000927;24713.629295560582;24721.87639061793;12449.502019919102;12554.309512976874;12584.4337004835;12592.81110783339;12699.492020319083;8796.252318552995;9523.142917137491;9580.281478888972;9730.12428881404;9776.413415195111;20804.895975520027;20814.479638009172;21106.894465527574;21127.154913803275;21213.939303034476;21450.03474843667;21512.892435537724;21549.24577639775;21624.67562986525;21729.565408691422;11356.602518911799;11591.594294199662;11593.304401735923;11605.187636865337;11621.59324423675;15262.847371526143;15492;15711.135887526296;15719.68560628804;15724.921375393049;12549.372531373212;12606.49574017029;12900.161489503153;12921.160124591872;13059.542915997894;12484.750304994031;12650.493980241055;12704.936475317934;12815.359232038547;12950.287734174712;11158.218924675195;11255.268407553483;11294.096472282363;11324.830127547928;11332.716682083013;8221.30118939873;8319.459235149696;8436.198561136682;8462.957685211535;8494.915050849413;8249;8320.625571849161;8429;8431.19903609156;8513 21:59:56 INFO - PID 23750 | |4;prototype.html;551.5807985930694;566.9716514174291;573.9767320196305;583.6818933681145;586.0886321769647;6231.252249730033;6249.250089989202;6321.52588555859;6326.019466982613;6372.367750382284;6093.238345206849;6111.7249723762425;6164.075388691687;6173.845653858656;6209.316975132731;4919.975400123012;5012.874678133057;5104.8979020419565;5125.564327032188;5147.584414286073;4968.875778105558;5011.3485246918035;5040.2439634055;5049.091163590552;5054.545090941814;4948.257761335793;4950.9504904950845;4974.850754477371;4995.175795993657;5028.4971502849785;4938.703677779345;4942;4984.800607975677;5008.974955125201;5012.172991456406;4563.247064234397;4565.885852853672;4576.771161441948;4588.4035075440315;4594.333821595883;5981.162637230791;6093.207882975229;6120.877582448326;6185.103160041814;6198.287196972361;5701.344345400291;5754.79858204965;5789.334226563957;5840.269966254218;5842.444967728059;6598.670066496704;6616.213622321994;6624.205095388536;6639.867202655968;6658.434033107192;4818.397700287464;5033.270175824521;5039.395272567279;5039.420466646346;5052.444231134572;6753;6771.1874575050815;6859.416949559293;6934.167899851999;6973.616451095188;5181.896362072737;5185.351831021122;5187;5194.428612852583;5194.714290713971;5233.476652334736;5246.3704355477585;5254.632175747661;5258.894822103536;5264.999300265951;5767.8558036049435;5816.82549523515;5819.359870414251;5819.6508209507565;5844.035734103911;6638.203415590064;6675.165604299463;6707.128073350434;6709;6722.495812814059;1800.540862080161;1817.0642119308566;1821.3443160462223;1826.9451916442529;1830.1398342778873;1225.8109633655517;1270.4981532294692;1276.183242724657;1288.15625765124;1303.276681441809;6043.8791224175275;6046.3349031606485;6046.637201767908;6073.635581865014;6122.653016336399;6709.329067093349;6765.966170169216;6782.898256526156;6784.270011147225;6785.728570857111;5834.679092649945;5991.4907232884825;6023.789167379121;6043.244594425697;6077.544184186204;3453.533772940671;3532.62227731185;3546.131197856542;3553.1117220694828;3564.376234159012;6830.624315662686;6831.11195544586;6905.240423553405;6907.620080895498;6908.965455172692;6775.288594697486;6803.557768745016;6847.370893426492;6862.759803406957;6870.175578930461;6840.213375461885;6845.760398386132;6900.307790702371;6910.896336554855;6937.687804048729;6399.744010239725;6601.636909969998;6602.372774586406;6708.664566771544;6723.663816809238;6467.159269294962;6499.480041596756;6521.510886683613;6573.441257492976;6681.730471210454;6748.831279218059;6756.054152418764;6841;6850.588964662136;6909.827254318682;5120.871978200575;5140;5143.177091665316;5162.122439185272;5180.352455943007;6530.608163510205;6733.158355205599;6772.796816095525;6820.215675197416;6856.314368563104;6351.809445716636;6432.839179020562;6475.935240647722;6514.641694706647;6520.836979075371;6437.103303513344;6449.451796597342;6464.353564643498;6482.254540727688;6572.737090516326;6363.409147713071;6376.171097757262;6404.871902562016;6429.7106630200815;6448.000559913221;6519.217693876765;6542.182227221598;6602.570832895846;6604.471642268511;6605.900911486236;6333.1766870306565;6400.519961003037;6412.743490260524;6434;6466.482681385383 21:59:56 INFO - PID 23750 | |5;yui.html;946.4634778792832;959.1176117971465;970.4419958523846;975.6975337645335;982.7543114221445;18671.06644667766;19406.90296548517;22777.202797902075;23590.46661966971;23674.408139796513;20741.481462963395;21322.36032919015;22287.888560557214;22501.774982250172;22590.43523911903;1052.9105026072773;1065.211743309953;1067.3009178987775;1067.9572817087308;1068.102793653331;942.2697409507653;1041.416806588313;1048.0933992096857;1059.57087379611;1069.620284798893;1122.5453691255013;1131.575659127827;1131.8302254661826;1132.162199972023;1132.2696860524957;1115.893990070942;1118.7370967822555;1119.748056687247;1120.5349779841356;1122.253701288642;824.1058451580043;825.9793505162359;827.611022819274;831.6049876308705;832.8001279692891;19311.03444827767;19342;19561.902190489098;19669.11488982999;20194;23502.177423790257;23573;23791.405214869766;23919;23962;18091.095445227686;18209.27162913482;18274.086295685163;18317.908410457996;18327.816721832743;3931.429942658327;4011.3180759270995;4018.3972404139613;4035.9192816143805;4037.4953130858644;155307;158361.20819395944;158603.99999999884;159709;161474;17015.914920425566;17061;17091.4617684409;17158.48524544266;17199;32031.199220019687;32592.185195370304;33663.4950475743;33713;34130.65869341324;9371.812563748823;9442.480663563432;9490.240780737524;9535.52322383878;9538.284628652878;4436.401085853368;4456.977715111404;4462.799174037111;4493.101379724003;4539.72761634303;5939.970300148558;6044.667543285162;6052.213212282375;6073.848153796191;6084.726187321581;1074.188987314588;1104.8839871813343;1117.5697356517799;1119.468252580018;1121.685927940178;723.9022731931227;748.6743266679013;757.6817736550552;770.1874522378832;775.7517594369748;12341;13219.537316193888;13543.119697219649;13709.794353084711;13786.586402407944;740.1820987808502;743.4684200796456;745.1095940351228;756.9583672897934;757.7916073079947;5997.970010149921;6013.1581578579035;6062.939370606326;6115.357887421846;6172.722227499773;137866;140554;141387;142053;143107;113715.431422844;119333.40333298278;120890;122490;123378.38310808389;107347;109355.45322273497;109424.90575094306;110826;111724;11373.772524549628;11388.772224555296;11513.539458421905;11549.711257218636;11783.351915644378;55367.44632553784;55433;55916.44083559112;55967.440325596224;56723.432765671816;69262.65368673124;69290;69477;69695.65152174207;70089.64955175192;16332.183390830649;16485.752713709542;16552;16703.164841758105;16871.915640422212;18304.26782928668;18309.422644338916;18624.44126676202;18630.813691862906;18782.248710051445;16229.43196988147;16312.918435407748;16357.509274721777;16387.508374748777;16617.252223649724;16397.344106236094;16499.340026398808;16559.668806624042;16634.251458684146;16727.66544669124;16111.758323624921;16122;16232.513024609281;16375.42686005984;16402.589935251715;12820.807687884502;12939.741205175655;12951;12958.157719748186;13097.279649619362;12139.453724582238;12375.319357435428;12394.876051239373;12547.43536540876;12595 21:59:56 INFO - PID 23750 | __end_tp_report 21:59:56 INFO - PID 23750 | __start_cc_report 21:59:56 INFO - PID 23750 | _x_x_mozilla_cycle_collect,280 21:59:56 INFO - PID 23750 | __end_cc_report 21:59:56 INFO - PID 23750 | __startTimestamp1505624396219__endTimestamp 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | ------- Summary: start ------- 21:59:56 INFO - PID 23750 | Number of tests: 6 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#0] dojo.html Cycles:165 Average:6342.81 Median:6684.83 stddev:910.58 (13.6%) stddev-sans-first:892.12 21:59:56 INFO - PID 23750 | Values: 3849.7 3857.9 3863.2 3887.1 3892.0 6286.7 6326.1 6373.6 6440.8 6448.5 6385.9 6407.6 6414.3 6422.9 6427.4 5667.4 5716.7 5723.6 5772.0 5784.4 5756.9 5808.9 5826.3 5835.6 5842.4 92.5 5660.5 5687.7 5693.3 5819.9 5667.8 5733.6 5777.5 5780.5 5787.3 5687.5 5701.9 5760.8 5765.3 5775.0 6303.9 6321.7 6342.8 6432.5 6448.6 6945.2 6958.1 7019.0 7023.0 7052.0 6802.2 6824.2 6828.0 6838.0 6948.6 6467.7 6496.6 6524.2 6545.1 6584.2 7141.7 7148.8 7162.7 7245.9 7250.7 6730.9 6821.6 6842.8 6856.1 6949.2 6979.1 6987.3 6997.8 6999.6 7024.5 6860.6 6887.9 6975.8 6987.2 6994.2 6883.2 6902.1 6970.6 6972.4 6992.8 4911.7 4952.8 4959.0 5007.3 5031.6 4553.6 4587.6 4600.6 4614.8 4642.1 6260.4 6324.0 6327.1 6334.9 6407.7 6905.6 6909.6 6936.2 6983.7 7033.2 6346.7 6361.6 6373.0 6386.7 6403.9 5549.8 5635.0 5636.1 5636.3 5645.0 7018.2 7034.6 7059.5 7148.7 7158.6 6890.7 6899.8 6969.4 6972.8 6975.1 7034.9 7037.3 7120.8 7125.1 7134.3 6855.4 6856.8 6924.8 6943.7 6947.4 6857.9 6943.7 6973.4 6980.5 7043.8 6684.8 6697.4 6702.7 6714.0 6779.3 6596.0 6711.4 6765.4 6804.9 6805.1 6630.8 6643.6 6725.2 6734.8 6736.7 6754.7 6776.1 6781.3 6863.4 6865.6 6471.3 6569.7 6576.0 6655.9 6672.6 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#1] ext.html Cycles:180 Average:41430.62 Median:3709.88 stddev:61624.76 (1661.1%) stddev-sans-first:61722.49 21:59:56 INFO - PID 23750 | Values: 899.3 909.9 926.3 953.6 962.4 43428.1 44004.6 44017.0 44072.0 44179.8 41001.4 41120.6 41185.8 41282.2 41375.8 7236.3 7324.8 7364.6 7375.3 7395.4 7262.1 7313.3 7343.5 7356.0 7367.3 8002.3 8156.5 8158.5 8161.4 8188.3 8091.5 8095.5 8136.7 8148.8 8150.6 7864.6 7979.5 8070.4 8082.0 8083.7 40286.6 40366.6 40669.8 40670.6 40705.4 3683.7 3736.1 3736.3 3737.0 3737.1 33876.0 33907.5 33919.2 33959.3 34019.7 5459.8 5481.2 5541.8 5545.2 5587.6 211698.0 211868.0 212516.0 213082.0 213885.0 52171.5 52921.0 52936.7 52937.7 52988.2 55104.2 55215.7 55256.2 55307.0 55391.0 15624.5 15835.5 15852.4 15909.2 15993.5 12882.9 13062.9 13068.2 13068.5 13087.7 15167.8 15272.3 15343.2 15443.8 15662.6 5829.0 5975.8 6016.6 6066.8 6163.9 1090.1 1095.6 1097.9 1100.6 1101.6 25366.6 25401.9 25573.7 25651.0 25773.7 1182.2 1194.1 1201.5 1212.7 1218.2 13262.9 13487.8 13545.8 13577.9 13737.5 268069.0 269183.0 270582.0 275653.0 277863.0 56510.2 57182.7 57203.1 57244.0 57273.0 1514.4 1541.6 1542.9 1554.9 1567.0 25348.5 25353.5 25441.9 25500.9 25568.2 40978.4 41074.8 41136.8 41141.6 41176.4 221965.0 222287.0 222292.0 222307.0 222999.0 36287.0 36362.6 36524.8 36722.0 36787.0 44603.8 45385.8 45658.3 46020.5 46281.8 34449.5 34489.8 34495.8 34804.7 35223.6 33640.7 34025.1 34122.5 34244.5 34505.0 39498.6 40379.0 40448.8 40461.8 40746.4 33584.8 33694.7 33895.7 34174.0 34683.0 24917.5 25167.0 25221.2 25853.7 25963.6 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#2] jquery.html Cycles:180 Average:39365.31 Median:2215.15 stddev:101340.01 (4574.9%) stddev-sans-first:101582.46 21:59:56 INFO - PID 23750 | Values: 586.8 589.7 595.9 603.7 606.2 23300.2 24007.5 24081.9 24107.5 24137.8 24271.5 25694.9 25825.9 25979.6 25998.2 6641.8 6810.7 6812.2 6815.8 6816.6 6546.1 6745.8 6762.0 6784.4 6850.2 6696.3 6706.1 6727.4 6746.7 6751.3 6427.3 6607.6 6618.5 6644.8 6654.7 6178.2 6182.0 6184.9 6213.1 6215.3 30091.0 30568.4 30599.2 30657.8 30669.4 2187.9 2197.8 2207.7 2211.4 2218.9 19354.9 20117.4 20286.6 20295.5 20302.7 2404.8 2435.1 2448.9 2484.1 2490.7 136252.0 142616.0 151429.2 157119.0 157905.0 15630.6 16083.8 16291.5 16335.6 16501.8 25184.7 25240.4 25262.2 25486.0 25510.9 10868.7 10945.1 11060.3 11083.3 11219.2 10042.9 10073.1 10097.5 10161.4 10225.8 9652.6 9658.5 9762.4 9835.6 9996.4 2806.1 2810.6 2871.4 2881.2 3008.2 1028.9 1039.2 1048.3 1049.3 1054.7 21116.3 21196.6 21270.3 21371.6 21734.5 1116.0 1120.4 1121.0 1121.6 1130.8 11506.8 11754.6 11863.5 11886.3 11920.8 580486.0 599346.0 600081.0 620053.0 638576.0 116111.0 119705.0 120560.0 121128.0 122457.0 1098.5 1151.9 1229.0 1236.4 1286.7 21840.2 22253.6 22487.2 22585.9 22665.9 61309.7 61776.4 62450.7 64350.7 64522.7 67653.3 72076.3 76055.0 76113.2 76812.6 15692.0 15714.7 15744.2 15885.4 16052.1 20561.5 24621.5 24681.9 24852.4 25139.0 16339.5 19228.2 19975.2 20169.7 20214.7 16405.3 16568.3 17412.9 18011.9 18289.9 20265.3 20279.5 20568.6 20602.4 20722.2 15404.2 15433.2 15439.5 15455.4 15625.7 15364.2 19660.0 19692.2 20016.3 20089.9 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#3] mootools.html Cycles:180 Average:10345.35 Median:25083.00 stddev:7637.86 (30.5%) stddev-sans-first:7629.51 21:59:56 INFO - PID 23750 | Values: 1369.2 1482.3 1500.1 1501.4 1502.8 16244.0 16928.0 16989.1 17015.3 17024.2 16589.6 16628.7 16655.9 16737.0 16799.9 2584.0 2588.3 2638.4 2645.5 2650.9 2782.9 2808.6 2814.6 2817.4 2829.2 2743.1 2777.5 2853.7 2854.5 2855.1 2408.8 2411.7 2430.0 2433.8 2436.1 2690.1 2763.6 2771.2 2774.2 2801.8 16504.6 16591.4 16598.2 16613.0 16676.6 8407.4 8708.9 8712.9 8714.8 8744.3 5522.5 5711.3 5766.5 5861.7 5877.0 1985.4 2019.9 2044.7 2068.9 2074.4 30032.1 30061.8 30282.8 30297.8 30306.5 6933.9 7085.1 7125.0 7132.4 7144.9 19519.1 19525.3 19533.0 19542.9 19689.3 7797.6 8313.5 8331.4 8332.7 8335.7 7571.4 7628.5 7628.5 7745.8 7810.6 5445.7 5553.9 5573.4 5604.4 5676.0 1606.8 1611.1 1619.8 1657.3 1662.4 983.8 998.6 998.7 1018.8 1021.1 8683.2 8790.3 8843.6 8901.9 8911.1 792.2 806.4 809.7 814.0 816.0 5316.8 5866.5 5954.7 5993.8 6147.1 23978.3 24829.3 24867.1 24922.6 25243.4 23906.9 24173.8 24497.1 24713.6 24721.9 12449.5 12554.3 12584.4 12592.8 12699.5 8796.3 9523.1 9580.3 9730.1 9776.4 20804.9 20814.5 21106.9 21127.2 21213.9 21450.0 21512.9 21549.2 21624.7 21729.6 11356.6 11591.6 11593.3 11605.2 11621.6 15262.8 15492.0 15711.1 15719.7 15724.9 12549.4 12606.5 12900.2 12921.2 13059.5 12484.8 12650.5 12704.9 12815.4 12950.3 11158.2 11255.3 11294.1 11324.8 11332.7 8221.3 8319.5 8436.2 8463.0 8494.9 8249.0 8320.6 8429.0 8431.2 8513.0 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#4] prototype.html Cycles:180 Average:5589.29 Median:6168.96 stddev:1549.52 (25.1%) stddev-sans-first:1507.03 21:59:56 INFO - PID 23750 | Values: 551.6 567.0 574.0 583.7 586.1 6231.3 6249.3 6321.5 6326.0 6372.4 6093.2 6111.7 6164.1 6173.8 6209.3 4920.0 5012.9 5104.9 5125.6 5147.6 4968.9 5011.3 5040.2 5049.1 5054.5 4948.3 4951.0 4974.9 4995.2 5028.5 4938.7 4942.0 4984.8 5009.0 5012.2 4563.2 4565.9 4576.8 4588.4 4594.3 5981.2 6093.2 6120.9 6185.1 6198.3 5701.3 5754.8 5789.3 5840.3 5842.4 6598.7 6616.2 6624.2 6639.9 6658.4 4818.4 5033.3 5039.4 5039.4 5052.4 6753.0 6771.2 6859.4 6934.2 6973.6 5181.9 5185.4 5187.0 5194.4 5194.7 5233.5 5246.4 5254.6 5258.9 5265.0 5767.9 5816.8 5819.4 5819.7 5844.0 6638.2 6675.2 6707.1 6709.0 6722.5 1800.5 1817.1 1821.3 1826.9 1830.1 1225.8 1270.5 1276.2 1288.2 1303.3 6043.9 6046.3 6046.6 6073.6 6122.7 6709.3 6766.0 6782.9 6784.3 6785.7 5834.7 5991.5 6023.8 6043.2 6077.5 3453.5 3532.6 3546.1 3553.1 3564.4 6830.6 6831.1 6905.2 6907.6 6909.0 6775.3 6803.6 6847.4 6862.8 6870.2 6840.2 6845.8 6900.3 6910.9 6937.7 6399.7 6601.6 6602.4 6708.7 6723.7 6467.2 6499.5 6521.5 6573.4 6681.7 6748.8 6756.1 6841.0 6850.6 6909.8 5120.9 5140.0 5143.2 5162.1 5180.4 6530.6 6733.2 6772.8 6820.2 6856.3 6351.8 6432.8 6475.9 6514.6 6520.8 6437.1 6449.5 6464.4 6482.3 6572.7 6363.4 6376.2 6404.9 6429.7 6448.0 6519.2 6542.2 6602.6 6604.5 6605.9 6333.2 6400.5 6412.7 6434.0 6466.5 21:59:56 INFO - PID 23750 | 21:59:56 INFO - PID 23750 | [#5] yui.html Cycles:180 Average:27322.84 Median:18241.68 stddev:40423.37 (221.6%) stddev-sans-first:40488.25 21:59:56 INFO - PID 23750 | Values: 946.5 959.1 970.4 975.7 982.8 18671.1 19406.9 22777.2 23590.5 23674.4 20741.5 21322.4 22287.9 22501.8 22590.4 1052.9 1065.2 1067.3 1068.0 1068.1 942.3 1041.4 1048.1 1059.6 1069.6 1122.5 1131.6 1131.8 1132.2 1132.3 1115.9 1118.7 1119.7 1120.5 1122.3 824.1 826.0 827.6 831.6 832.8 19311.0 19342.0 19561.9 19669.1 20194.0 23502.2 23573.0 23791.4 23919.0 23962.0 18091.1 18209.3 18274.1 18317.9 18327.8 3931.4 4011.3 4018.4 4035.9 4037.5 155307.0 158361.2 158604.0 159709.0 161474.0 17015.9 17061.0 17091.5 17158.5 17199.0 32031.2 32592.2 33663.5 33713.0 34130.7 9371.8 9442.5 9490.2 9535.5 9538.3 4436.4 4457.0 4462.8 4493.1 4539.7 5940.0 6044.7 6052.2 6073.8 6084.7 1074.2 1104.9 1117.6 1119.5 1121.7 723.9 748.7 757.7 770.2 775.8 12341.0 13219.5 13543.1 13709.8 13786.6 740.2 743.5 745.1 757.0 757.8 5998.0 6013.2 6062.9 6115.4 6172.7 137866.0 140554.0 141387.0 142053.0 143107.0 113715.4 119333.4 120890.0 122490.0 123378.4 107347.0 109355.5 109424.9 110826.0 111724.0 11373.8 11388.8 11513.5 11549.7 11783.4 55367.4 55433.0 55916.4 55967.4 56723.4 69262.7 69290.0 69477.0 69695.7 70089.6 16332.2 16485.8 16552.0 16703.2 16871.9 18304.3 18309.4 18624.4 18630.8 18782.2 16229.4 16312.9 16357.5 16387.5 16617.3 16397.3 16499.3 16559.7 16634.3 16727.7 16111.8 16122.0 16232.5 16375.4 16402.6 12820.8 12939.7 12951.0 12958.2 13097.3 12139.5 12375.3 12394.9 12547.4 12595.0 21:59:56 INFO - PID 23750 | -------- Summary: end -------- 21:59:56 INFO - PID 23750 | 21:59:56 INFO - TEST-INFO | 23750: exit 0 21:59:56 INFO - TEST-OK | dromaeo_css | took 1107032ms 21:59:56 INFO - TEST-START | kraken 21:59:56 INFO - Initialising browser for kraken test... 21:59:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47866/getInfo.html -profile /tmp/tmpZOtdWS/profile 21:59:56 INFO - TEST-INFO | started process 24117 (/builds/slave/test/build/application/firefox/firefox http://localhost:47866/getInfo.html) 22:00:01 INFO - TEST-INFO | 24117: exit 0 22:00:02 INFO - Browser initialized. 22:00:02 INFO - Running cycle 1/1 for kraken test... 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'JSGC_DISABLE_POISONING': '1', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:02 INFO - 'MOZ_CRASHREPORTER': '1', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test', 22:00:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:02 INFO - 'RUST_BACKTRACE': 'full', 22:00:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'STYLO_FORCE_DISABLED': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - TEST-INFO | started process 24354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZOtdWS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:02 INFO - PID 24354 | 22:00:02 INFO - PID 24354 | (/builds/slave/test/build/application/firefox/firefox:24403): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:00:02 INFO - PID 24354 | 22:00:13 INFO - PID 24354 | RSS: Main: 146997248 22:00:13 INFO - PID 24354 | 22:00:15 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47866/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:16 INFO - PID 24354 | RSS: Main: 152596480 22:00:16 INFO - PID 24354 | 22:00:19 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47866/tests/kraken/driver.html?testName=audio-dft) 22:00:19 INFO - PID 24354 | RSS: Main: 153214976 22:00:19 INFO - PID 24354 | 22:00:22 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47866/tests/kraken/driver.html?testName=audio-fft) 22:00:23 INFO - PID 24354 | RSS: Main: 149274624 22:00:23 INFO - PID 24354 | 22:00:25 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47866/tests/kraken/driver.html?testName=audio-oscillator) 22:00:25 INFO - PID 24354 | RSS: Main: 150319104 22:00:25 INFO - PID 24354 | 22:00:27 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:28 INFO - PID 24354 | RSS: Main: 150265856 22:00:28 INFO - PID 24354 | 22:00:31 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47866/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:32 INFO - PID 24354 | RSS: Main: 150343680 22:00:32 INFO - PID 24354 | 22:00:35 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47866/tests/kraken/driver.html?testName=imaging-desaturate) 22:00:36 INFO - PID 24354 | RSS: Main: 151646208 22:00:36 INFO - PID 24354 | 22:00:39 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47866/tests/kraken/driver.html?testName=json-parse-financial) 22:00:39 INFO - PID 24354 | RSS: Main: 153296896 22:00:39 INFO - PID 24354 | 22:00:41 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:00:42 INFO - PID 24354 | RSS: Main: 153219072 22:00:42 INFO - PID 24354 | 22:00:43 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:00:44 INFO - PID 24354 | RSS: Main: 153124864 22:00:44 INFO - PID 24354 | 22:00:46 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:00:46 INFO - PID 24354 | RSS: Main: 150142976 22:00:46 INFO - PID 24354 | 22:00:49 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:00:49 INFO - PID 24354 | RSS: Main: 150224896 22:00:49 INFO - PID 24354 | 22:00:52 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:53 INFO - PID 24354 | RSS: Main: 150867968 22:00:53 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | Cycle 1(1): loaded http://localhost:47866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47866/tests/kraken/driver.html?testName=ai-astar) 22:00:55 INFO - PID 24354 | RSS: Main: 152059904 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | __start_tp_report 22:00:55 INFO - PID 24354 | _x_x_mozilla_page_load 22:00:55 INFO - PID 24354 | _x_x_mozilla_page_load_details 22:00:55 INFO - PID 24354 | |i|pagename|runs| 22:00:55 INFO - PID 24354 | |0;ai-astar;105;106;105;105;105;108;109;108;109;106 22:00:55 INFO - PID 24354 | |1;audio-beat-detection;113;113;111;114;113;112;112;111;114;140 22:00:55 INFO - PID 24354 | |2;audio-dft;164;163;165;161;161;161;161;162;165;167 22:00:55 INFO - PID 24354 | |3;audio-fft;75;73;81;74;74;73;73;73;75;73 22:00:55 INFO - PID 24354 | |4;audio-oscillator;82;79;79;78;78;78;78;78;78;78 22:00:55 INFO - PID 24354 | |5;imaging-gaussian-blur;113;112;114;114;109;113;113;113;114;114 22:00:55 INFO - PID 24354 | |6;imaging-darkroom;149;150;155;149;151;151;149;150;150;149 22:00:55 INFO - PID 24354 | |7;imaging-desaturate;94;94;94;93;94;94;93;94;94;94 22:00:55 INFO - PID 24354 | |8;json-parse-financial;44;43;44;43;49;44;53;44;42;43 22:00:55 INFO - PID 24354 | |9;json-stringify-tinderbox;39;39;42;38;39;38;38;40;43;42 22:00:55 INFO - PID 24354 | |10;stanford-crypto-aes;72;72;73;72;71;72;70;71;73;79 22:00:55 INFO - PID 24354 | |11;stanford-crypto-ccm;108;103;106;112;111;113;112;109;107;109 22:00:55 INFO - PID 24354 | |12;stanford-crypto-pbkdf2;157;155;152;148;154;158;151;151;173;168 22:00:55 INFO - PID 24354 | |13;stanford-crypto-sha256-iterative;61;59;65;64;61;59;59;62;61;60 22:00:55 INFO - PID 24354 | __end_tp_report 22:00:55 INFO - PID 24354 | __start_cc_report 22:00:55 INFO - PID 24354 | _x_x_mozilla_cycle_collect,734 22:00:55 INFO - PID 24354 | __end_cc_report 22:00:55 INFO - PID 24354 | __startTimestamp1505624455267__endTimestamp 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | ------- Summary: start ------- 22:00:55 INFO - PID 24354 | Number of tests: 14 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:1.71 (1.6%) stddev-sans-first:1.72 22:00:55 INFO - PID 24354 | Values: 105.0 106.0 105.0 105.0 105.0 108.0 109.0 108.0 109.0 106.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#1] audio-beat-detection Cycles:10 Average:115.30 Median:113.00 stddev:8.74 (7.7%) stddev-sans-first:9.23 22:00:55 INFO - PID 24354 | Values: 113.0 113.0 111.0 114.0 113.0 112.0 112.0 111.0 114.0 140.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:2.16 (1.3%) stddev-sans-first:2.26 22:00:55 INFO - PID 24354 | Values: 164.0 163.0 165.0 161.0 161.0 161.0 161.0 162.0 165.0 167.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.00 stddev:2.46 (3.3%) stddev-sans-first:2.60 22:00:55 INFO - PID 24354 | Values: 75.0 73.0 81.0 74.0 74.0 73.0 73.0 73.0 75.0 73.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:1.26 (1.6%) stddev-sans-first:0.44 22:00:55 INFO - PID 24354 | Values: 82.0 79.0 79.0 78.0 78.0 78.0 78.0 78.0 78.0 78.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.50 stddev:1.52 (1.3%) stddev-sans-first:1.62 22:00:55 INFO - PID 24354 | Values: 113.0 112.0 114.0 114.0 109.0 113.0 113.0 113.0 114.0 114.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.83 (1.2%) stddev-sans-first:1.88 22:00:55 INFO - PID 24354 | Values: 149.0 150.0 155.0 149.0 151.0 151.0 149.0 150.0 150.0 149.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:00:55 INFO - PID 24354 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:44.00 stddev:3.41 (7.8%) stddev-sans-first:3.61 22:00:55 INFO - PID 24354 | Values: 44.0 43.0 44.0 43.0 49.0 44.0 53.0 44.0 42.0 43.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#9] json-stringify-tinderbox Cycles:10 Average:39.80 Median:39.50 stddev:1.87 (4.7%) stddev-sans-first:1.96 22:00:55 INFO - PID 24354 | Values: 39.0 39.0 42.0 38.0 39.0 38.0 38.0 40.0 43.0 42.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:72.00 stddev:2.46 (3.4%) stddev-sans-first:2.60 22:00:55 INFO - PID 24354 | Values: 72.0 72.0 73.0 72.0 71.0 72.0 70.0 71.0 73.0 79.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#11] stanford-crypto-ccm Cycles:10 Average:109.00 Median:110.00 stddev:3.13 (2.8%) stddev-sans-first:3.30 22:00:55 INFO - PID 24354 | Values: 108.0 103.0 106.0 112.0 111.0 113.0 112.0 109.0 107.0 109.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:156.00 stddev:7.94 (5.1%) stddev-sans-first:8.43 22:00:55 INFO - PID 24354 | Values: 157.0 155.0 152.0 148.0 154.0 158.0 151.0 151.0 173.0 168.0 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:2.08 (3.4%) stddev-sans-first:2.20 22:00:55 INFO - PID 24354 | Values: 61.0 59.0 65.0 64.0 61.0 59.0 59.0 62.0 61.0 60.0 22:00:55 INFO - PID 24354 | -------- Summary: end -------- 22:00:55 INFO - PID 24354 | 22:00:55 INFO - PID 24354 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 22:00:56 INFO - TEST-INFO | 24354: exit 0 22:00:56 INFO - TEST-OK | kraken | took 59202ms 22:00:56 INFO - SUITE-END | took 1166s 22:00:56 INFO - Completed test suite (00:19:26) 22:00:56 INFO - javascript benchmark 22:00:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8990.87427776565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3849.6535311821935, 3857.864974725885, 3863.188730366623, 3887.14482813781, 3891.961080389197, 6286.748530058803, 6326.145970294009, 6373.649449280288, 6440.806775796722, 6448.548601597884, 6385.90421143682, 6407.615543067408, 6414.262359828621, 6422.903656445157, 6427.35726427357, 5667.376588575254, 5716.7141642917895, 5723.570732195081, 5772.0, 5784.392638772932, 5756.913646295309, 5808.854778630526, 5826.271716035496, 5835.649861008332, 5842.357340692542, 92.54286096128583, 5660.490555849972, 5687.744051517691, 5693.259876216086, 5819.941800582003, 5667.773289068432, 5733.598648094635, 5777.45114214149, 5780.508656764138, 5787.334456537468, 5687.488126068673, 5701.942980570183, 5760.7695692172265, 5765.279340082489, 5775.0, 6303.936960630381, 6321.74713011479, 6342.809715708536, 6432.5497215194955, 6448.580842245286, 6945.201301850251, 6958.095447591781, 7019.0, 7022.964885175541, 7052.0, 6802.217744959344, 6824.18109826824, 6828.0, 6837.965810170967, 6948.583085014915, 6467.708953097122, 6496.577722448073, 6524.217093948709, 6545.149130613037, 6584.242812076624, 7141.678624461912, 7148.820444626578, 7162.677679504435, 7245.89131163033, 7250.709971601183, 6730.865382692319, 6821.556598821061, 6842.794716158423, 6856.108705868205, 6949.235584085847, 6979.092717946634, 6987.336203060701, 6997.790066298019, 6999.615021173884, 7024.5434046786795, 6860.622665753432, 6887.931120688829, 6975.825604359931, 6987.231404545496, 6994.195667498201, 6883.242843287235, 6902.068220790229, 6970.616616086062, 6972.442204623618, 6992.79021629352, 4911.705297682151, 4952.752362381866, 4958.975205124024, 5007.273945277914, 5031.572316353077, 4553.59017688403, 4587.610053145453, 4600.5629465200755, 4614.838480653161, 4642.141203877293, 6260.40526150015, 6324.0, 6327.050942358591, 6334.904976425358, 6407.679616019181, 6905.551139175937, 6909.619970901548, 6936.237013928464, 6983.650817459208, 7033.191183013917, 6346.746130154835, 6361.554691171574, 6373.0440433934355, 6386.744530218739, 6403.871922561616, 5549.750261238254, 5634.97182514093, 5636.126400407943, 5636.323641163005, 5645.0, 7018.227994920555, 7034.577925324497, 7059.470539709542, 7148.678309476086, 7158.642067896689, 6890.689918953659, 6899.793006209822, 6969.4424446045205, 6972.755953541602, 6975.128108986377, 7034.894476582753, 7037.296270372922, 7120.821979450555, 7125.07374041392, 7134.250903655042, 6855.4172895304455, 6856.760013399507, 6924.757633482804, 6943.722251110101, 6947.40947019509, 6857.897131543131, 6943.722251110101, 6973.4072603829245, 6980.476464265099, 7043.788686339418, 6684.83287917806, 6697.430718388797, 6702.731890724316, 6713.966430167818, 6779.322067793181, 6596.0, 6711.362420570038, 6765.42493888025, 6804.897926531007, 6805.149356330458, 6630.83422914431, 6643.634600096848, 6725.19297684281, 6734.79795606113, 6736.730530778714, 6754.6622668865375, 6776.119104516579, 6781.254062053269, 6863.416609588241, 6865.588064716133, 6471.320511346241, 6569.671516424064, 6576.0, 6655.933440665725, 6672.566283191577], "value": 6281.39434766891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.2940541674786, 909.8680691299758, 926.3006430145241, 953.6137864165014, 962.3504134709074, 43428.13143737123, 44004.55995440044, 44017.0, 44072.0, 44179.77910110449, 41001.38497922534, 41120.58879411205, 41185.7940710296, 41282.17435651285, 41375.793121034425, 7236.276372362774, 7324.780256592284, 7364.631768411585, 7375.336219740222, 7395.445341599401, 7262.128544574632, 7313.268673132698, 7343.485955983083, 7356.0, 7367.263273672644, 8002.279794818465, 8156.510609363428, 8158.469699469545, 8161.387895907801, 8188.2630563249295, 8091.4740541864885, 8095.473794203417, 8136.674533018672, 8148.796280092985, 8150.592470376458, 7864.567448790314, 7979.48133371329, 8070.354371650254, 8082.0, 8083.676652933876, 40286.597134028576, 40366.59633403658, 40669.79665101656, 40670.59329406697, 40705.38941915874, 3683.650053244964, 3736.1033351995325, 3736.290104880064, 3736.9626303736886, 3737.103095257146, 33876.0, 33907.491387629205, 33919.15202119942, 33959.32081358359, 34019.6598034019, 5459.808906688287, 5481.150421684605, 5541.806036788693, 5545.168224766277, 5587.552995760329, 211698.0, 211868.0, 212516.0, 213082.0, 213885.0, 52171.47828521666, 52921.0, 52936.735316323175, 52937.735311323966, 52988.205176922376, 55104.17343739767, 55215.72392138094, 55256.17115743267, 55307.0, 55391.0, 15624.453144139901, 15835.524934251991, 15852.44516441919, 15909.204539772965, 15993.520194394187, 12882.871171288354, 13062.934685326512, 13068.150570213096, 13068.477260909647, 13087.672808179681, 15167.772483412758, 15272.31274592646, 15343.156126413154, 15443.845561544465, 15662.608434789221, 5828.950788857961, 5975.7609695612555, 6016.639001659914, 6066.75732970685, 6163.876722465615, 1090.1333439915286, 1095.5508241620896, 1097.8682558092921, 1100.6092837042895, 1101.553870682375, 25366.619500707136, 25401.87299063493, 25573.74426255751, 25651.0, 25773.74226257751, 1182.2020136407891, 1194.0744429229428, 1201.4653479201845, 1212.6907638552289, 1218.1777300322246, 13262.93368533151, 13487.797683034762, 13545.796813047813, 13577.864221357857, 13737.450501980009, 268069.0, 269183.0, 270582.0, 275653.0, 277863.0, 56510.152347714815, 57182.7140864293, 57203.14195287074, 57244.0, 57273.0, 1514.4320879670124, 1541.5914782582624, 1542.9151396673292, 1554.8911576189785, 1566.9921650391675, 25348.493030139663, 25353.492930140925, 25441.872790635927, 25500.872495637403, 25568.23295301144, 40978.385324220755, 41074.79462602788, 41136.79431602823, 41141.58858411378, 41176.38235426531, 221965.0, 222287.0, 222292.0, 222307.0, 222999.0, 36287.0, 36362.63637363593, 36524.81737591401, 36722.0, 36787.0, 44603.77698111489, 45385.773071134434, 45658.315125272486, 46020.539794601624, 46281.768591156826, 34449.48325775166, 34489.827550862086, 34495.827520862236, 34804.65195348014, 35223.647763522036, 33640.66359336375, 34025.149371265914, 34122.48816267808, 34244.48633270553, 34505.0, 39498.60501395064, 40379.0, 40448.79775601221, 40461.79769101136, 40746.38880416737, 33584.83207583946, 33694.66305336915, 33895.66104338925, 34174.0, 34683.0, 24917.50164996726, 25167.0, 25221.243362699148, 25853.741462585134, 25963.61054584145], "value": 18301.915208931347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.8268860686097, 589.7493565234774, 595.934447210807, 603.7011679218788, 606.1634943777586, 23300.18449354273, 24007.51984960302, 24081.879590602046, 24107.517849642998, 24137.75862241377, 24271.514569708594, 25694.871525642346, 25825.87087064562, 25979.61030584538, 25998.22005339843, 6641.767538136154, 6810.727570897183, 6812.182538095435, 6815.795526134224, 6816.591004539719, 6546.149000629912, 6745.763898263562, 6762.019507171457, 6784.389404953553, 6850.1779786425695, 6696.296888826676, 6706.094677218562, 6727.394534491895, 6746.662666866661, 6751.25736169021, 6427.260865000515, 6607.570507917018, 6618.4705223582, 6644.800655980328, 6654.667266636673, 6178.227721534809, 6181.979973304445, 6184.855801676659, 6213.068039794022, 6215.28524219716, 30091.0, 30568.40168585673, 30599.235019124477, 30657.846710766527, 30669.386612267852, 2187.8796666183352, 2197.846150769447, 2207.6798864164607, 2211.4360837986374, 2218.8668679879097, 19354.903225483922, 20117.396478105682, 20286.594268114703, 20295.492612684655, 20302.69545956812, 2404.7956965769135, 2435.0503303711566, 2448.902043918259, 2484.0808900706675, 2490.651308816767, 136252.0, 142616.0, 151429.24285378613, 157119.0, 157904.99999999886, 15630.609234768994, 16083.828683127862, 16291.511254662379, 16335.59161020984, 16501.752473712902, 25184.74815251824, 25240.36899077501, 25262.242132736046, 25486.0, 25510.87244563765, 10868.663237403996, 10945.124390048777, 11060.281081729661, 11083.334999899871, 11219.1585631078, 10042.899571004342, 10073.1437827784, 10097.545610447547, 10161.390316581028, 10225.795484090277, 9652.561714368496, 9658.468784216795, 9762.411666516726, 9835.557399916877, 9996.400215987063, 2806.0880213930145, 2810.578413238031, 2871.425714857037, 2881.207667891305, 3008.217863355543, 1028.861103750984, 1039.1634734039171, 1048.3447845096814, 1049.2864851900629, 1054.6888667843004, 21116.260930867655, 21196.576068478545, 21270.255541055987, 21371.572568548854, 21734.45663858416, 1115.9776804463866, 1120.38938778366, 1121.0471099565304, 1121.5906194239208, 1130.8190689489643, 11506.827397589042, 11754.588589399329, 11863.525458981716, 11886.346250956107, 11920.821187682192, 580486.0, 599346.0, 600081.0, 620053.0, 638576.0, 116111.0, 119705.0, 120560.0, 121128.0, 122457.0, 1098.4672433869566, 1151.8963293303643, 1228.975420491603, 1236.437420973455, 1286.6847622332402, 21840.23559175421, 22253.55492890101, 22487.21294754676, 22585.887070564542, 22665.886670566542, 61309.693451532454, 61776.382236177065, 62450.68774656098, 64350.67824660847, 64522.67738661277, 67653.3234667647, 72076.27923720905, 76055.0, 76113.23886761062, 76812.61593691996, 15692.0, 15714.685706286038, 15744.212789360257, 15885.444009459614, 16052.1171335573, 20561.48596285105, 24621.50756984886, 24681.876590616932, 24852.37869053288, 25139.0, 16339.509814705578, 19228.230870765572, 19975.20099196016, 20169.697454538487, 20214.696779548023, 16405.343786248417, 16568.337266509203, 17412.91293543524, 18011.909940450212, 18289.908550457163, 20265.29071482491, 20279.4930126748, 20568.58862822705, 20602.381928541567, 20722.171113155306, 15404.15277159722, 15433.151176685391, 15439.536813895602, 15455.381784728484, 15625.68748625044, 15364.231788410758, 19660.0, 19692.212311507952, 20016.2994295199, 20089.899550502152], "value": 12728.827875601186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.2058606008513, 1482.2885015192714, 1500.0549653718156, 1501.4444655477475, 1502.7595584706442, 16244.0, 16928.0, 16989.06560139195, 17015.31938722451, 17024.23390947407, 16589.585260368465, 16628.66742665146, 16655.91672041641, 16737.0, 16799.916000420013, 2584.030988379358, 2588.2623452316093, 2638.4195476995033, 2645.5105805426056, 2650.9337266568295, 2782.8886844526296, 2808.5646724757594, 2814.5637426198973, 2817.3520090379225, 2829.193679801257, 2743.0810678422754, 2777.4583956128563, 2853.7146285371505, 2854.5147324954805, 2855.11491437655, 2408.8193385496156, 2411.686480757499, 2430.0158435833514, 2433.8174636902213, 2436.062116085302, 2690.125709144536, 2763.6269103671148, 2771.2240572639694, 2774.1954833098375, 2801.80387372884, 16504.587385315343, 16591.41930032443, 16598.170091495496, 16613.0, 16676.58308542296, 8407.369447291478, 8708.912910870873, 8712.912870871336, 8714.825703485894, 8744.344174186961, 5522.530584900288, 5711.343195532484, 5766.538676905838, 5861.677607731573, 5877.030290002144, 1985.3746069987908, 2019.8586098973078, 2044.6830741235133, 2068.9275875344442, 2074.408793493847, 30032.099037028926, 30061.849690751624, 30282.84858575715, 30297.848510757307, 30306.545401818992, 6933.861322773516, 7085.114360704912, 7124.964375178195, 7132.4294056475355, 7144.8928266076055, 19519.121639526256, 19525.316613918443, 19533.023348832503, 19542.9251391172, 19689.310874119623, 7797.610119494116, 8313.542755148525, 8331.416800824005, 8332.70835520766, 8335.708250211213, 7571.3564347031115, 7628.466007379541, 7628.504147230412, 7745.8450830983065, 7810.648520816577, 5445.727713614304, 5553.944460555424, 5573.359063707644, 5604.3835178130375, 5675.971620141955, 1606.8232494425604, 1611.0575313441534, 1619.7813295205233, 1657.3287818433553, 1662.401535447238, 983.8376667849868, 998.6005597760809, 998.650472334677, 1018.7707765752647, 1021.1065317846884, 8683.218510333974, 8790.340724445565, 8843.60203790831, 8901.866472002925, 8911.108889111038, 792.1998781230998, 806.4032615864219, 809.7327881798992, 813.9743922657376, 816.0207750699185, 5316.813911513079, 5866.472017518444, 5954.732037058343, 5993.820185394445, 6147.108669242934, 23978.28065158048, 24829.25512234636, 24867.129650462146, 24922.626160607604, 25243.368915777253, 23906.880465597907, 24173.7582624175, 24497.14260000927, 24713.629295560582, 24721.87639061793, 12449.502019919102, 12554.309512976874, 12584.4337004835, 12592.81110783339, 12699.492020319083, 8796.252318552995, 9523.142917137491, 9580.281478888972, 9730.12428881404, 9776.413415195111, 20804.895975520027, 20814.479638009172, 21106.894465527574, 21127.154913803275, 21213.939303034476, 21450.03474843667, 21512.892435537724, 21549.24577639775, 21624.67562986525, 21729.565408691422, 11356.602518911799, 11591.594294199662, 11593.304401735923, 11605.187636865337, 11621.59324423675, 15262.847371526143, 15492.0, 15711.135887526296, 15719.68560628804, 15724.921375393049, 12549.372531373212, 12606.49574017029, 12900.161489503153, 12921.160124591872, 13059.542915997894, 12484.750304994031, 12650.493980241055, 12704.936475317934, 12815.359232038547, 12950.287734174712, 11158.218924675195, 11255.268407553483, 11294.096472282363, 11324.830127547928, 11332.716682083013, 8221.30118939873, 8319.459235149696, 8436.198561136682, 8462.957685211535, 8494.915050849413, 8249.0, 8320.625571849161, 8429.0, 8431.19903609156, 8513.0], "value": 7202.8074463974945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5807985930694, 566.9716514174291, 573.9767320196305, 583.6818933681145, 586.0886321769647, 6231.252249730033, 6249.250089989202, 6321.52588555859, 6326.019466982613, 6372.367750382284, 6093.238345206849, 6111.7249723762425, 6164.075388691687, 6173.845653858656, 6209.316975132731, 4919.975400123012, 5012.874678133057, 5104.8979020419565, 5125.564327032188, 5147.584414286073, 4968.875778105558, 5011.3485246918035, 5040.2439634055, 5049.091163590552, 5054.545090941814, 4948.257761335793, 4950.9504904950845, 4974.850754477371, 4995.175795993657, 5028.4971502849785, 4938.703677779345, 4942.0, 4984.800607975677, 5008.974955125201, 5012.172991456406, 4563.247064234397, 4565.885852853672, 4576.771161441948, 4588.4035075440315, 4594.333821595883, 5981.162637230791, 6093.207882975229, 6120.877582448326, 6185.103160041814, 6198.287196972361, 5701.344345400291, 5754.79858204965, 5789.334226563957, 5840.269966254218, 5842.444967728059, 6598.670066496704, 6616.213622321994, 6624.205095388536, 6639.867202655968, 6658.434033107192, 4818.397700287464, 5033.270175824521, 5039.395272567279, 5039.420466646346, 5052.444231134572, 6753.0, 6771.1874575050815, 6859.416949559293, 6934.167899851999, 6973.616451095188, 5181.896362072737, 5185.351831021122, 5187.0, 5194.428612852583, 5194.714290713971, 5233.476652334736, 5246.3704355477585, 5254.632175747661, 5258.894822103536, 5264.999300265951, 5767.8558036049435, 5816.82549523515, 5819.359870414251, 5819.6508209507565, 5844.035734103911, 6638.203415590064, 6675.165604299463, 6707.128073350434, 6709.0, 6722.495812814059, 1800.540862080161, 1817.0642119308566, 1821.3443160462223, 1826.9451916442529, 1830.1398342778873, 1225.8109633655517, 1270.4981532294692, 1276.183242724657, 1288.15625765124, 1303.276681441809, 6043.8791224175275, 6046.3349031606485, 6046.637201767908, 6073.635581865014, 6122.653016336399, 6709.329067093349, 6765.966170169216, 6782.898256526156, 6784.270011147225, 6785.728570857111, 5834.679092649945, 5991.4907232884825, 6023.789167379121, 6043.244594425697, 6077.544184186204, 3453.533772940671, 3532.62227731185, 3546.131197856542, 3553.1117220694828, 3564.376234159012, 6830.624315662686, 6831.11195544586, 6905.240423553405, 6907.620080895498, 6908.965455172692, 6775.288594697486, 6803.557768745016, 6847.370893426492, 6862.759803406957, 6870.175578930461, 6840.213375461885, 6845.760398386132, 6900.307790702371, 6910.896336554855, 6937.687804048729, 6399.744010239725, 6601.636909969998, 6602.372774586406, 6708.664566771544, 6723.663816809238, 6467.159269294962, 6499.480041596756, 6521.510886683613, 6573.441257492976, 6681.730471210454, 6748.831279218059, 6756.054152418764, 6841.0, 6850.588964662136, 6909.827254318682, 5120.871978200575, 5140.0, 5143.177091665316, 5162.122439185272, 5180.352455943007, 6530.608163510205, 6733.158355205599, 6772.796816095525, 6820.215675197416, 6856.314368563104, 6351.809445716636, 6432.839179020562, 6475.935240647722, 6514.641694706647, 6520.836979075371, 6437.103303513344, 6449.451796597342, 6464.353564643498, 6482.254540727688, 6572.737090516326, 6363.409147713071, 6376.171097757262, 6404.871902562016, 6429.7106630200815, 6448.000559913221, 6519.217693876765, 6542.182227221598, 6602.570832895846, 6604.471642268511, 6605.900911486236, 6333.1766870306565, 6400.519961003037, 6412.743490260524, 6434.0, 6466.482681385383], "value": 5146.454567997896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.4634778792832, 959.1176117971465, 970.4419958523846, 975.6975337645335, 982.7543114221445, 18671.06644667766, 19406.90296548517, 22777.202797902075, 23590.46661966971, 23674.408139796513, 20741.481462963395, 21322.36032919015, 22287.888560557214, 22501.774982250172, 22590.43523911903, 1052.9105026072773, 1065.211743309953, 1067.3009178987775, 1067.9572817087308, 1068.102793653331, 942.2697409507653, 1041.416806588313, 1048.0933992096857, 1059.57087379611, 1069.620284798893, 1122.5453691255013, 1131.575659127827, 1131.8302254661826, 1132.162199972023, 1132.2696860524957, 1115.893990070942, 1118.7370967822555, 1119.748056687247, 1120.5349779841356, 1122.253701288642, 824.1058451580043, 825.9793505162359, 827.611022819274, 831.6049876308705, 832.8001279692891, 19311.03444827767, 19342.0, 19561.902190489098, 19669.11488982999, 20194.0, 23502.177423790257, 23573.0, 23791.405214869766, 23919.0, 23962.0, 18091.095445227686, 18209.27162913482, 18274.086295685163, 18317.908410457996, 18327.816721832743, 3931.429942658327, 4011.3180759270995, 4018.3972404139613, 4035.9192816143805, 4037.4953130858644, 155307.0, 158361.20819395944, 158603.99999999884, 159709.0, 161474.0, 17015.914920425566, 17061.0, 17091.4617684409, 17158.48524544266, 17199.0, 32031.199220019687, 32592.185195370304, 33663.4950475743, 33713.0, 34130.65869341324, 9371.812563748823, 9442.480663563432, 9490.240780737524, 9535.52322383878, 9538.284628652878, 4436.401085853368, 4456.977715111404, 4462.799174037111, 4493.101379724003, 4539.72761634303, 5939.970300148558, 6044.667543285162, 6052.213212282375, 6073.848153796191, 6084.726187321581, 1074.188987314588, 1104.8839871813343, 1117.5697356517799, 1119.468252580018, 1121.685927940178, 723.9022731931227, 748.6743266679013, 757.6817736550552, 770.1874522378832, 775.7517594369748, 12341.0, 13219.537316193888, 13543.119697219649, 13709.794353084711, 13786.586402407944, 740.1820987808502, 743.4684200796456, 745.1095940351228, 756.9583672897934, 757.7916073079947, 5997.970010149921, 6013.1581578579035, 6062.939370606326, 6115.357887421846, 6172.722227499773, 137866.0, 140554.0, 141387.0, 142053.0, 143107.0, 113715.431422844, 119333.40333298278, 120890.0, 122490.0, 123378.38310808389, 107347.0, 109355.45322273497, 109424.90575094306, 110826.0, 111724.0, 11373.772524549628, 11388.772224555296, 11513.539458421905, 11549.711257218636, 11783.351915644378, 55367.44632553784, 55433.0, 55916.44083559112, 55967.440325596224, 56723.432765671816, 69262.65368673124, 69290.0, 69477.0, 69695.65152174207, 70089.64955175192, 16332.183390830649, 16485.752713709542, 16552.0, 16703.164841758105, 16871.915640422212, 18304.26782928668, 18309.422644338916, 18624.44126676202, 18630.813691862906, 18782.248710051445, 16229.43196988147, 16312.918435407748, 16357.509274721777, 16387.508374748777, 16617.252223649724, 16397.344106236094, 16499.340026398808, 16559.668806624042, 16634.251458684146, 16727.66544669124, 16111.758323624921, 16122.0, 16232.513024609281, 16375.42686005984, 16402.589935251715, 12820.807687884502, 12939.741205175655, 12951.0, 12958.157719748186, 13097.279649619362, 12139.453724582238, 12375.319357435428, 12394.876051239373, 12547.43536540876, 12595.0], "value": 9737.2012494581, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1378.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 105.0, 105.0, 105.0, 108.0, 109.0, 108.0, 109.0, 106.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 111.0, 114.0, 113.0, 112.0, 112.0, 111.0, 114.0, 140.0], "value": 115.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 161.0, 161.0, 161.0, 161.0, 162.0, 165.0, 167.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 81.0, 74.0, 74.0, 73.0, 73.0, 73.0, 75.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 114.0, 109.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 155.0, 149.0, 151.0, 151.0, 149.0, 150.0, 150.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 44.0, 43.0, 49.0, 44.0, 53.0, 44.0, 42.0, 43.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 42.0, 38.0, 39.0, 38.0, 38.0, 40.0, 43.0, 42.0], "value": 39.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 71.0, 72.0, 70.0, 71.0, 73.0, 79.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 106.0, 112.0, 111.0, 113.0, 112.0, 109.0, 107.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 152.0, 148.0, 154.0, 158.0, 151.0, 151.0, 173.0, 168.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 65.0, 64.0, 61.0, 59.0, 59.0, 62.0, 61.0, 60.0], "value": 61.1, "unit": "score"}]}]} 22:00:56 INFO - Return code: 0 22:00:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:00:56 INFO - # TBPL SUCCESS # 22:00:56 INFO - Running post-action listener: _package_coverage_data 22:00:56 INFO - Running post-action listener: _resource_record_post_action 22:00:56 INFO - [mozharness: 2017-09-17 05:00:56.571422Z] Finished run-tests step (success) 22:00:56 INFO - Running post-run listener: _resource_record_post_run 22:00:56 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323940352; Read time: 24; Write time: 210716 22:00:56 INFO - TinderboxPrint: CPU usage
13.1% 22:00:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 22:00:56 INFO - TinderboxPrint: I/O write bytes / time
323,940,352 / 210,716 22:00:56 INFO - TinderboxPrint: CPU idle
8,207.4 (86.9%) 22:00:56 INFO - TinderboxPrint: CPU user
1,185.4 (12.6%) 22:00:56 INFO - TinderboxPrint: Swap in / out
0 / 0 22:00:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13049856; Read time: 0; Write time: 996 22:00:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:00:56 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310890496; Read time: 24; Write time: 209720 22:00:57 INFO - Running post-run listener: _upload_blobber_files 22:00:57 INFO - Blob upload gear active. 22:00:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:00:57 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 22:00:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:00:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:00:57 INFO - (blobuploader) - INFO - Open directory for files ... 22:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 22:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 22:00:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:58 INFO - (blobuploader) - INFO - Done attempting. 22:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:59 INFO - (blobuploader) - INFO - Done attempting. 22:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:01:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:07 INFO - (blobuploader) - INFO - Done attempting. 22:01:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 22:01:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 22:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:08 INFO - (blobuploader) - INFO - Done attempting. 22:01:08 INFO - (blobuploader) - INFO - Iteration through files over. 22:01:08 INFO - Return code: 0 22:01:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:01:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:01:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3dbee24126bc94bff82d605bf203440c54bd4a5da3274a61857c3fa67f579474bd71c703b0e67895d984eb52db3f475e41d27d7cc2675370734675c6547331", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7a205b022a521c7a04ef8b1858c7621e51cfe0ed1364829e701ee1f8a4de462e3a80388e19bcba94971e3495d09bf6b4abcf614c930251b104c8a4d538407c0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c57855880f47d1246b3bd1cf4a50e2eed5068e479ff61711ad46bc45c2e7a71d33f322baf5c8c9bf99635f41797201ae369c7755fa8baef2f9a92664c532ba5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4de58b139d2eddb1296503088219b864d6e0e5daec6324e7f69b3293491f61d15ec28b59ef0c4fdb30ae4fe745242c345142f7e119058b93cb2a7d2e95e9534"} 22:01:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:01:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:01:08 INFO - Contents: 22:01:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3dbee24126bc94bff82d605bf203440c54bd4a5da3274a61857c3fa67f579474bd71c703b0e67895d984eb52db3f475e41d27d7cc2675370734675c6547331", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7a205b022a521c7a04ef8b1858c7621e51cfe0ed1364829e701ee1f8a4de462e3a80388e19bcba94971e3495d09bf6b4abcf614c930251b104c8a4d538407c0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c57855880f47d1246b3bd1cf4a50e2eed5068e479ff61711ad46bc45c2e7a71d33f322baf5c8c9bf99635f41797201ae369c7755fa8baef2f9a92664c532ba5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4de58b139d2eddb1296503088219b864d6e0e5daec6324e7f69b3293491f61d15ec28b59ef0c4fdb30ae4fe745242c345142f7e119058b93cb2a7d2e95e9534"} 22:01:08 INFO - Running post-run listener: copy_logs_to_upload_dir 22:01:08 INFO - Copying logs to upload dir... 22:01:08 INFO - mkdir: /builds/slave/test/build/upload/logs 22:01:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.187605 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-16 22:01:08.083963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 22:01:08.087921) ========= 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=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3dbee24126bc94bff82d605bf203440c54bd4a5da3274a61857c3fa67f579474bd71c703b0e67895d984eb52db3f475e41d27d7cc2675370734675c6547331", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7a205b022a521c7a04ef8b1858c7621e51cfe0ed1364829e701ee1f8a4de462e3a80388e19bcba94971e3495d09bf6b4abcf614c930251b104c8a4d538407c0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c57855880f47d1246b3bd1cf4a50e2eed5068e479ff61711ad46bc45c2e7a71d33f322baf5c8c9bf99635f41797201ae369c7755fa8baef2f9a92664c532ba5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4de58b139d2eddb1296503088219b864d6e0e5daec6324e7f69b3293491f61d15ec28b59ef0c4fdb30ae4fe745242c345142f7e119058b93cb2a7d2e95e9534"} build_url:https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/GPt6YtBqSMKXuR3LJzkq-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa3dbee24126bc94bff82d605bf203440c54bd4a5da3274a61857c3fa67f579474bd71c703b0e67895d984eb52db3f475e41d27d7cc2675370734675c6547331", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7a205b022a521c7a04ef8b1858c7621e51cfe0ed1364829e701ee1f8a4de462e3a80388e19bcba94971e3495d09bf6b4abcf614c930251b104c8a4d538407c0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c57855880f47d1246b3bd1cf4a50e2eed5068e479ff61711ad46bc45c2e7a71d33f322baf5c8c9bf99635f41797201ae369c7755fa8baef2f9a92664c532ba5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4de58b139d2eddb1296503088219b864d6e0e5daec6324e7f69b3293491f61d15ec28b59ef0c4fdb30ae4fe745242c345142f7e119058b93cb2a7d2e95e9534"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 22:01:08.119990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 22:01:08.120346) ========= 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=930c87414c89fc706ee2024c000001c6-1505623127.387525-2033684843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 22:01:08.204723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 22:01:08.205076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 22:01:08.205563) ========= ========= Total master_lag: 0.20 =========