builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1505621010.78 results: success (0) revision: 015f852e93fe8887e666ee5a1ff246d3d4e8063b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.779774) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.780203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.780498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.835785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.836100) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 21:03:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2017-09-16 21:03:30 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.939390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.939678) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018868 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:30.990103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:03:30.990436) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 015f852e93fe8887e666ee5a1ff246d3d4e8063b --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 015f852e93fe8887e666ee5a1ff246d3d4e8063b --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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 21:03:31,042 truncating revision to first 12 chars 2017-09-16 21:03:31,042 Setting DEBUG logging. 2017-09-16 21:03:31,042 attempt 1/10 2017-09-16 21:03:31,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/015f852e93fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 21:03:32,030 unpacking tar archive at: mozilla-central-015f852e93fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:03:32.275611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:32.275977) ========= script_repo_revision: 015f852e93fe8887e666ee5a1ff246d3d4e8063b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:32.276437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:32.276725) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:03:32.290792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-16 21:03:32.291185) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:03:32 INFO - MultiFileLogger online at 20170916 21:03:32 in /builds/slave/test 21:03:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:03:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:03:32 INFO - {'append_to_log': False, 21:03:32 INFO - 'base_work_dir': '/builds/slave/test', 21:03:32 INFO - 'blob_upload_branch': 'Firefox', 21:03:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:03:32 INFO - 'branch': 'Firefox', 21:03:32 INFO - 'buildbot_json_path': 'buildprops.json', 21:03:32 INFO - 'code_coverage': False, 21:03:32 INFO - 'config_files': ('talos/linux_config.py',), 21:03:32 INFO - 'default_actions': ('clobber', 21:03:32 INFO - 'read-buildbot-config', 21:03:32 INFO - 'download-and-extract', 21:03:32 INFO - 'populate-webroot', 21:03:32 INFO - 'create-virtualenv', 21:03:32 INFO - 'install', 21:03:32 INFO - 'setup-mitmproxy', 21:03:32 INFO - 'run-tests'), 21:03:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:03:32 INFO - 'disable_ccov_upload': False, 21:03:32 INFO - 'disable_stylo': False, 21:03:32 INFO - 'download_minidump_stackwalk': True, 21:03:32 INFO - 'download_symbols': 'ondemand', 21:03:32 INFO - 'enable_stylo': False, 21:03:32 INFO - 'enable_webrender': False, 21:03:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:03:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:03:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:03:32 INFO - 'gecko_profile': False, 21:03:32 INFO - 'gecko_profile_interval': 0, 21:03:32 INFO - 'installer_path': 'installer.exe', 21:03:32 INFO - 'log_level': 'info', 21:03:32 INFO - 'log_name': 'talos', 21:03:32 INFO - 'log_to_console': True, 21:03:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:03:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:03:32 INFO - 'opt_config_files': (), 21:03:32 INFO - 'pip_index': False, 21:03:32 INFO - 'suite': 'dromaeojs-e10s', 21:03:32 INFO - 'system_bits': '32', 21:03:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:03:32 INFO - 'title': 'talos-linux64-ix-061', 21:03:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:03:32 INFO - 'use_talos_json': True, 21:03:32 INFO - 'verify': 'False', 21:03:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:03:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:03:32 INFO - 'work_dir': 'build'} 21:03:32 INFO - [mozharness: 2017-09-17 04:03:32.483879Z] Running clobber step. 21:03:32 INFO - Running pre-action listener: _resource_record_pre_action 21:03:32 INFO - Running main action method: clobber 21:03:32 INFO - rmtree: /builds/slave/test/build 21:03:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:03:33 INFO - Running post-action listener: _resource_record_post_action 21:03:33 INFO - [mozharness: 2017-09-17 04:03:33.982718Z] Finished clobber step (success) 21:03:33 INFO - [mozharness: 2017-09-17 04:03:33.982816Z] Running read-buildbot-config step. 21:03:33 INFO - Running pre-action listener: _resource_record_pre_action 21:03:33 INFO - Running main action method: read_buildbot_config 21:03:33 INFO - Using buildbot properties: 21:03:33 INFO - { 21:03:33 INFO - "project": "", 21:03:33 INFO - "product": "firefox", 21:03:33 INFO - "who": "ryanvm@gmail.com", 21:03:33 INFO - "installer_path": "public/build/target.tar.bz2", 21:03:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 21:03:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:03:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 21:03:33 INFO - "stage_platform": "linux64-qr", 21:03:33 INFO - "basedir": "/builds/slave/test", 21:03:33 INFO - "buildnumber": 62, 21:03:33 INFO - "platform": "ubuntu64_hw_qr", 21:03:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:03:33 INFO - "slavebuilddir": "test", 21:03:33 INFO - "taskId": "ZBUlVuKtQc-_Jot2Cm-KoQ", 21:03:33 INFO - "branch": "mozilla-central", 21:03:33 INFO - "script_repo_revision": "production", 21:03:33 INFO - "revision": "015f852e93fe8887e666ee5a1ff246d3d4e8063b", 21:03:33 INFO - "slavename": "talos-linux64-ix-061", 21:03:33 INFO - "repo_path": "mozilla-central" 21:03:33 INFO - } 21:03:33 INFO - Finding installer, test and symbols from parent task. 21:03:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBUlVuKtQc-_Jot2Cm-KoQ'}, attempt #1 21:03:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZBUlVuKtQc-_Jot2Cm-KoQ'}, attempt #1 21:03:34 INFO - Task dependencies: HL4DSwsdQYWbDYpmGciB1w 21:03:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w'}, attempt #1 21:03:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 21:03:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.test_packages.json 21:03:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.crashreporter-symbols.zip 21:03:35 INFO - Running post-action listener: _resource_record_post_action 21:03:35 INFO - [mozharness: 2017-09-17 04:03:35.323570Z] Finished read-buildbot-config step (success) 21:03:35 INFO - [mozharness: 2017-09-17 04:03:35.323787Z] Running download-and-extract step. 21:03:35 INFO - Running pre-action listener: _resource_record_pre_action 21:03:35 INFO - Running main action method: download_and_extract 21:03:35 INFO - mkdir: /builds/slave/test/build/tests 21:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:35 INFO - trying https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.test_packages.json 21:03:35 INFO - Downloading https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:03:35 INFO - Downloaded 989 bytes. 21:03:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:03:35 INFO - Using the following test package requirements: 21:03:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:03:35 INFO - u'common': [u'target.common.tests.zip'], 21:03:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:03:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:03:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:03:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:03:35 INFO - u'mozbase': [u'target.common.tests.zip'], 21:03:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:03:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:03:35 INFO - u'web-platform': [u'target.common.tests.zip', 21:03:35 INFO - u'target.web-platform.tests.tar.gz'], 21:03:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:03:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.common.tests.zip 21:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.common.tests.zip into memory 21:03:38 INFO - Content-Length response header: 54731171 21:03:38 INFO - Bytes received: 54731171 21:03:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.talos.tests.zip 21:03:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:03:48 INFO - Fetch https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.talos.tests.zip into memory 21:03:50 INFO - Content-Length response header: 14508748 21:03:50 INFO - Bytes received: 14508748 21:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:51 INFO - trying https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 21:03:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:03:54 INFO - Downloaded 61424265 bytes. 21:03:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 21:03:54 INFO - mkdir: /builds/slave/test/properties 21:03:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:03:54 INFO - Writing to file /builds/slave/test/properties/build_url 21:03:54 INFO - Contents: 21:03:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 21:03:54 INFO - Running post-action listener: _resource_record_post_action 21:03:54 INFO - Running post-action listener: find_tests_for_verification 21:03:54 INFO - Running post-action listener: set_extra_try_arguments 21:03:54 INFO - [mozharness: 2017-09-17 04:03:54.912920Z] Finished download-and-extract step (success) 21:03:54 INFO - [mozharness: 2017-09-17 04:03:54.913168Z] Running populate-webroot step. 21:03:54 INFO - Running pre-action listener: _resource_record_pre_action 21:03:54 INFO - Running main action method: populate_webroot 21:03:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:03:54 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['tresize', 21:03:54 INFO - 'tcanvasmark']}, 21:03:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:03:54 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['dromaeo_css', 21:03:54 INFO - 'kraken']}, 21:03:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:03:54 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:03:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'tests': ['damp', 'tps']}, 21:03:54 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['damp', 'tps']}, 21:03:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:03:54 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['dromaeo_dom']}, 21:03:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:03:54 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['basic_compositor_video', 21:03:54 INFO - 'glvideo']}, 21:03:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:03:54 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['ts_paint_webext', 21:03:54 INFO - 'tp5o_webext']}, 21:03:54 INFO - 'other-e10s': {'tests': ['a11yr', 21:03:54 INFO - 'ts_paint', 21:03:54 INFO - 'tpaint', 21:03:54 INFO - 'sessionrestore', 21:03:54 INFO - 'sessionrestore_many_windows', 21:03:54 INFO - 'sessionrestore_no_auto_restore', 21:03:54 INFO - 'tabpaint']}, 21:03:54 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['a11yr', 21:03:54 INFO - 'ts_paint', 21:03:54 INFO - 'tpaint', 21:03:54 INFO - 'sessionrestore', 21:03:54 INFO - 'sessionrestore_many_windows', 21:03:54 INFO - 'sessionrestore_no_auto_restore', 21:03:54 INFO - 'tabpaint']}, 21:03:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:03:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:03:54 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['perf_reftest_singletons']}, 21:03:54 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['bloom_basic']}, 21:03:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:03:54 INFO - 'tsvgr_opacity', 21:03:54 INFO - 'tart', 21:03:54 INFO - 'tscrollx', 21:03:54 INFO - 'tsvg_static']}, 21:03:54 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['tsvgx', 21:03:54 INFO - 'tsvgr_opacity', 21:03:54 INFO - 'tart', 21:03:54 INFO - 'tscrollx', 21:03:54 INFO - 'tsvg_static']}, 21:03:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:03:54 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo'], 21:03:54 INFO - 'tests': ['tp5o']}, 21:03:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:03:54 INFO - 'talos_options': ['--mitmproxy', 21:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:03:54 INFO - '--firstNonBlankPaint'], 21:03:54 INFO - 'tests': ['tp6_google', 21:03:54 INFO - 'tp6_youtube', 21:03:54 INFO - 'tp6_amazon', 21:03:54 INFO - 'tp6_facebook']}, 21:03:54 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo', 21:03:54 INFO - '--mitmproxy', 21:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:03:54 INFO - '--firstNonBlankPaint'], 21:03:54 INFO - 'tests': ['tp6_google', 21:03:54 INFO - 'tp6_youtube', 21:03:54 INFO - 'tp6_amazon', 21:03:54 INFO - 'tp6_facebook']}, 21:03:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:03:54 INFO - 'talos_options': ['--stylo-threads=1', 21:03:54 INFO - '--mitmproxy', 21:03:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:03:54 INFO - '--firstNonBlankPaint'], 21:03:54 INFO - 'tests': ['tp6_google', 21:03:54 INFO - 'tp6_youtube', 21:03:54 INFO - 'tp6_amazon', 21:03:54 INFO - 'tp6_facebook']}, 21:03:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--xperf_path', 21:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:03:54 INFO - 'tests': ['tp5n']}, 21:03:54 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:03:54 INFO - 'talos_options': ['--disable-stylo', 21:03:54 INFO - '--xperf_path', 21:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:03:54 INFO - 'tests': ['tp5n']}}} 21:03:54 INFO - Running post-action listener: _resource_record_post_action 21:03:54 INFO - [mozharness: 2017-09-17 04:03:54.933018Z] Finished populate-webroot step (success) 21:03:54 INFO - [mozharness: 2017-09-17 04:03:54.933107Z] Running create-virtualenv step. 21:03:54 INFO - Running pre-action listener: _resource_record_pre_action 21:03:54 INFO - Running main action method: create_virtualenv 21:03:54 INFO - Creating virtualenv /builds/slave/test/build/venv 21:03:54 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:03:54 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:03:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:03:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:03:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:03:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:03:55 INFO - Installing pip...............done. 21:03:55 INFO - Return code: 0 21:03:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:03:55 INFO - Reading from file tmpfile_stdout 21:03:55 INFO - Output received: 21:03:55 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:03:55 INFO - Using env: {'DISPLAY': ':0', 21:03:55 INFO - 'HOME': '/home/cltbld', 21:03:55 INFO - 'LANG': 'en_US.UTF-8', 21:03:55 INFO - 'LANGUAGE': 'en_US:en', 21:03:55 INFO - 'LOGNAME': 'cltbld', 21:03:55 INFO - 'MAIL': '/var/mail/cltbld', 21:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:55 INFO - 'MOZ_NO_REMOTE': '1', 21:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:55 INFO - 'NO_EM_RESTART': '1', 21:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:55 INFO - 'PWD': '/builds/slave/test', 21:03:55 INFO - 'SHELL': '/bin/bash', 21:03:55 INFO - 'SHLVL': '1', 21:03:55 INFO - 'TERM': 'linux', 21:03:55 INFO - 'TMOUT': '86400', 21:03:55 INFO - 'USER': 'cltbld', 21:03:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:55 INFO - '_': '/tools/buildbot/bin/python'} 21:03:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:03:57 INFO - Downloading/unpacking pip>=1.5 21:03:57 INFO - Running setup.py egg_info for package pip 21:03:57 INFO - warning: no files found matching 'pip/cacert.pem' 21:03:57 INFO - warning: no files found matching '*.html' under directory 'docs' 21:03:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:03:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:03:57 INFO - Installing collected packages: pip 21:03:57 INFO - Found existing installation: pip 1.1 21:03:57 INFO - Uninstalling pip: 21:03:57 INFO - Successfully uninstalled pip 21:03:57 INFO - Running setup.py install for pip 21:03:57 INFO - warning: no files found matching 'pip/cacert.pem' 21:03:57 INFO - warning: no files found matching '*.html' under directory 'docs' 21:03:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:03:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:03:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:03:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:03:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:03:57 INFO - Successfully installed pip 21:03:57 INFO - Cleaning up... 21:03:57 INFO - Return code: 0 21:03:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03: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')]} 21:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03: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', '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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:03: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:03: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 psutil>=3.1.1 21:03:57 INFO - Using env: {'DISPLAY': ':0', 21:03:57 INFO - 'HOME': '/home/cltbld', 21:03:57 INFO - 'LANG': 'en_US.UTF-8', 21:03:57 INFO - 'LANGUAGE': 'en_US:en', 21:03:57 INFO - 'LOGNAME': 'cltbld', 21:03:57 INFO - 'MAIL': '/var/mail/cltbld', 21:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:57 INFO - 'MOZ_NO_REMOTE': '1', 21:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:57 INFO - 'NO_EM_RESTART': '1', 21:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:57 INFO - 'PWD': '/builds/slave/test', 21:03:57 INFO - 'SHELL': '/bin/bash', 21:03:57 INFO - 'SHLVL': '1', 21:03:57 INFO - 'TERM': 'linux', 21:03:57 INFO - 'TMOUT': '86400', 21:03:57 INFO - 'USER': 'cltbld', 21:03:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:57 INFO - '_': '/tools/buildbot/bin/python'} 21:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:58 INFO - Downloading/unpacking psutil>=3.1.1 21:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:03:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:59 INFO - Installing collected packages: psutil 21:03:59 INFO - Running setup.py install for psutil 21:03:59 INFO - building 'psutil._psutil_linux' extension 21:03:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:03:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:03:59 INFO - building 'psutil._psutil_posix' extension 21:03:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:03:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:03:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:59 INFO - Successfully installed psutil 21:03:59 INFO - Cleaning up... 21:03:59 INFO - Return code: 0 21:03:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:03: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 mozsystemmonitor==0.3 21:03:59 INFO - Using env: {'DISPLAY': ':0', 21:03:59 INFO - 'HOME': '/home/cltbld', 21:03:59 INFO - 'LANG': 'en_US.UTF-8', 21:03:59 INFO - 'LANGUAGE': 'en_US:en', 21:03:59 INFO - 'LOGNAME': 'cltbld', 21:03:59 INFO - 'MAIL': '/var/mail/cltbld', 21:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:59 INFO - 'MOZ_NO_REMOTE': '1', 21:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:59 INFO - 'NO_EM_RESTART': '1', 21:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:59 INFO - 'PWD': '/builds/slave/test', 21:03:59 INFO - 'SHELL': '/bin/bash', 21:03:59 INFO - 'SHLVL': '1', 21:03:59 INFO - 'TERM': 'linux', 21:03:59 INFO - 'TMOUT': '86400', 21:03:59 INFO - 'USER': 'cltbld', 21:03:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:59 INFO - '_': '/tools/buildbot/bin/python'} 21:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:04:01 INFO - Installing collected packages: mozsystemmonitor 21:04:01 INFO - Running setup.py install for mozsystemmonitor 21:04:01 INFO - Successfully installed mozsystemmonitor 21:04:01 INFO - Cleaning up... 21:04:01 INFO - Return code: 0 21:04:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:01 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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:04:01 INFO - Using env: {'DISPLAY': ':0', 21:04:01 INFO - 'HOME': '/home/cltbld', 21:04:01 INFO - 'LANG': 'en_US.UTF-8', 21:04:01 INFO - 'LANGUAGE': 'en_US:en', 21:04:01 INFO - 'LOGNAME': 'cltbld', 21:04:01 INFO - 'MAIL': '/var/mail/cltbld', 21:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:01 INFO - 'MOZ_NO_REMOTE': '1', 21:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:01 INFO - 'NO_EM_RESTART': '1', 21:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:01 INFO - 'PWD': '/builds/slave/test', 21:04:01 INFO - 'SHELL': '/bin/bash', 21:04:01 INFO - 'SHLVL': '1', 21:04:01 INFO - 'TERM': 'linux', 21:04:01 INFO - 'TMOUT': '86400', 21:04:01 INFO - 'USER': 'cltbld', 21:04:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:01 INFO - '_': '/tools/buildbot/bin/python'} 21:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:01 INFO - Downloading/unpacking jsonschema==2.5.1 21:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:04:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:04:02 INFO - warning: no files found matching '*.txt' 21:04:02 INFO - no previously-included directories found matching 'build' 21:04:02 INFO - no previously-included directories found matching 'dist' 21:04:02 INFO - no previously-included directories found matching '.git*' 21:04:02 INFO - Installing collected packages: jsonschema, functools32 21:04:02 INFO - Running setup.py install for functools32 21:04:02 INFO - warning: no files found matching '*.txt' 21:04:02 INFO - no previously-included directories found matching 'build' 21:04:02 INFO - no previously-included directories found matching 'dist' 21:04:02 INFO - no previously-included directories found matching '.git*' 21:04:03 INFO - Successfully installed jsonschema functools32 21:04:03 INFO - Cleaning up... 21:04:03 INFO - Return code: 0 21:04:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:04:03 INFO - Using env: {'DISPLAY': ':0', 21:04:03 INFO - 'HOME': '/home/cltbld', 21:04:03 INFO - 'LANG': 'en_US.UTF-8', 21:04:03 INFO - 'LANGUAGE': 'en_US:en', 21:04:03 INFO - 'LOGNAME': 'cltbld', 21:04:03 INFO - 'MAIL': '/var/mail/cltbld', 21:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:03 INFO - 'MOZ_NO_REMOTE': '1', 21:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:03 INFO - 'NO_EM_RESTART': '1', 21:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:03 INFO - 'PWD': '/builds/slave/test', 21:04:03 INFO - 'SHELL': '/bin/bash', 21:04:03 INFO - 'SHLVL': '1', 21:04:03 INFO - 'TERM': 'linux', 21:04:03 INFO - 'TMOUT': '86400', 21:04:03 INFO - 'USER': 'cltbld', 21:04:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:03 INFO - '_': '/tools/buildbot/bin/python'} 21:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:04:03 INFO - Cleaning up... 21:04:03 INFO - Return code: 0 21:04:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:04:03 INFO - Using env: {'DISPLAY': ':0', 21:04:03 INFO - 'HOME': '/home/cltbld', 21:04:03 INFO - 'LANG': 'en_US.UTF-8', 21:04:03 INFO - 'LANGUAGE': 'en_US:en', 21:04:03 INFO - 'LOGNAME': 'cltbld', 21:04:03 INFO - 'MAIL': '/var/mail/cltbld', 21:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:03 INFO - 'MOZ_NO_REMOTE': '1', 21:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:03 INFO - 'NO_EM_RESTART': '1', 21:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:03 INFO - 'PWD': '/builds/slave/test', 21:04:03 INFO - 'SHELL': '/bin/bash', 21:04:03 INFO - 'SHLVL': '1', 21:04:03 INFO - 'TERM': 'linux', 21:04:03 INFO - 'TMOUT': '86400', 21:04:03 INFO - 'USER': 'cltbld', 21:04:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:03 INFO - '_': '/tools/buildbot/bin/python'} 21:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:03 INFO - Downloading/unpacking blobuploader==1.2.4 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:04:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:04:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:05 INFO - Downloading docopt-0.6.1.tar.gz 21:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:04:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:04:05 INFO - Running setup.py install for blobuploader 21:04:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:04:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:04:05 INFO - Running setup.py install for requests 21:04:05 INFO - Running setup.py install for docopt 21:04:05 INFO - Successfully installed blobuploader requests docopt 21:04:05 INFO - Cleaning up... 21:04:05 INFO - Return code: 0 21:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:05 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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:04:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:05 INFO - Using env: {'DISPLAY': ':0', 21:04:05 INFO - 'HOME': '/home/cltbld', 21:04:05 INFO - 'LANG': 'en_US.UTF-8', 21:04:05 INFO - 'LANGUAGE': 'en_US:en', 21:04:05 INFO - 'LOGNAME': 'cltbld', 21:04:05 INFO - 'MAIL': '/var/mail/cltbld', 21:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:05 INFO - 'MOZ_NO_REMOTE': '1', 21:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:05 INFO - 'NO_EM_RESTART': '1', 21:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:05 INFO - 'PWD': '/builds/slave/test', 21:04:05 INFO - 'SHELL': '/bin/bash', 21:04:05 INFO - 'SHLVL': '1', 21:04:05 INFO - 'TERM': 'linux', 21:04:05 INFO - 'TMOUT': '86400', 21:04:05 INFO - 'USER': 'cltbld', 21:04:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:05 INFO - '_': '/tools/buildbot/bin/python'} 21:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:06 INFO - Running setup.py (path:/tmp/pip-rd34Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:06 INFO - Running setup.py (path:/tmp/pip-awbltP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:06 INFO - Running setup.py (path:/tmp/pip-cJwXLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:06 INFO - Running setup.py (path:/tmp/pip-iwK9Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:06 INFO - Running setup.py (path:/tmp/pip-kuJKqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:06 INFO - Running setup.py (path:/tmp/pip-rj1wyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:06 INFO - Running setup.py (path:/tmp/pip-z4L7kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:06 INFO - Running setup.py (path:/tmp/pip-JK7Nx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:06 INFO - Running setup.py (path:/tmp/pip-AtrCiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:06 INFO - Running setup.py (path:/tmp/pip-fenrQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:06 INFO - Running setup.py (path:/tmp/pip-6w1J1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:06 INFO - Running setup.py (path:/tmp/pip-CAUsNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:06 INFO - Running setup.py (path:/tmp/pip-Slr6Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:06 INFO - Running setup.py (path:/tmp/pip-lC2WD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:07 INFO - Running setup.py (path:/tmp/pip-lzDdEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:07 INFO - Running setup.py (path:/tmp/pip-t83DGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:07 INFO - Running setup.py (path:/tmp/pip-ylrlca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:04:07 INFO - Running setup.py install for manifestparser 21:04:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Running setup.py install for mozcrash 21:04:07 INFO - Running setup.py install for mozdebug 21:04:07 INFO - Running setup.py install for mozdevice 21:04:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Running setup.py install for mozfile 21:04:07 INFO - Running setup.py install for mozhttpd 21:04:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Running setup.py install for mozinfo 21:04:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Running setup.py install for mozInstall 21:04:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:04:07 INFO - Running setup.py install for mozleak 21:04:08 INFO - Running setup.py install for mozlog 21:04:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Running setup.py install for moznetwork 21:04:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Running setup.py install for mozprocess 21:04:08 INFO - Running setup.py install for mozprofile 21:04:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Running setup.py install for mozrunner 21:04:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Running setup.py install for mozscreenshot 21:04:08 INFO - Running setup.py install for moztest 21:04:08 INFO - Running setup.py install for mozversion 21:04:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:04:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:04:08 INFO - Cleaning up... 21:04:08 INFO - Return code: 0 21:04:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:08 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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:08 INFO - Using env: {'DISPLAY': ':0', 21:04:08 INFO - 'HOME': '/home/cltbld', 21:04:08 INFO - 'LANG': 'en_US.UTF-8', 21:04:08 INFO - 'LANGUAGE': 'en_US:en', 21:04:08 INFO - 'LOGNAME': 'cltbld', 21:04:08 INFO - 'MAIL': '/var/mail/cltbld', 21:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:08 INFO - 'MOZ_NO_REMOTE': '1', 21:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:08 INFO - 'NO_EM_RESTART': '1', 21:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:08 INFO - 'PWD': '/builds/slave/test', 21:04:08 INFO - 'SHELL': '/bin/bash', 21:04:08 INFO - 'SHLVL': '1', 21:04:08 INFO - 'TERM': 'linux', 21:04:08 INFO - 'TMOUT': '86400', 21:04:08 INFO - 'USER': 'cltbld', 21:04:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:08 INFO - '_': '/tools/buildbot/bin/python'} 21:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:09 INFO - Running setup.py (path:/tmp/pip-u0glTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:09 INFO - Running setup.py (path:/tmp/pip-h3AYDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:09 INFO - Running setup.py (path:/tmp/pip-TrXOK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:09 INFO - Running setup.py (path:/tmp/pip-LTWtAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:09 INFO - Running setup.py (path:/tmp/pip-lyX_qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:09 INFO - Running setup.py (path:/tmp/pip-oa5CDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:09 INFO - Running setup.py (path:/tmp/pip-IfUOGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:09 INFO - Running setup.py (path:/tmp/pip-e9xPsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:09 INFO - Running setup.py (path:/tmp/pip-zyL9ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:09 INFO - Running setup.py (path:/tmp/pip-qDMHSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:09 INFO - Running setup.py (path:/tmp/pip-7Vjbn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:09 INFO - Running setup.py (path:/tmp/pip-D2ZVU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:10 INFO - Running setup.py (path:/tmp/pip-GEs3ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:10 INFO - Running setup.py (path:/tmp/pip-1p_41D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:10 INFO - Running setup.py (path:/tmp/pip-wNlTOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:10 INFO - Running setup.py (path:/tmp/pip-AhTp7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:10 INFO - Running setup.py (path:/tmp/pip-BGJGn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:04:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:11 INFO - Downloading blessings-1.6.tar.gz 21:04:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:04:11 INFO - Installing collected packages: blessings 21:04:11 INFO - Running setup.py install for blessings 21:04:11 INFO - Successfully installed blessings 21:04:11 INFO - Cleaning up... 21:04:11 INFO - Return code: 0 21:04:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:11 INFO - Reading from file tmpfile_stdout 21:04:11 INFO - Current package versions: 21:04:11 INFO - argparse == 1.2.1 21:04:11 INFO - blessings == 1.6 21:04:11 INFO - blobuploader == 1.2.4 21:04:11 INFO - docopt == 0.6.1 21:04:11 INFO - functools32 == 3.2.3-2 21:04:11 INFO - jsonschema == 2.5.1 21:04:11 INFO - manifestparser == 1.1 21:04:11 INFO - mozInstall == 1.13 21:04:11 INFO - mozcrash == 1.0 21:04:11 INFO - mozdebug == 0.1 21:04:11 INFO - mozdevice == 0.51 21:04:11 INFO - mozfile == 1.2 21:04:11 INFO - mozhttpd == 0.7 21:04:11 INFO - mozinfo == 0.10 21:04:11 INFO - mozleak == 0.1 21:04:11 INFO - mozlog == 3.5 21:04:11 INFO - moznetwork == 0.27 21:04:11 INFO - mozprocess == 0.25 21:04:11 INFO - mozprofile == 0.28 21:04:11 INFO - mozrunner == 6.13 21:04:11 INFO - mozscreenshot == 0.1 21:04:11 INFO - mozsystemmonitor == 0.3 21:04:11 INFO - moztest == 0.8 21:04:11 INFO - mozversion == 1.4 21:04:11 INFO - psutil == 3.1.1 21:04:11 INFO - requests == 1.2.3 21:04:11 INFO - wsgiref == 0.1.2 21:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:11 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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:11 INFO - Using env: {'DISPLAY': ':0', 21:04:11 INFO - 'HOME': '/home/cltbld', 21:04:11 INFO - 'LANG': 'en_US.UTF-8', 21:04:11 INFO - 'LANGUAGE': 'en_US:en', 21:04:11 INFO - 'LOGNAME': 'cltbld', 21:04:11 INFO - 'MAIL': '/var/mail/cltbld', 21:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:11 INFO - 'MOZ_NO_REMOTE': '1', 21:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:11 INFO - 'NO_EM_RESTART': '1', 21:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:11 INFO - 'PWD': '/builds/slave/test', 21:04:11 INFO - 'SHELL': '/bin/bash', 21:04:11 INFO - 'SHLVL': '1', 21:04:11 INFO - 'TERM': 'linux', 21:04:11 INFO - 'TMOUT': '86400', 21:04:11 INFO - 'USER': 'cltbld', 21:04:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:11 INFO - '_': '/tools/buildbot/bin/python'} 21:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:04:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:04:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:13 INFO - Installing collected packages: simplejson 21:04:13 INFO - Running setup.py install for simplejson 21:04:13 INFO - building 'simplejson._speedups' extension 21:04:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 21:04:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 21:04:14 INFO - Successfully installed simplejson 21:04:14 INFO - Cleaning up... 21:04:14 INFO - Return code: 0 21:04:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:14 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 0x198a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:04:14 INFO - Using env: {'DISPLAY': ':0', 21:04:14 INFO - 'HOME': '/home/cltbld', 21:04:14 INFO - 'LANG': 'en_US.UTF-8', 21:04:14 INFO - 'LANGUAGE': 'en_US:en', 21:04:14 INFO - 'LOGNAME': 'cltbld', 21:04:14 INFO - 'MAIL': '/var/mail/cltbld', 21:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:14 INFO - 'MOZ_NO_REMOTE': '1', 21:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:14 INFO - 'NO_EM_RESTART': '1', 21:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:14 INFO - 'PWD': '/builds/slave/test', 21:04:14 INFO - 'SHELL': '/bin/bash', 21:04:14 INFO - 'SHLVL': '1', 21:04:14 INFO - 'TERM': 'linux', 21:04:14 INFO - 'TMOUT': '86400', 21:04:14 INFO - 'USER': 'cltbld', 21:04:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:14 INFO - '_': '/tools/buildbot/bin/python'} 21:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:04:14 INFO - Cleaning up... 21:04:14 INFO - Return code: 0 21:04:14 INFO - Running post-action listener: _resource_record_post_action 21:04:14 INFO - Running post-action listener: _start_resource_monitoring 21:04:14 INFO - Starting resource monitoring. 21:04:14 INFO - [mozharness: 2017-09-17 04:04:14.686242Z] Finished create-virtualenv step (success) 21:04:14 INFO - [mozharness: 2017-09-17 04:04:14.686767Z] Running install step. 21:04:14 INFO - Running pre-action listener: _resource_record_pre_action 21:04:14 INFO - Running main action method: install 21:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:14 INFO - Reading from file tmpfile_stdout 21:04:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:04:15 INFO - Reading from file tmpfile_stdout 21:04:15 INFO - Output received: 21:04:15 INFO - Usage: mozinstall [options] installer 21:04:15 INFO - Options: 21:04:15 INFO - -h, --help show this help message and exit 21:04:15 INFO - -d DEST, --destination=DEST 21:04:15 INFO - Directory to install application into. [default: 21:04:15 INFO - "/builds/slave/test"] 21:04:15 INFO - --app=APP Application being installed. [default: firefox] 21:04:15 INFO - mkdir: /builds/slave/test/build/application 21:04:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:04:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:04:33 INFO - Reading from file tmpfile_stdout 21:04:33 INFO - Output received: 21:04:33 INFO - /builds/slave/test/build/application/firefox/firefox 21:04:33 INFO - Running post-action listener: _resource_record_post_action 21:04:33 INFO - [mozharness: 2017-09-17 04:04:33.030497Z] Finished install step (success) 21:04:33 INFO - [mozharness: 2017-09-17 04:04:33.030751Z] Running setup-mitmproxy step. 21:04:33 INFO - Running pre-action listener: _resource_record_pre_action 21:04:33 INFO - Running main action method: setup_mitmproxy 21:04:33 INFO - Skipping: mitmproxy is not required 21:04:33 INFO - Running post-action listener: _resource_record_post_action 21:04:33 INFO - [mozharness: 2017-09-17 04:04:33.031875Z] Finished setup-mitmproxy step (success) 21:04:33 INFO - [mozharness: 2017-09-17 04:04:33.032095Z] Running run-tests step. 21:04:33 INFO - Running pre-action listener: _resource_record_pre_action 21:04:33 INFO - Running pre-action listener: _set_gcov_prefix 21:04:33 INFO - Running main action method: run_tests 21:04:33 WARNING - Try message not found. 21:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:04:33 INFO - Python 2.7.3 21:04:33 INFO - Return code: 0 21:04:33 INFO - grabbing minidump binary from tooltool 21:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:33 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 0x1cfa090>, '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 0x1cfad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:04:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:04:33 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:04:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:04:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:04:33 INFO - Return code: 0 21:04:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:04:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:04:33 INFO - ENV: RUST_BACKTRACE is now full 21:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:04:33 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/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:04:33 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/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:04:33 INFO - Using env: {'DISPLAY': ':0', 21:04:33 INFO - 'HOME': '/home/cltbld', 21:04:33 INFO - 'LANG': 'en_US.UTF-8', 21:04:33 INFO - 'LANGUAGE': 'en_US:en', 21:04:33 INFO - 'LOGNAME': 'cltbld', 21:04:33 INFO - 'MAIL': '/var/mail/cltbld', 21:04:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:04:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:04:33 INFO - 'MOZ_ACCELERATED': '1', 21:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:33 INFO - 'MOZ_NO_REMOTE': '1', 21:04:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:04:33 INFO - 'MOZ_WEBRENDER': '1', 21:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:33 INFO - 'NO_EM_RESTART': '1', 21:04:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:33 INFO - 'PWD': '/builds/slave/test', 21:04:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:04:33 INFO - 'RUST_BACKTRACE': 'full', 21:04:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:04:33 INFO - 'SHELL': '/bin/bash', 21:04:33 INFO - 'SHLVL': '1', 21:04:33 INFO - 'TERM': 'linux', 21:04:33 INFO - 'TMOUT': '86400', 21:04:33 INFO - 'USER': 'cltbld', 21:04:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:33 INFO - '_': '/tools/buildbot/bin/python'} 21:04:33 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/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:04:33 INFO - mozversion application_buildid: 20170917031052 21:04:33 INFO - mozversion application_changeset: 015f852e93fe8887e666ee5a1ff246d3d4e8063b 21:04:33 INFO - mozversion application_display_name: Nightly 21:04:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:04:33 INFO - mozversion application_name: Firefox 21:04:33 INFO - mozversion application_remotingname: firefox 21:04:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:04:33 INFO - mozversion application_vendor: Mozilla 21:04:33 INFO - mozversion application_version: 57.0a1 21:04:33 INFO - mozversion platform_buildid: 20170917031052 21:04:33 INFO - mozversion platform_changeset: 015f852e93fe8887e666ee5a1ff246d3d4e8063b 21:04:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:04:33 INFO - mozversion platform_version: 57.0a1 21:04:33 INFO - using testdate: 1505621073 21:04:33 INFO - actual date: 1505621073 21:04:33 INFO - starting webserver on 'localhost:40168' 21:04:33 INFO - SUITE-START | Running 2 tests 21:04:33 INFO - TEST-START | dromaeo_css 21:04:33 INFO - Initialising browser for dromaeo_css test... 21:04:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40168/getInfo.html -profile /tmp/tmpcsIghL/profile 21:04:33 INFO - TEST-INFO | started process 11580 (/builds/slave/test/build/application/firefox/firefox http://localhost:40168/getInfo.html) 21:04:39 INFO - TEST-INFO | 11580: exit 0 21:04:39 INFO - Browser initialized. 21:04:39 INFO - Running cycle 1/1 for dromaeo_css test... 21:04:39 INFO - Using env: {'DISPLAY': ':0', 21:04:39 INFO - 'HOME': '/home/cltbld', 21:04:39 INFO - 'JSGC_DISABLE_POISONING': '1', 21:04:39 INFO - 'LANG': 'en_US.UTF-8', 21:04:39 INFO - 'LANGUAGE': 'en_US:en', 21:04:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:04:39 INFO - 'LOGNAME': 'cltbld', 21:04:39 INFO - 'MAIL': '/var/mail/cltbld', 21:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:04:39 INFO - 'MOZ_ACCELERATED': '1', 21:04:39 INFO - 'MOZ_CRASHREPORTER': '1', 21:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:04:39 INFO - 'MOZ_NO_REMOTE': '1', 21:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:04:39 INFO - 'MOZ_WEBRENDER': '1', 21:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:39 INFO - 'NO_EM_RESTART': '1', 21:04:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:39 INFO - 'PWD': '/builds/slave/test', 21:04:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:04:39 INFO - 'RUST_BACKTRACE': 'full', 21:04:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:04:39 INFO - 'SHELL': '/bin/bash', 21:04:39 INFO - 'SHLVL': '1', 21:04:39 INFO - 'TERM': 'linux', 21:04:39 INFO - 'TMOUT': '86400', 21:04:39 INFO - 'USER': 'cltbld', 21:04:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:39 INFO - '_': '/tools/buildbot/bin/python'} 21:04:39 INFO - TEST-INFO | started process 11828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsIghL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:04:40 INFO - PID 11828 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:04:40 INFO - PID 11828 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:04:40 INFO - PID 11828 | 21:04:40 INFO - PID 11828 | (/builds/slave/test/build/application/firefox/firefox:11887): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:04:40 INFO - PID 11828 | 21:04:51 INFO - PID 11828 | RSS: Main: 207491072 21:04:51 INFO - PID 11828 | 21:07:49 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40168/tests/dromaeo/cssquery-ext.html) 21:07:50 INFO - PID 11828 | RSS: Main: 208904192 21:07:50 INFO - PID 11828 | 21:10:52 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-ext.html (next: http://localhost:40168/tests/dromaeo/cssquery-jquery.html) 21:10:53 INFO - PID 11828 | RSS: Main: 204312576 21:10:53 INFO - PID 11828 | 21:13:55 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40168/tests/dromaeo/cssquery-mootools.html) 21:13:56 INFO - PID 11828 | RSS: Main: 208801792 21:13:56 INFO - PID 11828 | 21:16:58 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40168/tests/dromaeo/cssquery-prototype.html) 21:16:58 INFO - PID 11828 | RSS: Main: 206823424 21:16:58 INFO - PID 11828 | 21:20:02 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40168/tests/dromaeo/cssquery-yui.html) 21:20:03 INFO - PID 11828 | RSS: Main: 209559552 21:20:03 INFO - PID 11828 | 21:23:04 INFO - PID 11828 | Cycle 1(1): loaded http://localhost:40168/tests/dromaeo/cssquery-yui.html (next: http://localhost:40168/tests/dromaeo/cssquery-dojo.html) 21:23:05 INFO - PID 11828 | RSS: Main: 214220800 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | __start_tp_report 21:23:05 INFO - PID 11828 | _x_x_mozilla_page_load 21:23:05 INFO - PID 11828 | _x_x_mozilla_page_load_details 21:23:05 INFO - PID 11828 | |i|pagename|runs| 21:23:05 INFO - PID 11828 | |0;dojo.html;3093.95359069614;3111.020028690963;3145.103645461044;3215.099772063823;3253.137918451609;6039.5772295939305;6203.193584833971;6213.347598502154;6264.404881536252;6280.748770049204;6070.57505974582;6113.32753397126;6170.074488826678;6194.504439644829;6195.783147589836;5621;5648.6893220872935;5659.490645841874;5680.318361796591;5693;5792.333881603607;5801.44886235809;5816.709164541777;5820.679862607555;5854.121881717755;5756.5682573807135;5776.797812076578;5812.593118481708;5899.469047785698;5901;5518.558515318765;5663.830085097454;5670.518005969498;5750.252467179282;5788.507976821975;5683.090705487102;5742.310922689262;5755.597108202427;5765.558610347413;5784;6191.907121393183;6252.155958945529;6256.124142620037;6293.685315734195;6341.682915854189;6627.039079333518;6631.966840165768;6638.701258443381;6665.200175978914;6723.93276067238;6715.395614394728;6812.3187681231975;6814.454843612499;6817.318268173192;6844.760433384858;5959.791407300723;6197.16338294329;6250.812475625738;6286.968565157145;6289.40250676185;6744.7976560703255;6768.661566921634;6806.863862722717;6819.386255236953;6820.863582728417;6414;6482.027695845567;6486.708098135501;6509;6510.153680021567;6592.406683398517;6694.230163531159;6780.898286525706;6784.253732089565;6787.490938179656;6667.566608170453;6684.766033188815;6689.331066893272;6744.156980377453;6766.323367663293;6537.411632953057;6725.8654826903185;6732.798016059526;6815.386615204656;6816.897746533806;5247;5261.76322065508;5268.341457317835;5292.9735351323;5329.653572517774;4591.540845915381;4619.19164146273;4646.86059418218;4699.671023028423;4720.33915251865;5863.648181109147;5888;5944.821655350346;5946.4053594641055;5949.613275137189;6585.83535411609;6644.933550664528;6680.265170831205;6680.665966701646;6859.965700171567;5743.879943411078;5776.855578610484;5795.94204057954;5807.0998995155815;5812.564057695689;5687.488126068673;5708.229389032511;5713.314402271754;5724.112762521816;5847.210626565445;6587.4071333580205;6588.077669126326;6627.204735431683;6646.235682896432;6664.100346453264;6671.933280667228;6752.527323087336;6757.797266082025;6800.319968003259;6858.8285292866085;6330.841728956813;6403.775867844603;6570.277269500256;6630.30381809903;6667.66661666905;6597.340265973365;6619.900701489385;6649.933500664932;6662.300458451793;6673.299303573055;6794.966025169842;6818.624975626388;6820.897686534607;6839.179298484214;6843.692033858588;6408.743650254124;6496.7726129585235;6526.771562995273;6567.047778072058;6607.306232845482;6390.744370225325;6463.838404039937;6515.348465153446;6521.054447105238;6552.475801935739;6367.713452894724;6475.287718350884;6480.57876238043;6481.384268494486;6489.8702025960165;6485.092087107903;6542;6613.636250006296;6639.302873198438;6703.095082163845;6368.140301059298;6369.649669268235;6371.331010243857;6431.807045788634;6475 21:23:05 INFO - PID 11828 | |1;ext.html;853.4537895746721;875.0505701314074;876.3558784293543;879.380037073863;881.1540920716114;37426.43860342094;40872.38691419627;41013.589864101385;41063.79468102663;41139.38290925638;36386.8180659097;36478.452823207605;36704.63295367046;36783.4482482763;36832.44751328732;6974.51178417511;6996.510244282902;7028.894566581505;7058.400035996947;7710;7696.692132314701;7757.728479503218;7789.922100779005;7800.141984381714;7804.3756499479905;7804.3756499479905;7840.843183136334;7841.137474877759;7852.411069169835;7868.488548244346;7717.421193410489;7800.804979875492;7804.414668899855;7806;7807.843843123106;7383.07711536058;7500.437467189928;7506.737264195727;7516.887246691249;7517.511361761468;37648.43527347092;37836.62163378359;37893.81053094717;37956.24087518234;38120.23759524822;3481.3211423772373;3520.2079532105327;3525.3301872644115;3530.6645868642436;3533.2756784859043;31234.219144521343;31602;31795.523067154012;31851;31960.680393196235;5224.294720212761;5270.92093618596;5281.841544753625;5284.154535274338;5423.078076726966;182031;182597.99999999866;183740;184763;184919.07540462347;41010.589894100674;41453.37819932703;47439.762801186465;47658.285125723145;47782.76108619435;47585.524144758805;47727.76136119367;47754.28368574474;47828.521714783106;47935;15904.76142857858;15976.641985431135;16013.759793603105;16079.758803617955;16138.19309034567;13292.136011159244;13367.264800436069;13381.866181338257;13385.866141338656;13439.865601344058;13156.671083222805;13343.132696374705;13345.73308533824;13355.131916425402;13482.730345393038;5464.98897703926;5573.804916827973;5584.329880414295;5603.159526071122;5604.159376093618;978.0366339155926;1005.3163848582888;1005.4068099820994;1007.5516395204211;1009.6213919780082;22496.77503224947;22526;22703.772962270497;22870.656940145913;22910.541789164457;1086.9673909782719;1102.9283096598695;1103.2387652519897;1122.259308856151;1150.8791576884307;11886.167968242313;12071.215371000857;12125.514979400725;12127.33299668509;12157.148999570121;191136;191800;192920;210702;212160;49773.253401199014;49903;50573.24140137901;50573.74713126484;50738;1450.332846890421;1473.2044695864327;1474.7566651502382;1478.3526927138444;1479.2529772464836;21879.343619691434;22004.66992995074;22049.33851984443;22611.43471413228;22811.657825132967;32322.676773231968;32559.511607325436;33490.49764253587;34939.30121397507;35729.28541429209;180544;181136;181576.55270341912;181743;181785;29618;30281.24296892595;31517.68482315239;32313;33727.83136084304;41407.171856563305;41460.58539414688;41623.37564936468;41872.16255674809;42332.36501452542;30384.392312154076;30802.075937721904;30953;31436.214094647818;31825.204369890937;30541.54187687142;30746.538801918436;30811.229719257197;31078.378432431677;31186.532202017443;34015.489767654;34155.82922085374;34293.314133717686;34482.65517344794;34997.65002349944;30352.392952141276;30395.69604304017;30429.391412172074;30586.929457468883;30708.692913071478;22472.77527224707;22763.203287884844;23148.6527702088;23419.765802341757;23599.41001474977 21:23:05 INFO - PID 11828 | |2;jquery.html;538.7414041260195;546.8550834028983;552.1055889459077;576.818302234796;595.8272101090683;21690.566188676235;22673.54652906943;22895.084196632113;22901.427464313358;22955.655665164995;23726.5254694906;24359.391015224628;24662.63006054906;24766.257012289614;24895.377615559573;6339.270983836848;6560.212774467071;6563.737450501974;6566.21205455346;6575.441087507544;6408.23101227851;6527;6529.216494020724;6530.771423000196;6534.117894084286;6285.2771931228035;6490.902636460457;6543.770968016121;6545.247296560909;6552.049952756847;6520.543561950642;6520.673966301666;6537.64042977636;6541.509386795961;6572.441342485894;5813.302403711539;6039.5772295939305;6048.1834952281315;6088.573799834014;6105.053716673922;29042.27394315138;29458;29499.410011799857;29511.262218444495;29520.557191642143;2094.455441585199;2098.3075585056895;2126.096409026173;2128.4891626009644;2131.7441906971108;19105.80894191054;19750.50623734418;19792;19911.50221244466;20110.49723756903;2404.326788499223;2437.6465412515263;2452.791512721421;2485.7389974052644;2488.4027833319874;120839.3958030213;125080;125355.37322313421;134616.3269183648;134693.3265333667;13575;13773.586792396243;13779.311034448438;13786.310684465736;14645.340959656842;21444.356669299945;21448.142074316853;21609.567808644053;21672.891635542037;21684.89157554202;9052.411593246417;9574.712758617252;9579.568919398644;9594.760130996641;9848.458334791656;8940.642374305085;8968.148025937526;9087.636494540144;9090.954545227232;9162.587683554257;8146.2261085196815;8285.917140828515;8300.626471808782;8324.83350333002;8385.664573416994;2550.7066687331194;2564.9358766031;2608.608708693711;2614.881945624051;2770.1966429735553;919.632147141149;926.4950601921969;928.1646518133733;959.098447459386;971.2763990826879;18851.245950162112;18871.81128188728;18975.24099036023;19204.807951920302;19348.226070957284;1006.104566935428;1032.3031953431405;1036.2487196782424;1038.08129805123;1039.4075377035017;10427.739306517398;10470.581176752845;10511.474426278655;10563.260571760056;10810.082893594892;460834;462134;472004;482688;485839;106313;111666;111825.44087279511;112607.4369628163;113541.43229283966;1114.3926560024806;1170.4264910193945;1171.4260012593768;1241.0629974369294;1246.4577908609783;19735.01324933719;19950.102245398703;20369.49076273105;20438.591228175057;20607;57525;58252;58990;59670.70164649149;60314.39685603263;73646;74660.62669686617;75345.3629122978;75695.62152189204;75816;13936.651583710489;14020.298985050502;14093;14184.290785460893;14224.786628200793;21664.891675541523;22060.55878882381;22308.665370019786;22525.436864077874;22573;17578.824211757717;17745.29018839232;17773.200205990503;17911.283548657906;18268.543286417946;15251.389944402099;16048.438304659281;16075.919620401823;16190.433334833224;16606.50180494587;17965.371212007518;18124.546886327946;18345.449636510926;18369.81630183681;18429.53926151857;13987.790183147465;14038.929805350908;14127.081739686888;14160.150390976163;14301.284935752963;17282.82717172812;17381.82618173802;17403.47789566315;17615.295388184328;17773.73339399936 21:23:05 INFO - PID 11828 | |3;mootools.html;1333.1001573937592;1407.099456347937;1423.1390009044528;1426.3581388375235;1431.6921861799724;15508;15765.763513547292;15787.28957196926;15851.841481585181;16042.59893502663;15797.368105275804;15840.207989600503;15873.84126158738;15895.602609934758;16001.519954401358;2717.904873329434;2745.6018877262786;2777.6944536101014;2779.4163225722523;2784.916452506428;2662.560677488212;2722.6460560127157;2738.7535121839032;2739.493193759161;2748.395353022342;2579.5872660374343;2703.3106557827728;2780.304923769058;2782.0262907982146;2784.693683694792;2697.635819164407;2722.5507791214427;2727.1954773341913;2745.3960128771737;2748.1618106477617;2592.287121041729;2594.4421949280804;2598.8180827342094;2602.8047896407843;2618.4108575570535;14653.12081275127;15070.246487675573;15145.545633631009;15195.696086078216;15200.315985780666;8076.434649574532;8290.170982901722;8316.958415207886;8361.372897032747;8395.202455766692;5245.186996015624;5382.219578161184;5503.394626591072;5543.307086614173;5628.099504079369;1831.0753069699717;1853.5736780540417;1891.527118220445;1894.393793985925;1904.523869032742;26981.190564283104;27274.5908811368;27294.727052729417;27309.317267068483;27311.726882731116;6701.329867013357;6840.486963477759;6886.2769409212315;6979.197392299849;7054.365107140279;17167.91416042937;17244.913775431043;17262.050587217822;17327.393541225996;17334.739978900325;7889.447738658354;7972.2824945755165;8019.599020048974;8036.357091432788;8067.7579672608745;7089.361957423856;7157.606331651809;7328.450366222448;7347.155077166194;7502.062242219723;5092.083424983464;5255.343082114736;5270.683758974474;5278.4721527846905;5291.074062039204;1382.3295701584723;1413.6324555615613;1491.6569189086572;1547.4351861570447;1557.3614817924597;846.2764336492334;858.4806192253722;879.7536689726886;887.5562218890555;891.38494438837;8142.47073940192;8359.414840961195;8391.286740627114;8451.281641060456;8547.316214702809;971.3346357744967;974.1865542272282;974.4883935933692;979.4759803505091;982.5480279071708;5189.6886186828915;5213.478652134756;5261.526462618306;5265.447128051576;5297.894042119136;21362.465938351354;21515.246966356102;22203.111875525123;22232.777672223394;22313.44216394603;21052.78947210539;21626.35120946374;22077.227297044847;22143.778562214495;22365.32904012882;10827.621033263798;11370.317780933005;11423.428828558539;11439.542418303341;11560.768784624428;7922.603869806371;8166.754997350089;8268.338532917232;8314.501129931981;8323.001239851257;18102.637947240717;18361.54096147607;19068;19156.808431915502;19319.613607727486;18631.44105676832;19465.4160375189;19553.120109594816;20102.39692809218;20379.69430458574;12194.451249693962;12403.875961240634;12428.254304741744;12454.31501267439;12492.937535312265;13495.527656531975;13840.93079534596;13892.583222503341;13934.651633709238;14161.221132837793;11048.558057677925;11457.828132578185;11501.424928753697;11510.827337589775;11678.6496405108;11108.555657773599;11165.665030049111;11239.66281011571;11261.042811361127;11401.885981140415;9282.907170928203;9288.72133835986;9411.576479058596;9429.669961551313;9494.810103798023;6820.693068811816;6957.130358705162;6984.196817366068;6995.265497122728;6998.790036298919;7012.894806577803;7068.893966590608;7087.716491340495;7111.928880711127;7165.6027074722015 21:23:05 INFO - PID 11828 | |4;prototype.html;500.9905041341697;501.524240338283;521.7339157029913;527.7071225469867;528.3923487988812;6180.45488627843;6190.350013248606;6230.906536401952;6248.375422390177;6263.123162757218;6043.425874541923;6090.208272924514;6098.908516372247;6197.752089916409;6199.938000619993;4824.44518880328;4934.6429731823855;4954.711774938524;5069.239614057884;5076.6700164489375;4904.362432883738;4955;4960.528749768766;4981.2279096739885;4987.675801072919;4875.41495020598;4880.414350277972;4899.721629442309;4918.606511479073;4939.135651261015;4839.830605928793;4871.318015477836;4878.073166098466;4894.1679914414635;4895.388076490439;4426.933595996063;4446.333050042487;4448.110377924428;4448.555144485558;4458.665600079975;5995.250593675791;6055.182550355689;6078.513718902477;6095.542834287402;6147.508199344086;5550.972245138789;5553.194786755938;5571.832845014656;5586.497215250606;5623.409541998113;6248.250209974786;6385.2656944451055;6416.711247993851;6425.357464253584;6453.451456626192;4537.296719008559;4794;4797.9520204797855;4804.8318308859025;4807.951920480786;6576.769813056568;6581.3747693969;6636.170478690164;6700.363465470821;6713.530052896348;4815.061063092663;4840.104580652591;4842.869137579454;4855.708657480563;4865.270209468537;4909.705417674951;4913.484084171182;4922.704637721748;4941.209406494943;4947.480514545993;5262.184546331586;5548.778048878;5559.555235581144;5561.304836895388;5604.579656525777;6388.2653494847755;6395.392437718409;6414.679266036773;6431.935680643133;6478.611283323015;1688.7840754656627;1700.7023770840053;1706.4624643237341;1716.8969861808332;1733.14209466315;1175.8118701007797;1193.6180422264792;1213.6723084767063;1220.560598184653;1232.1744431231098;5540.861478463071;5584.385717571064;5593.188987596775;5610.607257492018;5640.830775076754;6364.459020983269;6420.5184611154355;6460.45086167681;6503.674816259263;6574.572652777554;5452.427495112956;5524.364698059774;5546.251256080458;5594.720263986785;5655.519280861173;3456.844442000116;3474.2356681530023;3477.704395126392;3483.9477407838904;3492.480770864682;6388.233411990498;6401.623650914982;6437.839054023687;6462.4183823456115;6464.515161362917;6646.534742567974;6662.467002639874;6684.732610695615;6692.464602831762;6696.497762667722;6252.562320637603;6337;6384.265809431882;6398.840028999312;6402.743890244431;6416.582922110048;6442.581232219891;6577.473802095725;6603.141591593062;6606.47148228131;5897.407699921083;6505.349465053457;6550.115734375799;6562.409383155348;6588.868222635616;6145.324014358328;6150.692465376803;6194.349593292639;6208.2239720034995;6314.210723659543;4887.535684110004;4923.803047878045;4930.186519224288;4941.827036053721;4965.925511117264;6499.1876015498065;6591.406773390418;6610.603363798187;6658.966705166443;6709.194896612437;6328.493720502441;6331.145295385064;6369.936300636934;6392.744290228339;6469.935300646934;6367.554271200971;6403.679816009274;6410.358964103552;6449.7097630605795;6458.903116453163;6206.472449841814;6273.341299163522;6313.779017734358;6345.079963405373;6352.428281454691;6361.268454127835;6399.200099987502;6400.615963042233;6407.1350367701625;6427.100205971261;6190.535709821691;6224.408681175281;6236.191504463654;6244.406781355764;6247.407325959676 21:23:05 INFO - PID 11828 | |5;yui.html;916.0793402630355;930.7207837648705;949.4588084791671;953.4041224234853;963.8843338799343;17634.38279660212;18370.72443913339;18592.256309747612;18660.160292786823;18666.626667466644;17438.128093595333;18181.27274909002;18417.53956151097;18626.906865465655;18630.62738745224;966.2946049383936;968.3028219681818;971.6744890461669;975.0395860077853;975.4976187263564;975.1077763846072;980.62736160259;981.249344251648;983.4001259231862;984.1536278800226;1039.7920415916808;1042.7705904700993;1046.272840375939;1046.4924511611862;1048.7273308939693;1026.091908660837;1037.0148359058849;1041.7603951091216;1046.9057784799365;1049.2497864027218;763.8777795552741;767.6277005652254;769.4344656677338;770.3221165374491;771.0631582627135;19311.227550897947;19838.60322793536;19895.50261243466;19987.90006049975;20158.79841201584;19808.61339706221;20385.4903627409;20837.68743468849;21067.789322106888;21260.893695531577;16607;16743.581410464714;16896.577585560335;16951.152442377832;16980.66038679232;3699.5375578052744;3710.4805327253935;3718.9070273243115;3719.3491139050557;3737.0470530014945;140169;142130.28934855363;142704;144016;145201;15918.9204053979;16084.919575402047;16113.677726445405;16372.918135409485;16498.092604906604;30060.398792024036;31090.53364199539;31164.376712465622;31225.8438707805;31452.842735786173;8507.53208573522;8681.782955426039;8696.695615653422;8730.476171429735;8758.430702004349;4250.298700714409;4301.827926882952;4306.612404883513;4316.848910288125;4371.278739008092;5121.411037730709;5185.688858668416;5212.296339994128;5234.502722241381;5304.9734751326;837.8491871463074;845.1759534453859;862.9654813807377;863.3050394432543;863.3179787967435;682.7917485166972;688.449240607512;695.7460526907744;702.2135208566439;708.4580296073508;10614.946925265323;10851.728706782395;11014.39420831862;11602.88397116018;11905.345206013752;665.7037618259828;667.7028722218663;675.4697562413481;680.4522359500551;689.7172159414716;5149.6964163660405;5152.562032227303;5153.510416510426;5170.68975861442;5210.192420174879;122003;124279;125035.3748231253;125287.3735631316;126111;108266;108404;109964;111786;114246.42876785729;92757;94232.52883735538;96190.51904740432;96968.51515742377;97307.51346243365;9504.382215155993;9557.426554406758;9564.091411315914;9596.376235544667;9858.507074646383;43862.56137438712;44086.33870492009;45004.549954501344;45418.31872521981;45691.54308457006;55679;56703.71648141733;56996.145057823334;57238.42761572331;58803.41196587979;15470.226488675746;15886;15901.28444220036;15959.920200398923;16141.273642685872;17257.56856078608;17308.307667693152;17327.82672173262;17351.30594776195;17357.47927562175;13180.945524357836;13226.206427614374;13286.468541258242;13404.597862064154;13611.11527750693;14190.929045354707;14318.785218221527;14430.855691442952;14457.710845783236;14823.777643335143;13574.796378054534;13638.454461821417;13737.519186828813;13756.518521851687;14234.501792437215;11609.361485118061;11714.707132321419;11907.166498345032;11931.940340298243;12240.816387754012;10932.344059356465;10956.66882244677;10982.615608453985;11035.558577656804;11460.541578336773 21:23:05 INFO - PID 11828 | __end_tp_report 21:23:05 INFO - PID 11828 | __start_cc_report 21:23:05 INFO - PID 11828 | _x_x_mozilla_cycle_collect,271 21:23:05 INFO - PID 11828 | __end_cc_report 21:23:05 INFO - PID 11828 | __startTimestamp1505622185180__endTimestamp 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | ------- Summary: start ------- 21:23:05 INFO - PID 11828 | Number of tests: 6 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#0] dojo.html Cycles:165 Average:6167.11 Median:6408.74 stddev:735.87 (11.5%) stddev-sans-first:697.52 21:23:05 INFO - PID 11828 | Values: 3094.0 3111.0 3145.1 3215.1 3253.1 6039.6 6203.2 6213.3 6264.4 6280.7 6070.6 6113.3 6170.1 6194.5 6195.8 5621.0 5648.7 5659.5 5680.3 5693.0 5792.3 5801.4 5816.7 5820.7 5854.1 5756.6 5776.8 5812.6 5899.5 5901.0 5518.6 5663.8 5670.5 5750.3 5788.5 5683.1 5742.3 5755.6 5765.6 5784.0 6191.9 6252.2 6256.1 6293.7 6341.7 6627.0 6632.0 6638.7 6665.2 6723.9 6715.4 6812.3 6814.5 6817.3 6844.8 5959.8 6197.2 6250.8 6287.0 6289.4 6744.8 6768.7 6806.9 6819.4 6820.9 6414.0 6482.0 6486.7 6509.0 6510.2 6592.4 6694.2 6780.9 6784.3 6787.5 6667.6 6684.8 6689.3 6744.2 6766.3 6537.4 6725.9 6732.8 6815.4 6816.9 5247.0 5261.8 5268.3 5293.0 5329.7 4591.5 4619.2 4646.9 4699.7 4720.3 5863.6 5888.0 5944.8 5946.4 5949.6 6585.8 6644.9 6680.3 6680.7 6860.0 5743.9 5776.9 5795.9 5807.1 5812.6 5687.5 5708.2 5713.3 5724.1 5847.2 6587.4 6588.1 6627.2 6646.2 6664.1 6671.9 6752.5 6757.8 6800.3 6858.8 6330.8 6403.8 6570.3 6630.3 6667.7 6597.3 6619.9 6649.9 6662.3 6673.3 6795.0 6818.6 6820.9 6839.2 6843.7 6408.7 6496.8 6526.8 6567.0 6607.3 6390.7 6463.8 6515.3 6521.1 6552.5 6367.7 6475.3 6480.6 6481.4 6489.9 6485.1 6542.0 6613.6 6639.3 6703.1 6368.1 6369.6 6371.3 6431.8 6475.0 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#1] ext.html Cycles:180 Average:35221.96 Median:33609.16 stddev:48663.27 (144.8%) stddev-sans-first:48731.35 21:23:05 INFO - PID 11828 | Values: 853.5 875.1 876.4 879.4 881.2 37426.4 40872.4 41013.6 41063.8 41139.4 36386.8 36478.5 36704.6 36783.4 36832.4 6974.5 6996.5 7028.9 7058.4 7710.0 7696.7 7757.7 7789.9 7800.1 7804.4 7804.4 7840.8 7841.1 7852.4 7868.5 7717.4 7800.8 7804.4 7806.0 7807.8 7383.1 7500.4 7506.7 7516.9 7517.5 37648.4 37836.6 37893.8 37956.2 38120.2 3481.3 3520.2 3525.3 3530.7 3533.3 31234.2 31602.0 31795.5 31851.0 31960.7 5224.3 5270.9 5281.8 5284.2 5423.1 182031.0 182598.0 183740.0 184763.0 184919.1 41010.6 41453.4 47439.8 47658.3 47782.8 47585.5 47727.8 47754.3 47828.5 47935.0 15904.8 15976.6 16013.8 16079.8 16138.2 13292.1 13367.3 13381.9 13385.9 13439.9 13156.7 13343.1 13345.7 13355.1 13482.7 5465.0 5573.8 5584.3 5603.2 5604.2 978.0 1005.3 1005.4 1007.6 1009.6 22496.8 22526.0 22703.8 22870.7 22910.5 1087.0 1102.9 1103.2 1122.3 1150.9 11886.2 12071.2 12125.5 12127.3 12157.1 191136.0 191800.0 192920.0 210702.0 212160.0 49773.3 49903.0 50573.2 50573.7 50738.0 1450.3 1473.2 1474.8 1478.4 1479.3 21879.3 22004.7 22049.3 22611.4 22811.7 32322.7 32559.5 33490.5 34939.3 35729.3 180544.0 181136.0 181576.6 181743.0 181785.0 29618.0 30281.2 31517.7 32313.0 33727.8 41407.2 41460.6 41623.4 41872.2 42332.4 30384.4 30802.1 30953.0 31436.2 31825.2 30541.5 30746.5 30811.2 31078.4 31186.5 34015.5 34155.8 34293.3 34482.7 34997.7 30352.4 30395.7 30429.4 30586.9 30708.7 22472.8 22763.2 23148.7 23419.8 23599.4 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#2] jquery.html Cycles:180 Average:33818.52 Median:22623.27 stddev:79590.92 (351.8%) stddev-sans-first:79774.97 21:23:05 INFO - PID 11828 | Values: 538.7 546.9 552.1 576.8 595.8 21690.6 22673.5 22895.1 22901.4 22955.7 23726.5 24359.4 24662.6 24766.3 24895.4 6339.3 6560.2 6563.7 6566.2 6575.4 6408.2 6527.0 6529.2 6530.8 6534.1 6285.3 6490.9 6543.8 6545.2 6552.0 6520.5 6520.7 6537.6 6541.5 6572.4 5813.3 6039.6 6048.2 6088.6 6105.1 29042.3 29458.0 29499.4 29511.3 29520.6 2094.5 2098.3 2126.1 2128.5 2131.7 19105.8 19750.5 19792.0 19911.5 20110.5 2404.3 2437.6 2452.8 2485.7 2488.4 120839.4 125080.0 125355.4 134616.3 134693.3 13575.0 13773.6 13779.3 13786.3 14645.3 21444.4 21448.1 21609.6 21672.9 21684.9 9052.4 9574.7 9579.6 9594.8 9848.5 8940.6 8968.1 9087.6 9091.0 9162.6 8146.2 8285.9 8300.6 8324.8 8385.7 2550.7 2564.9 2608.6 2614.9 2770.2 919.6 926.5 928.2 959.1 971.3 18851.2 18871.8 18975.2 19204.8 19348.2 1006.1 1032.3 1036.2 1038.1 1039.4 10427.7 10470.6 10511.5 10563.3 10810.1 460834.0 462134.0 472004.0 482688.0 485839.0 106313.0 111666.0 111825.4 112607.4 113541.4 1114.4 1170.4 1171.4 1241.1 1246.5 19735.0 19950.1 20369.5 20438.6 20607.0 57525.0 58252.0 58990.0 59670.7 60314.4 73646.0 74660.6 75345.4 75695.6 75816.0 13936.7 14020.3 14093.0 14184.3 14224.8 21664.9 22060.6 22308.7 22525.4 22573.0 17578.8 17745.3 17773.2 17911.3 18268.5 15251.4 16048.4 16075.9 16190.4 16606.5 17965.4 18124.5 18345.4 18369.8 18429.5 13987.8 14038.9 14127.1 14160.2 14301.3 17282.8 17381.8 17403.5 17615.3 17773.7 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#3] mootools.html Cycles:180 Average:9451.23 Median:2720.23 stddev:6829.85 (251.1%) stddev-sans-first:6821.78 21:23:05 INFO - PID 11828 | Values: 1333.1 1407.1 1423.1 1426.4 1431.7 15508.0 15765.8 15787.3 15851.8 16042.6 15797.4 15840.2 15873.8 15895.6 16001.5 2717.9 2745.6 2777.7 2779.4 2784.9 2662.6 2722.6 2738.8 2739.5 2748.4 2579.6 2703.3 2780.3 2782.0 2784.7 2697.6 2722.6 2727.2 2745.4 2748.2 2592.3 2594.4 2598.8 2602.8 2618.4 14653.1 15070.2 15145.5 15195.7 15200.3 8076.4 8290.2 8317.0 8361.4 8395.2 5245.2 5382.2 5503.4 5543.3 5628.1 1831.1 1853.6 1891.5 1894.4 1904.5 26981.2 27274.6 27294.7 27309.3 27311.7 6701.3 6840.5 6886.3 6979.2 7054.4 17167.9 17244.9 17262.1 17327.4 17334.7 7889.4 7972.3 8019.6 8036.4 8067.8 7089.4 7157.6 7328.5 7347.2 7502.1 5092.1 5255.3 5270.7 5278.5 5291.1 1382.3 1413.6 1491.7 1547.4 1557.4 846.3 858.5 879.8 887.6 891.4 8142.5 8359.4 8391.3 8451.3 8547.3 971.3 974.2 974.5 979.5 982.5 5189.7 5213.5 5261.5 5265.4 5297.9 21362.5 21515.2 22203.1 22232.8 22313.4 21052.8 21626.4 22077.2 22143.8 22365.3 10827.6 11370.3 11423.4 11439.5 11560.8 7922.6 8166.8 8268.3 8314.5 8323.0 18102.6 18361.5 19068.0 19156.8 19319.6 18631.4 19465.4 19553.1 20102.4 20379.7 12194.5 12403.9 12428.3 12454.3 12492.9 13495.5 13840.9 13892.6 13934.7 14161.2 11048.6 11457.8 11501.4 11510.8 11678.6 11108.6 11165.7 11239.7 11261.0 11401.9 9282.9 9288.7 9411.6 9429.7 9494.8 6820.7 6957.1 6984.2 6995.3 6998.8 7012.9 7068.9 7087.7 7111.9 7165.6 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#4] prototype.html Cycles:180 Average:5389.83 Median:6092.88 stddev:1503.09 (24.7%) stddev-sans-first:1461.84 21:23:05 INFO - PID 11828 | Values: 501.0 501.5 521.7 527.7 528.4 6180.5 6190.4 6230.9 6248.4 6263.1 6043.4 6090.2 6098.9 6197.8 6199.9 4824.4 4934.6 4954.7 5069.2 5076.7 4904.4 4955.0 4960.5 4981.2 4987.7 4875.4 4880.4 4899.7 4918.6 4939.1 4839.8 4871.3 4878.1 4894.2 4895.4 4426.9 4446.3 4448.1 4448.6 4458.7 5995.3 6055.2 6078.5 6095.5 6147.5 5551.0 5553.2 5571.8 5586.5 5623.4 6248.3 6385.3 6416.7 6425.4 6453.5 4537.3 4794.0 4798.0 4804.8 4808.0 6576.8 6581.4 6636.2 6700.4 6713.5 4815.1 4840.1 4842.9 4855.7 4865.3 4909.7 4913.5 4922.7 4941.2 4947.5 5262.2 5548.8 5559.6 5561.3 5604.6 6388.3 6395.4 6414.7 6431.9 6478.6 1688.8 1700.7 1706.5 1716.9 1733.1 1175.8 1193.6 1213.7 1220.6 1232.2 5540.9 5584.4 5593.2 5610.6 5640.8 6364.5 6420.5 6460.5 6503.7 6574.6 5452.4 5524.4 5546.3 5594.7 5655.5 3456.8 3474.2 3477.7 3483.9 3492.5 6388.2 6401.6 6437.8 6462.4 6464.5 6646.5 6662.5 6684.7 6692.5 6696.5 6252.6 6337.0 6384.3 6398.8 6402.7 6416.6 6442.6 6577.5 6603.1 6606.5 5897.4 6505.3 6550.1 6562.4 6588.9 6145.3 6150.7 6194.3 6208.2 6314.2 4887.5 4923.8 4930.2 4941.8 4965.9 6499.2 6591.4 6610.6 6659.0 6709.2 6328.5 6331.1 6369.9 6392.7 6469.9 6367.6 6403.7 6410.4 6449.7 6458.9 6206.5 6273.3 6313.8 6345.1 6352.4 6361.3 6399.2 6400.6 6407.1 6427.1 6190.5 6224.4 6236.2 6244.4 6247.4 21:23:05 INFO - PID 11828 | 21:23:05 INFO - PID 11828 | [#5] yui.html Cycles:180 Average:24169.03 Median:20272.14 stddev:35955.96 (177.4%) stddev-sans-first:36014.43 21:23:05 INFO - PID 11828 | Values: 916.1 930.7 949.5 953.4 963.9 17634.4 18370.7 18592.3 18660.2 18666.6 17438.1 18181.3 18417.5 18626.9 18630.6 966.3 968.3 971.7 975.0 975.5 975.1 980.6 981.2 983.4 984.2 1039.8 1042.8 1046.3 1046.5 1048.7 1026.1 1037.0 1041.8 1046.9 1049.2 763.9 767.6 769.4 770.3 771.1 19311.2 19838.6 19895.5 19987.9 20158.8 19808.6 20385.5 20837.7 21067.8 21260.9 16607.0 16743.6 16896.6 16951.2 16980.7 3699.5 3710.5 3718.9 3719.3 3737.0 140169.0 142130.3 142704.0 144016.0 145201.0 15918.9 16084.9 16113.7 16372.9 16498.1 30060.4 31090.5 31164.4 31225.8 31452.8 8507.5 8681.8 8696.7 8730.5 8758.4 4250.3 4301.8 4306.6 4316.8 4371.3 5121.4 5185.7 5212.3 5234.5 5305.0 837.8 845.2 863.0 863.3 863.3 682.8 688.4 695.7 702.2 708.5 10614.9 10851.7 11014.4 11602.9 11905.3 665.7 667.7 675.5 680.5 689.7 5149.7 5152.6 5153.5 5170.7 5210.2 122003.0 124279.0 125035.4 125287.4 126111.0 108266.0 108404.0 109964.0 111786.0 114246.4 92757.0 94232.5 96190.5 96968.5 97307.5 9504.4 9557.4 9564.1 9596.4 9858.5 43862.6 44086.3 45004.5 45418.3 45691.5 55679.0 56703.7 56996.1 57238.4 58803.4 15470.2 15886.0 15901.3 15959.9 16141.3 17257.6 17308.3 17327.8 17351.3 17357.5 13180.9 13226.2 13286.5 13404.6 13611.1 14190.9 14318.8 14430.9 14457.7 14823.8 13574.8 13638.5 13737.5 13756.5 14234.5 11609.4 11714.7 11907.2 11931.9 12240.8 10932.3 10956.7 10982.6 11035.6 11460.5 21:23:05 INFO - PID 11828 | -------- Summary: end -------- 21:23:05 INFO - PID 11828 | 21:23:05 INFO - TEST-INFO | 11828: exit 0 21:23:05 INFO - TEST-OK | dromaeo_css | took 1112586ms 21:23:05 INFO - TEST-START | kraken 21:23:05 INFO - Initialising browser for kraken test... 21:23:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40168/getInfo.html -profile /tmp/tmpody56M/profile 21:23:05 INFO - TEST-INFO | started process 12221 (/builds/slave/test/build/application/firefox/firefox http://localhost:40168/getInfo.html) 21:23:11 INFO - TEST-INFO | 12221: exit 0 21:23:11 INFO - Browser initialized. 21:23:11 INFO - Running cycle 1/1 for kraken test... 21:23:11 INFO - Using env: {'DISPLAY': ':0', 21:23:11 INFO - 'HOME': '/home/cltbld', 21:23:11 INFO - 'JSGC_DISABLE_POISONING': '1', 21:23:11 INFO - 'LANG': 'en_US.UTF-8', 21:23:11 INFO - 'LANGUAGE': 'en_US:en', 21:23:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:23:11 INFO - 'LOGNAME': 'cltbld', 21:23:11 INFO - 'MAIL': '/var/mail/cltbld', 21:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:23:11 INFO - 'MOZ_ACCELERATED': '1', 21:23:11 INFO - 'MOZ_CRASHREPORTER': '1', 21:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:23:11 INFO - 'MOZ_NO_REMOTE': '1', 21:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:11 INFO - 'MOZ_WEBRENDER': '1', 21:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:23:11 INFO - 'NO_EM_RESTART': '1', 21:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:11 INFO - 'PWD': '/builds/slave/test', 21:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:11 INFO - 'RUST_BACKTRACE': 'full', 21:23:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:23:11 INFO - 'SHELL': '/bin/bash', 21:23:11 INFO - 'SHLVL': '1', 21:23:11 INFO - 'TERM': 'linux', 21:23:11 INFO - 'TMOUT': '86400', 21:23:11 INFO - 'USER': 'cltbld', 21:23:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429', 21:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:11 INFO - '_': '/tools/buildbot/bin/python'} 21:23:11 INFO - TEST-INFO | started process 12471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpody56M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:12 INFO - PID 12471 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:23:13 INFO - PID 12471 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 21:23:13 INFO - PID 12471 | 21:23:13 INFO - PID 12471 | (/builds/slave/test/build/application/firefox/firefox:12532): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:23:13 INFO - PID 12471 | 21:23:23 INFO - PID 12471 | RSS: Main: 207175680 21:23:23 INFO - PID 12471 | 21:23:26 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-beat-detection) 21:23:27 INFO - PID 12471 | RSS: Main: 204857344 21:23:27 INFO - PID 12471 | 21:23:30 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-dft) 21:23:30 INFO - PID 12471 | RSS: Main: 205586432 21:23:30 INFO - PID 12471 | 21:23:33 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-fft) 21:23:34 INFO - PID 12471 | RSS: Main: 201691136 21:23:34 INFO - PID 12471 | 21:23:36 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40168/tests/kraken/driver.html?testName=audio-oscillator) 21:23:36 INFO - PID 12471 | RSS: Main: 202649600 21:23:36 INFO - PID 12471 | 21:23:39 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:23:39 INFO - PID 12471 | RSS: Main: 202612736 21:23:39 INFO - PID 12471 | 21:23:42 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-darkroom) 21:23:43 INFO - PID 12471 | RSS: Main: 205709312 21:23:43 INFO - PID 12471 | 21:23:47 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40168/tests/kraken/driver.html?testName=imaging-desaturate) 21:23:47 INFO - PID 12471 | RSS: Main: 204275712 21:23:47 INFO - PID 12471 | 21:23:50 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40168/tests/kraken/driver.html?testName=json-parse-financial) 21:23:51 INFO - PID 12471 | RSS: Main: 205578240 21:23:51 INFO - PID 12471 | 21:23:53 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:23:53 INFO - PID 12471 | RSS: Main: 204754944 21:23:53 INFO - PID 12471 | 21:23:55 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:23:56 INFO - PID 12471 | RSS: Main: 202047488 21:23:56 INFO - PID 12471 | 21:23:58 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:23:58 INFO - PID 12471 | RSS: Main: 201768960 21:23:58 INFO - PID 12471 | 21:24:01 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:24:02 INFO - PID 12471 | RSS: Main: 201474048 21:24:02 INFO - PID 12471 | 21:24:05 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:24:05 INFO - PID 12471 | RSS: Main: 202092544 21:24:05 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | Cycle 1(1): loaded http://localhost:40168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40168/tests/kraken/driver.html?testName=ai-astar) 21:24:07 INFO - PID 12471 | RSS: Main: 203251712 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | __start_tp_report 21:24:07 INFO - PID 12471 | _x_x_mozilla_page_load 21:24:07 INFO - PID 12471 | _x_x_mozilla_page_load_details 21:24:07 INFO - PID 12471 | |i|pagename|runs| 21:24:07 INFO - PID 12471 | |0;ai-astar;115;115;107;114;112;113;114;118;107;110 21:24:07 INFO - PID 12471 | |1;audio-beat-detection;120;124;124;117;123;128;123;115;130;123 21:24:07 INFO - PID 12471 | |2;audio-dft;170;173;171;163;168;171;166;169;169;164 21:24:07 INFO - PID 12471 | |3;audio-fft;80;75;76;76;74;78;87;79;74;74 21:24:07 INFO - PID 12471 | |4;audio-oscillator;85;85;80;84;80;83;80;79;79;85 21:24:07 INFO - PID 12471 | |5;imaging-gaussian-blur;119;115;116;114;115;117;114;115;115;124 21:24:07 INFO - PID 12471 | |6;imaging-darkroom;154;158;152;149;148;148;159;149;155;152 21:24:07 INFO - PID 12471 | |7;imaging-desaturate;100;94;95;98;96;94;97;101;97;95 21:24:07 INFO - PID 12471 | |8;json-parse-financial;55;62;56;54;54;56;59;60;54;55 21:24:07 INFO - PID 12471 | |9;json-stringify-tinderbox;38;45;40;42;43;39;43;45;45;44 21:24:07 INFO - PID 12471 | |10;stanford-crypto-aes;78;78;75;77;73;77;85;77;85;79 21:24:07 INFO - PID 12471 | |11;stanford-crypto-ccm;123;109;120;120;112;124;120;116;119;114 21:24:07 INFO - PID 12471 | |12;stanford-crypto-pbkdf2;175;169;169;166;165;172;169;168;176;176 21:24:07 INFO - PID 12471 | |13;stanford-crypto-sha256-iterative;65;66;65;66;65;65;67;67;72;64 21:24:07 INFO - PID 12471 | __end_tp_report 21:24:07 INFO - PID 12471 | __start_cc_report 21:24:07 INFO - PID 12471 | _x_x_mozilla_cycle_collect,729 21:24:07 INFO - PID 12471 | __end_cc_report 21:24:07 INFO - PID 12471 | __startTimestamp1505622247894__endTimestamp 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | ------- Summary: start ------- 21:24:07 INFO - PID 12471 | Number of tests: 14 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.57 (3.1%) stddev-sans-first:3.67 21:24:07 INFO - PID 12471 | Values: 115.0 115.0 107.0 114.0 112.0 113.0 114.0 118.0 107.0 110.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:123.50 stddev:4.52 (3.7%) stddev-sans-first:4.69 21:24:07 INFO - PID 12471 | Values: 120.0 124.0 124.0 117.0 123.0 128.0 123.0 115.0 130.0 123.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#2] audio-dft Cycles:10 Average:168.40 Median:169.50 stddev:3.20 (1.9%) stddev-sans-first:3.35 21:24:07 INFO - PID 12471 | Values: 170.0 173.0 171.0 163.0 168.0 171.0 166.0 169.0 169.0 164.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#3] audio-fft Cycles:10 Average:77.30 Median:77.00 stddev:4.03 (5.2%) stddev-sans-first:4.15 21:24:07 INFO - PID 12471 | Values: 80.0 75.0 76.0 76.0 74.0 78.0 87.0 79.0 74.0 74.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:83.50 stddev:2.62 (3.1%) stddev-sans-first:2.55 21:24:07 INFO - PID 12471 | Values: 85.0 85.0 80.0 84.0 80.0 83.0 80.0 79.0 79.0 85.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:115.50 stddev:3.06 (2.7%) stddev-sans-first:3.10 21:24:07 INFO - PID 12471 | Values: 119.0 115.0 116.0 114.0 115.0 117.0 114.0 115.0 115.0 124.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:153.00 stddev:4.03 (2.6%) stddev-sans-first:4.24 21:24:07 INFO - PID 12471 | Values: 154.0 158.0 152.0 149.0 148.0 148.0 159.0 149.0 155.0 152.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:95.50 stddev:2.41 (2.5%) stddev-sans-first:2.24 21:24:07 INFO - PID 12471 | Values: 100.0 94.0 95.0 98.0 96.0 94.0 97.0 101.0 97.0 95.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.84 (5.1%) stddev-sans-first:2.96 21:24:07 INFO - PID 12471 | Values: 55.0 62.0 56.0 54.0 54.0 56.0 59.0 60.0 54.0 55.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#9] json-stringify-tinderbox Cycles:10 Average:42.40 Median:43.50 stddev:2.59 (6.0%) stddev-sans-first:2.20 21:24:07 INFO - PID 12471 | Values: 38.0 45.0 40.0 42.0 43.0 39.0 43.0 45.0 45.0 44.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:3.86 (5.0%) stddev-sans-first:4.10 21:24:07 INFO - PID 12471 | Values: 78.0 78.0 75.0 77.0 73.0 77.0 85.0 77.0 85.0 79.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:120.00 stddev:4.83 (4.0%) stddev-sans-first:4.73 21:24:07 INFO - PID 12471 | Values: 123.0 109.0 120.0 120.0 112.0 124.0 120.0 116.0 119.0 114.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.50 stddev:4.03 (2.4%) stddev-sans-first:3.94 21:24:07 INFO - PID 12471 | Values: 175.0 169.0 169.0 166.0 165.0 172.0 169.0 168.0 176.0 176.0 21:24:07 INFO - PID 12471 | 21:24:07 INFO - PID 12471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:2.25 (3.4%) stddev-sans-first:2.35 21:24:07 INFO - PID 12471 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 67.0 67.0 72.0 64.0 21:24:07 INFO - PID 12471 | -------- Summary: end -------- 21:24:07 INFO - PID 12471 | 21:24:08 INFO - PID 12471 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:24:08 INFO - TEST-INFO | 12471: exit 0 21:24:08 INFO - TEST-OK | kraken | took 62771ms 21:24:08 INFO - SUITE-END | took 1175s 21:24:09 INFO - Completed test suite (00:19:35) 21:24:09 INFO - javascript benchmark 21:24:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8374.45414383756, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.95359069614, 3111.020028690963, 3145.103645461044, 3215.099772063823, 3253.137918451609, 6039.5772295939305, 6203.193584833971, 6213.347598502154, 6264.404881536252, 6280.748770049204, 6070.57505974582, 6113.32753397126, 6170.074488826678, 6194.504439644829, 6195.783147589836, 5621.0, 5648.6893220872935, 5659.490645841874, 5680.318361796591, 5693.0, 5792.333881603607, 5801.44886235809, 5816.709164541777, 5820.679862607555, 5854.121881717755, 5756.5682573807135, 5776.797812076578, 5812.593118481708, 5899.469047785698, 5901.0, 5518.558515318765, 5663.830085097454, 5670.518005969498, 5750.252467179282, 5788.507976821975, 5683.090705487102, 5742.310922689262, 5755.597108202427, 5765.558610347413, 5784.0, 6191.907121393183, 6252.155958945529, 6256.124142620037, 6293.685315734195, 6341.682915854189, 6627.039079333518, 6631.966840165768, 6638.701258443381, 6665.200175978914, 6723.93276067238, 6715.395614394728, 6812.3187681231975, 6814.454843612499, 6817.318268173192, 6844.760433384858, 5959.791407300723, 6197.16338294329, 6250.812475625738, 6286.968565157145, 6289.40250676185, 6744.7976560703255, 6768.661566921634, 6806.863862722717, 6819.386255236953, 6820.863582728417, 6414.0, 6482.027695845567, 6486.708098135501, 6509.0, 6510.153680021567, 6592.406683398517, 6694.230163531159, 6780.898286525706, 6784.253732089565, 6787.490938179656, 6667.566608170453, 6684.766033188815, 6689.331066893272, 6744.156980377453, 6766.323367663293, 6537.411632953057, 6725.8654826903185, 6732.798016059526, 6815.386615204656, 6816.897746533806, 5247.0, 5261.76322065508, 5268.341457317835, 5292.9735351323, 5329.653572517774, 4591.540845915381, 4619.19164146273, 4646.86059418218, 4699.671023028423, 4720.33915251865, 5863.648181109147, 5888.0, 5944.821655350346, 5946.4053594641055, 5949.613275137189, 6585.83535411609, 6644.933550664528, 6680.265170831205, 6680.665966701646, 6859.965700171567, 5743.879943411078, 5776.855578610484, 5795.94204057954, 5807.0998995155815, 5812.564057695689, 5687.488126068673, 5708.229389032511, 5713.314402271754, 5724.112762521816, 5847.210626565445, 6587.4071333580205, 6588.077669126326, 6627.204735431683, 6646.235682896432, 6664.100346453264, 6671.933280667228, 6752.527323087336, 6757.797266082025, 6800.319968003259, 6858.8285292866085, 6330.841728956813, 6403.775867844603, 6570.277269500256, 6630.30381809903, 6667.66661666905, 6597.340265973365, 6619.900701489385, 6649.933500664932, 6662.300458451793, 6673.299303573055, 6794.966025169842, 6818.624975626388, 6820.897686534607, 6839.179298484214, 6843.692033858588, 6408.743650254124, 6496.7726129585235, 6526.771562995273, 6567.047778072058, 6607.306232845482, 6390.744370225325, 6463.838404039937, 6515.348465153446, 6521.054447105238, 6552.475801935739, 6367.713452894724, 6475.287718350884, 6480.57876238043, 6481.384268494486, 6489.8702025960165, 6485.092087107903, 6542.0, 6613.636250006296, 6639.302873198438, 6703.095082163845, 6368.140301059298, 6369.649669268235, 6371.331010243857, 6431.807045788634, 6475.0], "value": 6111.545035117572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.4537895746721, 875.0505701314074, 876.3558784293543, 879.380037073863, 881.1540920716114, 37426.43860342094, 40872.38691419627, 41013.589864101385, 41063.79468102663, 41139.38290925638, 36386.8180659097, 36478.452823207605, 36704.63295367046, 36783.4482482763, 36832.44751328732, 6974.51178417511, 6996.510244282902, 7028.894566581505, 7058.400035996947, 7710.0, 7696.692132314701, 7757.728479503218, 7789.922100779005, 7800.141984381714, 7804.3756499479905, 7804.3756499479905, 7840.843183136334, 7841.137474877759, 7852.411069169835, 7868.488548244346, 7717.421193410489, 7800.804979875492, 7804.414668899855, 7806.0, 7807.843843123106, 7383.07711536058, 7500.437467189928, 7506.737264195727, 7516.887246691249, 7517.511361761468, 37648.43527347092, 37836.62163378359, 37893.81053094717, 37956.24087518234, 38120.23759524822, 3481.3211423772373, 3520.2079532105327, 3525.3301872644115, 3530.6645868642436, 3533.2756784859043, 31234.219144521343, 31602.0, 31795.523067154012, 31851.0, 31960.680393196235, 5224.294720212761, 5270.92093618596, 5281.841544753625, 5284.154535274338, 5423.078076726966, 182031.0, 182597.99999999866, 183740.0, 184763.0, 184919.07540462347, 41010.589894100674, 41453.37819932703, 47439.762801186465, 47658.285125723145, 47782.76108619435, 47585.524144758805, 47727.76136119367, 47754.28368574474, 47828.521714783106, 47935.0, 15904.76142857858, 15976.641985431135, 16013.759793603105, 16079.758803617955, 16138.19309034567, 13292.136011159244, 13367.264800436069, 13381.866181338257, 13385.866141338656, 13439.865601344058, 13156.671083222805, 13343.132696374705, 13345.73308533824, 13355.131916425402, 13482.730345393038, 5464.98897703926, 5573.804916827973, 5584.329880414295, 5603.159526071122, 5604.159376093618, 978.0366339155926, 1005.3163848582888, 1005.4068099820994, 1007.5516395204211, 1009.6213919780082, 22496.77503224947, 22526.0, 22703.772962270497, 22870.656940145913, 22910.541789164457, 1086.9673909782719, 1102.9283096598695, 1103.2387652519897, 1122.259308856151, 1150.8791576884307, 11886.167968242313, 12071.215371000857, 12125.514979400725, 12127.33299668509, 12157.148999570121, 191136.0, 191800.0, 192920.0, 210702.0, 212160.0, 49773.253401199014, 49903.0, 50573.24140137901, 50573.74713126484, 50738.0, 1450.332846890421, 1473.2044695864327, 1474.7566651502382, 1478.3526927138444, 1479.2529772464836, 21879.343619691434, 22004.66992995074, 22049.33851984443, 22611.43471413228, 22811.657825132967, 32322.676773231968, 32559.511607325436, 33490.49764253587, 34939.30121397507, 35729.28541429209, 180544.0, 181136.0, 181576.55270341912, 181743.0, 181785.0, 29618.0, 30281.24296892595, 31517.68482315239, 32313.0, 33727.83136084304, 41407.171856563305, 41460.58539414688, 41623.37564936468, 41872.16255674809, 42332.36501452542, 30384.392312154076, 30802.075937721904, 30953.0, 31436.214094647818, 31825.204369890937, 30541.54187687142, 30746.538801918436, 30811.229719257197, 31078.378432431677, 31186.532202017443, 34015.489767654, 34155.82922085374, 34293.314133717686, 34482.65517344794, 34997.65002349944, 30352.392952141276, 30395.69604304017, 30429.391412172074, 30586.929457468883, 30708.692913071478, 22472.77527224707, 22763.203287884844, 23148.6527702088, 23419.765802341757, 23599.41001474977], "value": 16616.97527336147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7414041260195, 546.8550834028983, 552.1055889459077, 576.818302234796, 595.8272101090683, 21690.566188676235, 22673.54652906943, 22895.084196632113, 22901.427464313358, 22955.655665164995, 23726.5254694906, 24359.391015224628, 24662.63006054906, 24766.257012289614, 24895.377615559573, 6339.270983836848, 6560.212774467071, 6563.737450501974, 6566.21205455346, 6575.441087507544, 6408.23101227851, 6527.0, 6529.216494020724, 6530.771423000196, 6534.117894084286, 6285.2771931228035, 6490.902636460457, 6543.770968016121, 6545.247296560909, 6552.049952756847, 6520.543561950642, 6520.673966301666, 6537.64042977636, 6541.509386795961, 6572.441342485894, 5813.302403711539, 6039.5772295939305, 6048.1834952281315, 6088.573799834014, 6105.053716673922, 29042.27394315138, 29458.0, 29499.410011799857, 29511.262218444495, 29520.557191642143, 2094.455441585199, 2098.3075585056895, 2126.096409026173, 2128.4891626009644, 2131.7441906971108, 19105.80894191054, 19750.50623734418, 19792.0, 19911.50221244466, 20110.49723756903, 2404.326788499223, 2437.6465412515263, 2452.791512721421, 2485.7389974052644, 2488.4027833319874, 120839.3958030213, 125080.0, 125355.37322313421, 134616.3269183648, 134693.3265333667, 13575.0, 13773.586792396243, 13779.311034448438, 13786.310684465736, 14645.340959656842, 21444.356669299945, 21448.142074316853, 21609.567808644053, 21672.891635542037, 21684.89157554202, 9052.411593246417, 9574.712758617252, 9579.568919398644, 9594.760130996641, 9848.458334791656, 8940.642374305085, 8968.148025937526, 9087.636494540144, 9090.954545227232, 9162.587683554257, 8146.2261085196815, 8285.917140828515, 8300.626471808782, 8324.83350333002, 8385.664573416994, 2550.7066687331194, 2564.9358766031, 2608.608708693711, 2614.881945624051, 2770.1966429735553, 919.632147141149, 926.4950601921969, 928.1646518133733, 959.098447459386, 971.2763990826879, 18851.245950162112, 18871.81128188728, 18975.24099036023, 19204.807951920302, 19348.226070957284, 1006.104566935428, 1032.3031953431405, 1036.2487196782424, 1038.08129805123, 1039.4075377035017, 10427.739306517398, 10470.581176752845, 10511.474426278655, 10563.260571760056, 10810.082893594892, 460834.0, 462134.0, 472004.0, 482688.0, 485839.0, 106313.0, 111666.0, 111825.44087279511, 112607.4369628163, 113541.43229283966, 1114.3926560024806, 1170.4264910193945, 1171.4260012593768, 1241.0629974369294, 1246.4577908609783, 19735.01324933719, 19950.102245398703, 20369.49076273105, 20438.591228175057, 20607.0, 57525.0, 58252.0, 58990.0, 59670.70164649149, 60314.39685603263, 73646.0, 74660.62669686617, 75345.3629122978, 75695.62152189204, 75816.0, 13936.651583710489, 14020.298985050502, 14093.0, 14184.290785460893, 14224.786628200793, 21664.891675541523, 22060.55878882381, 22308.665370019786, 22525.436864077874, 22573.0, 17578.824211757717, 17745.29018839232, 17773.200205990503, 17911.283548657906, 18268.543286417946, 15251.389944402099, 16048.438304659281, 16075.919620401823, 16190.433334833224, 16606.50180494587, 17965.371212007518, 18124.546886327946, 18345.449636510926, 18369.81630183681, 18429.53926151857, 13987.790183147465, 14038.929805350908, 14127.081739686888, 14160.150390976163, 14301.284935752963, 17282.82717172812, 17381.82618173802, 17403.47789566315, 17615.295388184328, 17773.73339399936], "value": 11741.702251041243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.1001573937592, 1407.099456347937, 1423.1390009044528, 1426.3581388375235, 1431.6921861799724, 15508.0, 15765.763513547292, 15787.28957196926, 15851.841481585181, 16042.59893502663, 15797.368105275804, 15840.207989600503, 15873.84126158738, 15895.602609934758, 16001.519954401358, 2717.904873329434, 2745.6018877262786, 2777.6944536101014, 2779.4163225722523, 2784.916452506428, 2662.560677488212, 2722.6460560127157, 2738.7535121839032, 2739.493193759161, 2748.395353022342, 2579.5872660374343, 2703.3106557827728, 2780.304923769058, 2782.0262907982146, 2784.693683694792, 2697.635819164407, 2722.5507791214427, 2727.1954773341913, 2745.3960128771737, 2748.1618106477617, 2592.287121041729, 2594.4421949280804, 2598.8180827342094, 2602.8047896407843, 2618.4108575570535, 14653.12081275127, 15070.246487675573, 15145.545633631009, 15195.696086078216, 15200.315985780666, 8076.434649574532, 8290.170982901722, 8316.958415207886, 8361.372897032747, 8395.202455766692, 5245.186996015624, 5382.219578161184, 5503.394626591072, 5543.307086614173, 5628.099504079369, 1831.0753069699717, 1853.5736780540417, 1891.527118220445, 1894.393793985925, 1904.523869032742, 26981.190564283104, 27274.5908811368, 27294.727052729417, 27309.317267068483, 27311.726882731116, 6701.329867013357, 6840.486963477759, 6886.2769409212315, 6979.197392299849, 7054.365107140279, 17167.91416042937, 17244.913775431043, 17262.050587217822, 17327.393541225996, 17334.739978900325, 7889.447738658354, 7972.2824945755165, 8019.599020048974, 8036.357091432788, 8067.7579672608745, 7089.361957423856, 7157.606331651809, 7328.450366222448, 7347.155077166194, 7502.062242219723, 5092.083424983464, 5255.343082114736, 5270.683758974474, 5278.4721527846905, 5291.074062039204, 1382.3295701584723, 1413.6324555615613, 1491.6569189086572, 1547.4351861570447, 1557.3614817924597, 846.2764336492334, 858.4806192253722, 879.7536689726886, 887.5562218890555, 891.38494438837, 8142.47073940192, 8359.414840961195, 8391.286740627114, 8451.281641060456, 8547.316214702809, 971.3346357744967, 974.1865542272282, 974.4883935933692, 979.4759803505091, 982.5480279071708, 5189.6886186828915, 5213.478652134756, 5261.526462618306, 5265.447128051576, 5297.894042119136, 21362.465938351354, 21515.246966356102, 22203.111875525123, 22232.777672223394, 22313.44216394603, 21052.78947210539, 21626.35120946374, 22077.227297044847, 22143.778562214495, 22365.32904012882, 10827.621033263798, 11370.317780933005, 11423.428828558539, 11439.542418303341, 11560.768784624428, 7922.603869806371, 8166.754997350089, 8268.338532917232, 8314.501129931981, 8323.001239851257, 18102.637947240717, 18361.54096147607, 19068.0, 19156.808431915502, 19319.613607727486, 18631.44105676832, 19465.4160375189, 19553.120109594816, 20102.39692809218, 20379.69430458574, 12194.451249693962, 12403.875961240634, 12428.254304741744, 12454.31501267439, 12492.937535312265, 13495.527656531975, 13840.93079534596, 13892.583222503341, 13934.651633709238, 14161.221132837793, 11048.558057677925, 11457.828132578185, 11501.424928753697, 11510.827337589775, 11678.6496405108, 11108.555657773599, 11165.665030049111, 11239.66281011571, 11261.042811361127, 11401.885981140415, 9282.907170928203, 9288.72133835986, 9411.576479058596, 9429.669961551313, 9494.810103798023, 6820.693068811816, 6957.130358705162, 6984.196817366068, 6995.265497122728, 6998.790036298919, 7012.894806577803, 7068.893966590608, 7087.716491340495, 7111.928880711127, 7165.6027074722015], "value": 6717.687843502245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.9905041341697, 501.524240338283, 521.7339157029913, 527.7071225469867, 528.3923487988812, 6180.45488627843, 6190.350013248606, 6230.906536401952, 6248.375422390177, 6263.123162757218, 6043.425874541923, 6090.208272924514, 6098.908516372247, 6197.752089916409, 6199.938000619993, 4824.44518880328, 4934.6429731823855, 4954.711774938524, 5069.239614057884, 5076.6700164489375, 4904.362432883738, 4955.0, 4960.528749768766, 4981.2279096739885, 4987.675801072919, 4875.41495020598, 4880.414350277972, 4899.721629442309, 4918.606511479073, 4939.135651261015, 4839.830605928793, 4871.318015477836, 4878.073166098466, 4894.1679914414635, 4895.388076490439, 4426.933595996063, 4446.333050042487, 4448.110377924428, 4448.555144485558, 4458.665600079975, 5995.250593675791, 6055.182550355689, 6078.513718902477, 6095.542834287402, 6147.508199344086, 5550.972245138789, 5553.194786755938, 5571.832845014656, 5586.497215250606, 5623.409541998113, 6248.250209974786, 6385.2656944451055, 6416.711247993851, 6425.357464253584, 6453.451456626192, 4537.296719008559, 4794.0, 4797.9520204797855, 4804.8318308859025, 4807.951920480786, 6576.769813056568, 6581.3747693969, 6636.170478690164, 6700.363465470821, 6713.530052896348, 4815.061063092663, 4840.104580652591, 4842.869137579454, 4855.708657480563, 4865.270209468537, 4909.705417674951, 4913.484084171182, 4922.704637721748, 4941.209406494943, 4947.480514545993, 5262.184546331586, 5548.778048878, 5559.555235581144, 5561.304836895388, 5604.579656525777, 6388.2653494847755, 6395.392437718409, 6414.679266036773, 6431.935680643133, 6478.611283323015, 1688.7840754656627, 1700.7023770840053, 1706.4624643237341, 1716.8969861808332, 1733.14209466315, 1175.8118701007797, 1193.6180422264792, 1213.6723084767063, 1220.560598184653, 1232.1744431231098, 5540.861478463071, 5584.385717571064, 5593.188987596775, 5610.607257492018, 5640.830775076754, 6364.459020983269, 6420.5184611154355, 6460.45086167681, 6503.674816259263, 6574.572652777554, 5452.427495112956, 5524.364698059774, 5546.251256080458, 5594.720263986785, 5655.519280861173, 3456.844442000116, 3474.2356681530023, 3477.704395126392, 3483.9477407838904, 3492.480770864682, 6388.233411990498, 6401.623650914982, 6437.839054023687, 6462.4183823456115, 6464.515161362917, 6646.534742567974, 6662.467002639874, 6684.732610695615, 6692.464602831762, 6696.497762667722, 6252.562320637603, 6337.0, 6384.265809431882, 6398.840028999312, 6402.743890244431, 6416.582922110048, 6442.581232219891, 6577.473802095725, 6603.141591593062, 6606.47148228131, 5897.407699921083, 6505.349465053457, 6550.115734375799, 6562.409383155348, 6588.868222635616, 6145.324014358328, 6150.692465376803, 6194.349593292639, 6208.2239720034995, 6314.210723659543, 4887.535684110004, 4923.803047878045, 4930.186519224288, 4941.827036053721, 4965.925511117264, 6499.1876015498065, 6591.406773390418, 6610.603363798187, 6658.966705166443, 6709.194896612437, 6328.493720502441, 6331.145295385064, 6369.936300636934, 6392.744290228339, 6469.935300646934, 6367.554271200971, 6403.679816009274, 6410.358964103552, 6449.7097630605795, 6458.903116453163, 6206.472449841814, 6273.341299163522, 6313.779017734358, 6345.079963405373, 6352.428281454691, 6361.268454127835, 6399.200099987502, 6400.615963042233, 6407.1350367701625, 6427.100205971261, 6190.535709821691, 6224.408681175281, 6236.191504463654, 6244.406781355764, 6247.407325959676], "value": 4950.712797431044, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [916.0793402630355, 930.7207837648705, 949.4588084791671, 953.4041224234853, 963.8843338799343, 17634.38279660212, 18370.72443913339, 18592.256309747612, 18660.160292786823, 18666.626667466644, 17438.128093595333, 18181.27274909002, 18417.53956151097, 18626.906865465655, 18630.62738745224, 966.2946049383936, 968.3028219681818, 971.6744890461669, 975.0395860077853, 975.4976187263564, 975.1077763846072, 980.62736160259, 981.249344251648, 983.4001259231862, 984.1536278800226, 1039.7920415916808, 1042.7705904700993, 1046.272840375939, 1046.4924511611862, 1048.7273308939693, 1026.091908660837, 1037.0148359058849, 1041.7603951091216, 1046.9057784799365, 1049.2497864027218, 763.8777795552741, 767.6277005652254, 769.4344656677338, 770.3221165374491, 771.0631582627135, 19311.227550897947, 19838.60322793536, 19895.50261243466, 19987.90006049975, 20158.79841201584, 19808.61339706221, 20385.4903627409, 20837.68743468849, 21067.789322106888, 21260.893695531577, 16607.0, 16743.581410464714, 16896.577585560335, 16951.152442377832, 16980.66038679232, 3699.5375578052744, 3710.4805327253935, 3718.9070273243115, 3719.3491139050557, 3737.0470530014945, 140169.0, 142130.28934855363, 142704.0, 144016.0, 145201.0, 15918.9204053979, 16084.919575402047, 16113.677726445405, 16372.918135409485, 16498.092604906604, 30060.398792024036, 31090.53364199539, 31164.376712465622, 31225.8438707805, 31452.842735786173, 8507.53208573522, 8681.782955426039, 8696.695615653422, 8730.476171429735, 8758.430702004349, 4250.298700714409, 4301.827926882952, 4306.612404883513, 4316.848910288125, 4371.278739008092, 5121.411037730709, 5185.688858668416, 5212.296339994128, 5234.502722241381, 5304.9734751326, 837.8491871463074, 845.1759534453859, 862.9654813807377, 863.3050394432543, 863.3179787967435, 682.7917485166972, 688.449240607512, 695.7460526907744, 702.2135208566439, 708.4580296073508, 10614.946925265323, 10851.728706782395, 11014.39420831862, 11602.88397116018, 11905.345206013752, 665.7037618259828, 667.7028722218663, 675.4697562413481, 680.4522359500551, 689.7172159414716, 5149.6964163660405, 5152.562032227303, 5153.510416510426, 5170.68975861442, 5210.192420174879, 122003.0, 124279.0, 125035.3748231253, 125287.3735631316, 126111.0, 108266.0, 108404.0, 109964.0, 111786.0, 114246.42876785729, 92757.0, 94232.52883735538, 96190.51904740432, 96968.51515742377, 97307.51346243365, 9504.382215155993, 9557.426554406758, 9564.091411315914, 9596.376235544667, 9858.507074646383, 43862.56137438712, 44086.33870492009, 45004.549954501344, 45418.31872521981, 45691.54308457006, 55679.0, 56703.71648141733, 56996.145057823334, 57238.42761572331, 58803.41196587979, 15470.226488675746, 15886.0, 15901.28444220036, 15959.920200398923, 16141.273642685872, 17257.56856078608, 17308.307667693152, 17327.82672173262, 17351.30594776195, 17357.47927562175, 13180.945524357836, 13226.206427614374, 13286.468541258242, 13404.597862064154, 13611.11527750693, 14190.929045354707, 14318.785218221527, 14430.855691442952, 14457.710845783236, 14823.777643335143, 13574.796378054534, 13638.454461821417, 13737.519186828813, 13756.518521851687, 14234.501792437215, 11609.361485118061, 11714.707132321419, 11907.166498345032, 11931.940340298243, 12240.816387754012, 10932.344059356465, 10956.66882244677, 10982.615608453985, 11035.558577656804, 11460.541578336773], "value": 8697.453587748081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 107.0, 114.0, 112.0, 113.0, 114.0, 118.0, 107.0, 110.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 124.0, 124.0, 117.0, 123.0, 128.0, 123.0, 115.0, 130.0, 123.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 171.0, 163.0, 168.0, 171.0, 166.0, 169.0, 169.0, 164.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 76.0, 74.0, 78.0, 87.0, 79.0, 74.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 80.0, 84.0, 80.0, 83.0, 80.0, 79.0, 79.0, 85.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 116.0, 114.0, 115.0, 117.0, 114.0, 115.0, 115.0, 124.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 152.0, 149.0, 148.0, 148.0, 159.0, 149.0, 155.0, 152.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 95.0, 98.0, 96.0, 94.0, 97.0, 101.0, 97.0, 95.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 56.0, 54.0, 54.0, 56.0, 59.0, 60.0, 54.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 45.0, 40.0, 42.0, 43.0, 39.0, 43.0, 45.0, 45.0, 44.0], "value": 42.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 75.0, 77.0, 73.0, 77.0, 85.0, 77.0, 85.0, 79.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 109.0, 120.0, 120.0, 112.0, 124.0, 120.0, 116.0, 119.0, 114.0], "value": 117.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 169.0, 166.0, 165.0, 172.0, 169.0, 168.0, 176.0, 176.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 67.0, 67.0, 72.0, 64.0], "value": 66.2, "unit": "score"}]}]} 21:24:09 INFO - Return code: 0 21:24:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:24:09 INFO - # TBPL SUCCESS # 21:24:09 INFO - Running post-action listener: _package_coverage_data 21:24:09 INFO - Running post-action listener: _resource_record_post_action 21:24:09 INFO - [mozharness: 2017-09-17 04:24:09.174513Z] Finished run-tests step (success) 21:24:09 INFO - Running post-run listener: _resource_record_post_run 21:24:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 427134976; Read time: 16; Write time: 420796 21:24:09 INFO - TinderboxPrint: CPU usage
13.3% 21:24:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:24:09 INFO - TinderboxPrint: I/O write bytes / time
427,134,976 / 420,796 21:24:09 INFO - TinderboxPrint: CPU idle
8,251.5 (86.7%) 21:24:09 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 21:24:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:24:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 97824768; Read time: 0; Write time: 82432 21:24:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:24:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 320909312; Read time: 0; Write time: 336576 21:24:09 INFO - Running post-run listener: _upload_blobber_files 21:24:09 INFO - Blob upload gear active. 21:24:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:24:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:24:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:24:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:24:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:24:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:11 INFO - (blobuploader) - INFO - Done attempting. 21:24:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:24:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:24:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:12 INFO - (blobuploader) - INFO - Done attempting. 21:24:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:24:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:16 INFO - (blobuploader) - INFO - Done attempting. 21:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:24:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:17 INFO - (blobuploader) - INFO - Done attempting. 21:24:17 INFO - (blobuploader) - INFO - Iteration through files over. 21:24:17 INFO - Return code: 0 21:24:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:24:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:24:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a46c542f814f9d2fb15cb1e50710d94f819967fa19668a3ea7c68da1f004e4ca84cf0f2e22c84e1f2d3e5a492f27b1578d4bad0dc8f1caa6d28b1d8d08689b92", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1648b9373b14b5350efb35a21f3837ed1962e7ca2c8d2b2dd4422d724d6d761087bdccb3dc880d44046126181a8778497e65be6162893b20503fc782dec31e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c57f32ad7baa4126b725be1a06fec9e2d737f80be1565fbb4fbd255b8dd25585cf09fc590e7eb1c5118c057bfe3bb40161a24534b6e8e408bb88a1c2e50c6c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a237a319765358d18086a3201a3400fbe4f4e21e7914b19a561a63485c0574a0d81677e101233b32fd50da11c83aa5e72656136e365369c790f1f579fbaa3138"} 21:24:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:24:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:24:17 INFO - Contents: 21:24:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a46c542f814f9d2fb15cb1e50710d94f819967fa19668a3ea7c68da1f004e4ca84cf0f2e22c84e1f2d3e5a492f27b1578d4bad0dc8f1caa6d28b1d8d08689b92", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1648b9373b14b5350efb35a21f3837ed1962e7ca2c8d2b2dd4422d724d6d761087bdccb3dc880d44046126181a8778497e65be6162893b20503fc782dec31e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c57f32ad7baa4126b725be1a06fec9e2d737f80be1565fbb4fbd255b8dd25585cf09fc590e7eb1c5118c057bfe3bb40161a24534b6e8e408bb88a1c2e50c6c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a237a319765358d18086a3201a3400fbe4f4e21e7914b19a561a63485c0574a0d81677e101233b32fd50da11c83aa5e72656136e365369c790f1f579fbaa3138"} 21:24:17 INFO - Running post-run listener: copy_logs_to_upload_dir 21:24:17 INFO - Copying logs to upload dir... 21:24:17 INFO - mkdir: /builds/slave/test/build/upload/logs 21:24:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.908780 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-16 21:24:17.226892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:24:17.230879) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a46c542f814f9d2fb15cb1e50710d94f819967fa19668a3ea7c68da1f004e4ca84cf0f2e22c84e1f2d3e5a492f27b1578d4bad0dc8f1caa6d28b1d8d08689b92", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1648b9373b14b5350efb35a21f3837ed1962e7ca2c8d2b2dd4422d724d6d761087bdccb3dc880d44046126181a8778497e65be6162893b20503fc782dec31e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c57f32ad7baa4126b725be1a06fec9e2d737f80be1565fbb4fbd255b8dd25585cf09fc590e7eb1c5118c057bfe3bb40161a24534b6e8e408bb88a1c2e50c6c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a237a319765358d18086a3201a3400fbe4f4e21e7914b19a561a63485c0574a0d81677e101233b32fd50da11c83aa5e72656136e365369c790f1f579fbaa3138"} build_url:https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011498 build_url: 'https://queue.taskcluster.net/v1/task/HL4DSwsdQYWbDYpmGciB1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a46c542f814f9d2fb15cb1e50710d94f819967fa19668a3ea7c68da1f004e4ca84cf0f2e22c84e1f2d3e5a492f27b1578d4bad0dc8f1caa6d28b1d8d08689b92", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1648b9373b14b5350efb35a21f3837ed1962e7ca2c8d2b2dd4422d724d6d761087bdccb3dc880d44046126181a8778497e65be6162893b20503fc782dec31e", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5c57f32ad7baa4126b725be1a06fec9e2d737f80be1565fbb4fbd255b8dd25585cf09fc590e7eb1c5118c057bfe3bb40161a24534b6e8e408bb88a1c2e50c6c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a237a319765358d18086a3201a3400fbe4f4e21e7914b19a561a63485c0574a0d81677e101233b32fd50da11c83aa5e72656136e365369c790f1f579fbaa3138"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:24:17.259472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:24:17.259802) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505601989.110304-2088652429 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 21:24:17.342449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:24:17.342806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:24:17.343197) ========= ========= Total master_lag: 0.19 =========