builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1505587225.85 results: success (0) revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:25.850704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:25.851146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:25.851605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:25.896596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:25.897148) ========= 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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 11:40:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-09-16 11:40:25 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082894 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.015648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.015966) ========= 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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018733 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.074343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 11:40:26.074651) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --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 34e2566a71f160eb3c5c3d92626453852e818f18 --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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 11:40:26,075 truncating revision to first 12 chars 2017-09-16 11:40:26,075 Setting DEBUG logging. 2017-09-16 11:40:26,075 attempt 1/10 2017-09-16 11:40:26,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e2566a71f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 11:40:26,743 unpacking tar archive at: mozilla-central-34e2566a71f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.011024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 11:40:27.104548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.104829) ========= script_repo_revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.105186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.109474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.122444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-16 11:40:27.122816) ========= /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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:27 INFO - MultiFileLogger online at 20170916 11:40:27 in /builds/slave/test 11:40:27 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:40:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:27 INFO - {'append_to_log': False, 11:40:27 INFO - 'base_work_dir': '/builds/slave/test', 11:40:27 INFO - 'blob_upload_branch': 'Firefox', 11:40:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:27 INFO - 'branch': 'Firefox', 11:40:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:27 INFO - 'code_coverage': False, 11:40:27 INFO - 'config_files': ('talos/linux_config.py',), 11:40:27 INFO - 'default_actions': ('clobber', 11:40:27 INFO - 'read-buildbot-config', 11:40:27 INFO - 'download-and-extract', 11:40:27 INFO - 'populate-webroot', 11:40:27 INFO - 'create-virtualenv', 11:40:27 INFO - 'install', 11:40:27 INFO - 'setup-mitmproxy', 11:40:27 INFO - 'run-tests'), 11:40:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:27 INFO - 'disable_ccov_upload': False, 11:40:27 INFO - 'disable_stylo': False, 11:40:27 INFO - 'download_minidump_stackwalk': True, 11:40:27 INFO - 'download_symbols': 'ondemand', 11:40:27 INFO - 'enable_stylo': False, 11:40:27 INFO - 'enable_webrender': False, 11:40:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:40:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:27 INFO - 'gecko_profile': False, 11:40:27 INFO - 'gecko_profile_interval': 0, 11:40:27 INFO - 'installer_path': 'installer.exe', 11:40:27 INFO - 'log_level': 'info', 11:40:27 INFO - 'log_name': 'talos', 11:40:27 INFO - 'log_to_console': True, 11:40:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:27 INFO - 'opt_config_files': (), 11:40:27 INFO - 'pip_index': False, 11:40:27 INFO - 'suite': 'dromaeojs-e10s', 11:40:27 INFO - 'system_bits': '32', 11:40:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:27 INFO - 'title': 'talos-linux64-ix-028', 11:40:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:27 INFO - 'use_talos_json': True, 11:40:27 INFO - 'verify': 'False', 11:40:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:27 INFO - 'work_dir': 'build'} 11:40:27 INFO - [mozharness: 2017-09-16 18:40:27.265607Z] Running clobber step. 11:40:27 INFO - Running pre-action listener: _resource_record_pre_action 11:40:27 INFO - Running main action method: clobber 11:40:27 INFO - rmtree: /builds/slave/test/build 11:40:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:28 INFO - Running post-action listener: _resource_record_post_action 11:40:28 INFO - [mozharness: 2017-09-16 18:40:28.257927Z] Finished clobber step (success) 11:40:28 INFO - [mozharness: 2017-09-16 18:40:28.258025Z] Running read-buildbot-config step. 11:40:28 INFO - Running pre-action listener: _resource_record_pre_action 11:40:28 INFO - Running main action method: read_buildbot_config 11:40:28 INFO - Using buildbot properties: 11:40:28 INFO - { 11:40:28 INFO - "project": "", 11:40:28 INFO - "product": "firefox", 11:40:28 INFO - "who": "ffxbld@noreply.mozilla.org", 11:40:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:40:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:40:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:40:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:40:28 INFO - "stage_platform": "linux64-pgo", 11:40:28 INFO - "basedir": "/builds/slave/test", 11:40:28 INFO - "buildnumber": 168, 11:40:28 INFO - "platform": "ubuntu64_hw", 11:40:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:40:28 INFO - "slavebuilddir": "test", 11:40:28 INFO - "taskId": "ajpWQQQUQhihT2_BPPIMRA", 11:40:28 INFO - "branch": "mozilla-central", 11:40:28 INFO - "script_repo_revision": "production", 11:40:28 INFO - "revision": "34e2566a71f160eb3c5c3d92626453852e818f18", 11:40:28 INFO - "slavename": "talos-linux64-ix-028", 11:40:28 INFO - "repo_path": "mozilla-central" 11:40:28 INFO - } 11:40:28 INFO - Finding installer, test and symbols from parent task. 11:40:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ajpWQQQUQhihT2_BPPIMRA'}, attempt #1 11:40:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ajpWQQQUQhihT2_BPPIMRA'}, attempt #1 11:40:29 INFO - Task dependencies: BvB_Y1Q7TT2lE8hTX3In_Q 11:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q'}, attempt #1 11:40:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json 11:40:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip 11:40:29 INFO - Running post-action listener: _resource_record_post_action 11:40:29 INFO - [mozharness: 2017-09-16 18:40:29.586063Z] Finished read-buildbot-config step (success) 11:40:29 INFO - [mozharness: 2017-09-16 18:40:29.586280Z] Running download-and-extract step. 11:40:29 INFO - Running pre-action listener: _resource_record_pre_action 11:40:29 INFO - Running main action method: download_and_extract 11:40:29 INFO - mkdir: /builds/slave/test/build/tests 11:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:29 INFO - trying https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json 11:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:40:30 INFO - Downloaded 989 bytes. 11:40:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:40:30 INFO - Using the following test package requirements: 11:40:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:40:30 INFO - u'common': [u'target.common.tests.zip'], 11:40:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:40:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:40:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:40:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:40:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:40:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:40:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:40:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:40:30 INFO - u'target.web-platform.tests.tar.gz'], 11:40:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:40:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip 11:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip into memory 11:40:32 INFO - Content-Length response header: 55324282 11:40:32 INFO - Bytes received: 55324282 11:40:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip 11:40:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:40:43 INFO - Fetch https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip into memory 11:40:44 INFO - Content-Length response header: 14508748 11:40:44 INFO - Bytes received: 14508748 11:40:45 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:40:45 INFO - trying https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:40:48 INFO - Downloaded 62158329 bytes. 11:40:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:48 INFO - mkdir: /builds/slave/test/properties 11:40:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:48 INFO - Contents: 11:40:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:48 INFO - Running post-action listener: _resource_record_post_action 11:40:48 INFO - Running post-action listener: find_tests_for_verification 11:40:48 INFO - Running post-action listener: set_extra_try_arguments 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.810571Z] Finished download-and-extract step (success) 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.810800Z] Running populate-webroot step. 11:40:48 INFO - Running pre-action listener: _resource_record_pre_action 11:40:48 INFO - Running main action method: populate_webroot 11:40:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tresize', 11:40:48 INFO - 'tcanvasmark']}, 11:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['dromaeo_css', 11:40:48 INFO - 'kraken']}, 11:40:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['damp', 'tps']}, 11:40:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['damp', 'tps']}, 11:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['dromaeo_dom']}, 11:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:40:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['basic_compositor_video', 11:40:48 INFO - 'glvideo']}, 11:40:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:40:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['ts_paint_webext', 11:40:48 INFO - 'tp5o_webext']}, 11:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:48 INFO - 'ts_paint', 11:40:48 INFO - 'tpaint', 11:40:48 INFO - 'sessionrestore', 11:40:48 INFO - 'sessionrestore_many_windows', 11:40:48 INFO - 'sessionrestore_no_auto_restore', 11:40:48 INFO - 'tabpaint']}, 11:40:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['a11yr', 11:40:48 INFO - 'ts_paint', 11:40:48 INFO - 'tpaint', 11:40:48 INFO - 'sessionrestore', 11:40:48 INFO - 'sessionrestore_many_windows', 11:40:48 INFO - 'sessionrestore_no_auto_restore', 11:40:48 INFO - 'tabpaint']}, 11:40:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:40:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:40:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:40:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['bloom_basic']}, 11:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:48 INFO - 'tsvgr_opacity', 11:40:48 INFO - 'tart', 11:40:48 INFO - 'tscrollx', 11:40:48 INFO - 'tsvg_static']}, 11:40:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tsvgx', 11:40:48 INFO - 'tsvgr_opacity', 11:40:48 INFO - 'tart', 11:40:48 INFO - 'tscrollx', 11:40:48 INFO - 'tsvg_static']}, 11:40:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:40:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tp5o']}, 11:40:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo', 11:40:48 INFO - '--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--stylo-threads=1', 11:40:48 INFO - '--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--xperf_path', 11:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:48 INFO - 'tests': ['tp5n']}, 11:40:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo', 11:40:48 INFO - '--xperf_path', 11:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:48 INFO - 'tests': ['tp5n']}}} 11:40:48 INFO - Running post-action listener: _resource_record_post_action 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.836223Z] Finished populate-webroot step (success) 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.836312Z] Running create-virtualenv step. 11:40:48 INFO - Running pre-action listener: _resource_record_pre_action 11:40:48 INFO - Running main action method: create_virtualenv 11:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:40:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:40:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:49 INFO - Installing pip...............done. 11:40:49 INFO - Return code: 0 11:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:40:49 INFO - Reading from file tmpfile_stdout 11:40:49 INFO - Output received: 11:40:49 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:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:49 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 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40:49 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:40:49 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:40:49 INFO - Using env: {'DISPLAY': ':0', 11:40:49 INFO - 'HOME': '/home/cltbld', 11:40:49 INFO - 'LANG': 'en_US.UTF-8', 11:40:49 INFO - 'LANGUAGE': 'en_US:en', 11:40:49 INFO - 'LOGNAME': 'cltbld', 11:40:49 INFO - 'MAIL': '/var/mail/cltbld', 11:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:49 INFO - 'MOZ_NO_REMOTE': '1', 11:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:49 INFO - 'NO_EM_RESTART': '1', 11:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:49 INFO - 'PWD': '/builds/slave/test', 11:40:49 INFO - 'SHELL': '/bin/bash', 11:40:49 INFO - 'SHLVL': '1', 11:40:49 INFO - 'TERM': 'linux', 11:40:49 INFO - 'TMOUT': '86400', 11:40:49 INFO - 'USER': 'cltbld', 11:40:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:49 INFO - '_': '/tools/buildbot/bin/python'} 11:40:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:40:51 INFO - Downloading/unpacking pip>=1.5 11:40:51 INFO - Running setup.py egg_info for package pip 11:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:40:51 INFO - Installing collected packages: pip 11:40:51 INFO - Found existing installation: pip 1.1 11:40:51 INFO - Uninstalling pip: 11:40:51 INFO - Successfully uninstalled pip 11:40:51 INFO - Running setup.py install for pip 11:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:40:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Successfully installed pip 11:40:51 INFO - Cleaning up... 11:40:51 INFO - Return code: 0 11:40:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:40:51 INFO - Using env: {'DISPLAY': ':0', 11:40:51 INFO - 'HOME': '/home/cltbld', 11:40:51 INFO - 'LANG': 'en_US.UTF-8', 11:40:51 INFO - 'LANGUAGE': 'en_US:en', 11:40:51 INFO - 'LOGNAME': 'cltbld', 11:40:51 INFO - 'MAIL': '/var/mail/cltbld', 11:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:51 INFO - 'MOZ_NO_REMOTE': '1', 11:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:51 INFO - 'NO_EM_RESTART': '1', 11:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:51 INFO - 'PWD': '/builds/slave/test', 11:40:51 INFO - 'SHELL': '/bin/bash', 11:40:51 INFO - 'SHLVL': '1', 11:40:51 INFO - 'TERM': 'linux', 11:40:51 INFO - 'TMOUT': '86400', 11:40:51 INFO - 'USER': 'cltbld', 11:40:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:51 INFO - '_': '/tools/buildbot/bin/python'} 11:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:51 INFO - Downloading/unpacking psutil>=3.1.1 11:40:51 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:40:51 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:40:51 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:40:51 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:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:53 INFO - Installing collected packages: psutil 11:40:53 INFO - Running setup.py install for psutil 11:40:53 INFO - building 'psutil._psutil_linux' extension 11:40:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:40:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:40:53 INFO - building 'psutil._psutil_posix' extension 11:40:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:40:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:40:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:56 INFO - Successfully installed psutil 11:40:56 INFO - Cleaning up... 11:40:56 INFO - Return code: 0 11:40:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40: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:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40: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:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:40: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 mozsystemmonitor==0.3 11:40:56 INFO - Using env: {'DISPLAY': ':0', 11:40:56 INFO - 'HOME': '/home/cltbld', 11:40:56 INFO - 'LANG': 'en_US.UTF-8', 11:40:56 INFO - 'LANGUAGE': 'en_US:en', 11:40:56 INFO - 'LOGNAME': 'cltbld', 11:40:56 INFO - 'MAIL': '/var/mail/cltbld', 11:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:56 INFO - 'MOZ_NO_REMOTE': '1', 11:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:56 INFO - 'NO_EM_RESTART': '1', 11:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:56 INFO - 'PWD': '/builds/slave/test', 11:40:56 INFO - 'SHELL': '/bin/bash', 11:40:56 INFO - 'SHLVL': '1', 11:40:56 INFO - 'TERM': 'linux', 11:40:56 INFO - 'TMOUT': '86400', 11:40:56 INFO - 'USER': 'cltbld', 11:40:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:56 INFO - '_': '/tools/buildbot/bin/python'} 11:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40: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:40: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:40: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:40: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:40:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:57 INFO - Installing collected packages: mozsystemmonitor 11:40:57 INFO - Running setup.py install for mozsystemmonitor 11:40:57 INFO - Successfully installed mozsystemmonitor 11:40:57 INFO - Cleaning up... 11:40:57 INFO - Return code: 0 11:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:40:57 INFO - Using env: {'DISPLAY': ':0', 11:40:57 INFO - 'HOME': '/home/cltbld', 11:40:57 INFO - 'LANG': 'en_US.UTF-8', 11:40:57 INFO - 'LANGUAGE': 'en_US:en', 11:40:57 INFO - 'LOGNAME': 'cltbld', 11:40:57 INFO - 'MAIL': '/var/mail/cltbld', 11:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:57 INFO - 'MOZ_NO_REMOTE': '1', 11:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:57 INFO - 'NO_EM_RESTART': '1', 11:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:57 INFO - 'PWD': '/builds/slave/test', 11:40:57 INFO - 'SHELL': '/bin/bash', 11:40:57 INFO - 'SHLVL': '1', 11:40:57 INFO - 'TERM': 'linux', 11:40:57 INFO - 'TMOUT': '86400', 11:40:57 INFO - 'USER': 'cltbld', 11:40:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:57 INFO - '_': '/tools/buildbot/bin/python'} 11:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:59 INFO - warning: no files found matching '*.txt' 11:40:59 INFO - no previously-included directories found matching 'build' 11:40:59 INFO - no previously-included directories found matching 'dist' 11:40:59 INFO - no previously-included directories found matching '.git*' 11:40:59 INFO - Installing collected packages: jsonschema, functools32 11:40:59 INFO - Running setup.py install for functools32 11:40:59 INFO - warning: no files found matching '*.txt' 11:40:59 INFO - no previously-included directories found matching 'build' 11:40:59 INFO - no previously-included directories found matching 'dist' 11:40:59 INFO - no previously-included directories found matching '.git*' 11:40:59 INFO - Successfully installed jsonschema functools32 11:40:59 INFO - Cleaning up... 11:40:59 INFO - Return code: 0 11:40:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:40:59 INFO - Using env: {'DISPLAY': ':0', 11:40:59 INFO - 'HOME': '/home/cltbld', 11:40:59 INFO - 'LANG': 'en_US.UTF-8', 11:40:59 INFO - 'LANGUAGE': 'en_US:en', 11:40:59 INFO - 'LOGNAME': 'cltbld', 11:40:59 INFO - 'MAIL': '/var/mail/cltbld', 11:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:59 INFO - 'MOZ_NO_REMOTE': '1', 11:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:59 INFO - 'NO_EM_RESTART': '1', 11:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:59 INFO - 'PWD': '/builds/slave/test', 11:40:59 INFO - 'SHELL': '/bin/bash', 11:40:59 INFO - 'SHLVL': '1', 11:40:59 INFO - 'TERM': 'linux', 11:40:59 INFO - 'TMOUT': '86400', 11:40:59 INFO - 'USER': 'cltbld', 11:40:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:59 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:40:59 INFO - Cleaning up... 11:40:59 INFO - Return code: 0 11:40:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:40:59 INFO - Using env: {'DISPLAY': ':0', 11:40:59 INFO - 'HOME': '/home/cltbld', 11:40:59 INFO - 'LANG': 'en_US.UTF-8', 11:40:59 INFO - 'LANGUAGE': 'en_US:en', 11:40:59 INFO - 'LOGNAME': 'cltbld', 11:40:59 INFO - 'MAIL': '/var/mail/cltbld', 11:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:59 INFO - 'MOZ_NO_REMOTE': '1', 11:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:59 INFO - 'NO_EM_RESTART': '1', 11:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:59 INFO - 'PWD': '/builds/slave/test', 11:40:59 INFO - 'SHELL': '/bin/bash', 11:40:59 INFO - 'SHLVL': '1', 11:40:59 INFO - 'TERM': 'linux', 11:40:59 INFO - 'TMOUT': '86400', 11:40:59 INFO - 'USER': 'cltbld', 11:40:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:59 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:01 INFO - Downloading docopt-0.6.1.tar.gz 11:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:01 INFO - Running setup.py install for blobuploader 11:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:01 INFO - Running setup.py install for requests 11:41:02 INFO - Running setup.py install for docopt 11:41:02 INFO - Successfully installed blobuploader requests docopt 11:41:02 INFO - Cleaning up... 11:41:02 INFO - Return code: 0 11:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:02 INFO - Using env: {'DISPLAY': ':0', 11:41:02 INFO - 'HOME': '/home/cltbld', 11:41:02 INFO - 'LANG': 'en_US.UTF-8', 11:41:02 INFO - 'LANGUAGE': 'en_US:en', 11:41:02 INFO - 'LOGNAME': 'cltbld', 11:41:02 INFO - 'MAIL': '/var/mail/cltbld', 11:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:02 INFO - 'MOZ_NO_REMOTE': '1', 11:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:02 INFO - 'NO_EM_RESTART': '1', 11:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:02 INFO - 'PWD': '/builds/slave/test', 11:41:02 INFO - 'SHELL': '/bin/bash', 11:41:02 INFO - 'SHLVL': '1', 11:41:02 INFO - 'TERM': 'linux', 11:41:02 INFO - 'TMOUT': '86400', 11:41:02 INFO - 'USER': 'cltbld', 11:41:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:02 INFO - '_': '/tools/buildbot/bin/python'} 11:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:02 INFO - Running setup.py (path:/tmp/pip-7peLYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:02 INFO - Running setup.py (path:/tmp/pip-jybfpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:02 INFO - Running setup.py (path:/tmp/pip-j21im6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:02 INFO - Running setup.py (path:/tmp/pip-9XAOU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:02 INFO - Running setup.py (path:/tmp/pip-cu6dST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 INFO - Running setup.py (path:/tmp/pip-hx6S1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 INFO - Running setup.py (path:/tmp/pip-kY1zYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:02 INFO - Running setup.py (path:/tmp/pip-ZZfw85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:03 INFO - Running setup.py (path:/tmp/pip-xOIAvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:03 INFO - Running setup.py (path:/tmp/pip-6qEZKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:03 INFO - Running setup.py (path:/tmp/pip-uIeqph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:03 INFO - Running setup.py (path:/tmp/pip-LdBBHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:03 INFO - Running setup.py (path:/tmp/pip-q6Q4Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:03 INFO - Running setup.py (path:/tmp/pip-XPnv5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:03 INFO - Running setup.py (path:/tmp/pip-lAuuvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:03 INFO - Running setup.py (path:/tmp/pip-cImE7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:03 INFO - Running setup.py (path:/tmp/pip-vn6vdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:03 INFO - Running setup.py install for manifestparser 11:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozcrash 11:41:03 INFO - Running setup.py install for mozdebug 11:41:03 INFO - Running setup.py install for mozdevice 11:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozfile 11:41:04 INFO - Running setup.py install for mozhttpd 11:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozinfo 11:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozInstall 11:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozleak 11:41:04 INFO - Running setup.py install for mozlog 11:41:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for moznetwork 11:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozprocess 11:41:04 INFO - Running setup.py install for mozprofile 11:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozrunner 11:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:05 INFO - Running setup.py install for mozscreenshot 11:41:05 INFO - Running setup.py install for moztest 11:41:05 INFO - Running setup.py install for mozversion 11:41:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:05 INFO - Cleaning up... 11:41:05 INFO - Return code: 0 11:41:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:05 INFO - Using env: {'DISPLAY': ':0', 11:41:05 INFO - 'HOME': '/home/cltbld', 11:41:05 INFO - 'LANG': 'en_US.UTF-8', 11:41:05 INFO - 'LANGUAGE': 'en_US:en', 11:41:05 INFO - 'LOGNAME': 'cltbld', 11:41:05 INFO - 'MAIL': '/var/mail/cltbld', 11:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:05 INFO - 'MOZ_NO_REMOTE': '1', 11:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:05 INFO - 'NO_EM_RESTART': '1', 11:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:05 INFO - 'PWD': '/builds/slave/test', 11:41:05 INFO - 'SHELL': '/bin/bash', 11:41:05 INFO - 'SHLVL': '1', 11:41:05 INFO - 'TERM': 'linux', 11:41:05 INFO - 'TMOUT': '86400', 11:41:05 INFO - 'USER': 'cltbld', 11:41:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:05 INFO - '_': '/tools/buildbot/bin/python'} 11:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:05 INFO - Running setup.py (path:/tmp/pip-TDSyUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:05 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:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:05 INFO - Running setup.py (path:/tmp/pip-_d7rYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:05 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:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:05 INFO - Running setup.py (path:/tmp/pip-yr_RVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:05 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:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:05 INFO - Running setup.py (path:/tmp/pip-WFsSEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:05 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:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:05 INFO - Running setup.py (path:/tmp/pip-Oly862-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:06 INFO - Running setup.py (path:/tmp/pip-bKRwwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:06 INFO - Running setup.py (path:/tmp/pip-icVgqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:06 INFO - Running setup.py (path:/tmp/pip-cHzacc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:06 INFO - Running setup.py (path:/tmp/pip-qOkQnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:06 INFO - Running setup.py (path:/tmp/pip-ra8KAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:06 INFO - Running setup.py (path:/tmp/pip-roMTDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:06 INFO - Running setup.py (path:/tmp/pip-9xhm7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:06 INFO - Running setup.py (path:/tmp/pip-SHXOTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:06 INFO - Running setup.py (path:/tmp/pip-wfp_Yq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:06 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:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:06 INFO - Running setup.py (path:/tmp/pip-9H3LAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:06 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:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:06 INFO - Running setup.py (path:/tmp/pip-Di3ztc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:06 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:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:06 INFO - Running setup.py (path:/tmp/pip-9vz8rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:06 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:41:06 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:41:06 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:41:06 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:41:06 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:41:06 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:41:06 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:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:07 INFO - Downloading blessings-1.6.tar.gz 11:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:08 INFO - Installing collected packages: blessings 11:41:08 INFO - Running setup.py install for blessings 11:41:08 INFO - Successfully installed blessings 11:41:08 INFO - Cleaning up... 11:41:08 INFO - Return code: 0 11:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:08 INFO - Reading from file tmpfile_stdout 11:41:08 INFO - Current package versions: 11:41:08 INFO - argparse == 1.2.1 11:41:08 INFO - blessings == 1.6 11:41:08 INFO - blobuploader == 1.2.4 11:41:08 INFO - docopt == 0.6.1 11:41:08 INFO - functools32 == 3.2.3-2 11:41:08 INFO - jsonschema == 2.5.1 11:41:08 INFO - manifestparser == 1.1 11:41:08 INFO - mozInstall == 1.13 11:41:08 INFO - mozcrash == 1.0 11:41:08 INFO - mozdebug == 0.1 11:41:08 INFO - mozdevice == 0.51 11:41:08 INFO - mozfile == 1.2 11:41:08 INFO - mozhttpd == 0.7 11:41:08 INFO - mozinfo == 0.10 11:41:08 INFO - mozleak == 0.1 11:41:08 INFO - mozlog == 3.5 11:41:08 INFO - moznetwork == 0.27 11:41:08 INFO - mozprocess == 0.25 11:41:08 INFO - mozprofile == 0.28 11:41:08 INFO - mozrunner == 6.13 11:41:08 INFO - mozscreenshot == 0.1 11:41:08 INFO - mozsystemmonitor == 0.3 11:41:08 INFO - moztest == 0.8 11:41:08 INFO - mozversion == 1.4 11:41:08 INFO - psutil == 3.1.1 11:41:08 INFO - requests == 1.2.3 11:41:08 INFO - wsgiref == 0.1.2 11:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:08 INFO - Using env: {'DISPLAY': ':0', 11:41:08 INFO - 'HOME': '/home/cltbld', 11:41:08 INFO - 'LANG': 'en_US.UTF-8', 11:41:08 INFO - 'LANGUAGE': 'en_US:en', 11:41:08 INFO - 'LOGNAME': 'cltbld', 11:41:08 INFO - 'MAIL': '/var/mail/cltbld', 11:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:08 INFO - 'MOZ_NO_REMOTE': '1', 11:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:08 INFO - 'NO_EM_RESTART': '1', 11:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:08 INFO - 'PWD': '/builds/slave/test', 11:41:08 INFO - 'SHELL': '/bin/bash', 11:41:08 INFO - 'SHLVL': '1', 11:41:08 INFO - 'TERM': 'linux', 11:41:08 INFO - 'TMOUT': '86400', 11:41:08 INFO - 'USER': 'cltbld', 11:41:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:08 INFO - '_': '/tools/buildbot/bin/python'} 11:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:41:09 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:41:09 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:41:09 INFO - Installing collected packages: simplejson 11:41:09 INFO - Running setup.py install for simplejson 11:41:09 INFO - building 'simplejson._speedups' extension 11:41:09 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:41:10 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:41:10 INFO - Successfully installed simplejson 11:41:10 INFO - Cleaning up... 11:41:10 INFO - Return code: 0 11:41:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:10 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 0x1ebd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2229a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, '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': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', '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:41:10 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:41:10 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:41:10 INFO - Using env: {'DISPLAY': ':0', 11:41:10 INFO - 'HOME': '/home/cltbld', 11:41:10 INFO - 'LANG': 'en_US.UTF-8', 11:41:10 INFO - 'LANGUAGE': 'en_US:en', 11:41:10 INFO - 'LOGNAME': 'cltbld', 11:41:10 INFO - 'MAIL': '/var/mail/cltbld', 11:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:10 INFO - 'MOZ_NO_REMOTE': '1', 11:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:10 INFO - 'NO_EM_RESTART': '1', 11:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:10 INFO - 'PWD': '/builds/slave/test', 11:41:10 INFO - 'SHELL': '/bin/bash', 11:41:10 INFO - 'SHLVL': '1', 11:41:10 INFO - 'TERM': 'linux', 11:41:10 INFO - 'TMOUT': '86400', 11:41:10 INFO - 'USER': 'cltbld', 11:41:10 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:10 INFO - '_': '/tools/buildbot/bin/python'} 11:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:11 INFO - Cleaning up... 11:41:11 INFO - Return code: 0 11:41:11 INFO - Running post-action listener: _resource_record_post_action 11:41:11 INFO - Running post-action listener: _start_resource_monitoring 11:41:11 INFO - Starting resource monitoring. 11:41:11 INFO - [mozharness: 2017-09-16 18:41:11.175229Z] Finished create-virtualenv step (success) 11:41:11 INFO - [mozharness: 2017-09-16 18:41:11.175827Z] Running install step. 11:41:11 INFO - Running pre-action listener: _resource_record_pre_action 11:41:11 INFO - Running main action method: install 11:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:11 INFO - Reading from file tmpfile_stdout 11:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:11 INFO - Reading from file tmpfile_stdout 11:41:11 INFO - Output received: 11:41:11 INFO - Usage: mozinstall [options] installer 11:41:11 INFO - Options: 11:41:11 INFO - -h, --help show this help message and exit 11:41:11 INFO - -d DEST, --destination=DEST 11:41:11 INFO - Directory to install application into. [default: 11:41:11 INFO - "/builds/slave/test"] 11:41:11 INFO - --app=APP Application being installed. [default: firefox] 11:41:11 INFO - mkdir: /builds/slave/test/build/application 11:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:41:29 INFO - Reading from file tmpfile_stdout 11:41:29 INFO - Output received: 11:41:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:29 INFO - Running post-action listener: _resource_record_post_action 11:41:29 INFO - [mozharness: 2017-09-16 18:41:29.083568Z] Finished install step (success) 11:41:29 INFO - [mozharness: 2017-09-16 18:41:29.083828Z] Running setup-mitmproxy step. 11:41:29 INFO - Running pre-action listener: _resource_record_pre_action 11:41:29 INFO - Running main action method: setup_mitmproxy 11:41:29 INFO - Skipping: mitmproxy is not required 11:41:29 INFO - Running post-action listener: _resource_record_post_action 11:41:29 INFO - [mozharness: 2017-09-16 18:41:29.084953Z] Finished setup-mitmproxy step (success) 11:41:29 INFO - [mozharness: 2017-09-16 18:41:29.085174Z] Running run-tests step. 11:41:29 INFO - Running pre-action listener: _resource_record_pre_action 11:41:29 INFO - Running pre-action listener: _set_gcov_prefix 11:41:29 INFO - Running main action method: run_tests 11:41:29 WARNING - Try message not found. 11:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:29 INFO - Python 2.7.3 11:41:29 INFO - Return code: 0 11:41:29 INFO - grabbing minidump binary from tooltool 11:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222d090>, '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 0x222dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2227f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:41:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:41:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:41:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:29 INFO - Return code: 0 11:41:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:29 INFO - ENV: RUST_BACKTRACE is now full 11:41:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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:41:29 INFO - Using env: {'DISPLAY': ':0', 11:41:29 INFO - 'HOME': '/home/cltbld', 11:41:29 INFO - 'LANG': 'en_US.UTF-8', 11:41:29 INFO - 'LANGUAGE': 'en_US:en', 11:41:29 INFO - 'LOGNAME': 'cltbld', 11:41:29 INFO - 'MAIL': '/var/mail/cltbld', 11:41:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:29 INFO - 'MOZ_NO_REMOTE': '1', 11:41:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:29 INFO - 'NO_EM_RESTART': '1', 11:41:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:29 INFO - 'PWD': '/builds/slave/test', 11:41:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:29 INFO - 'RUST_BACKTRACE': 'full', 11:41:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:41:29 INFO - 'SHELL': '/bin/bash', 11:41:29 INFO - 'SHLVL': '1', 11:41:29 INFO - 'TERM': 'linux', 11:41:29 INFO - 'TMOUT': '86400', 11:41:29 INFO - 'USER': 'cltbld', 11:41:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:29 INFO - '_': '/tools/buildbot/bin/python'} 11:41:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:41:29 INFO - mozversion application_buildid: 20170916172404 11:41:29 INFO - mozversion application_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:41:29 INFO - mozversion application_display_name: Nightly 11:41:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:29 INFO - mozversion application_name: Firefox 11:41:29 INFO - mozversion application_remotingname: firefox 11:41:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:41:29 INFO - mozversion application_vendor: Mozilla 11:41:29 INFO - mozversion application_version: 57.0a1 11:41:29 INFO - mozversion platform_buildid: 20170916172404 11:41:29 INFO - mozversion platform_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:41:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:41:29 INFO - mozversion platform_version: 57.0a1 11:41:29 INFO - using testdate: 1505587289 11:41:29 INFO - actual date: 1505587289 11:41:29 INFO - starting webserver on 'localhost:50839' 11:41:29 INFO - SUITE-START | Running 2 tests 11:41:29 INFO - TEST-START | dromaeo_css 11:41:29 INFO - Initialising browser for dromaeo_css test... 11:41:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50839/getInfo.html -profile /tmp/tmpz7VuUZ/profile 11:41:29 INFO - TEST-INFO | started process 11926 (/builds/slave/test/build/application/firefox/firefox http://localhost:50839/getInfo.html) 11:41:35 INFO - TEST-INFO | 11926: exit 0 11:41:35 INFO - Browser initialized. 11:41:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:35 INFO - Using env: {'DISPLAY': ':0', 11:41:35 INFO - 'HOME': '/home/cltbld', 11:41:35 INFO - 'JSGC_DISABLE_POISONING': '1', 11:41:35 INFO - 'LANG': 'en_US.UTF-8', 11:41:35 INFO - 'LANGUAGE': 'en_US:en', 11:41:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:41:35 INFO - 'LOGNAME': 'cltbld', 11:41:35 INFO - 'MAIL': '/var/mail/cltbld', 11:41:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:35 INFO - 'MOZ_CRASHREPORTER': '1', 11:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:41:35 INFO - 'MOZ_NO_REMOTE': '1', 11:41:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:35 INFO - 'NO_EM_RESTART': '1', 11:41:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:35 INFO - 'PWD': '/builds/slave/test', 11:41:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:35 INFO - 'RUST_BACKTRACE': 'full', 11:41:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:41:35 INFO - 'SHELL': '/bin/bash', 11:41:35 INFO - 'SHLVL': '1', 11:41:35 INFO - 'TERM': 'linux', 11:41:35 INFO - 'TMOUT': '86400', 11:41:35 INFO - 'USER': 'cltbld', 11:41:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 11:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:35 INFO - '_': '/tools/buildbot/bin/python'} 11:41:35 INFO - TEST-INFO | started process 12165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7VuUZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:36 INFO - PID 12165 | 11:41:36 INFO - PID 12165 | (/builds/slave/test/build/application/firefox/firefox:12215): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:41:36 INFO - PID 12165 | 11:41:47 INFO - PID 12165 | RSS: Main: 147603456 11:41:47 INFO - PID 12165 | 11:44:43 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50839/tests/dromaeo/cssquery-ext.html) 11:44:45 INFO - PID 12165 | RSS: Main: 148553728 11:44:45 INFO - PID 12165 | 11:47:46 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-ext.html (next: http://localhost:50839/tests/dromaeo/cssquery-jquery.html) 11:47:47 INFO - PID 12165 | RSS: Main: 148701184 11:47:47 INFO - PID 12165 | 11:50:48 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50839/tests/dromaeo/cssquery-mootools.html) 11:50:49 INFO - PID 12165 | RSS: Main: 151109632 11:50:49 INFO - PID 12165 | 11:53:51 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50839/tests/dromaeo/cssquery-prototype.html) 11:53:51 INFO - PID 12165 | RSS: Main: 149688320 11:53:51 INFO - PID 12165 | 11:56:54 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50839/tests/dromaeo/cssquery-yui.html) 11:56:55 INFO - PID 12165 | RSS: Main: 150392832 11:56:55 INFO - PID 12165 | 11:59:56 INFO - PID 12165 | Cycle 1(1): loaded http://localhost:50839/tests/dromaeo/cssquery-yui.html (next: http://localhost:50839/tests/dromaeo/cssquery-dojo.html) 11:59:57 INFO - PID 12165 | RSS: Main: 152973312 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | __start_tp_report 11:59:57 INFO - PID 12165 | _x_x_mozilla_page_load 11:59:57 INFO - PID 12165 | _x_x_mozilla_page_load_details 11:59:57 INFO - PID 12165 | |i|pagename|runs| 11:59:57 INFO - PID 12165 | |0;dojo.html;3876.6898648108154;3881.631245031721;3888.9805550972246;3898.0449789801487;3908.3941988991705;6192.442680158785;6238.875222495559;6296.779612713556;6328.114064031033;6380;6269.874602507947;6302.4012718791755;6322.24133104027;6333.303336632966;6338.746450141989;5678.261825962619;5681.119426488901;5715.828525144242;5746.310442746876;5775.855603609923;5778.50882674971;5782.074868021117;5812.622179558336;5836.737346819382;5865.882682346371;84.22466992450654;5642.7178641067985;5656.858578535549;5742.511886489653;5753.108268218432;5674.914876276859;5698.487136157724;5735.340435849847;5757.395473475267;5764.423557644244;5671.2060311556415;5683;5762.711864406763;5772.422757724236;5772.595918285721;6253.781117660906;6308.526860485436;6341.4926805855885;6360.077788720656;6379.266384365811;6763.391294783493;6802.387785099365;6891.827704307382;6894.931050689479;6975.965120174417;6897.965510172417;6912.723491060352;6919.550229235084;6923.9653801730665;6932.23745388007;6307.936920630781;6359.904601430982;6411.294757576663;6447.355264473562;6465.77369792055;7088.716451341992;7148.106486689164;7173.0675012248075;7186.353228209487;7192.784216473409;6782.491313151533;6783.762568310184;6855.760048398282;6867.07294515234;6924.896126558005;6807.217170025411;6899.0341352210735;6930.272321406281;6955.7217711292;7025.156981162293;6919;6929.133858267716;6939.306069393121;6951.270116637781;6964.129483814523;6843.931560684329;6848.794536163923;6931.618760968095;6945.444364450832;6951.409130223988;4857.198562237191;4938.629602779806;4954;5018.397792264952;5022.096022715946;4443.622292105143;4453.131639330364;4459.843905463358;4493.752843593634;4539.84110556129;6351.491880649537;6373.171487706569;6396.0405939109505;6398.520110991694;6399.232092148879;6748.089007983957;6797.2523022467485;6891.724331026803;6900.827479313058;6940.02839602446;6207.81376558704;6223.37766223374;6305.92799224133;6327.240731112204;6410.61536307823;5502.5597952163735;5538.889222215614;5547.029269877755;5556.944430555643;5559.221708960748;7061.082059332357;7097.9353097035855;7167.856642867114;7172.569645821268;7184.209736928934;6778.559393639398;6818.897716534157;6883.793486195422;6890.276520965226;6923.6884340204815;6982.511224214256;7081.327273908971;7101.254368291255;7176.7488137914925;7182.820429489305;6740.359665831738;6798.456123510206;6849.315068493111;6851;6860.0738900247825;6809.285025072296;6898.344657257552;6904.102466679299;6931.44548436134;6941.965290173517;6526.771562995463;6532.379423954717;6602.933970660232;6619.900701489385;6627.801165965029;6559.770408035696;6563.409293163638;6615.470762339098;6642.568233064835;6649.03588979605;6542.607443553402;6593.439557637655;6607.174103237096;6611.140551728245;6628.635425051476;6583.967080164569;6671.933280667326;6681.29846366144;6778.762743303961;6779.050932869303;6419.839504012437;6462.7414903405215;6488.772892948724;6557.2131344239;6572.671366431564 11:59:57 INFO - PID 12165 | |1;ext.html;945.6359301668859;946.8674385586015;971.5870754929156;999.8000399920015;1005.3615953869296;43094.353584696255;43737;43843.342349864695;43998;44037.55962440379;40305.798471007605;40785.59214407855;40897.182056358855;40899.795501022454;40903.79548102263;7352.48532602718;7390.815229619248;7414.703411863519;7416.555006699588;7420.4805663603565;7291.781246562585;7344.30229128232;7361.337479626833;7383.741569045084;7404.814879627998;7358.632068396586;7969.442139050268;8250.422470427073;8256.628451719687;8261.256486916176;8132.064812546544;8158.673653053871;8171.836563268701;8176.1415051419635;8189.426740128193;5094.6688465249645;5113.463086375951;5236.266922630834;5369.81205657804;8007.119216886138;37381.25237495262;37685.81157094224;37814.24371512582;37815;37881.62118378836;3537.7169826414083;3560.412531932228;3571.2857428514403;3582.695470884978;3593.083763640281;32458.6754132458;32552.348953020806;32578.83710581432;32803.34393312144;32818.6718132818;5450.345958485007;5470.972645136749;5484.61607687462;5487.835364939018;5502.422245664227;218206;220478.89760551255;220522;220834;220907;52722;52993.2051019235;53050.469495304555;53086.73456632692;53104.203436948475;56322.7183864078;56364;56463.15305270424;56490.435095648514;56518;16553;16703.582410439594;16798.244079016473;16843.157842107845;16859.915700421418;13663.726725465434;13739;13762.105463144864;13787.172769633855;13913;15457.149856757762;15524.301406436738;15612.531624051297;15654;15768.92115539415;5944.4352786485215;5999.620087379927;6075.726592303268;6131.540134489931;6157.322694503601;1061.4162210784193;1068.529846867376;1092.6121226964312;1098.0776148035688;1103.0679076180616;24542;24621.63067553988;24730.752692473205;24767.62848557273;25059;1190.5178402746901;1202.7173614200656;1203.2599951030054;1206.8250103734908;1211.6607349941853;13187.934060329637;13261.336933153496;13304.46782128704;13321.06752527333;13348.46606135763;273332;275045;275222;275889;275912;57070.71464642733;57432.13851792226;57745.42254577485;61639;61703.69148154231;1463.27567853913;1508.0499285450096;1526.7328217562103;1532.716447457224;1540.1837026376038;29761;30226.69773302239;30260.394792104475;30310.87823852309;30356.544651829798;41294.58705412907;41469.79265103655;41513.58486415097;41568.376474353514;41571.37642935419;240329;240563;240756;241209;241348;35005.299894001466;35054.824725876206;35059.298814024085;35116.82441587776;35425.46861797023;43248.783756081015;44353.55646443623;45416.77291613521;45421;45598.54401456076;33111.66888331086;33130.33739325152;33145.50281745727;33351.33297334088;34304.485432719026;33414.498782517796;33594.832025839714;34113.82943085269;34177.65822341844;34472.655273446944;39695.40456893207;39712.40431393589;40114.1977160461;40131.39802903017;40228;32868.34263314673;32895.342093158484;32960.17599559934;33072.66927330696;33428.331433371684;25350.619740704275;25555.488890222463;25721;26136.477270454863;26198.476030479665 11:59:57 INFO - PID 12165 | |2;jquery.html;599.9310079340877;604.6493034040257;608.5435923057706;611.8195132435931;614.3794767285041;23391.18130865418;24161.39596510086;24229.394265143357;24250.151244706438;24289.878550607224;23717.644235336484;24574.385640359;24627.507449850993;24732.505349892992;24790.876045619792;6699.2965738597595;6938.583684978892;6939;6943.826404339881;6945.89581156283;6637.73449062037;6823.488238382141;6879.484038697117;6923.549969252008;6931.41083007945;6829.3170682931805;6838.247792742794;6844.1444819397575;6845.623490708034;6850.280720524348;6827;6848.383645471907;6853.383195512403;6855.314468553154;6864.176298844146;6006.939930600682;6250.624962502265;6263.498920086382;6282.2461304643275;6395.168628078367;29172.562411563842;29571.556426653617;29674.258143546584;29698;29700.108996729916;2168.382011126837;2207.3046990198036;2209.7348318201757;2209.767974362701;2210.9889450552646;19811.50471238216;19945.9002704987;20033.699494507593;20125.597488050156;20223;2539.7968162547136;2556.105363122892;2597.6363309136736;2603.2971097803675;2619.607058941155;131794;136718;147456;154622;154795.99999999886;15294.923525382525;15668.68662626764;15769.211539422982;16080;16620.418285359956;25477.745222547906;25483.745162548137;25508.362290942874;25523.87238063798;25544.361390965;10496.475176241158;10675.306105103144;10796.460176991119;10809.56761729522;10809.729756755987;9583;9604.471754053595;9612.423254604606;9770.071843174886;9777.657781977596;9589.904100958902;9672.903270967201;9970.950145249228;10042.949785251027;10093.444860532742;2828.8019838611513;2913.67949525552;2919.8394088325344;2967.5845381646586;3020.2147441665325;1023.3961962442046;1053.2258789789498;1056.7199692081604;1057.9153667706564;1074.7742973975553;21461.57076858454;21542;21611.783882161293;21911.452213694785;22231.66652500214;1070.4166229404993;1123.1520202247414;1131.8472006279212;1138.214631904;1139.9829002564968;11591.710207244887;11853.644390668294;11909.52361905514;11917.880821191677;12047.759044819055;592230;593704;600972;612546;628574;127334;130080;133025.33487332694;133288;133347.333263335;1210.291979192165;1235.6416639174718;1265.6203139058246;1268.2644066441442;1273.216971562501;18736.53158671044;19004.904975475034;19287.614247714686;19470.805291947465;19479.61040779205;59584.40415595962;59956;60569.274382652;61612.38387616246;62111.37888621237;78793.21206787859;78857.60571197107;79243.60378198302;79350.6032469834;80191;15348.23258837076;15440.613984650025;15554.455594054607;15721.606959826096;15722.2924968379;24153.63769543423;24315.270541883772;24372.390690232885;24499.38751531226;24555.263342099766;19624.41126766199;19691.70462443036;19728.802711972698;20019.699704504153;20024.49938751543;17346;17765.467035988942;17917.193726282087;18131.546711331794;18288.359907403177;20707.378778636667;20759.584808303447;20847;20972.895135524224;20987.370378888656;14735.631609209428;15422;15445.691086178438;15511.844881551491;15519.146446945526;20118.39644810658;20216;20225;20246.696299555224;20258.493537661678 11:59:57 INFO - PID 12165 | |3;mootools.html;1406.4514839212707;1478.0835881753314;1501.5345242974672;1504.2704288420114;1521.2013692811279;16669.249883755245;17276.48170554884;17344.132793360313;17345.392911248095;17357;16840.15799210041;17022.744658830128;17059.48821535356;17072.2317495713;17076.573085672866;2807;2854.4433835402106;2889.3065664240535;2889.6387951506063;2893.07421625079;2706.4181201041774;2724.141895302983;2738.835669859805;2740.7122252163535;2741.7943654226015;2796.272969028047;2886.9422611547757;2905.549639805823;2907.0842684554405;2908.37469943962;2835.2061422801544;2845.544712845945;2865;2868.956965645517;2878.2660421592464;2699.311675522749;2707.620933069372;2715.5655095184675;2715.660542432196;2716.090109813215;16707.66584668312;16739;16814.15929203547;16826.747598786027;17136.657266854592;8367.121452247547;8605;8623.568821558896;8669.176428239307;8676.34927380449;5550.58370622205;5623.662580245157;5728.713564321809;5797.594168408213;5819.621724587888;1982.1773963805003;2005.3081686818025;2050.456628993318;2090.937271881846;2108.673155660875;30883.382332353227;31081.533776993365;31084.37831243385;31111.84444077765;31136.37727245465;6915.861682766417;6993.440524758007;7089.92910070903;7231.602261875647;7243.239459856744;19803.10886010133;19853.801461985484;19880.304189353305;19895.403137905887;20008.899510527062;8228.917710822934;8351.916480835236;8388.161183881684;8399.62201700925;8405;7282.417406607458;7559.357454616309;7704.460687751915;7712.074551053909;7714.382849372037;5613.775448981995;5634.070378387602;5637.943620563824;5735.283089613798;5792.160136780143;1422.729681360559;1471.0144203383759;1590.554644699486;1604.8074231092344;1638.5166375919132;981.6417007792104;997.581015973293;1005.1707341443339;1010.888802231754;1026.225199974015;9869.358491698016;9912.702618921443;10041.246906482043;10131.493425328705;10149.39103653783;1048.4128887822844;1075.5590208014676;1080.287010573018;1082.4804094034907;1091.6233899304887;5258;5270.78916843322;5298.629095963245;5925.525957923356;6159.753609855646;24313.270601881974;24412.877935610562;24965.5006899861;25133.371665708502;25459.854306556248;24187;24636.5072698545;25408;25713.228603141935;25718.87140564285;12479;12659.49362025527;12748.936255318664;12884.613461596167;12899.548515801902;9490.810183796424;9529.952350238205;9585;9603.519824008632;9825.459599722084;21199.25802596902;21437;21513.6772948409;21661.241856535577;22255;21929.67105493387;22047.33857984263;22193.44516387103;22351.44121396978;22671;12488.063395245576;12672.556460524207;12681.112322137362;12712.173708708904;12720.363981801058;15460.458883939009;15537.68924621524;15588;15722.606934826263;15744.370225190863;12678;12733.87266127364;12878.42047107901;13100.60698179056;13282.402291896695;11704.770999044978;11794.823077654013;11813;11921.880781192423;12100.45547950362;11087.390193539433;11141.38722370245;11207.831882521605;11289.322640641587;11358.204925655455;8422.705205317785;8538.274246689101;8553.57232138403;8620.78448038804;8739.300855931637;8511.95744021276;8543.829123417621;8574.22831945128;8576;8624.482531048157 11:59:57 INFO - PID 12165 | |4;prototype.html;514.8878422607166;550.2489102375256;552.3620218647459;562.9099344104943;568.6929058308514;6258.687065646723;6270.216222972129;6283.497320214383;6292;6324.810255692325;6196.535259855506;6241.188645476093;6268.749250029993;6275.780347687832;6304.117423560705;4811.951880481203;4941.357623508939;4990.4261009983775;5106.489351064883;5218.582513398928;4993.500649934996;4997.475265097167;5010.674306170105;5012.82455114071;5019.573336266403;4900.754962251891;4926.285688575154;4928.457869634337;4934.703917764928;4937.604991600681;4901.828436004741;4917.311576379309;4957.405111386656;4987.700737955698;5014.097462456756;4456.286994080931;4508.436445444319;4530.388397566319;4539.6368290536675;4543.681942264043;6039.849003774897;6159.168512250833;6171.722272497748;6256.468200202989;6293.118963345135;5737.307494289194;5763.740631671543;5853.151293062525;5880.176775251425;5890.764369425217;6670.6331151786635;6717.395434410926;6724.630145342005;6740.32596740327;6742.662866856686;4977.651564390494;5011.348524691767;5015.423226328982;5017.949820501784;5032.798688052473;7005.334493223136;7065.540739851893;7103.928960710378;7111.573305601681;7127.786166415016;5222.399424066281;5225.451327610622;5230.189320655304;5241.31862857826;5264.289106040552;5294.258803767476;5302.681839089667;5339.733013349317;5369.704666243316;5389.272448219519;5610.231303392084;5794.942050579524;5828.5337173026055;5845.240118784616;5879.441453061952;6387.968060159669;6502.804915852532;6593.2088149421415;6611.867762644816;6643.236027856762;1804.49474147239;1806.864485163618;1819.4814477873742;1820.2718912435132;1827.6436094961355;1275.483429211171;1284.5311461316553;1291.4317700211877;1297.0920355751011;1309.6594885329691;6149.169862068653;6167.198264225712;6212.658303793244;6269.5611307208055;6383.106365108889;6749.493787965922;6838.760643377458;6896.3793258605965;6896.758553470042;6931.861362772716;6156.353582873823;6254.092501786908;6276.748930042747;6294.937050629526;6353.332900045429;3555.1467647764352;3582.6775590197008;3607.296577167427;3610.693091087287;3636.4545318201954;7114.181869085018;7184.856302873914;7219.8556028880175;7248.166460856964;7259.0200322955725;7069.116360454943;7076.32774886385;7119.394851437686;7138.39323657495;7146.784496806007;7026.15686117659;7044.753433629799;7200.507753739432;7200.947729896954;7219.386352160125;6711.429528490133;6803.863922721617;6807.693653785493;6815.931840681728;6821.590704557742;6816.352446517573;6860.897086543606;6874.696976512924;6876.346747059021;6904.4131248844415;7182.60495672743;7188.424926005802;7199.496035277481;7227.168875579166;7294.744683936036;5696.721311475278;5726.685032323262;5732.942670573241;5751.513819221014;5772.960867043972;6590.209174898851;6691.230508491586;6765.830854228684;6782.966085169543;6876.793696189123;6359.236891573041;6606.306337834458;6623.470122390101;6634.800955971328;6656.600603963778;6566.4418524425955;6617.338266173537;6630.801075967729;6636.502262330248;6708.396244338033;6528.902066469102;6578.506612004215;6596.505262105457;6605.636689981905;6635.270120286668;6737.079932219294;6778.695243617194;6779.93220067793;6798.184217893884;6798.830029249309;6507.609543427409;6529.640869752209;6547;6563.803085907431;6566.409023187936 11:59:57 INFO - PID 12165 | |5;yui.html;958.0898146760575;968.2205824311428;984.3306551544947;986.0238364019618;995.731152588801;22537.549249015032;23314.533709325824;24182.879085604593;24353;24391.268261952147;22412;22984.77015229847;23134;23219.651705224434;23286.88356558215;1083.5557421457224;1095.5289225632976;1099.3403957625442;1100.4332768624165;1102.0192029094112;1058.1006144776954;1088.472091035847;1091.983620245697;1094.3379255550396;1094.7044298039525;1155.6128696886553;1156.2079975216961;1157.768446310737;1157.8784227656101;1164.2083383299353;1150.0569532982956;1151.77540379626;1153.0487347937985;1154.6420609610964;1154.7286387698884;849.5370023337296;849.5879498443312;850.2900078434515;852.3224036890687;853.4793775796759;19207.327743529047;19886;19890.80109198904;19902.905340206282;20952.895235523876;22632.547349053093;22675.88662056696;23075.423114422105;23105.191318303947;23188.18841340562;16990.575235619086;17179;17230.0523471209;17232.48302550913;17267.136643167916;3894.162755007687;3970.980145099285;3996.680265578747;4015.558288588253;4017.1764788218347;163287;163557;167048;168234;169001;17020.574485637957;17484.82515174832;17489.562760930825;17548.64902701939;17563.0340331283;27830;29039.41921161565;33386;34301.828490857886;34663;9277.489738064336;9523.476208808583;9683;9696.466694331879;9705.175060119827;4353.085851971058;4471.217536931024;4486.528914463999;4488.192125417456;4493.303537951622;5847.444492773265;5888.352281249059;5939.168516407706;5941;5947.1376650385455;1192.7495226002636;1220.8351872497276;1230.267990545624;1239.1387985350095;1242.3663931395054;540.7481679910993;558.8267637032452;561.901667208245;563.650536667269;565.7369323264702;12925.353732313346;13115.344232788322;13402.396892139877;13538.120022198525;13612.86387136116;652.1163823019834;664.6842749693857;675.6689222281145;678.5826716569374;680.6256558892688;5825.3883342248455;5969.940300597025;6010.9699451502465;6023.6385816851125;6064.302605200371;154000;155035;157048;157725;164374;130561.34719326343;132119.33940330238;134736.3263183678;135301;137042;116220.41889790496;116475;117463.41268293603;118248;119670;10693;11395.715107122056;11427.371494567546;11602.18784685064;11628.709282268012;53726.731366342916;55059;55459;55879.72060139673;56371.43628563826;72448.63775681087;73147.26852731405;73784;73995;74795.25204747883;16420.753688694916;17397.391091311743;17419.39032133869;17751.73372399441;20943.16227350889;22325;22796.202132925268;22891.656625150303;22982.195623153108;23199.6520052196;20398.184072637523;20759.481012974797;20855.270065547633;20963.580728385652;21074.57850842944;20672.276470323468;20869;20880;20905.581888361845;20964.790352096283;19079.618407631493;19140.71288930695;19304.71042934329;19421.4173574793;19457;13939.790903136663;13998.860011400164;14116;14185.432582696576;14295.57113286603;14730.852691472948;14992.625184370041;15022.323995420451;15143.848561514244;15234.542963711106 11:59:57 INFO - PID 12165 | __end_tp_report 11:59:57 INFO - PID 12165 | __start_cc_report 11:59:57 INFO - PID 12165 | _x_x_mozilla_cycle_collect,267 11:59:57 INFO - PID 12165 | __end_cc_report 11:59:57 INFO - PID 12165 | __startTimestamp1505588397125__endTimestamp 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | ------- Summary: start ------- 11:59:57 INFO - PID 12165 | Number of tests: 6 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#0] dojo.html Cycles:165 Average:6292.49 Median:6563.41 stddev:903.73 (13.8%) stddev-sans-first:886.41 11:59:57 INFO - PID 12165 | Values: 3876.7 3881.6 3889.0 3898.0 3908.4 6192.4 6238.9 6296.8 6328.1 6380.0 6269.9 6302.4 6322.2 6333.3 6338.7 5678.3 5681.1 5715.8 5746.3 5775.9 5778.5 5782.1 5812.6 5836.7 5865.9 84.2 5642.7 5656.9 5742.5 5753.1 5674.9 5698.5 5735.3 5757.4 5764.4 5671.2 5683.0 5762.7 5772.4 5772.6 6253.8 6308.5 6341.5 6360.1 6379.3 6763.4 6802.4 6891.8 6894.9 6976.0 6898.0 6912.7 6919.6 6924.0 6932.2 6307.9 6359.9 6411.3 6447.4 6465.8 7088.7 7148.1 7173.1 7186.4 7192.8 6782.5 6783.8 6855.8 6867.1 6924.9 6807.2 6899.0 6930.3 6955.7 7025.2 6919.0 6929.1 6939.3 6951.3 6964.1 6843.9 6848.8 6931.6 6945.4 6951.4 4857.2 4938.6 4954.0 5018.4 5022.1 4443.6 4453.1 4459.8 4493.8 4539.8 6351.5 6373.2 6396.0 6398.5 6399.2 6748.1 6797.3 6891.7 6900.8 6940.0 6207.8 6223.4 6305.9 6327.2 6410.6 5502.6 5538.9 5547.0 5556.9 5559.2 7061.1 7097.9 7167.9 7172.6 7184.2 6778.6 6818.9 6883.8 6890.3 6923.7 6982.5 7081.3 7101.3 7176.7 7182.8 6740.4 6798.5 6849.3 6851.0 6860.1 6809.3 6898.3 6904.1 6931.4 6942.0 6526.8 6532.4 6602.9 6619.9 6627.8 6559.8 6563.4 6615.5 6642.6 6649.0 6542.6 6593.4 6607.2 6611.1 6628.6 6584.0 6671.9 6681.3 6778.8 6779.1 6419.8 6462.7 6488.8 6557.2 6572.7 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#1] ext.html Cycles:180 Average:42167.83 Median:19481.59 stddev:64093.02 (329.0%) stddev-sans-first:64198.08 11:59:57 INFO - PID 12165 | Values: 945.6 946.9 971.6 999.8 1005.4 43094.4 43737.0 43843.3 43998.0 44037.6 40305.8 40785.6 40897.2 40899.8 40903.8 7352.5 7390.8 7414.7 7416.6 7420.5 7291.8 7344.3 7361.3 7383.7 7404.8 7358.6 7969.4 8250.4 8256.6 8261.3 8132.1 8158.7 8171.8 8176.1 8189.4 5094.7 5113.5 5236.3 5369.8 8007.1 37381.3 37685.8 37814.2 37815.0 37881.6 3537.7 3560.4 3571.3 3582.7 3593.1 32458.7 32552.3 32578.8 32803.3 32818.7 5450.3 5471.0 5484.6 5487.8 5502.4 218206.0 220478.9 220522.0 220834.0 220907.0 52722.0 52993.2 53050.5 53086.7 53104.2 56322.7 56364.0 56463.2 56490.4 56518.0 16553.0 16703.6 16798.2 16843.2 16859.9 13663.7 13739.0 13762.1 13787.2 13913.0 15457.1 15524.3 15612.5 15654.0 15768.9 5944.4 5999.6 6075.7 6131.5 6157.3 1061.4 1068.5 1092.6 1098.1 1103.1 24542.0 24621.6 24730.8 24767.6 25059.0 1190.5 1202.7 1203.3 1206.8 1211.7 13187.9 13261.3 13304.5 13321.1 13348.5 273332.0 275045.0 275222.0 275889.0 275912.0 57070.7 57432.1 57745.4 61639.0 61703.7 1463.3 1508.0 1526.7 1532.7 1540.2 29761.0 30226.7 30260.4 30310.9 30356.5 41294.6 41469.8 41513.6 41568.4 41571.4 240329.0 240563.0 240756.0 241209.0 241348.0 35005.3 35054.8 35059.3 35116.8 35425.5 43248.8 44353.6 45416.8 45421.0 45598.5 33111.7 33130.3 33145.5 33351.3 34304.5 33414.5 33594.8 34113.8 34177.7 34472.7 39695.4 39712.4 40114.2 40131.4 40228.0 32868.3 32895.3 32960.2 33072.7 33428.3 25350.6 25555.5 25721.0 26136.5 26198.5 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#2] jquery.html Cycles:180 Average:39561.43 Median:12221.33 stddev:101182.01 (827.9%) stddev-sans-first:101423.56 11:59:57 INFO - PID 12165 | Values: 599.9 604.6 608.5 611.8 614.4 23391.2 24161.4 24229.4 24250.2 24289.9 23717.6 24574.4 24627.5 24732.5 24790.9 6699.3 6938.6 6939.0 6943.8 6945.9 6637.7 6823.5 6879.5 6923.5 6931.4 6829.3 6838.2 6844.1 6845.6 6850.3 6827.0 6848.4 6853.4 6855.3 6864.2 6006.9 6250.6 6263.5 6282.2 6395.2 29172.6 29571.6 29674.3 29698.0 29700.1 2168.4 2207.3 2209.7 2209.8 2211.0 19811.5 19945.9 20033.7 20125.6 20223.0 2539.8 2556.1 2597.6 2603.3 2619.6 131794.0 136718.0 147456.0 154622.0 154796.0 15294.9 15668.7 15769.2 16080.0 16620.4 25477.7 25483.7 25508.4 25523.9 25544.4 10496.5 10675.3 10796.5 10809.6 10809.7 9583.0 9604.5 9612.4 9770.1 9777.7 9589.9 9672.9 9971.0 10042.9 10093.4 2828.8 2913.7 2919.8 2967.6 3020.2 1023.4 1053.2 1056.7 1057.9 1074.8 21461.6 21542.0 21611.8 21911.5 22231.7 1070.4 1123.2 1131.8 1138.2 1140.0 11591.7 11853.6 11909.5 11917.9 12047.8 592230.0 593704.0 600972.0 612546.0 628574.0 127334.0 130080.0 133025.3 133288.0 133347.3 1210.3 1235.6 1265.6 1268.3 1273.2 18736.5 19004.9 19287.6 19470.8 19479.6 59584.4 59956.0 60569.3 61612.4 62111.4 78793.2 78857.6 79243.6 79350.6 80191.0 15348.2 15440.6 15554.5 15721.6 15722.3 24153.6 24315.3 24372.4 24499.4 24555.3 19624.4 19691.7 19728.8 20019.7 20024.5 17346.0 17765.5 17917.2 18131.5 18288.4 20707.4 20759.6 20847.0 20972.9 20987.4 14735.6 15422.0 15445.7 15511.8 15519.1 20118.4 20216.0 20225.0 20246.7 20258.5 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#3] mootools.html Cycles:180 Average:10539.95 Median:25049.44 stddev:7803.54 (31.2%) stddev-sans-first:7795.26 11:59:57 INFO - PID 12165 | Values: 1406.5 1478.1 1501.5 1504.3 1521.2 16669.2 17276.5 17344.1 17345.4 17357.0 16840.2 17022.7 17059.5 17072.2 17076.6 2807.0 2854.4 2889.3 2889.6 2893.1 2706.4 2724.1 2738.8 2740.7 2741.8 2796.3 2886.9 2905.5 2907.1 2908.4 2835.2 2845.5 2865.0 2869.0 2878.3 2699.3 2707.6 2715.6 2715.7 2716.1 16707.7 16739.0 16814.2 16826.7 17136.7 8367.1 8605.0 8623.6 8669.2 8676.3 5550.6 5623.7 5728.7 5797.6 5819.6 1982.2 2005.3 2050.5 2090.9 2108.7 30883.4 31081.5 31084.4 31111.8 31136.4 6915.9 6993.4 7089.9 7231.6 7243.2 19803.1 19853.8 19880.3 19895.4 20008.9 8228.9 8351.9 8388.2 8399.6 8405.0 7282.4 7559.4 7704.5 7712.1 7714.4 5613.8 5634.1 5637.9 5735.3 5792.2 1422.7 1471.0 1590.6 1604.8 1638.5 981.6 997.6 1005.2 1010.9 1026.2 9869.4 9912.7 10041.2 10131.5 10149.4 1048.4 1075.6 1080.3 1082.5 1091.6 5258.0 5270.8 5298.6 5925.5 6159.8 24313.3 24412.9 24965.5 25133.4 25459.9 24187.0 24636.5 25408.0 25713.2 25718.9 12479.0 12659.5 12748.9 12884.6 12899.5 9490.8 9530.0 9585.0 9603.5 9825.5 21199.3 21437.0 21513.7 21661.2 22255.0 21929.7 22047.3 22193.4 22351.4 22671.0 12488.1 12672.6 12681.1 12712.2 12720.4 15460.5 15537.7 15588.0 15722.6 15744.4 12678.0 12733.9 12878.4 13100.6 13282.4 11704.8 11794.8 11813.0 11921.9 12100.5 11087.4 11141.4 11207.8 11289.3 11358.2 8422.7 8538.3 8553.6 8620.8 8739.3 8512.0 8543.8 8574.2 8576.0 8624.5 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#4] prototype.html Cycles:180 Average:5701.29 Median:6276.26 stddev:1611.89 (25.7%) stddev-sans-first:1568.71 11:59:57 INFO - PID 12165 | Values: 514.9 550.2 552.4 562.9 568.7 6258.7 6270.2 6283.5 6292.0 6324.8 6196.5 6241.2 6268.7 6275.8 6304.1 4812.0 4941.4 4990.4 5106.5 5218.6 4993.5 4997.5 5010.7 5012.8 5019.6 4900.8 4926.3 4928.5 4934.7 4937.6 4901.8 4917.3 4957.4 4987.7 5014.1 4456.3 4508.4 4530.4 4539.6 4543.7 6039.8 6159.2 6171.7 6256.5 6293.1 5737.3 5763.7 5853.2 5880.2 5890.8 6670.6 6717.4 6724.6 6740.3 6742.7 4977.7 5011.3 5015.4 5017.9 5032.8 7005.3 7065.5 7103.9 7111.6 7127.8 5222.4 5225.5 5230.2 5241.3 5264.3 5294.3 5302.7 5339.7 5369.7 5389.3 5610.2 5794.9 5828.5 5845.2 5879.4 6388.0 6502.8 6593.2 6611.9 6643.2 1804.5 1806.9 1819.5 1820.3 1827.6 1275.5 1284.5 1291.4 1297.1 1309.7 6149.2 6167.2 6212.7 6269.6 6383.1 6749.5 6838.8 6896.4 6896.8 6931.9 6156.4 6254.1 6276.7 6294.9 6353.3 3555.1 3582.7 3607.3 3610.7 3636.5 7114.2 7184.9 7219.9 7248.2 7259.0 7069.1 7076.3 7119.4 7138.4 7146.8 7026.2 7044.8 7200.5 7200.9 7219.4 6711.4 6803.9 6807.7 6815.9 6821.6 6816.4 6860.9 6874.7 6876.3 6904.4 7182.6 7188.4 7199.5 7227.2 7294.7 5696.7 5726.7 5732.9 5751.5 5773.0 6590.2 6691.2 6765.8 6783.0 6876.8 6359.2 6606.3 6623.5 6634.8 6656.6 6566.4 6617.3 6630.8 6636.5 6708.4 6528.9 6578.5 6596.5 6605.6 6635.3 6737.1 6778.7 6779.9 6798.2 6798.8 6507.6 6529.6 6547.0 6563.8 6566.4 11:59:57 INFO - PID 12165 | 11:59:57 INFO - PID 12165 | [#5] yui.html Cycles:180 Average:29298.09 Median:20807.38 stddev:43751.56 (210.3%) stddev-sans-first:43822.55 11:59:57 INFO - PID 12165 | Values: 958.1 968.2 984.3 986.0 995.7 22537.5 23314.5 24182.9 24353.0 24391.3 22412.0 22984.8 23134.0 23219.7 23286.9 1083.6 1095.5 1099.3 1100.4 1102.0 1058.1 1088.5 1092.0 1094.3 1094.7 1155.6 1156.2 1157.8 1157.9 1164.2 1150.1 1151.8 1153.0 1154.6 1154.7 849.5 849.6 850.3 852.3 853.5 19207.3 19886.0 19890.8 19902.9 20952.9 22632.5 22675.9 23075.4 23105.2 23188.2 16990.6 17179.0 17230.1 17232.5 17267.1 3894.2 3971.0 3996.7 4015.6 4017.2 163287.0 163557.0 167048.0 168234.0 169001.0 17020.6 17484.8 17489.6 17548.6 17563.0 27830.0 29039.4 33386.0 34301.8 34663.0 9277.5 9523.5 9683.0 9696.5 9705.2 4353.1 4471.2 4486.5 4488.2 4493.3 5847.4 5888.4 5939.2 5941.0 5947.1 1192.7 1220.8 1230.3 1239.1 1242.4 540.7 558.8 561.9 563.7 565.7 12925.4 13115.3 13402.4 13538.1 13612.9 652.1 664.7 675.7 678.6 680.6 5825.4 5969.9 6011.0 6023.6 6064.3 154000.0 155035.0 157048.0 157725.0 164374.0 130561.3 132119.3 134736.3 135301.0 137042.0 116220.4 116475.0 117463.4 118248.0 119670.0 10693.0 11395.7 11427.4 11602.2 11628.7 53726.7 55059.0 55459.0 55879.7 56371.4 72448.6 73147.3 73784.0 73995.0 74795.3 16420.8 17397.4 17419.4 17751.7 20943.2 22325.0 22796.2 22891.7 22982.2 23199.7 20398.2 20759.5 20855.3 20963.6 21074.6 20672.3 20869.0 20880.0 20905.6 20964.8 19079.6 19140.7 19304.7 19421.4 19457.0 13939.8 13998.9 14116.0 14185.4 14295.6 14730.9 14992.6 15022.3 15143.8 15234.5 11:59:57 INFO - PID 12165 | -------- Summary: end -------- 11:59:57 INFO - PID 12165 | 11:59:57 INFO - TEST-INFO | 12165: exit 0 11:59:57 INFO - TEST-OK | dromaeo_css | took 1108413ms 11:59:57 INFO - TEST-START | kraken 11:59:57 INFO - Initialising browser for kraken test... 11:59:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50839/getInfo.html -profile /tmp/tmphfKMZi/profile 11:59:57 INFO - TEST-INFO | started process 12539 (/builds/slave/test/build/application/firefox/firefox http://localhost:50839/getInfo.html) 12:00:03 INFO - TEST-INFO | 12539: exit 0 12:00:03 INFO - Browser initialized. 12:00:03 INFO - Running cycle 1/1 for kraken test... 12:00:03 INFO - Using env: {'DISPLAY': ':0', 12:00:03 INFO - 'HOME': '/home/cltbld', 12:00:03 INFO - 'JSGC_DISABLE_POISONING': '1', 12:00:03 INFO - 'LANG': 'en_US.UTF-8', 12:00:03 INFO - 'LANGUAGE': 'en_US:en', 12:00:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:00:03 INFO - 'LOGNAME': 'cltbld', 12:00:03 INFO - 'MAIL': '/var/mail/cltbld', 12:00:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:00:03 INFO - 'MOZ_CRASHREPORTER': '1', 12:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:00:03 INFO - 'MOZ_NO_REMOTE': '1', 12:00:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:03 INFO - 'NO_EM_RESTART': '1', 12:00:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:03 INFO - 'PWD': '/builds/slave/test', 12:00:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:03 INFO - 'RUST_BACKTRACE': 'full', 12:00:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:00:03 INFO - 'SHELL': '/bin/bash', 12:00:03 INFO - 'SHLVL': '1', 12:00:03 INFO - 'TERM': 'linux', 12:00:03 INFO - 'TMOUT': '86400', 12:00:03 INFO - 'USER': 'cltbld', 12:00:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796', 12:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:03 INFO - '_': '/tools/buildbot/bin/python'} 12:00:03 INFO - TEST-INFO | started process 12775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfKMZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:03 INFO - PID 12775 | 12:00:03 INFO - PID 12775 | (/builds/slave/test/build/application/firefox/firefox:12825): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:00:03 INFO - PID 12775 | 12:00:14 INFO - PID 12775 | RSS: Main: 147730432 12:00:14 INFO - PID 12775 | 12:00:16 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50839/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:17 INFO - PID 12775 | RSS: Main: 152834048 12:00:17 INFO - PID 12775 | 12:00:20 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50839/tests/kraken/driver.html?testName=audio-dft) 12:00:20 INFO - PID 12775 | RSS: Main: 153391104 12:00:20 INFO - PID 12775 | 12:00:23 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50839/tests/kraken/driver.html?testName=audio-fft) 12:00:24 INFO - PID 12775 | RSS: Main: 149770240 12:00:24 INFO - PID 12775 | 12:00:26 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50839/tests/kraken/driver.html?testName=audio-oscillator) 12:00:27 INFO - PID 12775 | RSS: Main: 150773760 12:00:27 INFO - PID 12775 | 12:00:28 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:29 INFO - PID 12775 | RSS: Main: 150421504 12:00:29 INFO - PID 12775 | 12:00:32 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50839/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:33 INFO - PID 12775 | RSS: Main: 151126016 12:00:33 INFO - PID 12775 | 12:00:36 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50839/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:37 INFO - PID 12775 | RSS: Main: 151511040 12:00:37 INFO - PID 12775 | 12:00:40 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50839/tests/kraken/driver.html?testName=json-parse-financial) 12:00:40 INFO - PID 12775 | RSS: Main: 153661440 12:00:40 INFO - PID 12775 | 12:00:42 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:43 INFO - PID 12775 | RSS: Main: 153448448 12:00:43 INFO - PID 12775 | 12:00:44 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:45 INFO - PID 12775 | RSS: Main: 153362432 12:00:45 INFO - PID 12775 | 12:00:47 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:48 INFO - PID 12775 | RSS: Main: 150347776 12:00:48 INFO - PID 12775 | 12:00:50 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:51 INFO - PID 12775 | RSS: Main: 150982656 12:00:51 INFO - PID 12775 | 12:00:53 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:54 INFO - PID 12775 | RSS: Main: 151298048 12:00:54 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | Cycle 1(1): loaded http://localhost:50839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50839/tests/kraken/driver.html?testName=ai-astar) 12:00:56 INFO - PID 12775 | RSS: Main: 152915968 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | __start_tp_report 12:00:56 INFO - PID 12775 | _x_x_mozilla_page_load 12:00:56 INFO - PID 12775 | _x_x_mozilla_page_load_details 12:00:56 INFO - PID 12775 | |i|pagename|runs| 12:00:56 INFO - PID 12775 | |0;ai-astar;104;105;104;106;104;107;107;105;105;105 12:00:56 INFO - PID 12775 | |1;audio-beat-detection;113;116;118;113;112;115;111;113;133;113 12:00:56 INFO - PID 12775 | |2;audio-dft;162;161;161;162;161;163;160;162;163;169 12:00:56 INFO - PID 12775 | |3;audio-fft;73;81;75;72;73;72;73;75;73;73 12:00:56 INFO - PID 12775 | |4;audio-oscillator;78;78;78;78;78;77;77;77;78;78 12:00:56 INFO - PID 12775 | |5;imaging-gaussian-blur;114;113;111;113;113;113;115;116;114;110 12:00:56 INFO - PID 12775 | |6;imaging-darkroom;149;150;150;150;150;151;151;150;151;149 12:00:56 INFO - PID 12775 | |7;imaging-desaturate;94;94;93;94;93;95;94;96;94;95 12:00:56 INFO - PID 12775 | |8;json-parse-financial;45;47;44;44;46;45;44;42;48;44 12:00:56 INFO - PID 12775 | |9;json-stringify-tinderbox;37;38;38;39;39;38;38;38;38;37 12:00:56 INFO - PID 12775 | |10;stanford-crypto-aes;73;72;72;71;78;75;71;70;70;71 12:00:56 INFO - PID 12775 | |11;stanford-crypto-ccm;105;107;116;103;105;107;111;105;110;111 12:00:56 INFO - PID 12775 | |12;stanford-crypto-pbkdf2;154;157;153;152;158;156;154;151;158;149 12:00:56 INFO - PID 12775 | |13;stanford-crypto-sha256-iterative;65;66;61;60;60;58;58;65;60;58 12:00:56 INFO - PID 12775 | __end_tp_report 12:00:56 INFO - PID 12775 | __start_cc_report 12:00:56 INFO - PID 12775 | _x_x_mozilla_cycle_collect,740 12:00:56 INFO - PID 12775 | __end_cc_report 12:00:56 INFO - PID 12775 | __startTimestamp1505588456303__endTimestamp 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | ------- Summary: start ------- 12:00:56 INFO - PID 12775 | Number of tests: 14 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#0] ai-astar Cycles:10 Average:105.20 Median:105.00 stddev:1.14 (1.1%) stddev-sans-first:1.12 12:00:56 INFO - PID 12775 | Values: 104.0 105.0 104.0 106.0 104.0 107.0 107.0 105.0 105.0 105.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#1] audio-beat-detection Cycles:10 Average:115.70 Median:114.00 stddev:6.41 (5.6%) stddev-sans-first:6.73 12:00:56 INFO - PID 12775 | Values: 113.0 116.0 118.0 113.0 112.0 115.0 111.0 113.0 133.0 113.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 12:00:56 INFO - PID 12775 | Values: 162.0 161.0 161.0 162.0 161.0 163.0 160.0 162.0 163.0 169.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#3] audio-fft Cycles:10 Average:74.00 Median:73.00 stddev:2.67 (3.7%) stddev-sans-first:2.80 12:00:56 INFO - PID 12775 | Values: 73.0 81.0 75.0 72.0 73.0 72.0 73.0 75.0 73.0 73.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 12:00:56 INFO - PID 12775 | Values: 78.0 78.0 78.0 78.0 78.0 77.0 77.0 77.0 78.0 78.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.50 stddev:1.75 (1.5%) stddev-sans-first:1.83 12:00:56 INFO - PID 12775 | Values: 114.0 113.0 111.0 113.0 113.0 113.0 115.0 116.0 114.0 110.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 12:00:56 INFO - PID 12775 | Values: 149.0 150.0 150.0 150.0 150.0 151.0 151.0 150.0 151.0 149.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 12:00:56 INFO - PID 12775 | Values: 94.0 94.0 93.0 94.0 93.0 95.0 94.0 96.0 94.0 95.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.73 (3.8%) stddev-sans-first:1.83 12:00:56 INFO - PID 12775 | Values: 45.0 47.0 44.0 44.0 46.0 45.0 44.0 42.0 48.0 44.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 12:00:56 INFO - PID 12775 | Values: 37.0 38.0 38.0 39.0 39.0 38.0 38.0 38.0 38.0 37.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.00 stddev:2.50 (3.5%) stddev-sans-first:2.64 12:00:56 INFO - PID 12775 | Values: 73.0 72.0 72.0 71.0 78.0 75.0 71.0 70.0 70.0 71.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#11] stanford-crypto-ccm Cycles:10 Average:108.00 Median:108.50 stddev:3.94 (3.6%) stddev-sans-first:4.03 12:00:56 INFO - PID 12775 | Values: 105.0 107.0 116.0 103.0 105.0 107.0 111.0 105.0 110.0 111.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.20 Median:155.00 stddev:3.05 (2.0%) stddev-sans-first:3.23 12:00:56 INFO - PID 12775 | Values: 154.0 157.0 153.0 152.0 158.0 156.0 154.0 151.0 158.0 149.0 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:60.50 stddev:3.11 (5.1%) stddev-sans-first:2.96 12:00:56 INFO - PID 12775 | Values: 65.0 66.0 61.0 60.0 60.0 58.0 58.0 65.0 60.0 58.0 12:00:56 INFO - PID 12775 | -------- Summary: end -------- 12:00:56 INFO - PID 12775 | 12:00:56 INFO - PID 12775 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:00:56 INFO - TEST-INFO | 12775: exit 0 12:00:57 INFO - TEST-OK | kraken | took 59195ms 12:00:57 INFO - SUITE-END | took 1167s 12:00:57 INFO - Completed test suite (00:19:28) 12:00:57 INFO - javascript benchmark 12:00:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9101.555813425559, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3876.6898648108154, 3881.631245031721, 3888.9805550972246, 3898.0449789801487, 3908.3941988991705, 6192.442680158785, 6238.875222495559, 6296.779612713556, 6328.114064031033, 6380.0, 6269.874602507947, 6302.4012718791755, 6322.24133104027, 6333.303336632966, 6338.746450141989, 5678.261825962619, 5681.119426488901, 5715.828525144242, 5746.310442746876, 5775.855603609923, 5778.50882674971, 5782.074868021117, 5812.622179558336, 5836.737346819382, 5865.882682346371, 84.22466992450654, 5642.7178641067985, 5656.858578535549, 5742.511886489653, 5753.108268218432, 5674.914876276859, 5698.487136157724, 5735.340435849847, 5757.395473475267, 5764.423557644244, 5671.2060311556415, 5683.0, 5762.711864406763, 5772.422757724236, 5772.595918285721, 6253.781117660906, 6308.526860485436, 6341.4926805855885, 6360.077788720656, 6379.266384365811, 6763.391294783493, 6802.387785099365, 6891.827704307382, 6894.931050689479, 6975.965120174417, 6897.965510172417, 6912.723491060352, 6919.550229235084, 6923.9653801730665, 6932.23745388007, 6307.936920630781, 6359.904601430982, 6411.294757576663, 6447.355264473562, 6465.77369792055, 7088.716451341992, 7148.106486689164, 7173.0675012248075, 7186.353228209487, 7192.784216473409, 6782.491313151533, 6783.762568310184, 6855.760048398282, 6867.07294515234, 6924.896126558005, 6807.217170025411, 6899.0341352210735, 6930.272321406281, 6955.7217711292, 7025.156981162293, 6919.0, 6929.133858267716, 6939.306069393121, 6951.270116637781, 6964.129483814523, 6843.931560684329, 6848.794536163923, 6931.618760968095, 6945.444364450832, 6951.409130223988, 4857.198562237191, 4938.629602779806, 4954.0, 5018.397792264952, 5022.096022715946, 4443.622292105143, 4453.131639330364, 4459.843905463358, 4493.752843593634, 4539.84110556129, 6351.491880649537, 6373.171487706569, 6396.0405939109505, 6398.520110991694, 6399.232092148879, 6748.089007983957, 6797.2523022467485, 6891.724331026803, 6900.827479313058, 6940.02839602446, 6207.81376558704, 6223.37766223374, 6305.92799224133, 6327.240731112204, 6410.61536307823, 5502.5597952163735, 5538.889222215614, 5547.029269877755, 5556.944430555643, 5559.221708960748, 7061.082059332357, 7097.9353097035855, 7167.856642867114, 7172.569645821268, 7184.209736928934, 6778.559393639398, 6818.897716534157, 6883.793486195422, 6890.276520965226, 6923.6884340204815, 6982.511224214256, 7081.327273908971, 7101.254368291255, 7176.7488137914925, 7182.820429489305, 6740.359665831738, 6798.456123510206, 6849.315068493111, 6851.0, 6860.0738900247825, 6809.285025072296, 6898.344657257552, 6904.102466679299, 6931.44548436134, 6941.965290173517, 6526.771562995463, 6532.379423954717, 6602.933970660232, 6619.900701489385, 6627.801165965029, 6559.770408035696, 6563.409293163638, 6615.470762339098, 6642.568233064835, 6649.03588979605, 6542.607443553402, 6593.439557637655, 6607.174103237096, 6611.140551728245, 6628.635425051476, 6583.967080164569, 6671.933280667326, 6681.29846366144, 6778.762743303961, 6779.050932869303, 6419.839504012437, 6462.7414903405215, 6488.772892948724, 6557.2131344239, 6572.671366431564], "value": 6231.967228381292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [945.6359301668859, 946.8674385586015, 971.5870754929156, 999.8000399920015, 1005.3615953869296, 43094.353584696255, 43737.0, 43843.342349864695, 43998.0, 44037.55962440379, 40305.798471007605, 40785.59214407855, 40897.182056358855, 40899.795501022454, 40903.79548102263, 7352.48532602718, 7390.815229619248, 7414.703411863519, 7416.555006699588, 7420.4805663603565, 7291.781246562585, 7344.30229128232, 7361.337479626833, 7383.741569045084, 7404.814879627998, 7358.632068396586, 7969.442139050268, 8250.422470427073, 8256.628451719687, 8261.256486916176, 8132.064812546544, 8158.673653053871, 8171.836563268701, 8176.1415051419635, 8189.426740128193, 5094.6688465249645, 5113.463086375951, 5236.266922630834, 5369.81205657804, 8007.119216886138, 37381.25237495262, 37685.81157094224, 37814.24371512582, 37815.0, 37881.62118378836, 3537.7169826414083, 3560.412531932228, 3571.2857428514403, 3582.695470884978, 3593.083763640281, 32458.6754132458, 32552.348953020806, 32578.83710581432, 32803.34393312144, 32818.6718132818, 5450.345958485007, 5470.972645136749, 5484.61607687462, 5487.835364939018, 5502.422245664227, 218206.0, 220478.89760551255, 220522.0, 220834.0, 220907.0, 52722.0, 52993.2051019235, 53050.469495304555, 53086.73456632692, 53104.203436948475, 56322.7183864078, 56364.0, 56463.15305270424, 56490.435095648514, 56518.0, 16553.0, 16703.582410439594, 16798.244079016473, 16843.157842107845, 16859.915700421418, 13663.726725465434, 13739.0, 13762.105463144864, 13787.172769633855, 13913.0, 15457.149856757762, 15524.301406436738, 15612.531624051297, 15654.0, 15768.92115539415, 5944.4352786485215, 5999.620087379927, 6075.726592303268, 6131.540134489931, 6157.322694503601, 1061.4162210784193, 1068.529846867376, 1092.6121226964312, 1098.0776148035688, 1103.0679076180616, 24542.0, 24621.63067553988, 24730.752692473205, 24767.62848557273, 25059.0, 1190.5178402746901, 1202.7173614200656, 1203.2599951030054, 1206.8250103734908, 1211.6607349941853, 13187.934060329637, 13261.336933153496, 13304.46782128704, 13321.06752527333, 13348.46606135763, 273332.0, 275045.0, 275222.0, 275889.0, 275912.0, 57070.71464642733, 57432.13851792226, 57745.42254577485, 61639.0, 61703.69148154231, 1463.27567853913, 1508.0499285450096, 1526.7328217562103, 1532.716447457224, 1540.1837026376038, 29761.0, 30226.69773302239, 30260.394792104475, 30310.87823852309, 30356.544651829798, 41294.58705412907, 41469.79265103655, 41513.58486415097, 41568.376474353514, 41571.37642935419, 240329.0, 240563.0, 240756.0, 241209.0, 241348.0, 35005.299894001466, 35054.824725876206, 35059.298814024085, 35116.82441587776, 35425.46861797023, 43248.783756081015, 44353.55646443623, 45416.77291613521, 45421.0, 45598.54401456076, 33111.66888331086, 33130.33739325152, 33145.50281745727, 33351.33297334088, 34304.485432719026, 33414.498782517796, 33594.832025839714, 34113.82943085269, 34177.65822341844, 34472.655273446944, 39695.40456893207, 39712.40431393589, 40114.1977160461, 40131.39802903017, 40228.0, 32868.34263314673, 32895.342093158484, 32960.17599559934, 33072.66927330696, 33428.331433371684, 25350.619740704275, 25555.488890222463, 25721.0, 26136.477270454863, 26198.476030479665], "value": 18220.60069730046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9310079340877, 604.6493034040257, 608.5435923057706, 611.8195132435931, 614.3794767285041, 23391.18130865418, 24161.39596510086, 24229.394265143357, 24250.151244706438, 24289.878550607224, 23717.644235336484, 24574.385640359, 24627.507449850993, 24732.505349892992, 24790.876045619792, 6699.2965738597595, 6938.583684978892, 6939.0, 6943.826404339881, 6945.89581156283, 6637.73449062037, 6823.488238382141, 6879.484038697117, 6923.549969252008, 6931.41083007945, 6829.3170682931805, 6838.247792742794, 6844.1444819397575, 6845.623490708034, 6850.280720524348, 6827.0, 6848.383645471907, 6853.383195512403, 6855.314468553154, 6864.176298844146, 6006.939930600682, 6250.624962502265, 6263.498920086382, 6282.2461304643275, 6395.168628078367, 29172.562411563842, 29571.556426653617, 29674.258143546584, 29698.0, 29700.108996729916, 2168.382011126837, 2207.3046990198036, 2209.7348318201757, 2209.767974362701, 2210.9889450552646, 19811.50471238216, 19945.9002704987, 20033.699494507593, 20125.597488050156, 20223.0, 2539.7968162547136, 2556.105363122892, 2597.6363309136736, 2603.2971097803675, 2619.607058941155, 131794.0, 136718.0, 147456.0, 154622.0, 154795.99999999886, 15294.923525382525, 15668.68662626764, 15769.211539422982, 16080.0, 16620.418285359956, 25477.745222547906, 25483.745162548137, 25508.362290942874, 25523.87238063798, 25544.361390965, 10496.475176241158, 10675.306105103144, 10796.460176991119, 10809.56761729522, 10809.729756755987, 9583.0, 9604.471754053595, 9612.423254604606, 9770.071843174886, 9777.657781977596, 9589.904100958902, 9672.903270967201, 9970.950145249228, 10042.949785251027, 10093.444860532742, 2828.8019838611513, 2913.67949525552, 2919.8394088325344, 2967.5845381646586, 3020.2147441665325, 1023.3961962442046, 1053.2258789789498, 1056.7199692081604, 1057.9153667706564, 1074.7742973975553, 21461.57076858454, 21542.0, 21611.783882161293, 21911.452213694785, 22231.66652500214, 1070.4166229404993, 1123.1520202247414, 1131.8472006279212, 1138.214631904, 1139.9829002564968, 11591.710207244887, 11853.644390668294, 11909.52361905514, 11917.880821191677, 12047.759044819055, 592230.0, 593704.0, 600972.0, 612546.0, 628574.0, 127334.0, 130080.0, 133025.33487332694, 133288.0, 133347.333263335, 1210.291979192165, 1235.6416639174718, 1265.6203139058246, 1268.2644066441442, 1273.216971562501, 18736.53158671044, 19004.904975475034, 19287.614247714686, 19470.805291947465, 19479.61040779205, 59584.40415595962, 59956.0, 60569.274382652, 61612.38387616246, 62111.37888621237, 78793.21206787859, 78857.60571197107, 79243.60378198302, 79350.6032469834, 80191.0, 15348.23258837076, 15440.613984650025, 15554.455594054607, 15721.606959826096, 15722.2924968379, 24153.63769543423, 24315.270541883772, 24372.390690232885, 24499.38751531226, 24555.263342099766, 19624.41126766199, 19691.70462443036, 19728.802711972698, 20019.699704504153, 20024.49938751543, 17346.0, 17765.467035988942, 17917.193726282087, 18131.546711331794, 18288.359907403177, 20707.378778636667, 20759.584808303447, 20847.0, 20972.895135524224, 20987.370378888656, 14735.631609209428, 15422.0, 15445.691086178438, 15511.844881551491, 15519.146446945526, 20118.39644810658, 20216.0, 20225.0, 20246.696299555224, 20258.493537661678], "value": 12796.77135597405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.4514839212707, 1478.0835881753314, 1501.5345242974672, 1504.2704288420114, 1521.2013692811279, 16669.249883755245, 17276.48170554884, 17344.132793360313, 17345.392911248095, 17357.0, 16840.15799210041, 17022.744658830128, 17059.48821535356, 17072.2317495713, 17076.573085672866, 2807.0, 2854.4433835402106, 2889.3065664240535, 2889.6387951506063, 2893.07421625079, 2706.4181201041774, 2724.141895302983, 2738.835669859805, 2740.7122252163535, 2741.7943654226015, 2796.272969028047, 2886.9422611547757, 2905.549639805823, 2907.0842684554405, 2908.37469943962, 2835.2061422801544, 2845.544712845945, 2865.0, 2868.956965645517, 2878.2660421592464, 2699.311675522749, 2707.620933069372, 2715.5655095184675, 2715.660542432196, 2716.090109813215, 16707.66584668312, 16739.0, 16814.15929203547, 16826.747598786027, 17136.657266854592, 8367.121452247547, 8605.0, 8623.568821558896, 8669.176428239307, 8676.34927380449, 5550.58370622205, 5623.662580245157, 5728.713564321809, 5797.594168408213, 5819.621724587888, 1982.1773963805003, 2005.3081686818025, 2050.456628993318, 2090.937271881846, 2108.673155660875, 30883.382332353227, 31081.533776993365, 31084.37831243385, 31111.84444077765, 31136.37727245465, 6915.861682766417, 6993.440524758007, 7089.92910070903, 7231.602261875647, 7243.239459856744, 19803.10886010133, 19853.801461985484, 19880.304189353305, 19895.403137905887, 20008.899510527062, 8228.917710822934, 8351.916480835236, 8388.161183881684, 8399.62201700925, 8405.0, 7282.417406607458, 7559.357454616309, 7704.460687751915, 7712.074551053909, 7714.382849372037, 5613.775448981995, 5634.070378387602, 5637.943620563824, 5735.283089613798, 5792.160136780143, 1422.729681360559, 1471.0144203383759, 1590.554644699486, 1604.8074231092344, 1638.5166375919132, 981.6417007792104, 997.581015973293, 1005.1707341443339, 1010.888802231754, 1026.225199974015, 9869.358491698016, 9912.702618921443, 10041.246906482043, 10131.493425328705, 10149.39103653783, 1048.4128887822844, 1075.5590208014676, 1080.287010573018, 1082.4804094034907, 1091.6233899304887, 5258.0, 5270.78916843322, 5298.629095963245, 5925.525957923356, 6159.753609855646, 24313.270601881974, 24412.877935610562, 24965.5006899861, 25133.371665708502, 25459.854306556248, 24187.0, 24636.5072698545, 25408.0, 25713.228603141935, 25718.87140564285, 12479.0, 12659.49362025527, 12748.936255318664, 12884.613461596167, 12899.548515801902, 9490.810183796424, 9529.952350238205, 9585.0, 9603.519824008632, 9825.459599722084, 21199.25802596902, 21437.0, 21513.6772948409, 21661.241856535577, 22255.0, 21929.67105493387, 22047.33857984263, 22193.44516387103, 22351.44121396978, 22671.0, 12488.063395245576, 12672.556460524207, 12681.112322137362, 12712.173708708904, 12720.363981801058, 15460.458883939009, 15537.68924621524, 15588.0, 15722.606934826263, 15744.370225190863, 12678.0, 12733.87266127364, 12878.42047107901, 13100.60698179056, 13282.402291896695, 11704.770999044978, 11794.823077654013, 11813.0, 11921.880781192423, 12100.45547950362, 11087.390193539433, 11141.38722370245, 11207.831882521605, 11289.322640641587, 11358.204925655455, 8422.705205317785, 8538.274246689101, 8553.57232138403, 8620.78448038804, 8739.300855931637, 8511.95744021276, 8543.829123417621, 8574.22831945128, 8576.0, 8624.482531048157], "value": 7375.511066452924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8878422607166, 550.2489102375256, 552.3620218647459, 562.9099344104943, 568.6929058308514, 6258.687065646723, 6270.216222972129, 6283.497320214383, 6292.0, 6324.810255692325, 6196.535259855506, 6241.188645476093, 6268.749250029993, 6275.780347687832, 6304.117423560705, 4811.951880481203, 4941.357623508939, 4990.4261009983775, 5106.489351064883, 5218.582513398928, 4993.500649934996, 4997.475265097167, 5010.674306170105, 5012.82455114071, 5019.573336266403, 4900.754962251891, 4926.285688575154, 4928.457869634337, 4934.703917764928, 4937.604991600681, 4901.828436004741, 4917.311576379309, 4957.405111386656, 4987.700737955698, 5014.097462456756, 4456.286994080931, 4508.436445444319, 4530.388397566319, 4539.6368290536675, 4543.681942264043, 6039.849003774897, 6159.168512250833, 6171.722272497748, 6256.468200202989, 6293.118963345135, 5737.307494289194, 5763.740631671543, 5853.151293062525, 5880.176775251425, 5890.764369425217, 6670.6331151786635, 6717.395434410926, 6724.630145342005, 6740.32596740327, 6742.662866856686, 4977.651564390494, 5011.348524691767, 5015.423226328982, 5017.949820501784, 5032.798688052473, 7005.334493223136, 7065.540739851893, 7103.928960710378, 7111.573305601681, 7127.786166415016, 5222.399424066281, 5225.451327610622, 5230.189320655304, 5241.31862857826, 5264.289106040552, 5294.258803767476, 5302.681839089667, 5339.733013349317, 5369.704666243316, 5389.272448219519, 5610.231303392084, 5794.942050579524, 5828.5337173026055, 5845.240118784616, 5879.441453061952, 6387.968060159669, 6502.804915852532, 6593.2088149421415, 6611.867762644816, 6643.236027856762, 1804.49474147239, 1806.864485163618, 1819.4814477873742, 1820.2718912435132, 1827.6436094961355, 1275.483429211171, 1284.5311461316553, 1291.4317700211877, 1297.0920355751011, 1309.6594885329691, 6149.169862068653, 6167.198264225712, 6212.658303793244, 6269.5611307208055, 6383.106365108889, 6749.493787965922, 6838.760643377458, 6896.3793258605965, 6896.758553470042, 6931.861362772716, 6156.353582873823, 6254.092501786908, 6276.748930042747, 6294.937050629526, 6353.332900045429, 3555.1467647764352, 3582.6775590197008, 3607.296577167427, 3610.693091087287, 3636.4545318201954, 7114.181869085018, 7184.856302873914, 7219.8556028880175, 7248.166460856964, 7259.0200322955725, 7069.116360454943, 7076.32774886385, 7119.394851437686, 7138.39323657495, 7146.784496806007, 7026.15686117659, 7044.753433629799, 7200.507753739432, 7200.947729896954, 7219.386352160125, 6711.429528490133, 6803.863922721617, 6807.693653785493, 6815.931840681728, 6821.590704557742, 6816.352446517573, 6860.897086543606, 6874.696976512924, 6876.346747059021, 6904.4131248844415, 7182.60495672743, 7188.424926005802, 7199.496035277481, 7227.168875579166, 7294.744683936036, 5696.721311475278, 5726.685032323262, 5732.942670573241, 5751.513819221014, 5772.960867043972, 6590.209174898851, 6691.230508491586, 6765.830854228684, 6782.966085169543, 6876.793696189123, 6359.236891573041, 6606.306337834458, 6623.470122390101, 6634.800955971328, 6656.600603963778, 6566.4418524425955, 6617.338266173537, 6630.801075967729, 6636.502262330248, 6708.396244338033, 6528.902066469102, 6578.506612004215, 6596.505262105457, 6605.636689981905, 6635.270120286668, 6737.079932219294, 6778.695243617194, 6779.93220067793, 6798.184217893884, 6798.830029249309, 6507.609543427409, 6529.640869752209, 6547.0, 6563.803085907431, 6566.409023187936], "value": 5232.996513835706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.0898146760575, 968.2205824311428, 984.3306551544947, 986.0238364019618, 995.731152588801, 22537.549249015032, 23314.533709325824, 24182.879085604593, 24353.0, 24391.268261952147, 22412.0, 22984.77015229847, 23134.0, 23219.651705224434, 23286.88356558215, 1083.5557421457224, 1095.5289225632976, 1099.3403957625442, 1100.4332768624165, 1102.0192029094112, 1058.1006144776954, 1088.472091035847, 1091.983620245697, 1094.3379255550396, 1094.7044298039525, 1155.6128696886553, 1156.2079975216961, 1157.768446310737, 1157.8784227656101, 1164.2083383299353, 1150.0569532982956, 1151.77540379626, 1153.0487347937985, 1154.6420609610964, 1154.7286387698884, 849.5370023337296, 849.5879498443312, 850.2900078434515, 852.3224036890687, 853.4793775796759, 19207.327743529047, 19886.0, 19890.80109198904, 19902.905340206282, 20952.895235523876, 22632.547349053093, 22675.88662056696, 23075.423114422105, 23105.191318303947, 23188.18841340562, 16990.575235619086, 17179.0, 17230.0523471209, 17232.48302550913, 17267.136643167916, 3894.162755007687, 3970.980145099285, 3996.680265578747, 4015.558288588253, 4017.1764788218347, 163287.0, 163557.0, 167048.0, 168234.0, 169001.0, 17020.574485637957, 17484.82515174832, 17489.562760930825, 17548.64902701939, 17563.0340331283, 27830.0, 29039.41921161565, 33386.0, 34301.828490857886, 34663.0, 9277.489738064336, 9523.476208808583, 9683.0, 9696.466694331879, 9705.175060119827, 4353.085851971058, 4471.217536931024, 4486.528914463999, 4488.192125417456, 4493.303537951622, 5847.444492773265, 5888.352281249059, 5939.168516407706, 5941.0, 5947.1376650385455, 1192.7495226002636, 1220.8351872497276, 1230.267990545624, 1239.1387985350095, 1242.3663931395054, 540.7481679910993, 558.8267637032452, 561.901667208245, 563.650536667269, 565.7369323264702, 12925.353732313346, 13115.344232788322, 13402.396892139877, 13538.120022198525, 13612.86387136116, 652.1163823019834, 664.6842749693857, 675.6689222281145, 678.5826716569374, 680.6256558892688, 5825.3883342248455, 5969.940300597025, 6010.9699451502465, 6023.6385816851125, 6064.302605200371, 154000.0, 155035.0, 157048.0, 157725.0, 164374.0, 130561.34719326343, 132119.33940330238, 134736.3263183678, 135301.0, 137042.0, 116220.41889790496, 116475.0, 117463.41268293603, 118248.0, 119670.0, 10693.0, 11395.715107122056, 11427.371494567546, 11602.18784685064, 11628.709282268012, 53726.731366342916, 55059.0, 55459.0, 55879.72060139673, 56371.43628563826, 72448.63775681087, 73147.26852731405, 73784.0, 73995.0, 74795.25204747883, 16420.753688694916, 17397.391091311743, 17419.39032133869, 17751.73372399441, 20943.16227350889, 22325.0, 22796.202132925268, 22891.656625150303, 22982.195623153108, 23199.6520052196, 20398.184072637523, 20759.481012974797, 20855.270065547633, 20963.580728385652, 21074.57850842944, 20672.276470323468, 20869.0, 20880.0, 20905.581888361845, 20964.790352096283, 19079.618407631493, 19140.71288930695, 19304.71042934329, 19421.4173574793, 19457.0, 13939.790903136663, 13998.860011400164, 14116.0, 14185.432582696576, 14295.57113286603, 14730.852691472948, 14992.625184370041, 15022.323995420451, 15143.848561514244, 15234.542963711106], "value": 10135.311775375954, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1371.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 104.0, 106.0, 104.0, 107.0, 107.0, 105.0, 105.0, 105.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 118.0, 113.0, 112.0, 115.0, 111.0, 113.0, 133.0, 113.0], "value": 115.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 163.0, 160.0, 162.0, 163.0, 169.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 75.0, 72.0, 73.0, 72.0, 73.0, 75.0, 73.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 78.0, 77.0, 77.0, 77.0, 78.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 111.0, 113.0, 113.0, 113.0, 115.0, 116.0, 114.0, 110.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 151.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 47.0, 44.0, 44.0, 46.0, 45.0, 44.0, 42.0, 48.0, 44.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 71.0, 78.0, 75.0, 71.0, 70.0, 70.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 107.0, 116.0, 103.0, 105.0, 107.0, 111.0, 105.0, 110.0, 111.0], "value": 108.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 153.0, 152.0, 158.0, 156.0, 154.0, 151.0, 158.0, 149.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 61.0, 60.0, 60.0, 58.0, 58.0, 65.0, 60.0, 58.0], "value": 61.1, "unit": "score"}]}]} 12:00:57 INFO - Return code: 0 12:00:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:57 INFO - # TBPL SUCCESS # 12:00:57 INFO - Running post-action listener: _package_coverage_data 12:00:57 INFO - Running post-action listener: _resource_record_post_action 12:00:57 INFO - [mozharness: 2017-09-16 19:00:57.627741Z] Finished run-tests step (success) 12:00:57 INFO - Running post-run listener: _resource_record_post_run 12:00:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 409292800; Read time: 800; Write time: 564196 12:00:57 INFO - TinderboxPrint: CPU usage
13.1% 12:00:57 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 800 12:00:57 INFO - TinderboxPrint: I/O write bytes / time
409,292,800 / 564,196 12:00:57 INFO - TinderboxPrint: CPU idle
8,217.6 (86.9%) 12:00:57 INFO - TinderboxPrint: CPU user
1,186.1 (12.5%) 12:00:57 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 75325440; Read time: 412; Write time: 73492 12:00:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:00:57 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 333967360; Read time: 388; Write time: 490704 12:00:58 INFO - Running post-run listener: _upload_blobber_files 12:00:58 INFO - Blob upload gear active. 12:00:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:00:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:00:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:00:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:59 INFO - (blobuploader) - INFO - Done attempting. 12:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:00 INFO - (blobuploader) - INFO - Done attempting. 12:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:07 INFO - (blobuploader) - INFO - Done attempting. 12:01:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:01:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:08 INFO - (blobuploader) - INFO - Done attempting. 12:01:08 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:08 INFO - Return code: 0 12:01:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3df58fd985d59ea1f7964f2b79be21a0bd3948d898a23e7fbcf1d5bf1e2e5a699f53086536aa1a63a68d9942902d27456c4fe5de2a8096c6ecd2a10b8272017", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb382cc68a34b85da62e2e6a759adceb924fb12fbfb31b3e3f26f4a006ea54f8ebe929e3377086f8a7b2e28ce10ed685e97202be490512a4641a34e7b4f2813", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4728583d70bb2be523c331a52ab84a3efce099b3e9f4b402a8a5471c5f1e075883677bdfdd582d5cee6fbd53256128aa42293d6d7a279d235476049682d5a72f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432f3887c5f15cd3ce33f81b4918ae645e5c83b0c6b54ef62603e39bc592dd6b1444ab52609aa5a0d2b64b96d4ad080a465c858d9a70e3af5142d586add1f7af"} 12:01:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:08 INFO - Contents: 12:01:08 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3df58fd985d59ea1f7964f2b79be21a0bd3948d898a23e7fbcf1d5bf1e2e5a699f53086536aa1a63a68d9942902d27456c4fe5de2a8096c6ecd2a10b8272017", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb382cc68a34b85da62e2e6a759adceb924fb12fbfb31b3e3f26f4a006ea54f8ebe929e3377086f8a7b2e28ce10ed685e97202be490512a4641a34e7b4f2813", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4728583d70bb2be523c331a52ab84a3efce099b3e9f4b402a8a5471c5f1e075883677bdfdd582d5cee6fbd53256128aa42293d6d7a279d235476049682d5a72f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432f3887c5f15cd3ce33f81b4918ae645e5c83b0c6b54ef62603e39bc592dd6b1444ab52609aa5a0d2b64b96d4ad080a465c858d9a70e3af5142d586add1f7af"} 12:01:08 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:08 INFO - Copying logs to upload dir... 12:01:08 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.746022 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-16 12:01:08.924847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:08.932893) ========= 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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 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/e3df58fd985d59ea1f7964f2b79be21a0bd3948d898a23e7fbcf1d5bf1e2e5a699f53086536aa1a63a68d9942902d27456c4fe5de2a8096c6ecd2a10b8272017", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb382cc68a34b85da62e2e6a759adceb924fb12fbfb31b3e3f26f4a006ea54f8ebe929e3377086f8a7b2e28ce10ed685e97202be490512a4641a34e7b4f2813", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4728583d70bb2be523c331a52ab84a3efce099b3e9f4b402a8a5471c5f1e075883677bdfdd582d5cee6fbd53256128aa42293d6d7a279d235476049682d5a72f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432f3887c5f15cd3ce33f81b4918ae645e5c83b0c6b54ef62603e39bc592dd6b1444ab52609aa5a0d2b64b96d4ad080a465c858d9a70e3af5142d586add1f7af"} build_url:https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3df58fd985d59ea1f7964f2b79be21a0bd3948d898a23e7fbcf1d5bf1e2e5a699f53086536aa1a63a68d9942902d27456c4fe5de2a8096c6ecd2a10b8272017", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb382cc68a34b85da62e2e6a759adceb924fb12fbfb31b3e3f26f4a006ea54f8ebe929e3377086f8a7b2e28ce10ed685e97202be490512a4641a34e7b4f2813", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4728583d70bb2be523c331a52ab84a3efce099b3e9f4b402a8a5471c5f1e075883677bdfdd582d5cee6fbd53256128aa42293d6d7a279d235476049682d5a72f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/432f3887c5f15cd3ce33f81b4918ae645e5c83b0c6b54ef62603e39bc592dd6b1444ab52609aa5a0d2b64b96d4ad080a465c858d9a70e3af5142d586add1f7af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:08.962505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:08.962905) ========= 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=836cfdc75598d54cb747368e000001a9-1505582596.521789-348367796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:09.044537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 12:01:09.044863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 12:01:09.045185) ========= ========= Total master_lag: 0.25 =========