builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1505931330.99 results: success (0) revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:30.992935) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:30.993317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:30.993606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.011655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.012051) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 11:15:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.9M=0s 2017-09-20 11:15:31 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.148043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.148319) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015613 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.201754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.202101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --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 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e --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=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 11:15:31,253 truncating revision to first 12 chars 2017-09-20 11:15:31,253 Setting DEBUG logging. 2017-09-20 11:15:31,253 attempt 1/10 2017-09-20 11:15:31,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b5664b73b5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 11:15:31,603 unpacking tar archive at: mozilla-central-7b5664b73b5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.837805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.838081) ========= script_repo_revision: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.838434) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.838696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 11:15:31.851050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-20 11:15:31.851321) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:32 INFO - MultiFileLogger online at 20170920 11:15:32 in /builds/slave/test 11:15:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:15:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:32 INFO - {'append_to_log': False, 11:15:32 INFO - 'base_work_dir': '/builds/slave/test', 11:15:32 INFO - 'blob_upload_branch': 'Firefox', 11:15:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:32 INFO - 'branch': 'Firefox', 11:15:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:32 INFO - 'code_coverage': False, 11:15:32 INFO - 'config_files': ('talos/linux_config.py',), 11:15:32 INFO - 'default_actions': ('clobber', 11:15:32 INFO - 'read-buildbot-config', 11:15:32 INFO - 'download-and-extract', 11:15:32 INFO - 'populate-webroot', 11:15:32 INFO - 'create-virtualenv', 11:15:32 INFO - 'install', 11:15:32 INFO - 'setup-mitmproxy', 11:15:32 INFO - 'run-tests'), 11:15:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:32 INFO - 'disable_ccov_upload': False, 11:15:32 INFO - 'disable_stylo': False, 11:15:32 INFO - 'download_minidump_stackwalk': True, 11:15:32 INFO - 'download_symbols': 'ondemand', 11:15:32 INFO - 'enable_stylo': False, 11:15:32 INFO - 'enable_webrender': False, 11:15:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:15:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:32 INFO - 'gecko_profile': False, 11:15:32 INFO - 'gecko_profile_interval': 0, 11:15:32 INFO - 'installer_path': 'installer.exe', 11:15:32 INFO - 'log_level': 'info', 11:15:32 INFO - 'log_name': 'talos', 11:15:32 INFO - 'log_to_console': True, 11:15:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:32 INFO - 'opt_config_files': (), 11:15:32 INFO - 'pip_index': False, 11:15:32 INFO - 'suite': 'dromaeojs-e10s', 11:15:32 INFO - 'system_bits': '32', 11:15:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:32 INFO - 'title': 'talos-linux64-ix-089', 11:15:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:32 INFO - 'use_talos_json': True, 11:15:32 INFO - 'verify': 'False', 11:15:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:32 INFO - 'work_dir': 'build'} 11:15:32 INFO - [mozharness: 2017-09-20 18:15:32.050137Z] Running clobber step. 11:15:32 INFO - Running pre-action listener: _resource_record_pre_action 11:15:32 INFO - Running main action method: clobber 11:15:32 INFO - rmtree: /builds/slave/test/build 11:15:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:33 INFO - Running post-action listener: _resource_record_post_action 11:15:33 INFO - [mozharness: 2017-09-20 18:15:33.037100Z] Finished clobber step (success) 11:15:33 INFO - [mozharness: 2017-09-20 18:15:33.037197Z] Running read-buildbot-config step. 11:15:33 INFO - Running pre-action listener: _resource_record_pre_action 11:15:33 INFO - Running main action method: read_buildbot_config 11:15:33 INFO - Using buildbot properties: 11:15:33 INFO - { 11:15:33 INFO - "project": "", 11:15:33 INFO - "product": "firefox", 11:15:33 INFO - "who": "ffxbld@noreply.mozilla.org", 11:15:33 INFO - "installer_path": "public/build/target.tar.bz2", 11:15:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:15:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:15:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:15:33 INFO - "stage_platform": "linux64-qr", 11:15:33 INFO - "basedir": "/builds/slave/test", 11:15:33 INFO - "buildnumber": 67, 11:15:33 INFO - "platform": "ubuntu64_hw_qr", 11:15:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:15:33 INFO - "slavebuilddir": "test", 11:15:33 INFO - "taskId": "SEBzEY_aSDuMa_HS1ZGR6A", 11:15:33 INFO - "branch": "mozilla-central", 11:15:33 INFO - "script_repo_revision": "production", 11:15:33 INFO - "revision": "7b5664b73b5bc700ee5c4befb10cdce2d9cff47e", 11:15:33 INFO - "slavename": "talos-linux64-ix-089", 11:15:33 INFO - "repo_path": "mozilla-central" 11:15:33 INFO - } 11:15:33 INFO - Finding installer, test and symbols from parent task. 11:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SEBzEY_aSDuMa_HS1ZGR6A'}, attempt #1 11:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SEBzEY_aSDuMa_HS1ZGR6A'}, attempt #1 11:15:33 INFO - Task dependencies: UzMIpOnOQTif8CpcZmKnmA 11:15:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA'}, attempt #1 11:15:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 11:15:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.test_packages.json 11:15:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.crashreporter-symbols.zip 11:15:34 INFO - Running post-action listener: _resource_record_post_action 11:15:34 INFO - [mozharness: 2017-09-20 18:15:34.387230Z] Finished read-buildbot-config step (success) 11:15:34 INFO - [mozharness: 2017-09-20 18:15:34.387446Z] Running download-and-extract step. 11:15:34 INFO - Running pre-action listener: _resource_record_pre_action 11:15:34 INFO - Running main action method: download_and_extract 11:15:34 INFO - mkdir: /builds/slave/test/build/tests 11:15: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')]} 11:15:34 INFO - trying https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.test_packages.json 11:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:15:34 INFO - Downloaded 989 bytes. 11:15:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:15:34 INFO - Using the following test package requirements: 11:15:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:15:34 INFO - u'common': [u'target.common.tests.zip'], 11:15:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:15:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:15:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:15:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:15:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:15:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:15:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:15:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:15:34 INFO - u'target.web-platform.tests.tar.gz'], 11:15:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:15:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:15:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.common.tests.zip 11:15:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:34 INFO - Fetch https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.common.tests.zip into memory 11:15:36 INFO - Content-Length response header: 54731824 11:15:36 INFO - Bytes received: 54731824 11:15:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.talos.tests.zip 11:15:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:15:47 INFO - Fetch https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.talos.tests.zip into memory 11:15:47 INFO - Content-Length response header: 14508893 11:15:47 INFO - Bytes received: 14508893 11:15: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')]} 11:15:48 INFO - trying https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 11:15:48 INFO - Downloading https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:15:49 INFO - Downloaded 61522326 bytes. 11:15:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 11:15:49 INFO - mkdir: /builds/slave/test/properties 11:15:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:49 INFO - Contents: 11:15:49 INFO - build_url:https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 11:15:49 INFO - Running post-action listener: _resource_record_post_action 11:15:49 INFO - Running post-action listener: find_tests_for_verification 11:15:49 INFO - Running post-action listener: set_extra_try_arguments 11:15:49 INFO - [mozharness: 2017-09-20 18:15:49.306260Z] Finished download-and-extract step (success) 11:15:49 INFO - [mozharness: 2017-09-20 18:15:49.306397Z] Running populate-webroot step. 11:15:49 INFO - Running pre-action listener: _resource_record_pre_action 11:15:49 INFO - Running main action method: populate_webroot 11:15:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['tresize', 11:15:49 INFO - 'tcanvasmark']}, 11:15:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['dromaeo_css', 11:15:49 INFO - 'kraken']}, 11:15:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'tests': ['damp', 'tps']}, 11:15:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['damp', 'tps']}, 11:15:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['dromaeo_dom']}, 11:15:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:15:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['basic_compositor_video', 11:15:49 INFO - 'glvideo']}, 11:15:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['ts_paint_webext', 11:15:49 INFO - 'tp5o_webext']}, 11:15:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:49 INFO - 'ts_paint', 11:15:49 INFO - 'tpaint', 11:15:49 INFO - 'sessionrestore', 11:15:49 INFO - 'sessionrestore_many_windows', 11:15:49 INFO - 'sessionrestore_no_auto_restore', 11:15:49 INFO - 'tabpaint']}, 11:15:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['a11yr', 11:15:49 INFO - 'ts_paint', 11:15:49 INFO - 'tpaint', 11:15:49 INFO - 'sessionrestore', 11:15:49 INFO - 'sessionrestore_many_windows', 11:15:49 INFO - 'sessionrestore_no_auto_restore', 11:15:49 INFO - 'tabpaint']}, 11:15:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:15:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:15:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['perf_reftest_singletons']}, 11:15:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['bloom_basic']}, 11:15:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:49 INFO - 'tsvgr_opacity', 11:15:49 INFO - 'tart', 11:15:49 INFO - 'tscrollx', 11:15:49 INFO - 'tsvg_static']}, 11:15:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['tsvgx', 11:15:49 INFO - 'tsvgr_opacity', 11:15:49 INFO - 'tart', 11:15:49 INFO - 'tscrollx', 11:15:49 INFO - 'tsvg_static']}, 11:15:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:15:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo'], 11:15:49 INFO - 'tests': ['tp5o']}, 11:15:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:49 INFO - 'talos_options': ['--mitmproxy', 11:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:49 INFO - '--firstNonBlankPaint'], 11:15:49 INFO - 'tests': ['tp6_google', 11:15:49 INFO - 'tp6_youtube', 11:15:49 INFO - 'tp6_amazon', 11:15:49 INFO - 'tp6_facebook']}, 11:15:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo', 11:15:49 INFO - '--mitmproxy', 11:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:49 INFO - '--firstNonBlankPaint'], 11:15:49 INFO - 'tests': ['tp6_google', 11:15:49 INFO - 'tp6_youtube', 11:15:49 INFO - 'tp6_amazon', 11:15:49 INFO - 'tp6_facebook']}, 11:15:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:49 INFO - 'talos_options': ['--stylo-threads=1', 11:15:49 INFO - '--mitmproxy', 11:15:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:49 INFO - '--firstNonBlankPaint'], 11:15:49 INFO - 'tests': ['tp6_google', 11:15:49 INFO - 'tp6_youtube', 11:15:49 INFO - 'tp6_amazon', 11:15:49 INFO - 'tp6_facebook']}, 11:15:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--xperf_path', 11:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:49 INFO - 'tests': ['tp5n']}, 11:15:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:15:49 INFO - 'talos_options': ['--disable-stylo', 11:15:49 INFO - '--xperf_path', 11:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:49 INFO - 'tests': ['tp5n']}}} 11:15:49 INFO - Running post-action listener: _resource_record_post_action 11:15:49 INFO - [mozharness: 2017-09-20 18:15:49.323991Z] Finished populate-webroot step (success) 11:15:49 INFO - [mozharness: 2017-09-20 18:15:49.324081Z] Running create-virtualenv step. 11:15:49 INFO - Running pre-action listener: _resource_record_pre_action 11:15:49 INFO - Running main action method: create_virtualenv 11:15:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:15:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:15:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:50 INFO - Installing pip...............done. 11:15:50 INFO - Return code: 0 11:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:15:50 INFO - Reading from file tmpfile_stdout 11:15:50 INFO - Output received: 11:15:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:50 INFO - Using env: {'DISPLAY': ':0', 11:15:50 INFO - 'HOME': '/home/cltbld', 11:15:50 INFO - 'LANG': 'en_US.UTF-8', 11:15:50 INFO - 'LANGUAGE': 'en_US:en', 11:15:50 INFO - 'LOGNAME': 'cltbld', 11:15:50 INFO - 'MAIL': '/var/mail/cltbld', 11:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:50 INFO - 'MOZ_NO_REMOTE': '1', 11:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:50 INFO - 'NO_EM_RESTART': '1', 11:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:50 INFO - 'PWD': '/builds/slave/test', 11:15:50 INFO - 'SHELL': '/bin/bash', 11:15:50 INFO - 'SHLVL': '1', 11:15:50 INFO - 'TERM': 'linux', 11:15:50 INFO - 'TMOUT': '86400', 11:15:50 INFO - 'USER': 'cltbld', 11:15:50 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:50 INFO - '_': '/tools/buildbot/bin/python'} 11:15:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:15:52 INFO - Downloading/unpacking pip>=1.5 11:15:52 INFO - Running setup.py egg_info for package pip 11:15:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:52 INFO - Installing collected packages: pip 11:15:52 INFO - Found existing installation: pip 1.1 11:15:52 INFO - Uninstalling pip: 11:15:52 INFO - Successfully uninstalled pip 11:15:52 INFO - Running setup.py install for pip 11:15:52 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:52 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:15:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:15:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:15:52 INFO - Successfully installed pip 11:15:52 INFO - Cleaning up... 11:15:52 INFO - Return code: 0 11:15:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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 11:15: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 11:15:52 INFO - Using env: {'DISPLAY': ':0', 11:15:52 INFO - 'HOME': '/home/cltbld', 11:15:52 INFO - 'LANG': 'en_US.UTF-8', 11:15:52 INFO - 'LANGUAGE': 'en_US:en', 11:15:52 INFO - 'LOGNAME': 'cltbld', 11:15:52 INFO - 'MAIL': '/var/mail/cltbld', 11:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:52 INFO - 'MOZ_NO_REMOTE': '1', 11:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:52 INFO - 'NO_EM_RESTART': '1', 11:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:52 INFO - 'PWD': '/builds/slave/test', 11:15:52 INFO - 'SHELL': '/bin/bash', 11:15:52 INFO - 'SHLVL': '1', 11:15:52 INFO - 'TERM': 'linux', 11:15:52 INFO - 'TMOUT': '86400', 11:15:52 INFO - 'USER': 'cltbld', 11:15:52 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:52 INFO - '_': '/tools/buildbot/bin/python'} 11:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:53 INFO - Downloading/unpacking psutil>=3.1.1 11:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:54 INFO - Installing collected packages: psutil 11:15:54 INFO - Running setup.py install for psutil 11:15:54 INFO - building 'psutil._psutil_linux' extension 11:15:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:15: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:15:54 INFO - building 'psutil._psutil_posix' extension 11:15:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:15: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 11:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:54 INFO - Successfully installed psutil 11:15:54 INFO - Cleaning up... 11:15:54 INFO - Return code: 0 11:15:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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 11:15: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 11:15:54 INFO - Using env: {'DISPLAY': ':0', 11:15:54 INFO - 'HOME': '/home/cltbld', 11:15:54 INFO - 'LANG': 'en_US.UTF-8', 11:15:54 INFO - 'LANGUAGE': 'en_US:en', 11:15:54 INFO - 'LOGNAME': 'cltbld', 11:15:54 INFO - 'MAIL': '/var/mail/cltbld', 11:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:54 INFO - 'MOZ_NO_REMOTE': '1', 11:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:54 INFO - 'NO_EM_RESTART': '1', 11:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:54 INFO - 'PWD': '/builds/slave/test', 11:15:54 INFO - 'SHELL': '/bin/bash', 11:15:54 INFO - 'SHLVL': '1', 11:15:54 INFO - 'TERM': 'linux', 11:15:54 INFO - 'TMOUT': '86400', 11:15:54 INFO - 'USER': 'cltbld', 11:15:54 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:54 INFO - '_': '/tools/buildbot/bin/python'} 11:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:56 INFO - Installing collected packages: mozsystemmonitor 11:15:56 INFO - Running setup.py install for mozsystemmonitor 11:15:56 INFO - Successfully installed mozsystemmonitor 11:15:56 INFO - Cleaning up... 11:15:56 INFO - Return code: 0 11:15:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:15:56 INFO - Using env: {'DISPLAY': ':0', 11:15:56 INFO - 'HOME': '/home/cltbld', 11:15:56 INFO - 'LANG': 'en_US.UTF-8', 11:15:56 INFO - 'LANGUAGE': 'en_US:en', 11:15:56 INFO - 'LOGNAME': 'cltbld', 11:15:56 INFO - 'MAIL': '/var/mail/cltbld', 11:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:56 INFO - 'MOZ_NO_REMOTE': '1', 11:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:56 INFO - 'NO_EM_RESTART': '1', 11:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:56 INFO - 'PWD': '/builds/slave/test', 11:15:56 INFO - 'SHELL': '/bin/bash', 11:15:56 INFO - 'SHLVL': '1', 11:15:56 INFO - 'TERM': 'linux', 11:15:56 INFO - 'TMOUT': '86400', 11:15:56 INFO - 'USER': 'cltbld', 11:15:56 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:56 INFO - '_': '/tools/buildbot/bin/python'} 11:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:56 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:57 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:57 INFO - warning: no files found matching '*.txt' 11:15:57 INFO - no previously-included directories found matching 'build' 11:15:57 INFO - no previously-included directories found matching 'dist' 11:15:57 INFO - no previously-included directories found matching '.git*' 11:15:57 INFO - Installing collected packages: jsonschema, functools32 11:15:57 INFO - Running setup.py install for functools32 11:15:57 INFO - warning: no files found matching '*.txt' 11:15:57 INFO - no previously-included directories found matching 'build' 11:15:57 INFO - no previously-included directories found matching 'dist' 11:15:57 INFO - no previously-included directories found matching '.git*' 11:15:57 INFO - Successfully installed jsonschema functools32 11:15:57 INFO - Cleaning up... 11:15:58 INFO - Return code: 0 11:15:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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', '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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:15: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 functools32==3.2.3-2 11:15:58 INFO - Using env: {'DISPLAY': ':0', 11:15:58 INFO - 'HOME': '/home/cltbld', 11:15:58 INFO - 'LANG': 'en_US.UTF-8', 11:15:58 INFO - 'LANGUAGE': 'en_US:en', 11:15:58 INFO - 'LOGNAME': 'cltbld', 11:15:58 INFO - 'MAIL': '/var/mail/cltbld', 11:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:58 INFO - 'MOZ_NO_REMOTE': '1', 11:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:58 INFO - 'NO_EM_RESTART': '1', 11:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:58 INFO - 'PWD': '/builds/slave/test', 11:15:58 INFO - 'SHELL': '/bin/bash', 11:15:58 INFO - 'SHLVL': '1', 11:15:58 INFO - 'TERM': 'linux', 11:15:58 INFO - 'TMOUT': '86400', 11:15:58 INFO - 'USER': 'cltbld', 11:15:58 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:58 INFO - '_': '/tools/buildbot/bin/python'} 11:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:58 INFO - Cleaning up... 11:15:58 INFO - Return code: 0 11:15:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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', '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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:15: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 blobuploader==1.2.4 11:15:58 INFO - Using env: {'DISPLAY': ':0', 11:15:58 INFO - 'HOME': '/home/cltbld', 11:15:58 INFO - 'LANG': 'en_US.UTF-8', 11:15:58 INFO - 'LANGUAGE': 'en_US:en', 11:15:58 INFO - 'LOGNAME': 'cltbld', 11:15:58 INFO - 'MAIL': '/var/mail/cltbld', 11:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:58 INFO - 'MOZ_NO_REMOTE': '1', 11:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:58 INFO - 'NO_EM_RESTART': '1', 11:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:58 INFO - 'PWD': '/builds/slave/test', 11:15:58 INFO - 'SHELL': '/bin/bash', 11:15:58 INFO - 'SHLVL': '1', 11:15:58 INFO - 'TERM': 'linux', 11:15:58 INFO - 'TMOUT': '86400', 11:15:58 INFO - 'USER': 'cltbld', 11:15:58 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:58 INFO - '_': '/tools/buildbot/bin/python'} 11:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15: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 11:15: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 11:15: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 11:15: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 11:16:00 INFO - Downloading docopt-0.6.1.tar.gz 11:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:00 INFO - Running setup.py install for blobuploader 11:16:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:00 INFO - Running setup.py install for requests 11:16:00 INFO - Running setup.py install for docopt 11:16:00 INFO - Successfully installed blobuploader requests docopt 11:16:00 INFO - Cleaning up... 11:16:00 INFO - Return code: 0 11:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:00 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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:00 INFO - Using env: {'DISPLAY': ':0', 11:16:00 INFO - 'HOME': '/home/cltbld', 11:16:00 INFO - 'LANG': 'en_US.UTF-8', 11:16:00 INFO - 'LANGUAGE': 'en_US:en', 11:16:00 INFO - 'LOGNAME': 'cltbld', 11:16:00 INFO - 'MAIL': '/var/mail/cltbld', 11:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:00 INFO - 'MOZ_NO_REMOTE': '1', 11:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:00 INFO - 'NO_EM_RESTART': '1', 11:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:00 INFO - 'PWD': '/builds/slave/test', 11:16:00 INFO - 'SHELL': '/bin/bash', 11:16:00 INFO - 'SHLVL': '1', 11:16:00 INFO - 'TERM': 'linux', 11:16:00 INFO - 'TMOUT': '86400', 11:16:00 INFO - 'USER': 'cltbld', 11:16:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:00 INFO - '_': '/tools/buildbot/bin/python'} 11:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:00 INFO - Running setup.py (path:/tmp/pip-zw9Jgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:01 INFO - Running setup.py (path:/tmp/pip-ekDwiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:01 INFO - Running setup.py (path:/tmp/pip-DiS1l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:01 INFO - Running setup.py (path:/tmp/pip-l37cFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:01 INFO - Running setup.py (path:/tmp/pip-cu_MGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:01 INFO - Running setup.py (path:/tmp/pip-osmwMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:01 INFO - Running setup.py (path:/tmp/pip-7VQEvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:01 INFO - Running setup.py (path:/tmp/pip-BMQoGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:01 INFO - Running setup.py (path:/tmp/pip-EqEBVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:01 INFO - Running setup.py (path:/tmp/pip-DDz45W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:01 INFO - Running setup.py (path:/tmp/pip-OCl3fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:01 INFO - Running setup.py (path:/tmp/pip-drSCyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:01 INFO - Running setup.py (path:/tmp/pip-C2pU9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:01 INFO - Running setup.py (path:/tmp/pip-CXaOGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:01 INFO - Running setup.py (path:/tmp/pip-1ms2aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:01 INFO - Running setup.py (path:/tmp/pip-injrWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:02 INFO - Running setup.py (path:/tmp/pip-l2wHPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:02 INFO - Running setup.py install for manifestparser 11:16:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Running setup.py install for mozcrash 11:16:02 INFO - Running setup.py install for mozdebug 11:16:02 INFO - Running setup.py install for mozdevice 11:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Running setup.py install for mozfile 11:16:02 INFO - Running setup.py install for mozhttpd 11:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Running setup.py install for mozinfo 11:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Running setup.py install for mozInstall 11:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:02 INFO - Running setup.py install for mozleak 11:16:03 INFO - Running setup.py install for mozlog 11:16:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Running setup.py install for moznetwork 11:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Running setup.py install for mozprocess 11:16:03 INFO - Running setup.py install for mozprofile 11:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Running setup.py install for mozrunner 11:16:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Running setup.py install for mozscreenshot 11:16:03 INFO - Running setup.py install for moztest 11:16:03 INFO - Running setup.py install for mozversion 11:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:03 INFO - Cleaning up... 11:16:03 INFO - Return code: 0 11:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:03 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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:03 INFO - Using env: {'DISPLAY': ':0', 11:16:03 INFO - 'HOME': '/home/cltbld', 11:16:03 INFO - 'LANG': 'en_US.UTF-8', 11:16:03 INFO - 'LANGUAGE': 'en_US:en', 11:16:03 INFO - 'LOGNAME': 'cltbld', 11:16:03 INFO - 'MAIL': '/var/mail/cltbld', 11:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:03 INFO - 'MOZ_NO_REMOTE': '1', 11:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:03 INFO - 'NO_EM_RESTART': '1', 11:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:03 INFO - 'PWD': '/builds/slave/test', 11:16:03 INFO - 'SHELL': '/bin/bash', 11:16:03 INFO - 'SHLVL': '1', 11:16:03 INFO - 'TERM': 'linux', 11:16:03 INFO - 'TMOUT': '86400', 11:16:03 INFO - 'USER': 'cltbld', 11:16:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:03 INFO - '_': '/tools/buildbot/bin/python'} 11:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:04 INFO - Running setup.py (path:/tmp/pip-zdmIvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:04 INFO - Running setup.py (path:/tmp/pip-cbabl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:04 INFO - Running setup.py (path:/tmp/pip-AfId8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:04 INFO - Running setup.py (path:/tmp/pip-SM27gU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:04 INFO - Running setup.py (path:/tmp/pip-AeSM5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:04 INFO - Running setup.py (path:/tmp/pip-qyYVhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:04 INFO - Running setup.py (path:/tmp/pip-YRlQ5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:04 INFO - Running setup.py (path:/tmp/pip-lgIkMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:04 INFO - Running setup.py (path:/tmp/pip-PzhWE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:04 INFO - Running setup.py (path:/tmp/pip-vVTWgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:04 INFO - Running setup.py (path:/tmp/pip-SO9D6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:04 INFO - Running setup.py (path:/tmp/pip-g5TPGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:05 INFO - Running setup.py (path:/tmp/pip-ZGPCvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:05 INFO - Running setup.py (path:/tmp/pip-Poszuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:05 INFO - Running setup.py (path:/tmp/pip-qVyZnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:05 INFO - Running setup.py (path:/tmp/pip-MuonsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:05 INFO - Running setup.py (path:/tmp/pip-jYhgPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:16:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:06 INFO - Downloading blessings-1.6.tar.gz 11:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:06 INFO - Installing collected packages: blessings 11:16:06 INFO - Running setup.py install for blessings 11:16:06 INFO - Successfully installed blessings 11:16:06 INFO - Cleaning up... 11:16:06 INFO - Return code: 0 11:16:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:06 INFO - Reading from file tmpfile_stdout 11:16:06 INFO - Current package versions: 11:16:06 INFO - argparse == 1.2.1 11:16:06 INFO - blessings == 1.6 11:16:06 INFO - blobuploader == 1.2.4 11:16:06 INFO - docopt == 0.6.1 11:16:06 INFO - functools32 == 3.2.3-2 11:16:06 INFO - jsonschema == 2.5.1 11:16:06 INFO - manifestparser == 1.1 11:16:06 INFO - mozInstall == 1.13 11:16:06 INFO - mozcrash == 1.0 11:16:06 INFO - mozdebug == 0.1 11:16:06 INFO - mozdevice == 0.51 11:16:06 INFO - mozfile == 1.2 11:16:06 INFO - mozhttpd == 0.7 11:16:06 INFO - mozinfo == 0.10 11:16:06 INFO - mozleak == 0.1 11:16:06 INFO - mozlog == 3.5 11:16:06 INFO - moznetwork == 0.27 11:16:06 INFO - mozprocess == 0.25 11:16:06 INFO - mozprofile == 0.28 11:16:06 INFO - mozrunner == 6.13 11:16:06 INFO - mozscreenshot == 0.1 11:16:06 INFO - mozsystemmonitor == 0.3 11:16:06 INFO - moztest == 0.8 11:16:06 INFO - mozversion == 1.4 11:16:06 INFO - psutil == 3.1.1 11:16:06 INFO - requests == 1.2.3 11:16:06 INFO - wsgiref == 0.1.2 11:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:06 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 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:06 INFO - Using env: {'DISPLAY': ':0', 11:16:06 INFO - 'HOME': '/home/cltbld', 11:16:06 INFO - 'LANG': 'en_US.UTF-8', 11:16:06 INFO - 'LANGUAGE': 'en_US:en', 11:16:06 INFO - 'LOGNAME': 'cltbld', 11:16:06 INFO - 'MAIL': '/var/mail/cltbld', 11:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:06 INFO - 'MOZ_NO_REMOTE': '1', 11:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:06 INFO - 'NO_EM_RESTART': '1', 11:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:06 INFO - 'PWD': '/builds/slave/test', 11:16:06 INFO - 'SHELL': '/bin/bash', 11:16:06 INFO - 'SHLVL': '1', 11:16:06 INFO - 'TERM': 'linux', 11:16:06 INFO - 'TMOUT': '86400', 11:16:06 INFO - 'USER': 'cltbld', 11:16:06 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:06 INFO - '_': '/tools/buildbot/bin/python'} 11:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:16:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:16: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 11:16: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 11:16: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 11:16: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 11:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:08 INFO - Installing collected packages: simplejson 11:16:08 INFO - Running setup.py install for simplejson 11:16:08 INFO - building 'simplejson._speedups' extension 11:16:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:16:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:16:09 INFO - Successfully installed simplejson 11:16:09 INFO - Cleaning up... 11:16:09 INFO - Return code: 0 11:16:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14481f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1611a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, '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': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:16:09 INFO - Using env: {'DISPLAY': ':0', 11:16:09 INFO - 'HOME': '/home/cltbld', 11:16:09 INFO - 'LANG': 'en_US.UTF-8', 11:16:09 INFO - 'LANGUAGE': 'en_US:en', 11:16:09 INFO - 'LOGNAME': 'cltbld', 11:16:09 INFO - 'MAIL': '/var/mail/cltbld', 11:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:09 INFO - 'MOZ_NO_REMOTE': '1', 11:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:09 INFO - 'NO_EM_RESTART': '1', 11:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:09 INFO - 'PWD': '/builds/slave/test', 11:16:09 INFO - 'SHELL': '/bin/bash', 11:16:09 INFO - 'SHLVL': '1', 11:16:09 INFO - 'TERM': 'linux', 11:16:09 INFO - 'TMOUT': '86400', 11:16:09 INFO - 'USER': 'cltbld', 11:16:09 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:09 INFO - '_': '/tools/buildbot/bin/python'} 11:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:09 INFO - Cleaning up... 11:16:09 INFO - Return code: 0 11:16:09 INFO - Running post-action listener: _resource_record_post_action 11:16:09 INFO - Running post-action listener: _start_resource_monitoring 11:16:09 INFO - Starting resource monitoring. 11:16:09 INFO - [mozharness: 2017-09-20 18:16:09.632882Z] Finished create-virtualenv step (success) 11:16:09 INFO - [mozharness: 2017-09-20 18:16:09.633383Z] Running install step. 11:16:09 INFO - Running pre-action listener: _resource_record_pre_action 11:16:09 INFO - Running main action method: install 11:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:09 INFO - Reading from file tmpfile_stdout 11:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:09 INFO - Reading from file tmpfile_stdout 11:16:09 INFO - Output received: 11:16:09 INFO - Usage: mozinstall [options] installer 11:16:09 INFO - Options: 11:16:09 INFO - -h, --help show this help message and exit 11:16:09 INFO - -d DEST, --destination=DEST 11:16:09 INFO - Directory to install application into. [default: 11:16:09 INFO - "/builds/slave/test"] 11:16:09 INFO - --app=APP Application being installed. [default: firefox] 11:16:09 INFO - mkdir: /builds/slave/test/build/application 11:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:16:27 INFO - Reading from file tmpfile_stdout 11:16:27 INFO - Output received: 11:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:27 INFO - Running post-action listener: _resource_record_post_action 11:16:27 INFO - [mozharness: 2017-09-20 18:16:27.739838Z] Finished install step (success) 11:16:27 INFO - [mozharness: 2017-09-20 18:16:27.740087Z] Running setup-mitmproxy step. 11:16:27 INFO - Running pre-action listener: _resource_record_pre_action 11:16:27 INFO - Running main action method: setup_mitmproxy 11:16:27 INFO - Skipping: mitmproxy is not required 11:16:27 INFO - Running post-action listener: _resource_record_post_action 11:16:27 INFO - [mozharness: 2017-09-20 18:16:27.741207Z] Finished setup-mitmproxy step (success) 11:16:27 INFO - [mozharness: 2017-09-20 18:16:27.741428Z] Running run-tests step. 11:16:27 INFO - Running pre-action listener: _resource_record_pre_action 11:16:27 INFO - Running pre-action listener: _set_gcov_prefix 11:16:27 INFO - Running main action method: run_tests 11:16:27 WARNING - Try message not found. 11:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:27 INFO - Python 2.7.3 11:16:27 INFO - Return code: 0 11:16:27 INFO - grabbing minidump binary from tooltool 11:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:27 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 0x17b8090>, '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 0x17b8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:16:27 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:16:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:27 INFO - Return code: 0 11:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:27 INFO - ENV: RUST_BACKTRACE is now full 11:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:16:27 INFO - Using env: {'DISPLAY': ':0', 11:16:27 INFO - 'HOME': '/home/cltbld', 11:16:27 INFO - 'LANG': 'en_US.UTF-8', 11:16:27 INFO - 'LANGUAGE': 'en_US:en', 11:16:27 INFO - 'LOGNAME': 'cltbld', 11:16:27 INFO - 'MAIL': '/var/mail/cltbld', 11:16:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:27 INFO - 'MOZ_ACCELERATED': '1', 11:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:27 INFO - 'MOZ_NO_REMOTE': '1', 11:16:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:27 INFO - 'MOZ_WEBRENDER': '1', 11:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:27 INFO - 'NO_EM_RESTART': '1', 11:16:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:27 INFO - 'PWD': '/builds/slave/test', 11:16:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:27 INFO - 'RUST_BACKTRACE': 'full', 11:16:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:27 INFO - 'SHELL': '/bin/bash', 11:16:27 INFO - 'SHLVL': '1', 11:16:27 INFO - 'TERM': 'linux', 11:16:27 INFO - 'TMOUT': '86400', 11:16:27 INFO - 'USER': 'cltbld', 11:16:27 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:27 INFO - '_': '/tools/buildbot/bin/python'} 11:16:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:16:28 INFO - mozversion application_buildid: 20170920172637 11:16:28 INFO - mozversion application_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:16:28 INFO - mozversion application_display_name: Nightly 11:16:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:28 INFO - mozversion application_name: Firefox 11:16:28 INFO - mozversion application_remotingname: firefox 11:16:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:16:28 INFO - mozversion application_vendor: Mozilla 11:16:28 INFO - mozversion application_version: 57.0a1 11:16:28 INFO - mozversion platform_buildid: 20170920172637 11:16:28 INFO - mozversion platform_changeset: 7b5664b73b5bc700ee5c4befb10cdce2d9cff47e 11:16:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:16:28 INFO - mozversion platform_version: 57.0a1 11:16:28 INFO - using testdate: 1505931388 11:16:28 INFO - actual date: 1505931388 11:16:28 INFO - starting webserver on 'localhost:34178' 11:16:28 INFO - SUITE-START | Running 2 tests 11:16:28 INFO - TEST-START | dromaeo_css 11:16:28 INFO - Initialising browser for dromaeo_css test... 11:16:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34178/getInfo.html -profile /tmp/tmpj6pNCt/profile 11:16:28 INFO - TEST-INFO | started process 14544 (/builds/slave/test/build/application/firefox/firefox http://localhost:34178/getInfo.html) 11:16:35 INFO - TEST-INFO | 14544: exit 0 11:16:35 INFO - Browser initialized. 11:16:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:35 INFO - Using env: {'DISPLAY': ':0', 11:16:35 INFO - 'HOME': '/home/cltbld', 11:16:35 INFO - 'JSGC_DISABLE_POISONING': '1', 11:16:35 INFO - 'LANG': 'en_US.UTF-8', 11:16:35 INFO - 'LANGUAGE': 'en_US:en', 11:16:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:16:35 INFO - 'LOGNAME': 'cltbld', 11:16:35 INFO - 'MAIL': '/var/mail/cltbld', 11:16:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:35 INFO - 'MOZ_ACCELERATED': '1', 11:16:35 INFO - 'MOZ_CRASHREPORTER': '1', 11:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:16:35 INFO - 'MOZ_NO_REMOTE': '1', 11:16:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:35 INFO - 'MOZ_WEBRENDER': '1', 11:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:35 INFO - 'NO_EM_RESTART': '1', 11:16:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:35 INFO - 'PWD': '/builds/slave/test', 11:16:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:35 INFO - 'RUST_BACKTRACE': 'full', 11:16:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:35 INFO - 'SHELL': '/bin/bash', 11:16:35 INFO - 'SHLVL': '1', 11:16:35 INFO - 'TERM': 'linux', 11:16:35 INFO - 'TMOUT': '86400', 11:16:35 INFO - 'USER': 'cltbld', 11:16:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:35 INFO - '_': '/tools/buildbot/bin/python'} 11:16:35 INFO - TEST-INFO | started process 14788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6pNCt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:36 INFO - PID 14788 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:16:36 INFO - PID 14788 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:16:37 INFO - PID 14788 | 11:16:37 INFO - PID 14788 | (/builds/slave/test/build/application/firefox/firefox:14849): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:16:37 INFO - PID 14788 | 11:16:47 INFO - PID 14788 | RSS: Main: 199684096 11:16:47 INFO - PID 14788 | 11:19:44 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34178/tests/dromaeo/cssquery-ext.html) 11:19:46 INFO - PID 14788 | RSS: Main: 201228288 11:19:46 INFO - PID 14788 | 11:22:48 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-ext.html (next: http://localhost:34178/tests/dromaeo/cssquery-jquery.html) 11:22:49 INFO - PID 14788 | RSS: Main: 202993664 11:22:49 INFO - PID 14788 | 11:25:51 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34178/tests/dromaeo/cssquery-mootools.html) 11:25:52 INFO - PID 14788 | RSS: Main: 204460032 11:25:52 INFO - PID 14788 | 11:28:54 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34178/tests/dromaeo/cssquery-prototype.html) 11:28:54 INFO - PID 14788 | RSS: Main: 202539008 11:28:54 INFO - PID 14788 | 11:31:58 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34178/tests/dromaeo/cssquery-yui.html) 11:31:58 INFO - PID 14788 | RSS: Main: 203804672 11:31:58 INFO - PID 14788 | 11:35:00 INFO - PID 14788 | Cycle 1(1): loaded http://localhost:34178/tests/dromaeo/cssquery-yui.html (next: http://localhost:34178/tests/dromaeo/cssquery-dojo.html) 11:35:01 INFO - PID 14788 | RSS: Main: 209170432 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | __start_tp_report 11:35:01 INFO - PID 14788 | _x_x_mozilla_page_load 11:35:01 INFO - PID 14788 | _x_x_mozilla_page_load_details 11:35:01 INFO - PID 14788 | |i|pagename|runs| 11:35:01 INFO - PID 14788 | |0;dojo.html;3122.2818751687096;3141.7800753947226;3170.778045536812;3182.5226216067585;3217.6138863336405;6151.692415379224;6361.80914572563;6381.042843573467;6383.872322553552;6399.712012959416;6290.842728931779;6314.6842657867155;6318.431341179293;6334.493240540757;6338.397852204045;5788.102844059177;5801.709914504279;5809.941900580982;5865;5889.941100588982;5891.381404952483;5910.113482977545;5917.260342457193;5924.911126333109;5954.821355359324;5869.148973398855;5879.559033072515;5905.055191169414;5912.763489460416;5933.110033494967;5630.577706672016;5748.798792042258;5839.124131380327;5913.763449462016;5921.141434492018;5708.914366284509;5794.478496935254;5858.853528661775;5868.2664666916635;5873.324567674729;6221.87556248877;6241.407066328691;6295.338989406092;6327.367263273682;6370.299267080617;6545.836354091138;6604.3725846044545;6634.701438435282;6672.599644021374;6732.360425759545;6740.696668649874;6768.458523318172;6802.14973128359;6802.3537763912345;6982.511224214307;6314.336994615591;6392.073149393312;6408.519361047894;6409.294977552466;6410.743570257184;6913.066735990677;7017.578945263301;7059.364657180879;7105.573665580082;7125.18060423058;6413.4869210463985;6569.211694596679;6658.1344425224415;6683.164604424447;6693.866122677519;6796.218434880052;6824.590524568542;6858.3141685831015;6858.554193977376;6878.931210687829;6760.7295708172105;6782.152230971129;6834.384905358442;6858.279880612564;6872.725090996404;6787.151606049244;6799.762008329685;6836.555623884531;6854.383105520527;6862.553933994274;5233.842984710464;5270.156774915995;5280.1815718563685;5385.272988146628;5387.326584176978;4671.065786842645;4701.294805779092;4724.196886529298;4748.643851711066;4749.430068391815;5726.770929162787;5827.76688932438;5896.911546326808;5900.586958912921;5902.085176797603;6682.763688717506;6723.394894459522;6756.695948682321;6800.489963252776;6840.110785597841;5736.053551164011;5779.537636989031;5781.82654520365;5807.622504537191;5898.439648233411;5836;5850.0932355484965;5885.352611212763;5894.498967587718;5931.288245410578;6480.837979050467;6515.381038801306;6632.303608121174;6644.833879152963;6662;6826.795196144124;6835.897461537981;6918;6919.100516932766;6930.064441300461;6284.874302513833;6304.148939893239;6316.557840951089;6364.904526432015;6366.236051673829;6557.704903279268;6591.571547849375;6623.105880706235;6636.933630663631;6641.103451034049;6755;6843.794686159423;6867.244603093755;6898.206706228848;6923.099997000358;6586.703598338182;6591.439727623014;6640.701168447528;6663.633500157538;6690;6372.681365931592;6551.80344589663;6597.703103360264;6598.934010660024;6655.667216639245;6596.769113081019;6599.8020059398295;6612.966935165294;6627.4698024158915;6632.938729803208;6666.766663166766;6705.1283333166375;6709.7651582194385;6758.594484330956;6791.966040169767;6449.3873082057125;6467.61194328323;6495.870082598227;6544.9672751635935;6547.050677651619 11:35:01 INFO - PID 14788 | |1;ext.html;849.4308813095225;873.7815546113471;876.4215617692322;883.9160279773428;884.4162852517336;38310.23379532408;39345.213095738065;39812.40281395778;39839.60160398395;40062.39906401399;35192.82403587985;35606.10984725383;35629.2874142517;40282.79151625456;40684.79657601715;7721;7761.922380776205;7803.804904877366;7836.098848632423;7862.135165131831;7734.1492435832015;7801.063872335328;7805.492642978216;7863.370930325589;7864.803379915491;7829.099653539831;7864.646090925922;7867.331276841475;7887.684492620317;7900.565468899237;7833.804154896173;7841.059072911258;7868.803279917991;7869.881951770728;7875.094364148139;7576.128745194318;7605.353544948686;7649.196834332426;7650.043744531934;7665.271799179069;36525.45211821825;36720.16399180057;36949.63050369489;36984.815075924445;36992.44511332332;3522.788632682047;3529.699975502085;3557.4485954677066;3561.3233485637647;3573.5711714594154;30327.69672303293;30453.39093218123;30476.54285185724;30523;30553.541696874563;5026.195808670632;5171.3535808024;5215.452377500345;5234.345706786652;5312.548433383167;180595;184702.99999999866;189460;189540;190179;44334;44433.111337773065;44517.332240016425;44669.55330446654;44745;45314;45429;45886.082278354916;46103.07793844104;46339.768301158954;14204.360803763855;14251.358688859027;14252.786208206886;14330.57008289753;14365;11966.700832479257;11982.700432489084;11993.760124797454;11998.460069296903;12004.579839705568;11722.413879306001;11747.236429632047;11753.353565553805;11754.177207595387;11929.343886086175;4937.950620493821;4943.629227807929;5106.055379754757;5115.948840511547;5176.818811341585;975.3903810118676;1012.7366884609908;1027.1320733979924;1028.3315844701003;1037.906588407047;22206.66689999651;22755.431114222276;22878.084876605084;22902.885485572464;22950.819672131107;1102.6581759654532;1120.9551617935354;1122.4668282565715;1128.1989787251143;1136.7953768321615;11986.52053917851;12108.515659373703;12123.211991220542;12206.206596571194;12213;229999;230870;231372;231383;232284;49200.50799491959;49232.753836231306;49258;49301.26048109281;49439;1427.5289154578963;1460.0582624207327;1470.3016067368128;1472.639203395175;1474.7345477814097;21970.560588788456;22064;22416.663750043437;22429.43926401853;22612.321630351114;35488.64511354853;35494.822525887204;35666.85998840078;35710;35727.82136089303;191349;192371.03814480838;192524;193016;193529;28426.57360139641;28463.857680711462;31231.687683123786;31386.529202062444;31404;39701.213445394445;40142.598574013886;40287.597124029555;40429.39355909605;41207.1758564833;29239.70760292455;29668.55497167501;29826.10521684353;29842.70157298399;30188.245293866952;29648;29669;29921;30012;30342.393152137276;32828;32920.506192407614;33015;33163.336733265685;33470;28819.567706484;29139.562906555995;29228;29349.55975660324;29849.850750746107;22033.77966220317;22353.888230558743;22470.550588988455;22578.322650320515;22878.199263025715 11:35:01 INFO - PID 14788 | |2;jquery.html;564.4017341617886;571.6227289988603;577.9335376431711;600.9068594367873;604.5526310530207;22309.44226394339;23049.654255186164;23068.65397019042;23183.420414489647;23183.420414489647;23666.290011299647;24120.75879241207;24747.876260618672;24972.625410618853;25179.49641007183;6358.078078678589;6477.708503117347;6538.803835884931;6540.345965403445;6551.344865513434;6484.221893372802;6552.868942621145;6619.569727967691;6619.966900165492;6622.072909792633;6358.173437453124;6565.770198043046;6584.045313429549;6588.93411065888;6603.174603174603;6532.11816404784;6543.770968016121;6572.178477690289;6584.242812076601;6589.637569933628;5962.642241465526;6049.939500604982;6090.725917333731;6109.327973922865;6186.721597528122;28804.8559757202;28896;29217.70782292171;29223.56164657532;29233.41533169346;2036.4094412620323;2059.6086743518686;2060.6393881070753;2068.4208421641965;2074.979250207494;18657.160427780782;19072.71390929137;19559.413217603495;20112;20151.99240038007;2423.8060955123547;2477.071098338123;2495.625656151574;2503.4492411669585;2511.2215213283757;120974.39512802468;126635;128427;133193.3340333292;139342.30328848393;14290.993610627502;14826.323493413192;14876.256187190596;14946.28117766449;15018.624534386508;22328.21851235199;22600.095996160297;22651.320460386214;22652.773472265395;22666.433339166324;10161.593536258466;10237.897621023843;10238.12975897057;10288.639897603547;10338.431386273827;9500.762480937894;9525.5713492893;9592.760180995392;9733.2213422926;9800.215982721365;8762.824743505222;9074.773130671654;9103;9111.68109116191;9261.583228754722;2604.6744156980376;2623.788818945603;2658.2025392382207;2661.5475369187284;2711.959320610192;943.556528431636;963.9180669643018;974.2303580171586;974.3439334662353;977.3402953006693;19350.61298774045;19573.706394404096;19620;20069.29757458511;20524.486887827625;1035.6064695415844;1045.0646671229358;1045.289203341735;1049.6588608702202;1051.1380667852288;10618.203634727426;10968.451577421098;11000.614978475714;11009.724756880982;11156.219064665396;471844;477021;486849;520190;533806;109660.451697741;111531;112473;114324;117056;1169.818678104878;1179.9764004719857;1189.8750631183775;1190.7320852808223;1198.3349241171059;17538.649227015645;17625;17782.110894454967;17947.820521795136;18073.638527229647;55988.16017759818;56233.71883140558;56281.43718562762;57071.14393284021;57681.711591443454;71700;72884.27115728987;72885.27114728784;73722.63138684272;74225;14189.858101418853;14379.64050898694;14441.350139243548;14518;14626.85373146255;23101.537969240857;23260.185893493646;23298.883505582362;23454.530909381374;23938.40153996164;18319.54201144982;18419.263229471206;18495.815041849408;18522.351717689817;18615.90692046531;16186.67626647484;16215.270312835715;16284.43004494837;16843.663126737152;17090.40183593568;17951.551211219303;18143.455696329132;18678.81321186825;18797.342093027226;18834;13946.860531394555;14022;14071.155730656194;14155.504557340444;14178.43286268579;18104;18118.728219076987;18274.45176644703;18295.54261143482;18550.257989680802 11:35:01 INFO - PID 14788 | |3;mootools.html;1314.1458052266025;1369.2332293915408;1379.3517046987918;1380.9102408343451;1382.785668221426;15113.773293400594;15636;15643.530694079167;15644.921775391107;15659.686806263868;15426.074435533876;15632.2965466554;15663.765043524356;15673.373065077383;15773.211339433012;2709.91870243893;2819.6334476518023;2849.8147620404607;2870.8708108135183;2881.366099458116;2751.2296556963984;2793.2877116335308;2803.3272014716526;2813.606095146681;2816.3663175785387;2724.5640697488407;2797.8181418207855;2800.2019424464033;2801.1596521043707;2801.3696918193446;2687.0863906271866;2717.9320516987036;2721.4012917158193;2722.169738229839;2730.194592595179;2681.919542413711;2693.124734461308;2697.1773609049233;2714.864256787153;2714.9457010859674;14613.196274204915;15010.549683509513;15103.773443398359;15139.621509462242;15144.621384465367;7987.440879138463;8310.958445207736;8330.166983301682;8338.416310858242;8362.749117526484;5552.750126244328;5624.128260119647;5714.314282286111;5764.682942438164;5788.739506722165;1846.22458567402;1874.8875067495858;1910.3313840155972;1953.3846838245906;1961.8136277053657;25788.355291117685;25955.091571794896;26109.608355874676;26162.345941351618;26192.34519137037;6945.0971373721095;6966.756163534252;6985.336393042653;7134.322239387354;7147.1780745214965;16990.32038718462;17041.7443738344;17070.658586828195;17184.226709798088;17190.828091719173;7820.178881217504;7909.367250619936;7991.400644951652;8019.919800802034;8026.277635012877;5938.8812223755285;6620.503462240351;6652;7208.855822883513;7322.377597904131;5234.162533994542;5439.48324909133;5452.454754524595;5467.234587157801;5489.368722596872;1531.7855500229978;1578.8657964073182;1581.1066747287746;1593.6334643031935;1607.7588361745832;877.8112705768291;882.1266945723687;902.9277657787361;913.6710784117712;918.1231923513029;7458.067741532309;7528.849423011509;7601.543907365465;7659.234076592296;8617.870731939025;696.9860602788017;715.3883429667663;719.4675939804507;720.2977097330062;723.2008630463367;5220.243064755665;5485.451454854483;5512.062949298629;5525.889482210333;5654.6324488908085;21071.157153713986;22225.888870555544;22458.438539036655;22475.21336753206;22498.77501224967;20730.170793168407;21558.029888655048;21645.13419463204;21819.563608728055;21831.563368732855;11275.436228188557;11512.481938312796;11540.24988375753;11605;11630.418479076012;8611.13888611134;8634;8666.739997800076;8670.26302764272;8682.34882383811;17961.281548738425;18155.909220453814;18252;18559.25762969466;18685;19120.470362371256;19175.232990680215;19269.61460770805;19693.507662308555;19790.802091978894;11159.88840111621;11197.72005699864;11198.10415166801;11217.383043932661;11236.719082023015;13783.793243101562;13887.861121388656;13927.791083133963;13965.930170349084;14040.1575905446;11091.223614347242;11507.654770356903;11705.941470292593;11758.764824703629;11836.349000804694;11108.000279974842;11138.053265472201;11193.384363859741;11230.101591872794;11344.659660210207;10006;10085.193184545073;10124.898751012395;10144.188464922936;10231.795364092824;6992.720291188295;6996.930030699831;7047.330503602149;7087.964560177166;7248.927510725036;6982.965085174542;7105.609191494517;7128.821779455555;7163.3552980232025;7308.342249197598 11:35:01 INFO - PID 14788 | |4;prototype.html;509.01147993852334;532.254843219493;532.5423172060939;533.1868899927609;535.8446050645313;6327.860985022694;6414.294427612959;6422.646754428504;6429.228492580891;6434.678266086695;6227.564070515065;6236.0401145272735;6275.4038366355235;6347.333529979355;6374.374534493709;5234.398044224925;5243.86890327741;5246.029484545362;5292.444293349201;5299.761510732007;5221;5238.947610523884;5252.159654455288;5283;5344.305240318772;4834.564889159975;5007.574356179729;5020.272060551236;5081;5113.951639913808;5036.874078148039;5054.898902021976;5054.974725126388;5060.620453465986;5091.974540127276;4501.257292546726;4508.45898492183;4512.977435112836;4518.52555481673;4518.599234237364;6110.297315808694;6122.234720659918;6211.3167551569295;6233.937660623381;6245.313015568284;5751.3831206800805;5761.423857614247;5767.798127065575;5791.82624521265;5810.6513609183585;6575.539712220147;6594.868102637968;6600.867982640369;6692.732290708414;6697.799066028027;4892.437369702494;4896.975515122437;4910.754462276872;4932.926006109911;4947.975260123676;6718.664066796689;6745.831354216184;6879.759208427731;6931.618760968145;6968.860622787516;4995.600351971833;5059.97470012655;5071.644984851099;5077.796888124508;5088.084144853962;5076.289319495199;5091.301610146555;5091.847244582668;5098.4646612105935;5139.614528910347;5687.374388817227;5701.686407247558;5712.143178523172;5736.741846616912;5758;6659.300773418721;6660.400563949268;6664.200295964419;6678.165229346332;6740.62926539045;1761.779777527809;1773.5388798912375;1776.9466915992282;1779.919903604341;1788.374069075839;1165.9650210493699;1199.4302706214653;1208.6192849252457;1244.1601918705019;1250.8242252282826;5690.772369105272;5692.288463942007;5745.540356771448;5777.653340799566;5795.623284486495;6719.428848547928;6726.596404215763;6730.663466826737;6766.458683305324;6798.5241033128195;5639.887202255932;5693.231413759089;5708.686022268815;5728.198052272685;5733.598648094677;3471.2016236265295;3476.617572067071;3507.9123021924656;3516.6659167379057;3535.964640353615;6244.781432649836;6300.401461861115;6371;6383.4574061204385;6418.1656384669695;6511.544191906521;6882.449404047664;6914.204866440323;6919.097248256669;6946.861062778716;6342.636333188294;6378.425941665179;6408.58344207625;6452.870942581122;6477.190351206099;6531.510136739668;6633.209033560815;6800.727970881109;6819.420349270367;6849.863002739818;6632.933670663425;6729.192496900403;6744.62904540255;6756.29058948823;6777.356151165632;6302.054691796267;6458.418742313214;6487.805365839033;6523.206118317501;6535.3137920517665;4958.752062396938;4976.576990955809;5019.996000799928;5039;5043.798248070036;6475.417212450902;6694.464442844658;6754.763583274562;6755.594664320157;6755.898661520179;6317.178766760292;6422.32565580626;6506.02409638558;6540.789953858552;6551.80344589663;6528.2492513359675;6569.605823650596;6616.437602803623;6617.801465955837;6652.90020649681;6474.2160870826;6523.902141467787;6529.902051469327;6572.244191917991;6579.039432255408;6525.477961762953;6621.635810030494;6627;6633.1376920999965;6718.8320291993095;6449.6130232186215;6472.611643301417;6498.122753428227;6534;6557.639329836714 11:35:01 INFO - PID 14788 | |5;yui.html;875.5315905990288;898.7438580004699;911.1389736698818;922.1424075609681;928.3084102343755;19209.807901920976;19805.60388792227;19808.40574782759;20068.498287542818;20103.095360708765;16863.494095177164;17195.140242987833;17213.22540485678;19210.231590736388;19285.807141928577;953.637617705271;954.6610953111649;954.6897258391016;956.7703751099756;957.2342126298968;972.6255391674221;974.9658761943333;982.1111893736145;982.4056445850265;991.4646091110792;989.302541708094;1008.5894711639188;1038.2991480750463;1041.3335465302212;1045.252644359283;1026.1739299863607;1032.5766435761377;1032.757302034025;1034.0228484082545;1035.9067683908484;724.8332883436839;736.3520102309986;755.029786724057;755.7657126290812;759.9924000759977;20428.387148385573;20431.8978405107;20506;20689.68965465519;20691.689624655643;21681.67477487839;21862.23482178132;22708.205212817473;22712.43218919524;22973.08107675691;16498;16955.491335259838;17097.914510427367;17167.570810729707;17236.56908577283;3770.8868733938025;3800.1259710266795;3802.068493219151;3802.125511132455;3803.2583646189005;136083;137676.31161844128;139745;139769.3011534946;140262.99999999898;16776.748348774778;16991;17090.316387344617;17110.315587376615;17139.74290385645;31411.37177256488;31433;31716.682833171835;32042.839785800923;32055.839720801247;8514.616842242114;8536.786580335542;8585.914140858637;8608.09614990417;8619.1811777881;4046.393041043867;4089.8568550100604;4104.138130992525;4122.154958233555;4124.175164967019;5429.131338985743;5519.834404967857;5593.188987596775;5598.104303311532;5618.634788738719;1008.3798463944621;1040.4705083527203;1050.4170185547096;1060.660588611637;1060.8037513060108;664.9235337936102;684.8561802021532;689.9965500172567;702.1749444402807;711.1572786248312;11942.104342174373;11989.160758746804;12175.512979480722;12226.877731222574;12410.627681169579;680.4624346766099;690.927452617478;696.9163700355888;702.9015937768717;716.451914285572;5271.314729085271;5374.381946076173;5465.606270401022;5479.643823151482;5535.58483113768;123756;124315.37842310911;124488;125294;125526;107897.4605126985;111066;113871;114317.4284128574;114403;94481;94899.52550237205;96862;97754.51122744483;98183.50908245413;10285;10318.380897146195;10361.792764144524;10396.532156053147;10453.111485523816;45659.771701142614;46009;46541.53458465372;47846.76076619595;47955;59767.40232597618;60249.69875150596;60825.39174608197;61347.44331524667;62247;15327.46353877609;15590.14254216029;15663.216839158224;15707.214639268219;16048.67902641964;17745.645087098444;17838.91080544589;17861.464156075337;17877.73183402224;18130.45608631743;15704.60738481547;15812.367505299659;15870.20648967524;15952.282147303167;16012.839871601134;15626.843731562994;15876.2061896907;16010.599735006717;16074.598135046717;16244.3502259913;15287.923560382127;15436.768448473058;15502.069875807487;15596.766048509508;15660.686786263983;11581.189316747746;11693.590724324607;11975.041996640073;11975.76048479043;11980.940095299467;11102;11118.888811112109;11261.831072533754;11288.49201785938;11395.259308144945 11:35:01 INFO - PID 14788 | __end_tp_report 11:35:01 INFO - PID 14788 | __start_cc_report 11:35:01 INFO - PID 14788 | _x_x_mozilla_cycle_collect,264 11:35:01 INFO - PID 14788 | __end_cc_report 11:35:01 INFO - PID 14788 | __startTimestamp1505932501007__endTimestamp 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | ------- Summary: start ------- 11:35:01 INFO - PID 14788 | Number of tests: 6 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#0] dojo.html Cycles:165 Average:6242.47 Median:6449.39 stddev:747.82 (11.6%) stddev-sans-first:708.92 11:35:01 INFO - PID 14788 | Values: 3122.3 3141.8 3170.8 3182.5 3217.6 6151.7 6361.8 6381.0 6383.9 6399.7 6290.8 6314.7 6318.4 6334.5 6338.4 5788.1 5801.7 5809.9 5865.0 5889.9 5891.4 5910.1 5917.3 5924.9 5954.8 5869.1 5879.6 5905.1 5912.8 5933.1 5630.6 5748.8 5839.1 5913.8 5921.1 5708.9 5794.5 5858.9 5868.3 5873.3 6221.9 6241.4 6295.3 6327.4 6370.3 6545.8 6604.4 6634.7 6672.6 6732.4 6740.7 6768.5 6802.1 6802.4 6982.5 6314.3 6392.1 6408.5 6409.3 6410.7 6913.1 7017.6 7059.4 7105.6 7125.2 6413.5 6569.2 6658.1 6683.2 6693.9 6796.2 6824.6 6858.3 6858.6 6878.9 6760.7 6782.2 6834.4 6858.3 6872.7 6787.2 6799.8 6836.6 6854.4 6862.6 5233.8 5270.2 5280.2 5385.3 5387.3 4671.1 4701.3 4724.2 4748.6 4749.4 5726.8 5827.8 5896.9 5900.6 5902.1 6682.8 6723.4 6756.7 6800.5 6840.1 5736.1 5779.5 5781.8 5807.6 5898.4 5836.0 5850.1 5885.4 5894.5 5931.3 6480.8 6515.4 6632.3 6644.8 6662.0 6826.8 6835.9 6918.0 6919.1 6930.1 6284.9 6304.1 6316.6 6364.9 6366.2 6557.7 6591.6 6623.1 6636.9 6641.1 6755.0 6843.8 6867.2 6898.2 6923.1 6586.7 6591.4 6640.7 6663.6 6690.0 6372.7 6551.8 6597.7 6598.9 6655.7 6596.8 6599.8 6613.0 6627.5 6632.9 6666.8 6705.1 6709.8 6758.6 6792.0 6449.4 6467.6 6495.9 6545.0 6547.1 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#1] ext.html Cycles:180 Average:36045.24 Median:32967.75 stddev:52991.62 (160.7%) stddev-sans-first:53074.38 11:35:01 INFO - PID 14788 | Values: 849.4 873.8 876.4 883.9 884.4 38310.2 39345.2 39812.4 39839.6 40062.4 35192.8 35606.1 35629.3 40282.8 40684.8 7721.0 7761.9 7803.8 7836.1 7862.1 7734.1 7801.1 7805.5 7863.4 7864.8 7829.1 7864.6 7867.3 7887.7 7900.6 7833.8 7841.1 7868.8 7869.9 7875.1 7576.1 7605.4 7649.2 7650.0 7665.3 36525.5 36720.2 36949.6 36984.8 36992.4 3522.8 3529.7 3557.4 3561.3 3573.6 30327.7 30453.4 30476.5 30523.0 30553.5 5026.2 5171.4 5215.5 5234.3 5312.5 180595.0 184703.0 189460.0 189540.0 190179.0 44334.0 44433.1 44517.3 44669.6 44745.0 45314.0 45429.0 45886.1 46103.1 46339.8 14204.4 14251.4 14252.8 14330.6 14365.0 11966.7 11982.7 11993.8 11998.5 12004.6 11722.4 11747.2 11753.4 11754.2 11929.3 4938.0 4943.6 5106.1 5115.9 5176.8 975.4 1012.7 1027.1 1028.3 1037.9 22206.7 22755.4 22878.1 22902.9 22950.8 1102.7 1121.0 1122.5 1128.2 1136.8 11986.5 12108.5 12123.2 12206.2 12213.0 229999.0 230870.0 231372.0 231383.0 232284.0 49200.5 49232.8 49258.0 49301.3 49439.0 1427.5 1460.1 1470.3 1472.6 1474.7 21970.6 22064.0 22416.7 22429.4 22612.3 35488.6 35494.8 35666.9 35710.0 35727.8 191349.0 192371.0 192524.0 193016.0 193529.0 28426.6 28463.9 31231.7 31386.5 31404.0 39701.2 40142.6 40287.6 40429.4 41207.2 29239.7 29668.6 29826.1 29842.7 30188.2 29648.0 29669.0 29921.0 30012.0 30342.4 32828.0 32920.5 33015.0 33163.3 33470.0 28819.6 29139.6 29228.0 29349.6 29849.9 22033.8 22353.9 22470.6 22578.3 22878.2 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#2] jquery.html Cycles:180 Average:34674.16 Median:22858.04 stddev:83587.54 (365.7%) stddev-sans-first:83782.79 11:35:01 INFO - PID 14788 | Values: 564.4 571.6 577.9 600.9 604.6 22309.4 23049.7 23068.7 23183.4 23183.4 23666.3 24120.8 24747.9 24972.6 25179.5 6358.1 6477.7 6538.8 6540.3 6551.3 6484.2 6552.9 6619.6 6620.0 6622.1 6358.2 6565.8 6584.0 6588.9 6603.2 6532.1 6543.8 6572.2 6584.2 6589.6 5962.6 6049.9 6090.7 6109.3 6186.7 28804.9 28896.0 29217.7 29223.6 29233.4 2036.4 2059.6 2060.6 2068.4 2075.0 18657.2 19072.7 19559.4 20112.0 20152.0 2423.8 2477.1 2495.6 2503.4 2511.2 120974.4 126635.0 128427.0 133193.3 139342.3 14291.0 14826.3 14876.3 14946.3 15018.6 22328.2 22600.1 22651.3 22652.8 22666.4 10161.6 10237.9 10238.1 10288.6 10338.4 9500.8 9525.6 9592.8 9733.2 9800.2 8762.8 9074.8 9103.0 9111.7 9261.6 2604.7 2623.8 2658.2 2661.5 2712.0 943.6 963.9 974.2 974.3 977.3 19350.6 19573.7 19620.0 20069.3 20524.5 1035.6 1045.1 1045.3 1049.7 1051.1 10618.2 10968.5 11000.6 11009.7 11156.2 471844.0 477021.0 486849.0 520190.0 533806.0 109660.5 111531.0 112473.0 114324.0 117056.0 1169.8 1180.0 1189.9 1190.7 1198.3 17538.6 17625.0 17782.1 17947.8 18073.6 55988.2 56233.7 56281.4 57071.1 57681.7 71700.0 72884.3 72885.3 73722.6 74225.0 14189.9 14379.6 14441.4 14518.0 14626.9 23101.5 23260.2 23298.9 23454.5 23938.4 18319.5 18419.3 18495.8 18522.4 18615.9 16186.7 16215.3 16284.4 16843.7 17090.4 17951.6 18143.5 18678.8 18797.3 18834.0 13946.9 14022.0 14071.2 14155.5 14178.4 18104.0 18118.7 18274.5 18295.5 18550.3 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#3] mootools.html Cycles:180 Average:9382.30 Median:2684.50 stddev:6676.17 (248.7%) stddev-sans-first:6667.38 11:35:01 INFO - PID 14788 | Values: 1314.1 1369.2 1379.4 1380.9 1382.8 15113.8 15636.0 15643.5 15644.9 15659.7 15426.1 15632.3 15663.8 15673.4 15773.2 2709.9 2819.6 2849.8 2870.9 2881.4 2751.2 2793.3 2803.3 2813.6 2816.4 2724.6 2797.8 2800.2 2801.2 2801.4 2687.1 2717.9 2721.4 2722.2 2730.2 2681.9 2693.1 2697.2 2714.9 2714.9 14613.2 15010.5 15103.8 15139.6 15144.6 7987.4 8311.0 8330.2 8338.4 8362.7 5552.8 5624.1 5714.3 5764.7 5788.7 1846.2 1874.9 1910.3 1953.4 1961.8 25788.4 25955.1 26109.6 26162.3 26192.3 6945.1 6966.8 6985.3 7134.3 7147.2 16990.3 17041.7 17070.7 17184.2 17190.8 7820.2 7909.4 7991.4 8019.9 8026.3 5938.9 6620.5 6652.0 7208.9 7322.4 5234.2 5439.5 5452.5 5467.2 5489.4 1531.8 1578.9 1581.1 1593.6 1607.8 877.8 882.1 902.9 913.7 918.1 7458.1 7528.8 7601.5 7659.2 8617.9 697.0 715.4 719.5 720.3 723.2 5220.2 5485.5 5512.1 5525.9 5654.6 21071.2 22225.9 22458.4 22475.2 22498.8 20730.2 21558.0 21645.1 21819.6 21831.6 11275.4 11512.5 11540.2 11605.0 11630.4 8611.1 8634.0 8666.7 8670.3 8682.3 17961.3 18155.9 18252.0 18559.3 18685.0 19120.5 19175.2 19269.6 19693.5 19790.8 11159.9 11197.7 11198.1 11217.4 11236.7 13783.8 13887.9 13927.8 13965.9 14040.2 11091.2 11507.7 11705.9 11758.8 11836.3 11108.0 11138.1 11193.4 11230.1 11344.7 10006.0 10085.2 10124.9 10144.2 10231.8 6992.7 6996.9 7047.3 7088.0 7248.9 6983.0 7105.6 7128.8 7163.4 7308.3 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#4] prototype.html Cycles:180 Average:5551.90 Median:6240.41 stddev:1547.99 (24.8%) stddev-sans-first:1505.34 11:35:01 INFO - PID 14788 | Values: 509.0 532.3 532.5 533.2 535.8 6327.9 6414.3 6422.6 6429.2 6434.7 6227.6 6236.0 6275.4 6347.3 6374.4 5234.4 5243.9 5246.0 5292.4 5299.8 5221.0 5238.9 5252.2 5283.0 5344.3 4834.6 5007.6 5020.3 5081.0 5114.0 5036.9 5054.9 5055.0 5060.6 5092.0 4501.3 4508.5 4513.0 4518.5 4518.6 6110.3 6122.2 6211.3 6233.9 6245.3 5751.4 5761.4 5767.8 5791.8 5810.7 6575.5 6594.9 6600.9 6692.7 6697.8 4892.4 4897.0 4910.8 4932.9 4948.0 6718.7 6745.8 6879.8 6931.6 6968.9 4995.6 5060.0 5071.6 5077.8 5088.1 5076.3 5091.3 5091.8 5098.5 5139.6 5687.4 5701.7 5712.1 5736.7 5758.0 6659.3 6660.4 6664.2 6678.2 6740.6 1761.8 1773.5 1776.9 1779.9 1788.4 1166.0 1199.4 1208.6 1244.2 1250.8 5690.8 5692.3 5745.5 5777.7 5795.6 6719.4 6726.6 6730.7 6766.5 6798.5 5639.9 5693.2 5708.7 5728.2 5733.6 3471.2 3476.6 3507.9 3516.7 3536.0 6244.8 6300.4 6371.0 6383.5 6418.2 6511.5 6882.4 6914.2 6919.1 6946.9 6342.6 6378.4 6408.6 6452.9 6477.2 6531.5 6633.2 6800.7 6819.4 6849.9 6632.9 6729.2 6744.6 6756.3 6777.4 6302.1 6458.4 6487.8 6523.2 6535.3 4958.8 4976.6 5020.0 5039.0 5043.8 6475.4 6694.5 6754.8 6755.6 6755.9 6317.2 6422.3 6506.0 6540.8 6551.8 6528.2 6569.6 6616.4 6617.8 6652.9 6474.2 6523.9 6529.9 6572.2 6579.0 6525.5 6621.6 6627.0 6633.1 6718.8 6449.6 6472.6 6498.1 6534.0 6557.6 11:35:01 INFO - PID 14788 | 11:35:01 INFO - PID 14788 | [#5] yui.html Cycles:180 Average:24673.74 Median:19807.00 stddev:35815.78 (180.8%) stddev-sans-first:35871.67 11:35:01 INFO - PID 14788 | Values: 875.5 898.7 911.1 922.1 928.3 19209.8 19805.6 19808.4 20068.5 20103.1 16863.5 17195.1 17213.2 19210.2 19285.8 953.6 954.7 954.7 956.8 957.2 972.6 975.0 982.1 982.4 991.5 989.3 1008.6 1038.3 1041.3 1045.3 1026.2 1032.6 1032.8 1034.0 1035.9 724.8 736.4 755.0 755.8 760.0 20428.4 20431.9 20506.0 20689.7 20691.7 21681.7 21862.2 22708.2 22712.4 22973.1 16498.0 16955.5 17097.9 17167.6 17236.6 3770.9 3800.1 3802.1 3802.1 3803.3 136083.0 137676.3 139745.0 139769.3 140263.0 16776.7 16991.0 17090.3 17110.3 17139.7 31411.4 31433.0 31716.7 32042.8 32055.8 8514.6 8536.8 8585.9 8608.1 8619.2 4046.4 4089.9 4104.1 4122.2 4124.2 5429.1 5519.8 5593.2 5598.1 5618.6 1008.4 1040.5 1050.4 1060.7 1060.8 664.9 684.9 690.0 702.2 711.2 11942.1 11989.2 12175.5 12226.9 12410.6 680.5 690.9 696.9 702.9 716.5 5271.3 5374.4 5465.6 5479.6 5535.6 123756.0 124315.4 124488.0 125294.0 125526.0 107897.5 111066.0 113871.0 114317.4 114403.0 94481.0 94899.5 96862.0 97754.5 98183.5 10285.0 10318.4 10361.8 10396.5 10453.1 45659.8 46009.0 46541.5 47846.8 47955.0 59767.4 60249.7 60825.4 61347.4 62247.0 15327.5 15590.1 15663.2 15707.2 16048.7 17745.6 17838.9 17861.5 17877.7 18130.5 15704.6 15812.4 15870.2 15952.3 16012.8 15626.8 15876.2 16010.6 16074.6 16244.4 15287.9 15436.8 15502.1 15596.8 15660.7 11581.2 11693.6 11975.0 11975.8 11980.9 11102.0 11118.9 11261.8 11288.5 11395.3 11:35:01 INFO - PID 14788 | -------- Summary: end -------- 11:35:01 INFO - PID 14788 | 11:35:01 INFO - TEST-INFO | 14788: exit 0 11:35:01 INFO - TEST-OK | dromaeo_css | took 1113689ms 11:35:01 INFO - TEST-START | kraken 11:35:01 INFO - Initialising browser for kraken test... 11:35:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34178/getInfo.html -profile /tmp/tmpDytzA3/profile 11:35:01 INFO - TEST-INFO | started process 15168 (/builds/slave/test/build/application/firefox/firefox http://localhost:34178/getInfo.html) 11:35:07 INFO - TEST-INFO | 15168: exit 0 11:35:07 INFO - Browser initialized. 11:35:07 INFO - Running cycle 1/1 for kraken test... 11:35:07 INFO - Using env: {'DISPLAY': ':0', 11:35:07 INFO - 'HOME': '/home/cltbld', 11:35:07 INFO - 'JSGC_DISABLE_POISONING': '1', 11:35:07 INFO - 'LANG': 'en_US.UTF-8', 11:35:07 INFO - 'LANGUAGE': 'en_US:en', 11:35:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:35:07 INFO - 'LOGNAME': 'cltbld', 11:35:07 INFO - 'MAIL': '/var/mail/cltbld', 11:35:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:07 INFO - 'MOZ_ACCELERATED': '1', 11:35:07 INFO - 'MOZ_CRASHREPORTER': '1', 11:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:35:07 INFO - 'MOZ_NO_REMOTE': '1', 11:35:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:07 INFO - 'MOZ_WEBRENDER': '1', 11:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:07 INFO - 'NO_EM_RESTART': '1', 11:35:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:07 INFO - 'PWD': '/builds/slave/test', 11:35:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:07 INFO - 'RUST_BACKTRACE': 'full', 11:35:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:07 INFO - 'SHELL': '/bin/bash', 11:35:07 INFO - 'SHLVL': '1', 11:35:07 INFO - 'TERM': 'linux', 11:35:07 INFO - 'TMOUT': '86400', 11:35:07 INFO - 'USER': 'cltbld', 11:35:07 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396', 11:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:07 INFO - '_': '/tools/buildbot/bin/python'} 11:35:07 INFO - TEST-INFO | started process 15416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDytzA3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:08 INFO - PID 15416 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:35:08 INFO - PID 15416 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:35:09 INFO - PID 15416 | 11:35:09 INFO - PID 15416 | (/builds/slave/test/build/application/firefox/firefox:15474): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:35:09 INFO - PID 15416 | 11:35:19 INFO - PID 15416 | RSS: Main: 203677696 11:35:19 INFO - PID 15416 | 11:35:22 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34178/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:23 INFO - PID 15416 | RSS: Main: 202366976 11:35:23 INFO - PID 15416 | 11:35:25 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34178/tests/kraken/driver.html?testName=audio-dft) 11:35:26 INFO - PID 15416 | RSS: Main: 202661888 11:35:26 INFO - PID 15416 | 11:35:29 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34178/tests/kraken/driver.html?testName=audio-fft) 11:35:30 INFO - PID 15416 | RSS: Main: 199417856 11:35:30 INFO - PID 15416 | 11:35:32 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34178/tests/kraken/driver.html?testName=audio-oscillator) 11:35:32 INFO - PID 15416 | RSS: Main: 198856704 11:35:32 INFO - PID 15416 | 11:35:34 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34178/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:35 INFO - PID 15416 | RSS: Main: 200212480 11:35:35 INFO - PID 15416 | 11:35:38 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34178/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:39 INFO - PID 15416 | RSS: Main: 202010624 11:35:39 INFO - PID 15416 | 11:35:43 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34178/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:43 INFO - PID 15416 | RSS: Main: 201773056 11:35:43 INFO - PID 15416 | 11:35:46 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34178/tests/kraken/driver.html?testName=json-parse-financial) 11:35:47 INFO - PID 15416 | RSS: Main: 202711040 11:35:47 INFO - PID 15416 | 11:35:49 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34178/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:49 INFO - PID 15416 | RSS: Main: 202817536 11:35:49 INFO - PID 15416 | 11:35:51 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:51 INFO - PID 15416 | RSS: Main: 199430144 11:35:51 INFO - PID 15416 | 11:35:54 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:54 INFO - PID 15416 | RSS: Main: 199241728 11:35:54 INFO - PID 15416 | 11:35:57 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:58 INFO - PID 15416 | RSS: Main: 200327168 11:35:58 INFO - PID 15416 | 11:36:01 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:01 INFO - PID 15416 | RSS: Main: 199688192 11:36:01 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | Cycle 1(1): loaded http://localhost:34178/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34178/tests/kraken/driver.html?testName=ai-astar) 11:36:03 INFO - PID 15416 | RSS: Main: 201801728 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | __start_tp_report 11:36:03 INFO - PID 15416 | _x_x_mozilla_page_load 11:36:03 INFO - PID 15416 | _x_x_mozilla_page_load_details 11:36:03 INFO - PID 15416 | |i|pagename|runs| 11:36:03 INFO - PID 15416 | |0;ai-astar;113;112;108;115;112;118;111;116;106;117 11:36:03 INFO - PID 15416 | |1;audio-beat-detection;125;119;119;117;149;120;119;123;124;124 11:36:03 INFO - PID 15416 | |2;audio-dft;165;173;167;160;163;161;164;170;163;166 11:36:03 INFO - PID 15416 | |3;audio-fft;78;80;74;80;74;85;77;75;75;83 11:36:03 INFO - PID 15416 | |4;audio-oscillator;79;91;82;86;77;79;81;89;86;88 11:36:03 INFO - PID 15416 | |5;imaging-gaussian-blur;115;118;120;115;114;114;115;111;117;119 11:36:03 INFO - PID 15416 | |6;imaging-darkroom;153;147;150;159;148;153;152;152;150;149 11:36:03 INFO - PID 15416 | |7;imaging-desaturate;95;96;99;94;95;94;97;99;100;98 11:36:03 INFO - PID 15416 | |8;json-parse-financial;55;53;54;56;54;54;64;53;53;52 11:36:03 INFO - PID 15416 | |9;json-stringify-tinderbox;39;42;38;45;39;40;40;39;38;50 11:36:03 INFO - PID 15416 | |10;stanford-crypto-aes;88;79;78;73;73;75;87;73;85;73 11:36:03 INFO - PID 15416 | |11;stanford-crypto-ccm;131;117;109;113;115;117;111;112;114;116 11:36:03 INFO - PID 15416 | |12;stanford-crypto-pbkdf2;180;174;177;172;174;170;171;169;170;178 11:36:03 INFO - PID 15416 | |13;stanford-crypto-sha256-iterative;71;76;74;68;67;71;65;68;69;67 11:36:03 INFO - PID 15416 | __end_tp_report 11:36:03 INFO - PID 15416 | __start_cc_report 11:36:03 INFO - PID 15416 | _x_x_mozilla_cycle_collect,742 11:36:03 INFO - PID 15416 | __end_cc_report 11:36:03 INFO - PID 15416 | __startTimestamp1505932563752__endTimestamp 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | ------- Summary: start ------- 11:36:03 INFO - PID 15416 | Number of tests: 14 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.85 (3.4%) stddev-sans-first:4.09 11:36:03 INFO - PID 15416 | Values: 113.0 112.0 108.0 115.0 112.0 118.0 111.0 116.0 106.0 117.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:123.50 stddev:9.23 (7.5%) stddev-sans-first:9.78 11:36:03 INFO - PID 15416 | Values: 125.0 119.0 119.0 117.0 149.0 120.0 119.0 123.0 124.0 124.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:3.99 (2.4%) stddev-sans-first:4.24 11:36:03 INFO - PID 15416 | Values: 165.0 173.0 167.0 160.0 163.0 161.0 164.0 170.0 163.0 166.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#3] audio-fft Cycles:10 Average:78.10 Median:79.00 stddev:3.84 (4.9%) stddev-sans-first:4.08 11:36:03 INFO - PID 15416 | Values: 78.0 80.0 74.0 80.0 74.0 85.0 77.0 75.0 75.0 83.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#4] audio-oscillator Cycles:10 Average:83.80 Median:86.00 stddev:4.83 (5.6%) stddev-sans-first:4.80 11:36:03 INFO - PID 15416 | Values: 79.0 91.0 82.0 86.0 77.0 79.0 81.0 89.0 86.0 88.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:2.70 (2.3%) stddev-sans-first:2.85 11:36:03 INFO - PID 15416 | Values: 115.0 118.0 120.0 115.0 114.0 114.0 115.0 111.0 117.0 119.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:152.00 stddev:3.40 (2.2%) stddev-sans-first:3.55 11:36:03 INFO - PID 15416 | Values: 153.0 147.0 150.0 159.0 148.0 153.0 152.0 152.0 150.0 149.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:2.21 (2.3%) stddev-sans-first:2.26 11:36:03 INFO - PID 15416 | Values: 95.0 96.0 99.0 94.0 95.0 94.0 97.0 99.0 100.0 98.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.43 (6.3%) stddev-sans-first:3.63 11:36:03 INFO - PID 15416 | Values: 55.0 53.0 54.0 56.0 54.0 54.0 64.0 53.0 53.0 52.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#9] json-stringify-tinderbox Cycles:10 Average:41.00 Median:40.00 stddev:3.80 (9.5%) stddev-sans-first:3.96 11:36:03 INFO - PID 15416 | Values: 39.0 42.0 38.0 45.0 39.0 40.0 40.0 39.0 38.0 50.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:6.13 (7.8%) stddev-sans-first:5.43 11:36:03 INFO - PID 15416 | Values: 88.0 79.0 78.0 73.0 73.0 75.0 87.0 73.0 85.0 73.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.50 stddev:6.04 (5.2%) stddev-sans-first:2.77 11:36:03 INFO - PID 15416 | Values: 131.0 117.0 109.0 113.0 115.0 117.0 111.0 112.0 114.0 116.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:3.78 (2.2%) stddev-sans-first:3.19 11:36:03 INFO - PID 15416 | Values: 180.0 174.0 177.0 172.0 174.0 170.0 171.0 169.0 170.0 178.0 11:36:03 INFO - PID 15416 | 11:36:03 INFO - PID 15416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:3.41 (4.9%) stddev-sans-first:3.57 11:36:03 INFO - PID 15416 | Values: 71.0 76.0 74.0 68.0 67.0 71.0 65.0 68.0 69.0 67.0 11:36:03 INFO - PID 15416 | -------- Summary: end -------- 11:36:03 INFO - PID 15416 | 11:36:04 INFO - PID 15416 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:36:04 INFO - TEST-INFO | 15416: exit 0 11:36:04 INFO - TEST-OK | kraken | took 62747ms 11:36:04 INFO - SUITE-END | took 1176s 11:36:04 INFO - Completed test suite (00:19:36) 11:36:04 INFO - javascript benchmark 11:36:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8474.39122687101, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.2818751687096, 3141.7800753947226, 3170.778045536812, 3182.5226216067585, 3217.6138863336405, 6151.692415379224, 6361.80914572563, 6381.042843573467, 6383.872322553552, 6399.712012959416, 6290.842728931779, 6314.6842657867155, 6318.431341179293, 6334.493240540757, 6338.397852204045, 5788.102844059177, 5801.709914504279, 5809.941900580982, 5865.0, 5889.941100588982, 5891.381404952483, 5910.113482977545, 5917.260342457193, 5924.911126333109, 5954.821355359324, 5869.148973398855, 5879.559033072515, 5905.055191169414, 5912.763489460416, 5933.110033494967, 5630.577706672016, 5748.798792042258, 5839.124131380327, 5913.763449462016, 5921.141434492018, 5708.914366284509, 5794.478496935254, 5858.853528661775, 5868.2664666916635, 5873.324567674729, 6221.87556248877, 6241.407066328691, 6295.338989406092, 6327.367263273682, 6370.299267080617, 6545.836354091138, 6604.3725846044545, 6634.701438435282, 6672.599644021374, 6732.360425759545, 6740.696668649874, 6768.458523318172, 6802.14973128359, 6802.3537763912345, 6982.511224214307, 6314.336994615591, 6392.073149393312, 6408.519361047894, 6409.294977552466, 6410.743570257184, 6913.066735990677, 7017.578945263301, 7059.364657180879, 7105.573665580082, 7125.18060423058, 6413.4869210463985, 6569.211694596679, 6658.1344425224415, 6683.164604424447, 6693.866122677519, 6796.218434880052, 6824.590524568542, 6858.3141685831015, 6858.554193977376, 6878.931210687829, 6760.7295708172105, 6782.152230971129, 6834.384905358442, 6858.279880612564, 6872.725090996404, 6787.151606049244, 6799.762008329685, 6836.555623884531, 6854.383105520527, 6862.553933994274, 5233.842984710464, 5270.156774915995, 5280.1815718563685, 5385.272988146628, 5387.326584176978, 4671.065786842645, 4701.294805779092, 4724.196886529298, 4748.643851711066, 4749.430068391815, 5726.770929162787, 5827.76688932438, 5896.911546326808, 5900.586958912921, 5902.085176797603, 6682.763688717506, 6723.394894459522, 6756.695948682321, 6800.489963252776, 6840.110785597841, 5736.053551164011, 5779.537636989031, 5781.82654520365, 5807.622504537191, 5898.439648233411, 5836.0, 5850.0932355484965, 5885.352611212763, 5894.498967587718, 5931.288245410578, 6480.837979050467, 6515.381038801306, 6632.303608121174, 6644.833879152963, 6662.0, 6826.795196144124, 6835.897461537981, 6918.0, 6919.100516932766, 6930.064441300461, 6284.874302513833, 6304.148939893239, 6316.557840951089, 6364.904526432015, 6366.236051673829, 6557.704903279268, 6591.571547849375, 6623.105880706235, 6636.933630663631, 6641.103451034049, 6755.0, 6843.794686159423, 6867.244603093755, 6898.206706228848, 6923.099997000358, 6586.703598338182, 6591.439727623014, 6640.701168447528, 6663.633500157538, 6690.0, 6372.681365931592, 6551.80344589663, 6597.703103360264, 6598.934010660024, 6655.667216639245, 6596.769113081019, 6599.8020059398295, 6612.966935165294, 6627.4698024158915, 6632.938729803208, 6666.766663166766, 6705.1283333166375, 6709.7651582194385, 6758.594484330956, 6791.966040169767, 6449.3873082057125, 6467.61194328323, 6495.870082598227, 6544.9672751635935, 6547.050677651619], "value": 6185.364565168964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.4308813095225, 873.7815546113471, 876.4215617692322, 883.9160279773428, 884.4162852517336, 38310.23379532408, 39345.213095738065, 39812.40281395778, 39839.60160398395, 40062.39906401399, 35192.82403587985, 35606.10984725383, 35629.2874142517, 40282.79151625456, 40684.79657601715, 7721.0, 7761.922380776205, 7803.804904877366, 7836.098848632423, 7862.135165131831, 7734.1492435832015, 7801.063872335328, 7805.492642978216, 7863.370930325589, 7864.803379915491, 7829.099653539831, 7864.646090925922, 7867.331276841475, 7887.684492620317, 7900.565468899237, 7833.804154896173, 7841.059072911258, 7868.803279917991, 7869.881951770728, 7875.094364148139, 7576.128745194318, 7605.353544948686, 7649.196834332426, 7650.043744531934, 7665.271799179069, 36525.45211821825, 36720.16399180057, 36949.63050369489, 36984.815075924445, 36992.44511332332, 3522.788632682047, 3529.699975502085, 3557.4485954677066, 3561.3233485637647, 3573.5711714594154, 30327.69672303293, 30453.39093218123, 30476.54285185724, 30523.0, 30553.541696874563, 5026.195808670632, 5171.3535808024, 5215.452377500345, 5234.345706786652, 5312.548433383167, 180595.0, 184702.99999999866, 189460.0, 189540.0, 190179.0, 44334.0, 44433.111337773065, 44517.332240016425, 44669.55330446654, 44745.0, 45314.0, 45429.0, 45886.082278354916, 46103.07793844104, 46339.768301158954, 14204.360803763855, 14251.358688859027, 14252.786208206886, 14330.57008289753, 14365.0, 11966.700832479257, 11982.700432489084, 11993.760124797454, 11998.460069296903, 12004.579839705568, 11722.413879306001, 11747.236429632047, 11753.353565553805, 11754.177207595387, 11929.343886086175, 4937.950620493821, 4943.629227807929, 5106.055379754757, 5115.948840511547, 5176.818811341585, 975.3903810118676, 1012.7366884609908, 1027.1320733979924, 1028.3315844701003, 1037.906588407047, 22206.66689999651, 22755.431114222276, 22878.084876605084, 22902.885485572464, 22950.819672131107, 1102.6581759654532, 1120.9551617935354, 1122.4668282565715, 1128.1989787251143, 1136.7953768321615, 11986.52053917851, 12108.515659373703, 12123.211991220542, 12206.206596571194, 12213.0, 229999.0, 230870.0, 231372.0, 231383.0, 232284.0, 49200.50799491959, 49232.753836231306, 49258.0, 49301.26048109281, 49439.0, 1427.5289154578963, 1460.0582624207327, 1470.3016067368128, 1472.639203395175, 1474.7345477814097, 21970.560588788456, 22064.0, 22416.663750043437, 22429.43926401853, 22612.321630351114, 35488.64511354853, 35494.822525887204, 35666.85998840078, 35710.0, 35727.82136089303, 191349.0, 192371.03814480838, 192524.0, 193016.0, 193529.0, 28426.57360139641, 28463.857680711462, 31231.687683123786, 31386.529202062444, 31404.0, 39701.213445394445, 40142.598574013886, 40287.597124029555, 40429.39355909605, 41207.1758564833, 29239.70760292455, 29668.55497167501, 29826.10521684353, 29842.70157298399, 30188.245293866952, 29648.0, 29669.0, 29921.0, 30012.0, 30342.393152137276, 32828.0, 32920.506192407614, 33015.0, 33163.336733265685, 33470.0, 28819.567706484, 29139.562906555995, 29228.0, 29349.55975660324, 29849.850750746107, 22033.77966220317, 22353.888230558743, 22470.550588988455, 22578.322650320515, 22878.199263025715], "value": 16419.65929573437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4017341617886, 571.6227289988603, 577.9335376431711, 600.9068594367873, 604.5526310530207, 22309.44226394339, 23049.654255186164, 23068.65397019042, 23183.420414489647, 23183.420414489647, 23666.290011299647, 24120.75879241207, 24747.876260618672, 24972.625410618853, 25179.49641007183, 6358.078078678589, 6477.708503117347, 6538.803835884931, 6540.345965403445, 6551.344865513434, 6484.221893372802, 6552.868942621145, 6619.569727967691, 6619.966900165492, 6622.072909792633, 6358.173437453124, 6565.770198043046, 6584.045313429549, 6588.93411065888, 6603.174603174603, 6532.11816404784, 6543.770968016121, 6572.178477690289, 6584.242812076601, 6589.637569933628, 5962.642241465526, 6049.939500604982, 6090.725917333731, 6109.327973922865, 6186.721597528122, 28804.8559757202, 28896.0, 29217.70782292171, 29223.56164657532, 29233.41533169346, 2036.4094412620323, 2059.6086743518686, 2060.6393881070753, 2068.4208421641965, 2074.979250207494, 18657.160427780782, 19072.71390929137, 19559.413217603495, 20112.0, 20151.99240038007, 2423.8060955123547, 2477.071098338123, 2495.625656151574, 2503.4492411669585, 2511.2215213283757, 120974.39512802468, 126635.0, 128427.0, 133193.3340333292, 139342.30328848393, 14290.993610627502, 14826.323493413192, 14876.256187190596, 14946.28117766449, 15018.624534386508, 22328.21851235199, 22600.095996160297, 22651.320460386214, 22652.773472265395, 22666.433339166324, 10161.593536258466, 10237.897621023843, 10238.12975897057, 10288.639897603547, 10338.431386273827, 9500.762480937894, 9525.5713492893, 9592.760180995392, 9733.2213422926, 9800.215982721365, 8762.824743505222, 9074.773130671654, 9103.0, 9111.68109116191, 9261.583228754722, 2604.6744156980376, 2623.788818945603, 2658.2025392382207, 2661.5475369187284, 2711.959320610192, 943.556528431636, 963.9180669643018, 974.2303580171586, 974.3439334662353, 977.3402953006693, 19350.61298774045, 19573.706394404096, 19620.0, 20069.29757458511, 20524.486887827625, 1035.6064695415844, 1045.0646671229358, 1045.289203341735, 1049.6588608702202, 1051.1380667852288, 10618.203634727426, 10968.451577421098, 11000.614978475714, 11009.724756880982, 11156.219064665396, 471844.0, 477021.0, 486849.0, 520190.0, 533806.0, 109660.451697741, 111531.0, 112473.0, 114324.0, 117056.0, 1169.818678104878, 1179.9764004719857, 1189.8750631183775, 1190.7320852808223, 1198.3349241171059, 17538.649227015645, 17625.0, 17782.110894454967, 17947.820521795136, 18073.638527229647, 55988.16017759818, 56233.71883140558, 56281.43718562762, 57071.14393284021, 57681.711591443454, 71700.0, 72884.27115728987, 72885.27114728784, 73722.63138684272, 74225.0, 14189.858101418853, 14379.64050898694, 14441.350139243548, 14518.0, 14626.85373146255, 23101.537969240857, 23260.185893493646, 23298.883505582362, 23454.530909381374, 23938.40153996164, 18319.54201144982, 18419.263229471206, 18495.815041849408, 18522.351717689817, 18615.90692046531, 16186.67626647484, 16215.270312835715, 16284.43004494837, 16843.663126737152, 17090.40183593568, 17951.551211219303, 18143.455696329132, 18678.81321186825, 18797.342093027226, 18834.0, 13946.860531394555, 14022.0, 14071.155730656194, 14155.504557340444, 14178.43286268579, 18104.0, 18118.728219076987, 18274.45176644703, 18295.54261143482, 18550.257989680802], "value": 11933.935725567017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.1458052266025, 1369.2332293915408, 1379.3517046987918, 1380.9102408343451, 1382.785668221426, 15113.773293400594, 15636.0, 15643.530694079167, 15644.921775391107, 15659.686806263868, 15426.074435533876, 15632.2965466554, 15663.765043524356, 15673.373065077383, 15773.211339433012, 2709.91870243893, 2819.6334476518023, 2849.8147620404607, 2870.8708108135183, 2881.366099458116, 2751.2296556963984, 2793.2877116335308, 2803.3272014716526, 2813.606095146681, 2816.3663175785387, 2724.5640697488407, 2797.8181418207855, 2800.2019424464033, 2801.1596521043707, 2801.3696918193446, 2687.0863906271866, 2717.9320516987036, 2721.4012917158193, 2722.169738229839, 2730.194592595179, 2681.919542413711, 2693.124734461308, 2697.1773609049233, 2714.864256787153, 2714.9457010859674, 14613.196274204915, 15010.549683509513, 15103.773443398359, 15139.621509462242, 15144.621384465367, 7987.440879138463, 8310.958445207736, 8330.166983301682, 8338.416310858242, 8362.749117526484, 5552.750126244328, 5624.128260119647, 5714.314282286111, 5764.682942438164, 5788.739506722165, 1846.22458567402, 1874.8875067495858, 1910.3313840155972, 1953.3846838245906, 1961.8136277053657, 25788.355291117685, 25955.091571794896, 26109.608355874676, 26162.345941351618, 26192.34519137037, 6945.0971373721095, 6966.756163534252, 6985.336393042653, 7134.322239387354, 7147.1780745214965, 16990.32038718462, 17041.7443738344, 17070.658586828195, 17184.226709798088, 17190.828091719173, 7820.178881217504, 7909.367250619936, 7991.400644951652, 8019.919800802034, 8026.277635012877, 5938.8812223755285, 6620.503462240351, 6652.0, 7208.855822883513, 7322.377597904131, 5234.162533994542, 5439.48324909133, 5452.454754524595, 5467.234587157801, 5489.368722596872, 1531.7855500229978, 1578.8657964073182, 1581.1066747287746, 1593.6334643031935, 1607.7588361745832, 877.8112705768291, 882.1266945723687, 902.9277657787361, 913.6710784117712, 918.1231923513029, 7458.067741532309, 7528.849423011509, 7601.543907365465, 7659.234076592296, 8617.870731939025, 696.9860602788017, 715.3883429667663, 719.4675939804507, 720.2977097330062, 723.2008630463367, 5220.243064755665, 5485.451454854483, 5512.062949298629, 5525.889482210333, 5654.6324488908085, 21071.157153713986, 22225.888870555544, 22458.438539036655, 22475.21336753206, 22498.77501224967, 20730.170793168407, 21558.029888655048, 21645.13419463204, 21819.563608728055, 21831.563368732855, 11275.436228188557, 11512.481938312796, 11540.24988375753, 11605.0, 11630.418479076012, 8611.13888611134, 8634.0, 8666.739997800076, 8670.26302764272, 8682.34882383811, 17961.281548738425, 18155.909220453814, 18252.0, 18559.25762969466, 18685.0, 19120.470362371256, 19175.232990680215, 19269.61460770805, 19693.507662308555, 19790.802091978894, 11159.88840111621, 11197.72005699864, 11198.10415166801, 11217.383043932661, 11236.719082023015, 13783.793243101562, 13887.861121388656, 13927.791083133963, 13965.930170349084, 14040.1575905446, 11091.223614347242, 11507.654770356903, 11705.941470292593, 11758.764824703629, 11836.349000804694, 11108.000279974842, 11138.053265472201, 11193.384363859741, 11230.101591872794, 11344.659660210207, 10006.0, 10085.193184545073, 10124.898751012395, 10144.188464922936, 10231.795364092824, 6992.720291188295, 6996.930030699831, 7047.330503602149, 7087.964560177166, 7248.927510725036, 6982.965085174542, 7105.609191494517, 7128.821779455555, 7163.3552980232025, 7308.342249197598], "value": 6681.852776770236, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.01147993852334, 532.254843219493, 532.5423172060939, 533.1868899927609, 535.8446050645313, 6327.860985022694, 6414.294427612959, 6422.646754428504, 6429.228492580891, 6434.678266086695, 6227.564070515065, 6236.0401145272735, 6275.4038366355235, 6347.333529979355, 6374.374534493709, 5234.398044224925, 5243.86890327741, 5246.029484545362, 5292.444293349201, 5299.761510732007, 5221.0, 5238.947610523884, 5252.159654455288, 5283.0, 5344.305240318772, 4834.564889159975, 5007.574356179729, 5020.272060551236, 5081.0, 5113.951639913808, 5036.874078148039, 5054.898902021976, 5054.974725126388, 5060.620453465986, 5091.974540127276, 4501.257292546726, 4508.45898492183, 4512.977435112836, 4518.52555481673, 4518.599234237364, 6110.297315808694, 6122.234720659918, 6211.3167551569295, 6233.937660623381, 6245.313015568284, 5751.3831206800805, 5761.423857614247, 5767.798127065575, 5791.82624521265, 5810.6513609183585, 6575.539712220147, 6594.868102637968, 6600.867982640369, 6692.732290708414, 6697.799066028027, 4892.437369702494, 4896.975515122437, 4910.754462276872, 4932.926006109911, 4947.975260123676, 6718.664066796689, 6745.831354216184, 6879.759208427731, 6931.618760968145, 6968.860622787516, 4995.600351971833, 5059.97470012655, 5071.644984851099, 5077.796888124508, 5088.084144853962, 5076.289319495199, 5091.301610146555, 5091.847244582668, 5098.4646612105935, 5139.614528910347, 5687.374388817227, 5701.686407247558, 5712.143178523172, 5736.741846616912, 5758.0, 6659.300773418721, 6660.400563949268, 6664.200295964419, 6678.165229346332, 6740.62926539045, 1761.779777527809, 1773.5388798912375, 1776.9466915992282, 1779.919903604341, 1788.374069075839, 1165.9650210493699, 1199.4302706214653, 1208.6192849252457, 1244.1601918705019, 1250.8242252282826, 5690.772369105272, 5692.288463942007, 5745.540356771448, 5777.653340799566, 5795.623284486495, 6719.428848547928, 6726.596404215763, 6730.663466826737, 6766.458683305324, 6798.5241033128195, 5639.887202255932, 5693.231413759089, 5708.686022268815, 5728.198052272685, 5733.598648094677, 3471.2016236265295, 3476.617572067071, 3507.9123021924656, 3516.6659167379057, 3535.964640353615, 6244.781432649836, 6300.401461861115, 6371.0, 6383.4574061204385, 6418.1656384669695, 6511.544191906521, 6882.449404047664, 6914.204866440323, 6919.097248256669, 6946.861062778716, 6342.636333188294, 6378.425941665179, 6408.58344207625, 6452.870942581122, 6477.190351206099, 6531.510136739668, 6633.209033560815, 6800.727970881109, 6819.420349270367, 6849.863002739818, 6632.933670663425, 6729.192496900403, 6744.62904540255, 6756.29058948823, 6777.356151165632, 6302.054691796267, 6458.418742313214, 6487.805365839033, 6523.206118317501, 6535.3137920517665, 4958.752062396938, 4976.576990955809, 5019.996000799928, 5039.0, 5043.798248070036, 6475.417212450902, 6694.464442844658, 6754.763583274562, 6755.594664320157, 6755.898661520179, 6317.178766760292, 6422.32565580626, 6506.02409638558, 6540.789953858552, 6551.80344589663, 6528.2492513359675, 6569.605823650596, 6616.437602803623, 6617.801465955837, 6652.90020649681, 6474.2160870826, 6523.902141467787, 6529.902051469327, 6572.244191917991, 6579.039432255408, 6525.477961762953, 6621.635810030494, 6627.0, 6633.1376920999965, 6718.8320291993095, 6449.6130232186215, 6472.611643301417, 6498.122753428227, 6534.0, 6557.639329836714], "value": 5096.84699376261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.5315905990288, 898.7438580004699, 911.1389736698818, 922.1424075609681, 928.3084102343755, 19209.807901920976, 19805.60388792227, 19808.40574782759, 20068.498287542818, 20103.095360708765, 16863.494095177164, 17195.140242987833, 17213.22540485678, 19210.231590736388, 19285.807141928577, 953.637617705271, 954.6610953111649, 954.6897258391016, 956.7703751099756, 957.2342126298968, 972.6255391674221, 974.9658761943333, 982.1111893736145, 982.4056445850265, 991.4646091110792, 989.302541708094, 1008.5894711639188, 1038.2991480750463, 1041.3335465302212, 1045.252644359283, 1026.1739299863607, 1032.5766435761377, 1032.757302034025, 1034.0228484082545, 1035.9067683908484, 724.8332883436839, 736.3520102309986, 755.029786724057, 755.7657126290812, 759.9924000759977, 20428.387148385573, 20431.8978405107, 20506.0, 20689.68965465519, 20691.689624655643, 21681.67477487839, 21862.23482178132, 22708.205212817473, 22712.43218919524, 22973.08107675691, 16498.0, 16955.491335259838, 17097.914510427367, 17167.570810729707, 17236.56908577283, 3770.8868733938025, 3800.1259710266795, 3802.068493219151, 3802.125511132455, 3803.2583646189005, 136083.0, 137676.31161844128, 139745.0, 139769.3011534946, 140262.99999999898, 16776.748348774778, 16991.0, 17090.316387344617, 17110.315587376615, 17139.74290385645, 31411.37177256488, 31433.0, 31716.682833171835, 32042.839785800923, 32055.839720801247, 8514.616842242114, 8536.786580335542, 8585.914140858637, 8608.09614990417, 8619.1811777881, 4046.393041043867, 4089.8568550100604, 4104.138130992525, 4122.154958233555, 4124.175164967019, 5429.131338985743, 5519.834404967857, 5593.188987596775, 5598.104303311532, 5618.634788738719, 1008.3798463944621, 1040.4705083527203, 1050.4170185547096, 1060.660588611637, 1060.8037513060108, 664.9235337936102, 684.8561802021532, 689.9965500172567, 702.1749444402807, 711.1572786248312, 11942.104342174373, 11989.160758746804, 12175.512979480722, 12226.877731222574, 12410.627681169579, 680.4624346766099, 690.927452617478, 696.9163700355888, 702.9015937768717, 716.451914285572, 5271.314729085271, 5374.381946076173, 5465.606270401022, 5479.643823151482, 5535.58483113768, 123756.0, 124315.37842310911, 124488.0, 125294.0, 125526.0, 107897.4605126985, 111066.0, 113871.0, 114317.4284128574, 114403.0, 94481.0, 94899.52550237205, 96862.0, 97754.51122744483, 98183.50908245413, 10285.0, 10318.380897146195, 10361.792764144524, 10396.532156053147, 10453.111485523816, 45659.771701142614, 46009.0, 46541.53458465372, 47846.76076619595, 47955.0, 59767.40232597618, 60249.69875150596, 60825.39174608197, 61347.44331524667, 62247.0, 15327.46353877609, 15590.14254216029, 15663.216839158224, 15707.214639268219, 16048.67902641964, 17745.645087098444, 17838.91080544589, 17861.464156075337, 17877.73183402224, 18130.45608631743, 15704.60738481547, 15812.367505299659, 15870.20648967524, 15952.282147303167, 16012.839871601134, 15626.843731562994, 15876.2061896907, 16010.599735006717, 16074.598135046717, 16244.3502259913, 15287.923560382127, 15436.768448473058, 15502.069875807487, 15596.766048509508, 15660.686786263983, 11581.189316747746, 11693.590724324607, 11975.041996640073, 11975.76048479043, 11980.940095299467, 11102.0, 11118.888811112109, 11261.831072533754, 11288.49201785938, 11395.259308144945], "value": 8972.536891562073, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 108.0, 115.0, 112.0, 118.0, 111.0, 116.0, 106.0, 117.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 119.0, 117.0, 149.0, 120.0, 119.0, 123.0, 124.0, 124.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 167.0, 160.0, 163.0, 161.0, 164.0, 170.0, 163.0, 166.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 74.0, 80.0, 74.0, 85.0, 77.0, 75.0, 75.0, 83.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 91.0, 82.0, 86.0, 77.0, 79.0, 81.0, 89.0, 86.0, 88.0], "value": 83.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 120.0, 115.0, 114.0, 114.0, 115.0, 111.0, 117.0, 119.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 150.0, 159.0, 148.0, 153.0, 152.0, 152.0, 150.0, 149.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 99.0, 94.0, 95.0, 94.0, 97.0, 99.0, 100.0, 98.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 56.0, 54.0, 54.0, 64.0, 53.0, 53.0, 52.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 42.0, 38.0, 45.0, 39.0, 40.0, 40.0, 39.0, 38.0, 50.0], "value": 41.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 78.0, 73.0, 73.0, 75.0, 87.0, 73.0, 85.0, 73.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 117.0, 109.0, 113.0, 115.0, 117.0, 111.0, 112.0, 114.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 174.0, 177.0, 172.0, 174.0, 170.0, 171.0, 169.0, 170.0, 178.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 74.0, 68.0, 67.0, 71.0, 65.0, 68.0, 69.0, 67.0], "value": 69.6, "unit": "score"}]}]} 11:36:04 INFO - Return code: 0 11:36:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:05 INFO - # TBPL SUCCESS # 11:36:05 INFO - Running post-action listener: _package_coverage_data 11:36:05 INFO - Running post-action listener: _resource_record_post_action 11:36:05 INFO - [mozharness: 2017-09-20 18:36:05.017671Z] Finished run-tests step (success) 11:36:05 INFO - Running post-run listener: _resource_record_post_run 11:36:05 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8658944; Write bytes: 508260352; Read time: 5672; Write time: 353656 11:36:05 INFO - TinderboxPrint: CPU usage
13.3% 11:36:05 INFO - TinderboxPrint: I/O read bytes / time
8,658,944 / 5,672 11:36:05 INFO - TinderboxPrint: I/O write bytes / time
508,260,352 / 353,656 11:36:05 INFO - TinderboxPrint: CPU idle
8,258.0 (86.7%) 11:36:05 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 11:36:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 176685056; Read time: 228; Write time: 149244 11:36:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:36:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8650752; Write bytes: 321613824; Read time: 5428; Write time: 202028 11:36:05 INFO - Running post-run listener: _upload_blobber_files 11:36:05 INFO - Blob upload gear active. 11:36:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:36:05 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'] 11:36:05 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 11:36:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:07 INFO - (blobuploader) - INFO - Done attempting. 11:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:07 INFO - (blobuploader) - INFO - Done attempting. 11:36:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:08 INFO - (blobuploader) - INFO - Done attempting. 11:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:16 INFO - (blobuploader) - INFO - Done attempting. 11:36:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:16 INFO - Return code: 0 11:36:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c80c5258aaf5b795094baf90c62a2c6d83903758f49cc2a5f855b06f74adb8f4bde8e0223c67822b02c945f830a1ecc2c81349da33cb0ab4133827a3565b5c9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2de2d3b99017305347c69eacab4badfdb1d09aa694369a2a2d464a152721abbc7e8c02c7546055df1ff8404e17f03d95ef82c271a745038c611f75f44c60ff07", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80a97f8acda413a42f5a7faf6b9d83ddd70731c1faceffcac01087d35ab4a5efc39a2e46aca4ab8427a901c091e429f96d852f58533a9916be94b4fe3044158c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234b4c92967374a92588c1abb38de175ae0d7aa1e3453590738164958c68dd4e9e8a1722b53424ea13fa3160c374a7e52e2c5bc649fa103c5bc5465de64ba409"} 11:36:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:16 INFO - Contents: 11:36:16 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c80c5258aaf5b795094baf90c62a2c6d83903758f49cc2a5f855b06f74adb8f4bde8e0223c67822b02c945f830a1ecc2c81349da33cb0ab4133827a3565b5c9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2de2d3b99017305347c69eacab4badfdb1d09aa694369a2a2d464a152721abbc7e8c02c7546055df1ff8404e17f03d95ef82c271a745038c611f75f44c60ff07", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80a97f8acda413a42f5a7faf6b9d83ddd70731c1faceffcac01087d35ab4a5efc39a2e46aca4ab8427a901c091e429f96d852f58533a9916be94b4fe3044158c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234b4c92967374a92588c1abb38de175ae0d7aa1e3453590738164958c68dd4e9e8a1722b53424ea13fa3160c374a7e52e2c5bc649fa103c5bc5465de64ba409"} 11:36:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:16 INFO - Copying logs to upload dir... 11:36:16 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.253814 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-20 11:36:16.136713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 11:36:16.140281) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 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/8c80c5258aaf5b795094baf90c62a2c6d83903758f49cc2a5f855b06f74adb8f4bde8e0223c67822b02c945f830a1ecc2c81349da33cb0ab4133827a3565b5c9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2de2d3b99017305347c69eacab4badfdb1d09aa694369a2a2d464a152721abbc7e8c02c7546055df1ff8404e17f03d95ef82c271a745038c611f75f44c60ff07", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80a97f8acda413a42f5a7faf6b9d83ddd70731c1faceffcac01087d35ab4a5efc39a2e46aca4ab8427a901c091e429f96d852f58533a9916be94b4fe3044158c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234b4c92967374a92588c1abb38de175ae0d7aa1e3453590738164958c68dd4e9e8a1722b53424ea13fa3160c374a7e52e2c5bc649fa103c5bc5465de64ba409"} build_url:https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011463 build_url: 'https://queue.taskcluster.net/v1/task/UzMIpOnOQTif8CpcZmKnmA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c80c5258aaf5b795094baf90c62a2c6d83903758f49cc2a5f855b06f74adb8f4bde8e0223c67822b02c945f830a1ecc2c81349da33cb0ab4133827a3565b5c9", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2de2d3b99017305347c69eacab4badfdb1d09aa694369a2a2d464a152721abbc7e8c02c7546055df1ff8404e17f03d95ef82c271a745038c611f75f44c60ff07", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80a97f8acda413a42f5a7faf6b9d83ddd70731c1faceffcac01087d35ab4a5efc39a2e46aca4ab8427a901c091e429f96d852f58533a9916be94b4fe3044158c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234b4c92967374a92588c1abb38de175ae0d7aa1e3453590738164958c68dd4e9e8a1722b53424ea13fa3160c374a7e52e2c5bc649fa103c5bc5465de64ba409"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 11:36:16.168701) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:36:16.169034) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1505921429.609381-912288396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 11:36:16.254906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 11:36:16.255219) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 11:36:16.255551) ========= ========= Total master_lag: 0.20 =========