builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1505916812.19 results: success (0) revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.186986) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.187449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.187740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.209641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.210071) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 07:13:32-- 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% 45.8M=0s 2017-09-20 07:13:32 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.349919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.350290) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:32.407361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 07:13:32.407701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 07:13:32,458 truncating revision to first 12 chars 2017-09-20 07:13:32,458 Setting DEBUG logging. 2017-09-20 07:13:32,458 attempt 1/10 2017-09-20 07:13:32,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c49ebf4195c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 07:13:33,586 unpacking tar archive at: mozilla-central-0c49ebf4195c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.394659 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 07:13:33.816934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:33.817243) ========= script_repo_revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:33.817665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:33.817953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 07:13:33.829603) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-20 07:13:33.829972) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:34 INFO - MultiFileLogger online at 20170920 07:13:34 in /builds/slave/test 07:13:34 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 07:13:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:34 INFO - {'append_to_log': False, 07:13:34 INFO - 'base_work_dir': '/builds/slave/test', 07:13:34 INFO - 'blob_upload_branch': 'Firefox', 07:13:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:34 INFO - 'branch': 'Firefox', 07:13:34 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:34 INFO - 'code_coverage': False, 07:13:34 INFO - 'config_files': ('talos/linux_config.py',), 07:13:34 INFO - 'default_actions': ('clobber', 07:13:34 INFO - 'read-buildbot-config', 07:13:34 INFO - 'download-and-extract', 07:13:34 INFO - 'populate-webroot', 07:13:34 INFO - 'create-virtualenv', 07:13:34 INFO - 'install', 07:13:34 INFO - 'setup-mitmproxy', 07:13:34 INFO - 'run-tests'), 07:13:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:34 INFO - 'disable_ccov_upload': False, 07:13:34 INFO - 'disable_stylo': False, 07:13:34 INFO - 'download_minidump_stackwalk': True, 07:13:34 INFO - 'download_symbols': 'ondemand', 07:13:34 INFO - 'enable_stylo': False, 07:13:34 INFO - 'enable_webrender': False, 07:13:34 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:13:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:34 INFO - 'gecko_profile': False, 07:13:34 INFO - 'gecko_profile_interval': 0, 07:13:34 INFO - 'installer_path': 'installer.exe', 07:13:34 INFO - 'log_level': 'info', 07:13:34 INFO - 'log_name': 'talos', 07:13:34 INFO - 'log_to_console': True, 07:13:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:34 INFO - 'opt_config_files': (), 07:13:34 INFO - 'pip_index': False, 07:13:34 INFO - 'suite': 'dromaeojs-e10s', 07:13:34 INFO - 'system_bits': '32', 07:13:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:34 INFO - 'title': 'talos-linux64-ix-005', 07:13:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:34 INFO - 'use_talos_json': True, 07:13:34 INFO - 'verify': 'False', 07:13:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:34 INFO - 'work_dir': 'build'} 07:13:34 INFO - [mozharness: 2017-09-20 14:13:34.033868Z] Running clobber step. 07:13:34 INFO - Running pre-action listener: _resource_record_pre_action 07:13:34 INFO - Running main action method: clobber 07:13:34 INFO - rmtree: /builds/slave/test/build 07:13:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:35 INFO - Running post-action listener: _resource_record_post_action 07:13:35 INFO - [mozharness: 2017-09-20 14:13:35.025462Z] Finished clobber step (success) 07:13:35 INFO - [mozharness: 2017-09-20 14:13:35.025577Z] Running read-buildbot-config step. 07:13:35 INFO - Running pre-action listener: _resource_record_pre_action 07:13:35 INFO - Running main action method: read_buildbot_config 07:13:35 INFO - Using buildbot properties: 07:13:35 INFO - { 07:13:35 INFO - "project": "", 07:13:35 INFO - "product": "firefox", 07:13:35 INFO - "who": "archaeopteryx@coole-files.de", 07:13:35 INFO - "installer_path": "public/build/target.tar.bz2", 07:13:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:13:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:13:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:13:35 INFO - "stage_platform": "linux64-pgo", 07:13:35 INFO - "basedir": "/builds/slave/test", 07:13:35 INFO - "buildnumber": 196, 07:13:35 INFO - "platform": "ubuntu64_hw", 07:13:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:13:35 INFO - "slavebuilddir": "test", 07:13:35 INFO - "taskId": "NbT0q7xYTGi_hFg3qdp83A", 07:13:35 INFO - "branch": "mozilla-central", 07:13:35 INFO - "script_repo_revision": "production", 07:13:35 INFO - "revision": "0c49ebf4195ce51072b24aacf01eaaffdcff9be6", 07:13:35 INFO - "slavename": "talos-linux64-ix-005", 07:13:35 INFO - "repo_path": "mozilla-central" 07:13:35 INFO - } 07:13:35 INFO - Finding installer, test and symbols from parent task. 07:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NbT0q7xYTGi_hFg3qdp83A'}, attempt #1 07:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NbT0q7xYTGi_hFg3qdp83A'}, attempt #1 07:13:35 INFO - Task dependencies: P20qr_HwSXq27OAkk440Sw 07:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw'}, attempt #1 07:13:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 07:13:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.test_packages.json 07:13:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.crashreporter-symbols.zip 07:13:36 INFO - Running post-action listener: _resource_record_post_action 07:13:36 INFO - [mozharness: 2017-09-20 14:13:36.942217Z] Finished read-buildbot-config step (success) 07:13:36 INFO - [mozharness: 2017-09-20 14:13:36.942434Z] Running download-and-extract step. 07:13:36 INFO - Running pre-action listener: _resource_record_pre_action 07:13:36 INFO - Running main action method: download_and_extract 07:13:36 INFO - mkdir: /builds/slave/test/build/tests 07:13:36 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')]} 07:13:36 INFO - trying https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.test_packages.json 07:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:13:37 INFO - Downloaded 989 bytes. 07:13:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:13:37 INFO - Using the following test package requirements: 07:13:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:13:37 INFO - u'common': [u'target.common.tests.zip'], 07:13:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:13:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:13:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:13:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:13:37 INFO - u'mozbase': [u'target.common.tests.zip'], 07:13:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:13:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:13:37 INFO - u'web-platform': [u'target.common.tests.zip', 07:13:37 INFO - u'target.web-platform.tests.tar.gz'], 07:13:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:13:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:13:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.common.tests.zip 07:13:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:13:37 INFO - Fetch https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.common.tests.zip into memory 07:13:38 INFO - Content-Length response header: 55324590 07:13:38 INFO - Bytes received: 55324590 07:13:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.talos.tests.zip 07:13:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:13:49 INFO - Fetch https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.talos.tests.zip into memory 07:13:51 INFO - Content-Length response header: 14508893 07:13:51 INFO - Bytes received: 14508893 07:13: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')]} 07:13:51 INFO - trying https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 07:13:51 INFO - Downloading https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:13:54 INFO - Downloaded 62209084 bytes. 07:13:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 07:13:54 INFO - mkdir: /builds/slave/test/properties 07:13:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:54 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:54 INFO - Contents: 07:13:54 INFO - build_url:https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 07:13:54 INFO - Running post-action listener: _resource_record_post_action 07:13:54 INFO - Running post-action listener: find_tests_for_verification 07:13:54 INFO - Running post-action listener: set_extra_try_arguments 07:13:54 INFO - [mozharness: 2017-09-20 14:13:54.616073Z] Finished download-and-extract step (success) 07:13:54 INFO - [mozharness: 2017-09-20 14:13:54.616271Z] Running populate-webroot step. 07:13:54 INFO - Running pre-action listener: _resource_record_pre_action 07:13:54 INFO - Running main action method: populate_webroot 07:13:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['tresize', 07:13:55 INFO - 'tcanvasmark']}, 07:13:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['dromaeo_css', 07:13:55 INFO - 'kraken']}, 07:13:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'tests': ['damp', 'tps']}, 07:13:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['damp', 'tps']}, 07:13:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['dromaeo_dom']}, 07:13:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:13:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['basic_compositor_video', 07:13:55 INFO - 'glvideo']}, 07:13:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:13:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['ts_paint_webext', 07:13:55 INFO - 'tp5o_webext']}, 07:13:55 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:55 INFO - 'ts_paint', 07:13:55 INFO - 'tpaint', 07:13:55 INFO - 'sessionrestore', 07:13:55 INFO - 'sessionrestore_many_windows', 07:13:55 INFO - 'sessionrestore_no_auto_restore', 07:13:55 INFO - 'tabpaint']}, 07:13:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['a11yr', 07:13:55 INFO - 'ts_paint', 07:13:55 INFO - 'tpaint', 07:13:55 INFO - 'sessionrestore', 07:13:55 INFO - 'sessionrestore_many_windows', 07:13:55 INFO - 'sessionrestore_no_auto_restore', 07:13:55 INFO - 'tabpaint']}, 07:13:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:13:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:13:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['perf_reftest_singletons']}, 07:13:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['bloom_basic']}, 07:13:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:55 INFO - 'tsvgr_opacity', 07:13:55 INFO - 'tart', 07:13:55 INFO - 'tscrollx', 07:13:55 INFO - 'tsvg_static']}, 07:13:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['tsvgx', 07:13:55 INFO - 'tsvgr_opacity', 07:13:55 INFO - 'tart', 07:13:55 INFO - 'tscrollx', 07:13:55 INFO - 'tsvg_static']}, 07:13:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:13:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo'], 07:13:55 INFO - 'tests': ['tp5o']}, 07:13:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:55 INFO - 'talos_options': ['--mitmproxy', 07:13:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:55 INFO - '--firstNonBlankPaint'], 07:13:55 INFO - 'tests': ['tp6_google', 07:13:55 INFO - 'tp6_youtube', 07:13:55 INFO - 'tp6_amazon', 07:13:55 INFO - 'tp6_facebook']}, 07:13:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo', 07:13:55 INFO - '--mitmproxy', 07:13:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:55 INFO - '--firstNonBlankPaint'], 07:13:55 INFO - 'tests': ['tp6_google', 07:13:55 INFO - 'tp6_youtube', 07:13:55 INFO - 'tp6_amazon', 07:13:55 INFO - 'tp6_facebook']}, 07:13:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:13:55 INFO - 'talos_options': ['--stylo-threads=1', 07:13:55 INFO - '--mitmproxy', 07:13:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:13:55 INFO - '--firstNonBlankPaint'], 07:13:55 INFO - 'tests': ['tp6_google', 07:13:55 INFO - 'tp6_youtube', 07:13:55 INFO - 'tp6_amazon', 07:13:55 INFO - 'tp6_facebook']}, 07:13:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--xperf_path', 07:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:55 INFO - 'tests': ['tp5n']}, 07:13:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:13:55 INFO - 'talos_options': ['--disable-stylo', 07:13:55 INFO - '--xperf_path', 07:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:55 INFO - 'tests': ['tp5n']}}} 07:13:55 INFO - Running post-action listener: _resource_record_post_action 07:13:55 INFO - [mozharness: 2017-09-20 14:13:55.059164Z] Finished populate-webroot step (success) 07:13:55 INFO - [mozharness: 2017-09-20 14:13:55.059260Z] Running create-virtualenv step. 07:13:55 INFO - Running pre-action listener: _resource_record_pre_action 07:13:55 INFO - Running main action method: create_virtualenv 07:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:13:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:13:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:55 INFO - Installing pip...............done. 07:13:55 INFO - Return code: 0 07:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:13:56 INFO - Reading from file tmpfile_stdout 07:13:56 INFO - Output received: 07:13:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:13:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:13:56 INFO - Using env: {'DISPLAY': ':0', 07:13:56 INFO - 'HOME': '/home/cltbld', 07:13:56 INFO - 'LANG': 'en_US.UTF-8', 07:13:56 INFO - 'LANGUAGE': 'en_US:en', 07:13:56 INFO - 'LOGNAME': 'cltbld', 07:13:56 INFO - 'MAIL': '/var/mail/cltbld', 07:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:56 INFO - 'MOZ_NO_REMOTE': '1', 07:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:56 INFO - 'NO_EM_RESTART': '1', 07:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:56 INFO - 'PWD': '/builds/slave/test', 07:13:56 INFO - 'SHELL': '/bin/bash', 07:13:56 INFO - 'SHLVL': '1', 07:13:56 INFO - 'TERM': 'linux', 07:13:56 INFO - 'TMOUT': '86400', 07:13:56 INFO - 'USER': 'cltbld', 07:13:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:56 INFO - '_': '/tools/buildbot/bin/python'} 07:13:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:13:57 INFO - Downloading/unpacking pip>=1.5 07:13:57 INFO - Running setup.py egg_info for package pip 07:13:57 INFO - warning: no files found matching 'pip/cacert.pem' 07:13:57 INFO - warning: no files found matching '*.html' under directory 'docs' 07:13:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:13:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:13:57 INFO - Installing collected packages: pip 07:13:57 INFO - Found existing installation: pip 1.1 07:13:57 INFO - Uninstalling pip: 07:13:57 INFO - Successfully uninstalled pip 07:13:57 INFO - Running setup.py install for pip 07:13:57 INFO - warning: no files found matching 'pip/cacert.pem' 07:13:57 INFO - warning: no files found matching '*.html' under directory 'docs' 07:13:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:13:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:13:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:13:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:13:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:13:57 INFO - Successfully installed pip 07:13:57 INFO - Cleaning up... 07:13:57 INFO - Return code: 0 07:13:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:13:57 INFO - Using env: {'DISPLAY': ':0', 07:13:57 INFO - 'HOME': '/home/cltbld', 07:13:57 INFO - 'LANG': 'en_US.UTF-8', 07:13:57 INFO - 'LANGUAGE': 'en_US:en', 07:13:57 INFO - 'LOGNAME': 'cltbld', 07:13:57 INFO - 'MAIL': '/var/mail/cltbld', 07:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:57 INFO - 'MOZ_NO_REMOTE': '1', 07:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:57 INFO - 'NO_EM_RESTART': '1', 07:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:57 INFO - 'PWD': '/builds/slave/test', 07:13:57 INFO - 'SHELL': '/bin/bash', 07:13:57 INFO - 'SHLVL': '1', 07:13:57 INFO - 'TERM': 'linux', 07:13:57 INFO - 'TMOUT': '86400', 07:13:57 INFO - 'USER': 'cltbld', 07:13:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:57 INFO - '_': '/tools/buildbot/bin/python'} 07:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:57 INFO - Downloading/unpacking psutil>=3.1.1 07:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:58 INFO - Installing collected packages: psutil 07:13:58 INFO - Running setup.py install for psutil 07:13:58 INFO - building 'psutil._psutil_linux' extension 07:13:58 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 07:13:58 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 07:13:58 INFO - building 'psutil._psutil_posix' extension 07:13:58 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 07:13: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 07:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:59 INFO - Successfully installed psutil 07:13:59 INFO - Cleaning up... 07:13:59 INFO - Return code: 0 07:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:13: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')]} 07:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13: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')]} 07:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:13: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 07:13: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 07:13:59 INFO - Using env: {'DISPLAY': ':0', 07:13:59 INFO - 'HOME': '/home/cltbld', 07:13:59 INFO - 'LANG': 'en_US.UTF-8', 07:13:59 INFO - 'LANGUAGE': 'en_US:en', 07:13:59 INFO - 'LOGNAME': 'cltbld', 07:13:59 INFO - 'MAIL': '/var/mail/cltbld', 07:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:59 INFO - 'MOZ_NO_REMOTE': '1', 07:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:59 INFO - 'NO_EM_RESTART': '1', 07:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:59 INFO - 'PWD': '/builds/slave/test', 07:13:59 INFO - 'SHELL': '/bin/bash', 07:13:59 INFO - 'SHLVL': '1', 07:13:59 INFO - 'TERM': 'linux', 07:13:59 INFO - 'TMOUT': '86400', 07:13:59 INFO - 'USER': 'cltbld', 07:13:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:59 INFO - '_': '/tools/buildbot/bin/python'} 07:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:14:00 INFO - Installing collected packages: mozsystemmonitor 07:14:00 INFO - Running setup.py install for mozsystemmonitor 07:14:00 INFO - Successfully installed mozsystemmonitor 07:14:00 INFO - Cleaning up... 07:14:01 INFO - Return code: 0 07:14:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:01 INFO - Using env: {'DISPLAY': ':0', 07:14:01 INFO - 'HOME': '/home/cltbld', 07:14:01 INFO - 'LANG': 'en_US.UTF-8', 07:14:01 INFO - 'LANGUAGE': 'en_US:en', 07:14:01 INFO - 'LOGNAME': 'cltbld', 07:14:01 INFO - 'MAIL': '/var/mail/cltbld', 07:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:01 INFO - 'MOZ_NO_REMOTE': '1', 07:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:01 INFO - 'NO_EM_RESTART': '1', 07:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:01 INFO - 'PWD': '/builds/slave/test', 07:14:01 INFO - 'SHELL': '/bin/bash', 07:14:01 INFO - 'SHLVL': '1', 07:14:01 INFO - 'TERM': 'linux', 07:14:01 INFO - 'TMOUT': '86400', 07:14:01 INFO - 'USER': 'cltbld', 07:14:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:01 INFO - '_': '/tools/buildbot/bin/python'} 07:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:01 INFO - Downloading/unpacking jsonschema==2.5.1 07:14: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 07:14: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 07:14: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 07:14: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 07:14:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:02 INFO - warning: no files found matching '*.txt' 07:14:02 INFO - no previously-included directories found matching 'build' 07:14:02 INFO - no previously-included directories found matching 'dist' 07:14:02 INFO - no previously-included directories found matching '.git*' 07:14:02 INFO - Installing collected packages: jsonschema, functools32 07:14:02 INFO - Running setup.py install for functools32 07:14:02 INFO - warning: no files found matching '*.txt' 07:14:02 INFO - no previously-included directories found matching 'build' 07:14:02 INFO - no previously-included directories found matching 'dist' 07:14:02 INFO - no previously-included directories found matching '.git*' 07:14:03 INFO - Successfully installed jsonschema functools32 07:14:03 INFO - Cleaning up... 07:14:03 INFO - Return code: 0 07:14:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:03 INFO - Using env: {'DISPLAY': ':0', 07:14:03 INFO - 'HOME': '/home/cltbld', 07:14:03 INFO - 'LANG': 'en_US.UTF-8', 07:14:03 INFO - 'LANGUAGE': 'en_US:en', 07:14:03 INFO - 'LOGNAME': 'cltbld', 07:14:03 INFO - 'MAIL': '/var/mail/cltbld', 07:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:03 INFO - 'MOZ_NO_REMOTE': '1', 07:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:03 INFO - 'NO_EM_RESTART': '1', 07:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:03 INFO - 'PWD': '/builds/slave/test', 07:14:03 INFO - 'SHELL': '/bin/bash', 07:14:03 INFO - 'SHLVL': '1', 07:14:03 INFO - 'TERM': 'linux', 07:14:03 INFO - 'TMOUT': '86400', 07:14:03 INFO - 'USER': 'cltbld', 07:14:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:03 INFO - '_': '/tools/buildbot/bin/python'} 07:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:14:03 INFO - Cleaning up... 07:14:03 INFO - Return code: 0 07:14:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:03 INFO - Using env: {'DISPLAY': ':0', 07:14:03 INFO - 'HOME': '/home/cltbld', 07:14:03 INFO - 'LANG': 'en_US.UTF-8', 07:14:03 INFO - 'LANGUAGE': 'en_US:en', 07:14:03 INFO - 'LOGNAME': 'cltbld', 07:14:03 INFO - 'MAIL': '/var/mail/cltbld', 07:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:03 INFO - 'MOZ_NO_REMOTE': '1', 07:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:03 INFO - 'NO_EM_RESTART': '1', 07:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:03 INFO - 'PWD': '/builds/slave/test', 07:14:03 INFO - 'SHELL': '/bin/bash', 07:14:03 INFO - 'SHLVL': '1', 07:14:03 INFO - 'TERM': 'linux', 07:14:03 INFO - 'TMOUT': '86400', 07:14:03 INFO - 'USER': 'cltbld', 07:14:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:03 INFO - '_': '/tools/buildbot/bin/python'} 07:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:14: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 07:14: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 07:14: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 07:14: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 07:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:05 INFO - Downloading docopt-0.6.1.tar.gz 07:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:05 INFO - Running setup.py install for blobuploader 07:14:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:05 INFO - Running setup.py install for requests 07:14:05 INFO - Running setup.py install for docopt 07:14:05 INFO - Successfully installed blobuploader requests docopt 07:14:05 INFO - Cleaning up... 07:14:05 INFO - Return code: 0 07:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:05 INFO - Using env: {'DISPLAY': ':0', 07:14:05 INFO - 'HOME': '/home/cltbld', 07:14:05 INFO - 'LANG': 'en_US.UTF-8', 07:14:05 INFO - 'LANGUAGE': 'en_US:en', 07:14:05 INFO - 'LOGNAME': 'cltbld', 07:14:05 INFO - 'MAIL': '/var/mail/cltbld', 07:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:05 INFO - 'MOZ_NO_REMOTE': '1', 07:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:05 INFO - 'NO_EM_RESTART': '1', 07:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:05 INFO - 'PWD': '/builds/slave/test', 07:14:05 INFO - 'SHELL': '/bin/bash', 07:14:05 INFO - 'SHLVL': '1', 07:14:05 INFO - 'TERM': 'linux', 07:14:05 INFO - 'TMOUT': '86400', 07:14:05 INFO - 'USER': 'cltbld', 07:14:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:05 INFO - '_': '/tools/buildbot/bin/python'} 07:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:05 INFO - Running setup.py (path:/tmp/pip-gPsgIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:06 INFO - Running setup.py (path:/tmp/pip-0MYfsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:06 INFO - Running setup.py (path:/tmp/pip-gmFeYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:06 INFO - Running setup.py (path:/tmp/pip-w4C6Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:06 INFO - Running setup.py (path:/tmp/pip-hr4rpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:06 INFO - Running setup.py (path:/tmp/pip-M6Zbhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:06 INFO - Running setup.py (path:/tmp/pip-aGKmH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:06 INFO - Running setup.py (path:/tmp/pip-vYPVO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:06 INFO - Running setup.py (path:/tmp/pip-sjAdY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:06 INFO - Running setup.py (path:/tmp/pip-6e1UQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:06 INFO - Running setup.py (path:/tmp/pip-Kf9oGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:06 INFO - Running setup.py (path:/tmp/pip-0U5zDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:06 INFO - Running setup.py (path:/tmp/pip-Mb5vjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:06 INFO - Running setup.py (path:/tmp/pip-Nq0si9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:06 INFO - Running setup.py (path:/tmp/pip-5NP4Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:07 INFO - Running setup.py (path:/tmp/pip-9TaSyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:07 INFO - Running setup.py (path:/tmp/pip-vACNNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:07 INFO - Running setup.py install for manifestparser 07:14:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozcrash 07:14:07 INFO - Running setup.py install for mozdebug 07:14:07 INFO - Running setup.py install for mozdevice 07:14:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozfile 07:14:07 INFO - Running setup.py install for mozhttpd 07:14:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozinfo 07:14:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozInstall 07:14:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:07 INFO - Running setup.py install for mozleak 07:14:08 INFO - Running setup.py install for mozlog 07:14:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for moznetwork 07:14:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozprocess 07:14:08 INFO - Running setup.py install for mozprofile 07:14:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozrunner 07:14:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Running setup.py install for mozscreenshot 07:14:08 INFO - Running setup.py install for moztest 07:14:08 INFO - Running setup.py install for mozversion 07:14:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:08 INFO - Cleaning up... 07:14:08 INFO - Return code: 0 07:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:08 INFO - Using env: {'DISPLAY': ':0', 07:14:08 INFO - 'HOME': '/home/cltbld', 07:14:08 INFO - 'LANG': 'en_US.UTF-8', 07:14:08 INFO - 'LANGUAGE': 'en_US:en', 07:14:08 INFO - 'LOGNAME': 'cltbld', 07:14:08 INFO - 'MAIL': '/var/mail/cltbld', 07:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:08 INFO - 'MOZ_NO_REMOTE': '1', 07:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:08 INFO - 'NO_EM_RESTART': '1', 07:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:08 INFO - 'PWD': '/builds/slave/test', 07:14:08 INFO - 'SHELL': '/bin/bash', 07:14:08 INFO - 'SHLVL': '1', 07:14:08 INFO - 'TERM': 'linux', 07:14:08 INFO - 'TMOUT': '86400', 07:14:08 INFO - 'USER': 'cltbld', 07:14:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:08 INFO - '_': '/tools/buildbot/bin/python'} 07:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:09 INFO - Running setup.py (path:/tmp/pip-UQUS7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:09 INFO - Running setup.py (path:/tmp/pip-A8hrRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:09 INFO - Running setup.py (path:/tmp/pip-S92UbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:09 INFO - Running setup.py (path:/tmp/pip-o2uBIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:09 INFO - Running setup.py (path:/tmp/pip-YWQKjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:09 INFO - Running setup.py (path:/tmp/pip-0A8haZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:09 INFO - Running setup.py (path:/tmp/pip-uPdbOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:09 INFO - Running setup.py (path:/tmp/pip-lGG85e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:09 INFO - Running setup.py (path:/tmp/pip-aZrVON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:09 INFO - Running setup.py (path:/tmp/pip-ejYbpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:09 INFO - Running setup.py (path:/tmp/pip-ckgyNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14: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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:09 INFO - Running setup.py (path:/tmp/pip-E2ctiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:09 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)) 07:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:09 INFO - Running setup.py (path:/tmp/pip-pXMufS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14: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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:10 INFO - Running setup.py (path:/tmp/pip-Dik9Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14: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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:10 INFO - Running setup.py (path:/tmp/pip-u319gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14: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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:10 INFO - Running setup.py (path:/tmp/pip-9QSnvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14: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)) 07:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:10 INFO - Running setup.py (path:/tmp/pip-Ivioth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:11 INFO - Downloading blessings-1.6.tar.gz 07:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:11 INFO - Installing collected packages: blessings 07:14:11 INFO - Running setup.py install for blessings 07:14:11 INFO - Successfully installed blessings 07:14:11 INFO - Cleaning up... 07:14:11 INFO - Return code: 0 07:14:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:11 INFO - Reading from file tmpfile_stdout 07:14:11 INFO - Current package versions: 07:14:11 INFO - argparse == 1.2.1 07:14:11 INFO - blessings == 1.6 07:14:11 INFO - blobuploader == 1.2.4 07:14:11 INFO - docopt == 0.6.1 07:14:11 INFO - functools32 == 3.2.3-2 07:14:11 INFO - jsonschema == 2.5.1 07:14:11 INFO - manifestparser == 1.1 07:14:11 INFO - mozInstall == 1.13 07:14:11 INFO - mozcrash == 1.0 07:14:11 INFO - mozdebug == 0.1 07:14:11 INFO - mozdevice == 0.51 07:14:11 INFO - mozfile == 1.2 07:14:11 INFO - mozhttpd == 0.7 07:14:11 INFO - mozinfo == 0.10 07:14:11 INFO - mozleak == 0.1 07:14:11 INFO - mozlog == 3.5 07:14:11 INFO - moznetwork == 0.27 07:14:11 INFO - mozprocess == 0.25 07:14:11 INFO - mozprofile == 0.28 07:14:11 INFO - mozrunner == 6.13 07:14:11 INFO - mozscreenshot == 0.1 07:14:11 INFO - mozsystemmonitor == 0.3 07:14:11 INFO - moztest == 0.8 07:14:11 INFO - mozversion == 1.4 07:14:11 INFO - psutil == 3.1.1 07:14:11 INFO - requests == 1.2.3 07:14:11 INFO - wsgiref == 0.1.2 07:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:11 INFO - Using env: {'DISPLAY': ':0', 07:14:11 INFO - 'HOME': '/home/cltbld', 07:14:11 INFO - 'LANG': 'en_US.UTF-8', 07:14:11 INFO - 'LANGUAGE': 'en_US:en', 07:14:11 INFO - 'LOGNAME': 'cltbld', 07:14:11 INFO - 'MAIL': '/var/mail/cltbld', 07:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:11 INFO - 'MOZ_NO_REMOTE': '1', 07:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:11 INFO - 'NO_EM_RESTART': '1', 07:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:11 INFO - 'PWD': '/builds/slave/test', 07:14:11 INFO - 'SHELL': '/bin/bash', 07:14:11 INFO - 'SHLVL': '1', 07:14:11 INFO - 'TERM': 'linux', 07:14:11 INFO - 'TMOUT': '86400', 07:14:11 INFO - 'USER': 'cltbld', 07:14:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:11 INFO - '_': '/tools/buildbot/bin/python'} 07:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14: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)) 07:14:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:14: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 07:14: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 07:14: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 07:14: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 07:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:14: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)) 07:14: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)) 07:14:13 INFO - Installing collected packages: simplejson 07:14:13 INFO - Running setup.py install for simplejson 07:14:13 INFO - building 'simplejson._speedups' extension 07:14: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 07:14: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 07:14:14 INFO - Successfully installed simplejson 07:14:14 INFO - Cleaning up... 07:14:14 INFO - Return code: 0 07:14:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14: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')]} 07:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14: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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', '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 07:14: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 07:14: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 07:14:14 INFO - Using env: {'DISPLAY': ':0', 07:14:14 INFO - 'HOME': '/home/cltbld', 07:14:14 INFO - 'LANG': 'en_US.UTF-8', 07:14:14 INFO - 'LANGUAGE': 'en_US:en', 07:14:14 INFO - 'LOGNAME': 'cltbld', 07:14:14 INFO - 'MAIL': '/var/mail/cltbld', 07:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:14 INFO - 'MOZ_NO_REMOTE': '1', 07:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:14 INFO - 'NO_EM_RESTART': '1', 07:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:14 INFO - 'PWD': '/builds/slave/test', 07:14:14 INFO - 'SHELL': '/bin/bash', 07:14:14 INFO - 'SHLVL': '1', 07:14:14 INFO - 'TERM': 'linux', 07:14:14 INFO - 'TMOUT': '86400', 07:14:14 INFO - 'USER': 'cltbld', 07:14:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:14 INFO - '_': '/tools/buildbot/bin/python'} 07:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:14:14 INFO - Cleaning up... 07:14:14 INFO - Return code: 0 07:14:14 INFO - Running post-action listener: _resource_record_post_action 07:14:14 INFO - Running post-action listener: _start_resource_monitoring 07:14:14 INFO - Starting resource monitoring. 07:14:14 INFO - [mozharness: 2017-09-20 14:14:14.615541Z] Finished create-virtualenv step (success) 07:14:14 INFO - [mozharness: 2017-09-20 14:14:14.616059Z] Running install step. 07:14:14 INFO - Running pre-action listener: _resource_record_pre_action 07:14:14 INFO - Running main action method: install 07:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:14 INFO - Reading from file tmpfile_stdout 07:14:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:14 INFO - Reading from file tmpfile_stdout 07:14:14 INFO - Output received: 07:14:14 INFO - Usage: mozinstall [options] installer 07:14:14 INFO - Options: 07:14:14 INFO - -h, --help show this help message and exit 07:14:14 INFO - -d DEST, --destination=DEST 07:14:14 INFO - Directory to install application into. [default: 07:14:14 INFO - "/builds/slave/test"] 07:14:14 INFO - --app=APP Application being installed. [default: firefox] 07:14:14 INFO - mkdir: /builds/slave/test/build/application 07:14:14 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'] 07:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:14:32 INFO - Reading from file tmpfile_stdout 07:14:32 INFO - Output received: 07:14:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - [mozharness: 2017-09-20 14:14:32.575054Z] Finished install step (success) 07:14:32 INFO - [mozharness: 2017-09-20 14:14:32.575305Z] Running setup-mitmproxy step. 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running main action method: setup_mitmproxy 07:14:32 INFO - Skipping: mitmproxy is not required 07:14:32 INFO - Running post-action listener: _resource_record_post_action 07:14:32 INFO - [mozharness: 2017-09-20 14:14:32.576450Z] Finished setup-mitmproxy step (success) 07:14:32 INFO - [mozharness: 2017-09-20 14:14:32.576672Z] Running run-tests step. 07:14:32 INFO - Running pre-action listener: _resource_record_pre_action 07:14:32 INFO - Running pre-action listener: _set_gcov_prefix 07:14:32 INFO - Running main action method: run_tests 07:14:32 WARNING - Try message not found. 07:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:14:32 INFO - Python 2.7.3 07:14:32 INFO - Return code: 0 07:14:32 INFO - grabbing minidump binary from tooltool 07:14:32 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')]} 07:14:32 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 0xeaa090>, '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 0xeaad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:14:32 INFO - Return code: 0 07:14:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:14:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:14:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:14:32 INFO - ENV: RUST_BACKTRACE is now full 07:14:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:14:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:14:32 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/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 07:14:32 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/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 07:14:32 INFO - Using env: {'DISPLAY': ':0', 07:14:32 INFO - 'HOME': '/home/cltbld', 07:14:32 INFO - 'LANG': 'en_US.UTF-8', 07:14:32 INFO - 'LANGUAGE': 'en_US:en', 07:14:32 INFO - 'LOGNAME': 'cltbld', 07:14:32 INFO - 'MAIL': '/var/mail/cltbld', 07:14:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:32 INFO - 'MOZ_NO_REMOTE': '1', 07:14:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:32 INFO - 'NO_EM_RESTART': '1', 07:14:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:32 INFO - 'PWD': '/builds/slave/test', 07:14:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:32 INFO - 'RUST_BACKTRACE': 'full', 07:14:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:32 INFO - 'SHELL': '/bin/bash', 07:14:32 INFO - 'SHLVL': '1', 07:14:32 INFO - 'TERM': 'linux', 07:14:32 INFO - 'TMOUT': '86400', 07:14:32 INFO - 'USER': 'cltbld', 07:14:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:32 INFO - '_': '/tools/buildbot/bin/python'} 07:14:32 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/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 07:14:32 INFO - mozversion application_buildid: 20170920125558 07:14:32 INFO - mozversion application_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 07:14:32 INFO - mozversion application_display_name: Nightly 07:14:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:14:32 INFO - mozversion application_name: Firefox 07:14:32 INFO - mozversion application_remotingname: firefox 07:14:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:14:32 INFO - mozversion application_vendor: Mozilla 07:14:32 INFO - mozversion application_version: 57.0a1 07:14:32 INFO - mozversion platform_buildid: 20170920125558 07:14:32 INFO - mozversion platform_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 07:14:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:14:32 INFO - mozversion platform_version: 57.0a1 07:14:32 INFO - using testdate: 1505916872 07:14:32 INFO - actual date: 1505916872 07:14:32 INFO - starting webserver on 'localhost:36435' 07:14:32 INFO - SUITE-START | Running 2 tests 07:14:32 INFO - TEST-START | dromaeo_css 07:14:32 INFO - Initialising browser for dromaeo_css test... 07:14:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36435/getInfo.html -profile /tmp/tmpw41Ybp/profile 07:14:32 INFO - TEST-INFO | started process 18597 (/builds/slave/test/build/application/firefox/firefox http://localhost:36435/getInfo.html) 07:14:38 INFO - TEST-INFO | 18597: exit 0 07:14:38 INFO - Browser initialized. 07:14:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:38 INFO - Using env: {'DISPLAY': ':0', 07:14:38 INFO - 'HOME': '/home/cltbld', 07:14:38 INFO - 'JSGC_DISABLE_POISONING': '1', 07:14:38 INFO - 'LANG': 'en_US.UTF-8', 07:14:38 INFO - 'LANGUAGE': 'en_US:en', 07:14:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:14:38 INFO - 'LOGNAME': 'cltbld', 07:14:38 INFO - 'MAIL': '/var/mail/cltbld', 07:14:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:14:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:14:38 INFO - 'MOZ_CRASHREPORTER': '1', 07:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:14:38 INFO - 'MOZ_NO_REMOTE': '1', 07:14:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:14:38 INFO - 'NO_EM_RESTART': '1', 07:14:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:38 INFO - 'PWD': '/builds/slave/test', 07:14:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:14:38 INFO - 'RUST_BACKTRACE': 'full', 07:14:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:14:38 INFO - 'SHELL': '/bin/bash', 07:14:38 INFO - 'SHLVL': '1', 07:14:38 INFO - 'TERM': 'linux', 07:14:38 INFO - 'TMOUT': '86400', 07:14:38 INFO - 'USER': 'cltbld', 07:14:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:38 INFO - '_': '/tools/buildbot/bin/python'} 07:14:38 INFO - TEST-INFO | started process 18834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw41Ybp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:39 INFO - PID 18834 | 07:14:39 INFO - PID 18834 | (/builds/slave/test/build/application/firefox/firefox:18884): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:14:39 INFO - PID 18834 | 07:14:49 INFO - PID 18834 | RSS: Main: 148475904 07:14:49 INFO - PID 18834 | 07:17:47 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36435/tests/dromaeo/cssquery-ext.html) 07:17:48 INFO - PID 18834 | RSS: Main: 148979712 07:17:48 INFO - PID 18834 | 07:20:50 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-ext.html (next: http://localhost:36435/tests/dromaeo/cssquery-jquery.html) 07:20:50 INFO - PID 18834 | RSS: Main: 146956288 07:20:50 INFO - PID 18834 | 07:23:52 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36435/tests/dromaeo/cssquery-mootools.html) 07:23:53 INFO - PID 18834 | RSS: Main: 151044096 07:23:53 INFO - PID 18834 | 07:26:54 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36435/tests/dromaeo/cssquery-prototype.html) 07:26:55 INFO - PID 18834 | RSS: Main: 150056960 07:26:55 INFO - PID 18834 | 07:29:58 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36435/tests/dromaeo/cssquery-yui.html) 07:29:58 INFO - PID 18834 | RSS: Main: 150863872 07:29:58 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | Cycle 1(1): loaded http://localhost:36435/tests/dromaeo/cssquery-yui.html (next: http://localhost:36435/tests/dromaeo/cssquery-dojo.html) 07:33:00 INFO - PID 18834 | RSS: Main: 153661440 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | __start_tp_report 07:33:00 INFO - PID 18834 | _x_x_mozilla_page_load 07:33:00 INFO - PID 18834 | _x_x_mozilla_page_load_details 07:33:00 INFO - PID 18834 | |i|pagename|runs| 07:33:00 INFO - PID 18834 | |0;dojo.html;3890.6692931100856;3911.863084792032;3914.0214946263436;3923.254581629492;3923.568407475177;6193.876122477548;6256.186695729549;6296.937030629692;6328.5886417382835;6348.301686814447;6261.906071408933;6302.4012718791755;6305.274893387262;6328.177336946202;6345;5602.8599285018;5604.607677462579;5642.548596112311;5645.858853528674;5674.432556744334;5591.049521581321;5695.259616249882;5700.686462244575;5709.600327977043;5724.685142317192;5639.6334238274385;5665.943340566583;5735.426457354252;5749.05140651794;5767.019606666856;5519.586031047687;5630.8029218977135;5700.572457065695;5767.452092051249;5779.3642699303255;5618.943810561883;5623.718814059322;5647.745851436695;5664.716764161775;5690.317161940552;6243.500519958392;6256.092866534327;6330.3669633036325;6341.239051313826;6399.968000160016;6712.53012289135;6772.55978361405;6803.183617965876;6845.657717114124;6901.861962760767;6787.864242715118;6847.965760171217;6876.793696189123;6894;6894.586324820527;6279.963805972055;6368.29948705642;6381.106645069647;6384.361563843625;6386.904196437057;6983.057287266256;6994.370506654425;7066.646667666699;7070.92929070713;7080.858382832417;6607.339266073451;6653.2681405045405;6684.231313398924;6730.461563074942;6733.259341472434;6830.146231721035;6840.794776156723;6936.7225310987;6959.791206263821;6962.965185174143;6772.288909664513;6790.117284752951;6869.622170780555;6882.4149947254045;6883.621400822903;6783.694733736994;6818.045473633695;6822.215445223863;6877.6217308047535;6902.8619427612175;4927.211646136601;4940;4944.703317800943;4963.726995015237;4965.875853103701;4439.977800110979;4462.330650402466;4488.663350248745;4506.864794056183;4517.503074661785;6257.530685198628;6284;6295.496360291166;6385.45723613498;6399;6827.6244806536115;6853.143357080365;6916;6922.480813938974;6932.549384290005;6210.347913469021;6287.622742635365;6328.335524769833;6339.619622822645;6371.808845734636;5525.889482210333;5543;5575.860603484945;5581.804636837691;5583.748731307101;7060.470464715167;7065.2228254891925;7077.858442831218;7165.104361954755;7181.96409017962;6757.831054223684;6771.3905748482875;6877.209120951155;6887.690053947485;6901.516893817385;7132.251113632994;7168.56988580666;7178.318059784312;7192.460565457507;7193.568385896654;6751.763688270887;6766.120404347404;6795.660216989229;6851.931480685129;6869.244383117753;6721.831954201184;6841.863162736817;6853.965730171517;6866.828329291808;6963.895541566779;6536.705848236746;6580.341965803382;6597.472202223715;6598.703058362481;6599.109120268894;6607.603543787388;6620.337966203341;6661.367170118831;6677.432418244503;6684.899726504009;6528.934710652833;6542.443892269211;6548.410643042149;6614.503912206507;6643.701033453603;6520.641364724986;6621.867562648624;6639.900401494078;6665.433438157811;6687.832804179934;6493.610383377012;6507.577007494498;6509.153810004669;6519.706613202512;6537.803865884031 07:33:00 INFO - PID 18834 | |1;ext.html;944.9433034017959;955.9378640388378;973.7468258252853;1008.697390782765;1010.7574182196275;42734.35898461522;43401;43412.78293608536;43427.13145737084;43490.34764478532;39907.60092399075;39908;40035.79982100085;40423.595764042424;40434.19131617366;7727.690892364313;7874.803129921769;7876;7881.96059019707;7896.881546776803;7756.18560051195;7817.6091195440285;7849.921500784976;7852.254035866584;7854.803629909269;7834.647440865147;7859.331956783681;7860.842783144334;8294.3779216559;8504.532250726208;8351.498910065386;8407.201315874981;8416.537090460022;8416.747497575114;8418.494890306602;8295.543745094017;8377.37169712274;8388.538630375328;8390.160983901562;8392.622331995075;39642.20715585672;40051;40149.799251003555;40208;40348.39477407841;3783.3190025795348;3820.3123437781187;3824.521934758155;3828.7894165820867;3828.885133446001;32919.34161316784;32968.505472417935;32969.505457418156;32976.835115824506;33002.504962425584;5361.865953351158;5363.6245462817615;5390.9191362129595;5400.432954539756;5421.891562168774;195096;195696;195790;195872;195997;50463.24305135426;50623;50636.74681626568;50759.49240507548;50902.23646645303;53268;53317.733411332694;53503.46496534985;53520.73239633777;53522.19716704253;13332.73334533304;13497.325133743274;13559.86440135586;13645.044846860625;13668.93165534166;10666;10754.300970436896;10762.892371076188;10765.30025548337;10788;15157.242137893281;15340.079595224322;15442.536723898302;15455.227238638248;15530.767038494432;6072.271327440647;6139.754409823647;6157.012819616125;6210.099535567318;6228.408301211378;1107.7839821234943;1123.5618108937358;1125.8198688209848;1135.8807325230732;1136.579465597734;25735;25795.742042579335;25859;25862.482750345265;26121.085761998238;1185.9940700296443;1198.1074099795708;1198.9160758746978;1202.5370232460566;1222.1383924333502;13236.867631323756;13493;13652.180869147884;13876.167429954236;13884.4446222152;276292;276985;277036;278685;279676;55476.16785748217;55603.165952510746;58610;59100.70449647724;61619;1466.552701426054;1496.0799108548165;1496.1172907984123;1498.4455751371845;1519.225195150481;30119.247018824706;30221;30379.544306835858;30490;30760.846195768878;41660.37509437421;42176.57823421727;42201.78899105485;42233;42256.788716057454;238666;239820;240064;241239;241377;35550.11124721799;35664.465033024004;35702;35723.10692232715;36052.639473604926;43448.56551434572;45018.77490612526;45357.319640206086;45423.54576454193;45442;33249.168770780925;33636.32727345488;33770.49344259887;34072.14819629529;34112.14719632029;32886.342273153925;33093;33193.502097468074;33418.164545886546;33731.49402758911;36713;37881.43177852279;38120.428193577674;38131.04672383213;38436;32287.677123228466;32414.35171296608;32561.674383255864;32620.510692340107;33350.666493335724;24257.39356516101;24489.3877653053;24692.876535617925;25128.24615261545;25428.74571254338 07:33:00 INFO - PID 18834 | |2;jquery.html;601.1943995046637;602.8342205893379;613.8189234175924;620.491197218281;630.3822254190893;23306.88346558267;23962.880185599046;24119.39701507463;24123.15568955087;24157.879210603944;24672.75327246727;26250;26320.868395658043;26364.604530932003;26391.736082639214;6580.572262802926;6775.254721980578;6781.660916954157;6784.72861085556;6818.249992500821;6530.542861999662;6723.09238252837;6794.3545363190415;6809.387155156035;6819.522633415663;6768;6768.52620316578;6771.085903403052;6775.932240677579;6777.932220677804;6556.770513032068;6700.631465269408;6712.060311556386;6743.797686069402;6781.694823732944;6307.936920630781;6336.46140078094;6344.04839274108;6352.650604216767;6353.809385718389;30404.54393184104;30860.53709194364;30946.226344341347;31086.689133108604;31124;2221.533477969628;2269.205777977711;2272.488690044727;2276.8747718875456;2277.1005452846034;20703.171873125208;21381.786182138134;21489.46276343088;21608.675869861963;21630.24294149713;2565.4484285878625;2570.139003433852;2607.1266125847865;2616.908408205704;2619.580867061261;128788;133679.33160334235;148087;155145.22427387792;155571.22214388856;15680;16003.839961600468;16026.759598605797;16184.352625894833;16428.917855410884;25865.870670646527;25918.74081259201;25934;25940;25961.480770384485;8868.290536757173;8950.283977281802;8953.552322383855;9029.41308814925;9087.22758565516;7623.656935437808;7641.732539361095;7711.53730776144;7743.45795794289;7796.4542482026845;9940.900590994142;9948.502574871227;10067.244956628283;10070.144037756727;10152.492375381202;2860.2134413036583;2879.6544414670375;2888.4511942730815;2897.9275518111795;2925.1078421081347;1049.3861091261697;1051.7948999944938;1063.500154927183;1066.2376400873413;1081.5835903177333;21483.892580536998;21665.56668866614;21949;21972;22111.115555377928;1098.3464838421128;1099.5546803544578;1109.5007246738999;1111.572044762756;1112.1547623805805;12021.699457513632;12110.878891211152;12129.818052729217;12150.939245303716;12156.635300940987;552153;563118;567047;576646;576684;123814;125226;125673.37163314308;126795;129224;1105.1545567640762;1151.4933429291086;1170.2627344772739;1218.4212499062874;1236.0605939485877;22109.889450552644;22198.334049978526;22510.212142574932;22772.886135569217;22814.543709126057;62010.37989620046;62521;62791;63491.36508635039;64169;78374.608126959;78656.60671696605;79292;79552.2044779568;79723.2027679739;15592.37630494813;15875;15955.361785528448;16050.598735031717;16091.436799711953;24705.752942471063;24709.629355560042;24797.62803557984;25017;25063;18902.810971890103;19748.210071596975;20156.29452969139;20396.388108356772;20438.591228175057;17027.318907244065;17491.47525574235;17871.463856084338;18015.549611259823;18250.817491824913;19502;19559.804401955796;19565.217391304188;19662.115204816102;19769.40691779249;15592.688146237238;15701.685966280838;15725.370985160465;15788.842111579197;15850.52448426549;20505.692414613495;20586.588268234253;20696.379108626767;20697.58604827865;20731.58536829225 07:33:00 INFO - PID 18834 | |3;mootools.html;1418.0640777087121;1447.435500154939;1474.5576327101867;1481.1187343530596;1497.8726808221302;16050.83949160508;16774.245158967846;16810.24353904074;16845.41041063563;16878.91560542197;16628.58428539284;16765.245563949622;16798.748018779697;16801.159942002912;16846;2665.840049597021;2679.102500662276;2721.7822574194115;2731.01683393978;2731.6312297839736;2797.958030629542;2836.702146274632;2844.104107206234;2846.5872448494956;2846.629938108043;2759.4205216904475;2763.115802943059;2773.8058335916494;2965.303153758865;2966.33257517058;2940.3825196708717;2950.8819647214086;2967.3471836196004;2973.4647763402577;2975.1966968918377;2712.864356782153;2714.0636480414228;2716.0765339784566;2773.778097752175;2904.2158617173245;16432.096234707085;16479.670406591802;16531.173441327886;16562.83437165637;16577.83422165775;8476.83046339076;8737.694180703646;8757.649694012232;8769.736907892773;8778.956105219497;5919.467247947662;5997.7001149942325;6065.696715164224;6105.99251123564;6158.3841615838055;2064.834813214954;2072.3782865140397;2078.3972647932083;2093.811556959881;2122.7028216049766;29586.408271834443;29762.851185744148;29901.70098299011;29945.401091978256;29945.401091978256;7002.614856182857;7058.470614703918;7157.7136914522835;7255.600941948138;7304.306090921354;18839.90580047091;18883.90558047201;18906.716399254023;18976.81023189778;18986.240550377832;8107.351411887035;8288.378371622153;8317.459365141367;8322.29260512851;8328.70849520276;7547.773566793005;7654.502457340255;7724.613769311624;7740.574268415178;7746.49647772893;5578.944210557924;5661.915071273934;5699.601027928005;5741.712914354349;5980.820575382745;1660.8256133106092;1686.9662606747797;1687.7130887749113;1706.496583507868;1707.069647042365;939.1453777062976;952.8380175370204;963.3545524498603;965.6571916969515;967.2938754709102;8051.879221811678;8068.596570171468;8072.394570407243;8095.595220239083;8108.1891810819625;761.2653789093551;783.1581050370875;794.6662401791261;796.3430170109683;799.5043073294595;4776.928346074812;4988.201887697951;5407.756650950638;5452.890942181134;5515.310586176728;23442.06231750745;23641.527169456516;24497;24977.125800596892;24997.250082497554;23309.18417855367;23485.17801876926;23656.645150322758;23663;23691.052357905835;11514.30914145154;11665.650030499099;12110.455029523693;12112.21270617407;12225.510979560719;8803.735887923373;9067.637294508146;9128.132827381389;9210.125038121369;9260.953695231481;20793.376198714064;20954;21026.158953641683;21154.894225528773;21726.89136554307;21704.565908681423;21822.672659910433;21940.561188775817;21944.231951881608;22354.217602384488;12074.637760867188;12211.633650990485;12241.69395765113;12364;12374.75250494967;15212.315445804745;15315.15766632846;15363.38546458174;15371.923140384673;15390.230488475307;11633.709157271136;11716.179867409199;11753.941230293794;12019.699507512381;12064.095192860395;11839.644810655695;11860.881391186324;11941.16411851162;12024.33866137371;12209.267443953391;9255.07449255096;9269.72190834276;9389.43663380172;9405.20055795265;9436.858447123435;7481.438892083007;7591.924080759342;7665.3101220890385;7667.808304792425;7689.807754806175;7656;7754.88367674474;7761;7823.8435231293915;7952.522848629101 07:33:00 INFO - PID 18834 | |4;prototype.html;556.974936127874;567.3532173322412;575.8128608202335;581.1457157977771;583.4369833111049;5941.554383421245;5988.281406231247;6098.634081955081;6268.874622507547;6291.622502649844;6184.814455566329;6230.84422889428;6261.906071408921;6266.248050233967;6303.117563541108;5245.186996015605;5247.737613119348;5256.6057545684225;5264.8157314494;5265.605079619025;4867.075255701406;5048.091343558158;5197.350331208599;5210.947890521104;5245.842624721246;4993.400791904976;5024.346834911456;5024.723640199788;5031.924521132186;5040;4971.154903666367;4977.228529577921;4979.601631869442;5006.424261209971;5018.121828679985;4522.276435770261;4530.864074077783;4536.523665015159;4541.296099104644;4575.839845605387;6227.785581811503;6249.312575616678;6251.12484252205;6272.498200144023;6283.7172327244925;5833.766649334021;5861.296644402656;5869.413058694139;5924.022536281508;5938.198343223653;6532.542722009462;6554.442872355856;6561.212654481445;6567.343265673395;6652.201735791736;4689.7655117244;5020.648554601179;5039.370078740158;5042.470540593222;5043.949560504421;6767.864642707167;6821.2155602105895;6839.213490448612;6918.377346038881;6942.19502929237;5079.31429257053;5146.176611742103;5151.690898546024;5192.714400707921;5224.895502090013;5168.431472538018;5247.396549396792;5265.262863199156;5278.788848446019;5287.180487024518;5755.532339253464;5796.94203057964;5810.215620891126;5814.563907706939;5866.794662186803;6545.2800191979795;6556.311587283267;6659;6667.833304167435;6669;1757.4815429448342;1780.6705759434547;1801.261482792049;1830.6704793137362;1834.0921243984312;1226.5400474821943;1264.1530174782918;1265.8797414245632;1273.1533530202496;1277.1698396042461;6093.222202234554;6099.268087829489;6165.1985241919165;6168.352323006109;6200.596961197508;6517.185351831021;6596.406323430914;6719.496037797185;6730.528862979544;6744.595324280559;5903.468687818117;6045;6123.418275263843;6145.594558556928;6225.252969643581;3503.0366649171683;3511.227529943408;3548.982255088708;3575.1598374382;3581.3732596795458;6822.761203357859;6886.208086070066;6928.960655901655;6933.861322773516;6934.341237582422;6829.658517074126;6883.8967415488805;6886;6888.965555172192;6986.965065174743;6852.554583952027;6874.793756187322;6970.128733908262;6980.616066116412;6991.615461149686;6570.375814297634;6644.970029645413;6732.8653426930205;6741.089952856498;6747.705780034812;6571.408573228432;6578.638174900235;6582.860570314762;6654.534182607171;6659.334066593302;6922.861542769016;6957.443404527525;7016.473764467583;7017.473689473412;7018.789436316919;5208.687478751287;5214.400343960341;5214.921776173284;5221.295125158055;5242.737863106906;6556.213254409501;6663.433608143362;6730.528862979544;6740.427063699444;6837.487188460786;6411.166548348685;6493.253275873146;6500.447461965786;6579.046038324512;6616.8345791355605;6369.267534233622;6407.295197528175;6434.774782882764;6447.967760161169;6464.22429308486;6363.745450182126;6414.294427612866;6421.165248517849;6489.772857950138;6495.967520162369;6439.484841212786;6551.279359270572;6551.344865513601;6570.630530697033;6645.468362531083;6284.120223168668;6321.936780632319;6333.1317261407075;6375.904361434675;6453.322401147811 07:33:00 INFO - PID 18834 | |5;yui.html;929.8651695504147;976.1409959235875;977.8288799460092;996.995015024925;1006.260398607024;20132.496687582818;20608.79391206091;20729.792702072995;20833.479163020933;20860.269890553835;17858.464246072606;17884;17970.4608861734;18841.717374239397;18923;1041.5677493840046;1062.102523367757;1064.1539975719322;1065.7388939709742;1066.0245875024382;1049.1973640165243;1091.4379094766202;1092.3282181458426;1092.5247517329947;1101.3777215873047;1148.6726283009343;1150.7928572856883;1151.4127794824617;1153.6250718516474;1162.511745067074;1139.595443617512;1141.4349896801054;1147.2829481574017;1148.3741360958297;1157.438642258504;849.7918010087507;851.8679604661287;852.6802449081595;853.0616322045762;854.0520022774715;19847.007649617462;20074.899625501777;20271.89864050685;20295.188192472284;21043.894780526152;22563.435914102116;22665.886670566542;22887.198948036737;22941.885290573606;22959.77040229593;17656.382026629006;17740.822591774046;17769.822301776945;17772.022538760364;17790.733139002925;3579.8568057277676;3737.9813100934593;3786.6970642348547;3790.0524868782804;3799.6580307772156;141341.1731765359;155038.22480887637;159875;161027.99999999884;162478;18206.726899096524;18277.817221827612;18375.90812045958;18751.624967500848;18769.1553880073;33482.3303533928;33940.49089263663;34116.97649070532;34176.658233417846;34252.486212706826;9225.40034897743;9305.674301399418;9333.113354231336;9353.859692104625;9366.812663746687;4459.509453960061;4505.909881802346;4512.774361281923;4520.9095818084115;4555.908881822345;6142.324344322121;6250.281217660027;6260.373962603794;6268.592541484789;6270.028145637433;1169.128998895811;1175.2419689300352;1175.9412029398495;1182.6156499137815;1183.1126655008743;665.311402698205;674.5480528046221;690.3648643248123;697.4629535257823;698.6925752668911;11784.94107529474;12273.69315767113;12279.69300767488;13408.463661453628;13426.328683565978;652.4095693397483;654.7511945460694;657.4181849063613;669.5246375073655;673.0274752981894;5077.907069419011;5118.513741194581;5118.59051275897;5137.660272338704;5178.637495375363;149893.25053374883;154469;155148;155787;157298;131496;131688;132196;134986.32506837402;136293;105920;105931;106192.93807061986;108862;110215;9250.167484926389;9486.762830929281;9576.76058098553;9681.564329605326;9718.465484398426;53873.73063134816;54263.72868135634;54945.72527137339;55594.72202638961;56416.43583564276;69464;70330.64834675794;71053.644731776;74090.62954685192;74524;15744.685106298039;16143.919280403523;16191.514254572381;16200.918995404947;16238.26927788276;18728.625427491646;18907.338243161423;18920.52698682544;18999;19107.90446047761;16255.837441625905;16276.10481423533;16286.185690715654;16414.09722465276;16423.67152656964;17337.826621734126;17347.132643368033;17361.652766944844;17470;17571.385001524886;16778.832211677727;16991.40530081441;17016.57458563546;17246.91376543109;17248.137593120544;11509.884901150881;11591.6522504325;11777.587784427848;11875.168738188244;11890.405479725807;10979.1216702662;11005.559777608805;11016.779664406507;11115.72210694739;11250 07:33:00 INFO - PID 18834 | __end_tp_report 07:33:00 INFO - PID 18834 | __start_cc_report 07:33:00 INFO - PID 18834 | _x_x_mozilla_cycle_collect,280 07:33:00 INFO - PID 18834 | __end_cc_report 07:33:00 INFO - PID 18834 | __startTimestamp1505917980526__endTimestamp 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | ------- Summary: start ------- 07:33:00 INFO - PID 18834 | Number of tests: 6 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#0] dojo.html Cycles:165 Average:6295.67 Median:6537.80 stddev:754.86 (11.5%) stddev-sans-first:733.22 07:33:00 INFO - PID 18834 | Values: 3890.7 3911.9 3914.0 3923.3 3923.6 6193.9 6256.2 6296.9 6328.6 6348.3 6261.9 6302.4 6305.3 6328.2 6345.0 5602.9 5604.6 5642.5 5645.9 5674.4 5591.0 5695.3 5700.7 5709.6 5724.7 5639.6 5665.9 5735.4 5749.1 5767.0 5519.6 5630.8 5700.6 5767.5 5779.4 5618.9 5623.7 5647.7 5664.7 5690.3 6243.5 6256.1 6330.4 6341.2 6400.0 6712.5 6772.6 6803.2 6845.7 6901.9 6787.9 6848.0 6876.8 6894.0 6894.6 6280.0 6368.3 6381.1 6384.4 6386.9 6983.1 6994.4 7066.6 7070.9 7080.9 6607.3 6653.3 6684.2 6730.5 6733.3 6830.1 6840.8 6936.7 6959.8 6963.0 6772.3 6790.1 6869.6 6882.4 6883.6 6783.7 6818.0 6822.2 6877.6 6902.9 4927.2 4940.0 4944.7 4963.7 4965.9 4440.0 4462.3 4488.7 4506.9 4517.5 6257.5 6284.0 6295.5 6385.5 6399.0 6827.6 6853.1 6916.0 6922.5 6932.5 6210.3 6287.6 6328.3 6339.6 6371.8 5525.9 5543.0 5575.9 5581.8 5583.7 7060.5 7065.2 7077.9 7165.1 7182.0 6757.8 6771.4 6877.2 6887.7 6901.5 7132.3 7168.6 7178.3 7192.5 7193.6 6751.8 6766.1 6795.7 6851.9 6869.2 6721.8 6841.9 6854.0 6866.8 6963.9 6536.7 6580.3 6597.5 6598.7 6599.1 6607.6 6620.3 6661.4 6677.4 6684.9 6528.9 6542.4 6548.4 6614.5 6643.7 6520.6 6621.9 6639.9 6665.4 6687.8 6493.6 6507.6 6509.2 6519.7 6537.8 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#1] ext.html Cycles:180 Average:41325.02 Median:35887.87 stddev:62492.45 (174.1%) stddev-sans-first:62594.20 07:33:00 INFO - PID 18834 | Values: 944.9 955.9 973.7 1008.7 1010.8 42734.4 43401.0 43412.8 43427.1 43490.3 39907.6 39908.0 40035.8 40423.6 40434.2 7727.7 7874.8 7876.0 7882.0 7896.9 7756.2 7817.6 7849.9 7852.3 7854.8 7834.6 7859.3 7860.8 8294.4 8504.5 8351.5 8407.2 8416.5 8416.7 8418.5 8295.5 8377.4 8388.5 8390.2 8392.6 39642.2 40051.0 40149.8 40208.0 40348.4 3783.3 3820.3 3824.5 3828.8 3828.9 32919.3 32968.5 32969.5 32976.8 33002.5 5361.9 5363.6 5390.9 5400.4 5421.9 195096.0 195696.0 195790.0 195872.0 195997.0 50463.2 50623.0 50636.7 50759.5 50902.2 53268.0 53317.7 53503.5 53520.7 53522.2 13332.7 13497.3 13559.9 13645.0 13668.9 10666.0 10754.3 10762.9 10765.3 10788.0 15157.2 15340.1 15442.5 15455.2 15530.8 6072.3 6139.8 6157.0 6210.1 6228.4 1107.8 1123.6 1125.8 1135.9 1136.6 25735.0 25795.7 25859.0 25862.5 26121.1 1186.0 1198.1 1198.9 1202.5 1222.1 13236.9 13493.0 13652.2 13876.2 13884.4 276292.0 276985.0 277036.0 278685.0 279676.0 55476.2 55603.2 58610.0 59100.7 61619.0 1466.6 1496.1 1496.1 1498.4 1519.2 30119.2 30221.0 30379.5 30490.0 30760.8 41660.4 42176.6 42201.8 42233.0 42256.8 238666.0 239820.0 240064.0 241239.0 241377.0 35550.1 35664.5 35702.0 35723.1 36052.6 43448.6 45018.8 45357.3 45423.5 45442.0 33249.2 33636.3 33770.5 34072.1 34112.1 32886.3 33093.0 33193.5 33418.2 33731.5 36713.0 37881.4 38120.4 38131.0 38436.0 32287.7 32414.4 32561.7 32620.5 33350.7 24257.4 24489.4 24692.9 25128.2 25428.7 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#2] jquery.html Cycles:180 Average:38510.70 Median:24121.28 stddev:95023.46 (393.9%) stddev-sans-first:95247.39 07:33:00 INFO - PID 18834 | Values: 601.2 602.8 613.8 620.5 630.4 23306.9 23962.9 24119.4 24123.2 24157.9 24672.8 26250.0 26320.9 26364.6 26391.7 6580.6 6775.3 6781.7 6784.7 6818.2 6530.5 6723.1 6794.4 6809.4 6819.5 6768.0 6768.5 6771.1 6775.9 6777.9 6556.8 6700.6 6712.1 6743.8 6781.7 6307.9 6336.5 6344.0 6352.7 6353.8 30404.5 30860.5 30946.2 31086.7 31124.0 2221.5 2269.2 2272.5 2276.9 2277.1 20703.2 21381.8 21489.5 21608.7 21630.2 2565.4 2570.1 2607.1 2616.9 2619.6 128788.0 133679.3 148087.0 155145.2 155571.2 15680.0 16003.8 16026.8 16184.4 16428.9 25865.9 25918.7 25934.0 25940.0 25961.5 8868.3 8950.3 8953.6 9029.4 9087.2 7623.7 7641.7 7711.5 7743.5 7796.5 9940.9 9948.5 10067.2 10070.1 10152.5 2860.2 2879.7 2888.5 2897.9 2925.1 1049.4 1051.8 1063.5 1066.2 1081.6 21483.9 21665.6 21949.0 21972.0 22111.1 1098.3 1099.6 1109.5 1111.6 1112.2 12021.7 12110.9 12129.8 12150.9 12156.6 552153.0 563118.0 567047.0 576646.0 576684.0 123814.0 125226.0 125673.4 126795.0 129224.0 1105.2 1151.5 1170.3 1218.4 1236.1 22109.9 22198.3 22510.2 22772.9 22814.5 62010.4 62521.0 62791.0 63491.4 64169.0 78374.6 78656.6 79292.0 79552.2 79723.2 15592.4 15875.0 15955.4 16050.6 16091.4 24705.8 24709.6 24797.6 25017.0 25063.0 18902.8 19748.2 20156.3 20396.4 20438.6 17027.3 17491.5 17871.5 18015.5 18250.8 19502.0 19559.8 19565.2 19662.1 19769.4 15592.7 15701.7 15725.4 15788.8 15850.5 20505.7 20586.6 20696.4 20697.6 20731.6 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#3] mootools.html Cycles:180 Average:10134.38 Median:2773.79 stddev:7520.77 (271.1%) stddev-sans-first:7513.35 07:33:00 INFO - PID 18834 | Values: 1418.1 1447.4 1474.6 1481.1 1497.9 16050.8 16774.2 16810.2 16845.4 16878.9 16628.6 16765.2 16798.7 16801.2 16846.0 2665.8 2679.1 2721.8 2731.0 2731.6 2798.0 2836.7 2844.1 2846.6 2846.6 2759.4 2763.1 2773.8 2965.3 2966.3 2940.4 2950.9 2967.3 2973.5 2975.2 2712.9 2714.1 2716.1 2773.8 2904.2 16432.1 16479.7 16531.2 16562.8 16577.8 8476.8 8737.7 8757.6 8769.7 8779.0 5919.5 5997.7 6065.7 6106.0 6158.4 2064.8 2072.4 2078.4 2093.8 2122.7 29586.4 29762.9 29901.7 29945.4 29945.4 7002.6 7058.5 7157.7 7255.6 7304.3 18839.9 18883.9 18906.7 18976.8 18986.2 8107.4 8288.4 8317.5 8322.3 8328.7 7547.8 7654.5 7724.6 7740.6 7746.5 5578.9 5661.9 5699.6 5741.7 5980.8 1660.8 1687.0 1687.7 1706.5 1707.1 939.1 952.8 963.4 965.7 967.3 8051.9 8068.6 8072.4 8095.6 8108.2 761.3 783.2 794.7 796.3 799.5 4776.9 4988.2 5407.8 5452.9 5515.3 23442.1 23641.5 24497.0 24977.1 24997.3 23309.2 23485.2 23656.6 23663.0 23691.1 11514.3 11665.7 12110.5 12112.2 12225.5 8803.7 9067.6 9128.1 9210.1 9261.0 20793.4 20954.0 21026.2 21154.9 21726.9 21704.6 21822.7 21940.6 21944.2 22354.2 12074.6 12211.6 12241.7 12364.0 12374.8 15212.3 15315.2 15363.4 15371.9 15390.2 11633.7 11716.2 11753.9 12019.7 12064.1 11839.6 11860.9 11941.2 12024.3 12209.3 9255.1 9269.7 9389.4 9405.2 9436.9 7481.4 7591.9 7665.3 7667.8 7689.8 7656.0 7754.9 7761.0 7823.8 7952.5 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#4] prototype.html Cycles:180 Average:5610.30 Median:6240.08 stddev:1555.43 (24.9%) stddev-sans-first:1512.84 07:33:00 INFO - PID 18834 | Values: 557.0 567.4 575.8 581.1 583.4 5941.6 5988.3 6098.6 6268.9 6291.6 6184.8 6230.8 6261.9 6266.2 6303.1 5245.2 5247.7 5256.6 5264.8 5265.6 4867.1 5048.1 5197.4 5210.9 5245.8 4993.4 5024.3 5024.7 5031.9 5040.0 4971.2 4977.2 4979.6 5006.4 5018.1 4522.3 4530.9 4536.5 4541.3 4575.8 6227.8 6249.3 6251.1 6272.5 6283.7 5833.8 5861.3 5869.4 5924.0 5938.2 6532.5 6554.4 6561.2 6567.3 6652.2 4689.8 5020.6 5039.4 5042.5 5043.9 6767.9 6821.2 6839.2 6918.4 6942.2 5079.3 5146.2 5151.7 5192.7 5224.9 5168.4 5247.4 5265.3 5278.8 5287.2 5755.5 5796.9 5810.2 5814.6 5866.8 6545.3 6556.3 6659.0 6667.8 6669.0 1757.5 1780.7 1801.3 1830.7 1834.1 1226.5 1264.2 1265.9 1273.2 1277.2 6093.2 6099.3 6165.2 6168.4 6200.6 6517.2 6596.4 6719.5 6730.5 6744.6 5903.5 6045.0 6123.4 6145.6 6225.3 3503.0 3511.2 3549.0 3575.2 3581.4 6822.8 6886.2 6929.0 6933.9 6934.3 6829.7 6883.9 6886.0 6889.0 6987.0 6852.6 6874.8 6970.1 6980.6 6991.6 6570.4 6645.0 6732.9 6741.1 6747.7 6571.4 6578.6 6582.9 6654.5 6659.3 6922.9 6957.4 7016.5 7017.5 7018.8 5208.7 5214.4 5214.9 5221.3 5242.7 6556.2 6663.4 6730.5 6740.4 6837.5 6411.2 6493.3 6500.4 6579.0 6616.8 6369.3 6407.3 6434.8 6448.0 6464.2 6363.7 6414.3 6421.2 6489.8 6496.0 6439.5 6551.3 6551.3 6570.6 6645.5 6284.1 6321.9 6333.1 6375.9 6453.3 07:33:00 INFO - PID 18834 | 07:33:00 INFO - PID 18834 | [#5] yui.html Cycles:180 Average:27748.48 Median:18326.86 stddev:42201.81 (230.3%) stddev-sans-first:42272.16 07:33:00 INFO - PID 18834 | Values: 929.9 976.1 977.8 997.0 1006.3 20132.5 20608.8 20729.8 20833.5 20860.3 17858.5 17884.0 17970.5 18841.7 18923.0 1041.6 1062.1 1064.2 1065.7 1066.0 1049.2 1091.4 1092.3 1092.5 1101.4 1148.7 1150.8 1151.4 1153.6 1162.5 1139.6 1141.4 1147.3 1148.4 1157.4 849.8 851.9 852.7 853.1 854.1 19847.0 20074.9 20271.9 20295.2 21043.9 22563.4 22665.9 22887.2 22941.9 22959.8 17656.4 17740.8 17769.8 17772.0 17790.7 3579.9 3738.0 3786.7 3790.1 3799.7 141341.2 155038.2 159875.0 161028.0 162478.0 18206.7 18277.8 18375.9 18751.6 18769.2 33482.3 33940.5 34117.0 34176.7 34252.5 9225.4 9305.7 9333.1 9353.9 9366.8 4459.5 4505.9 4512.8 4520.9 4555.9 6142.3 6250.3 6260.4 6268.6 6270.0 1169.1 1175.2 1175.9 1182.6 1183.1 665.3 674.5 690.4 697.5 698.7 11784.9 12273.7 12279.7 13408.5 13426.3 652.4 654.8 657.4 669.5 673.0 5077.9 5118.5 5118.6 5137.7 5178.6 149893.3 154469.0 155148.0 155787.0 157298.0 131496.0 131688.0 132196.0 134986.3 136293.0 105920.0 105931.0 106192.9 108862.0 110215.0 9250.2 9486.8 9576.8 9681.6 9718.5 53873.7 54263.7 54945.7 55594.7 56416.4 69464.0 70330.6 71053.6 74090.6 74524.0 15744.7 16143.9 16191.5 16200.9 16238.3 18728.6 18907.3 18920.5 18999.0 19107.9 16255.8 16276.1 16286.2 16414.1 16423.7 17337.8 17347.1 17361.7 17470.0 17571.4 16778.8 16991.4 17016.6 17246.9 17248.1 11509.9 11591.7 11777.6 11875.2 11890.4 10979.1 11005.6 11016.8 11115.7 11250.0 07:33:00 INFO - PID 18834 | -------- Summary: end -------- 07:33:00 INFO - PID 18834 | 07:33:01 INFO - TEST-INFO | 18834: exit 0 07:33:01 INFO - TEST-OK | dromaeo_css | took 1108228ms 07:33:01 INFO - TEST-START | kraken 07:33:01 INFO - Initialising browser for kraken test... 07:33:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36435/getInfo.html -profile /tmp/tmpNxD0fs/profile 07:33:01 INFO - TEST-INFO | started process 19223 (/builds/slave/test/build/application/firefox/firefox http://localhost:36435/getInfo.html) 07:33:06 INFO - TEST-INFO | 19223: exit 0 07:33:06 INFO - Browser initialized. 07:33:06 INFO - Running cycle 1/1 for kraken test... 07:33:06 INFO - Using env: {'DISPLAY': ':0', 07:33:06 INFO - 'HOME': '/home/cltbld', 07:33:06 INFO - 'JSGC_DISABLE_POISONING': '1', 07:33:06 INFO - 'LANG': 'en_US.UTF-8', 07:33:06 INFO - 'LANGUAGE': 'en_US:en', 07:33:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:33:06 INFO - 'LOGNAME': 'cltbld', 07:33:06 INFO - 'MAIL': '/var/mail/cltbld', 07:33:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:06 INFO - 'MOZ_CRASHREPORTER': '1', 07:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:33:06 INFO - 'MOZ_NO_REMOTE': '1', 07:33:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:06 INFO - 'NO_EM_RESTART': '1', 07:33:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:06 INFO - 'PWD': '/builds/slave/test', 07:33:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:06 INFO - 'RUST_BACKTRACE': 'full', 07:33:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:33:06 INFO - 'SHELL': '/bin/bash', 07:33:06 INFO - 'SHLVL': '1', 07:33:06 INFO - 'TERM': 'linux', 07:33:06 INFO - 'TMOUT': '86400', 07:33:06 INFO - 'USER': 'cltbld', 07:33:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715', 07:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:06 INFO - '_': '/tools/buildbot/bin/python'} 07:33:06 INFO - TEST-INFO | started process 19453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNxD0fs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:06 INFO - PID 19453 | 07:33:06 INFO - PID 19453 | (/builds/slave/test/build/application/firefox/firefox:19502): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:33:06 INFO - PID 19453 | 07:33:17 INFO - PID 19453 | RSS: Main: 149291008 07:33:17 INFO - PID 19453 | 07:33:19 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36435/tests/kraken/driver.html?testName=audio-beat-detection) 07:33:20 INFO - PID 19453 | RSS: Main: 155856896 07:33:20 INFO - PID 19453 | 07:33:23 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36435/tests/kraken/driver.html?testName=audio-dft) 07:33:23 INFO - PID 19453 | RSS: Main: 155873280 07:33:23 INFO - PID 19453 | 07:33:26 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36435/tests/kraken/driver.html?testName=audio-fft) 07:33:27 INFO - PID 19453 | RSS: Main: 151240704 07:33:27 INFO - PID 19453 | 07:33:29 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36435/tests/kraken/driver.html?testName=audio-oscillator) 07:33:30 INFO - PID 19453 | RSS: Main: 152428544 07:33:30 INFO - PID 19453 | 07:33:32 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:32 INFO - PID 19453 | RSS: Main: 152641536 07:33:32 INFO - PID 19453 | 07:33:35 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36435/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:36 INFO - PID 19453 | RSS: Main: 152535040 07:33:36 INFO - PID 19453 | 07:33:39 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36435/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:40 INFO - PID 19453 | RSS: Main: 153481216 07:33:40 INFO - PID 19453 | 07:33:43 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36435/tests/kraken/driver.html?testName=json-parse-financial) 07:33:44 INFO - PID 19453 | RSS: Main: 155426816 07:33:44 INFO - PID 19453 | 07:33:45 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:46 INFO - PID 19453 | RSS: Main: 154845184 07:33:46 INFO - PID 19453 | 07:33:47 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:48 INFO - PID 19453 | RSS: Main: 155312128 07:33:48 INFO - PID 19453 | 07:33:50 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:50 INFO - PID 19453 | RSS: Main: 151437312 07:33:50 INFO - PID 19453 | 07:33:53 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:53 INFO - PID 19453 | RSS: Main: 152162304 07:33:53 INFO - PID 19453 | 07:33:56 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:57 INFO - PID 19453 | RSS: Main: 152678400 07:33:57 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | Cycle 1(1): loaded http://localhost:36435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36435/tests/kraken/driver.html?testName=ai-astar) 07:33:59 INFO - PID 19453 | RSS: Main: 154001408 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | __start_tp_report 07:33:59 INFO - PID 19453 | _x_x_mozilla_page_load 07:33:59 INFO - PID 19453 | _x_x_mozilla_page_load_details 07:33:59 INFO - PID 19453 | |i|pagename|runs| 07:33:59 INFO - PID 19453 | |0;ai-astar;107;105;105;105;105;109;106;105;105;105 07:33:59 INFO - PID 19453 | |1;audio-beat-detection;112;114;113;112;116;112;112;138;114;112 07:33:59 INFO - PID 19453 | |2;audio-dft;160;161;160;161;160;163;162;163;162;167 07:33:59 INFO - PID 19453 | |3;audio-fft;73;74;76;73;83;111;74;73;72;73 07:33:59 INFO - PID 19453 | |4;audio-oscillator;77;78;84;77;77;78;78;78;75;77 07:33:59 INFO - PID 19453 | |5;imaging-gaussian-blur;114;113;110;114;114;114;113;113;113;115 07:33:59 INFO - PID 19453 | |6;imaging-darkroom;151;149;151;149;150;150;150;150;151;150 07:33:59 INFO - PID 19453 | |7;imaging-desaturate;94;94;94;95;95;94;94;94;94;94 07:33:59 INFO - PID 19453 | |8;json-parse-financial;45;45;44;45;44;45;45;45;45;45 07:33:59 INFO - PID 19453 | |9;json-stringify-tinderbox;37;37;37;36;37;36;37;37;37;37 07:33:59 INFO - PID 19453 | |10;stanford-crypto-aes;72;70;70;70;77;76;72;73;71;73 07:33:59 INFO - PID 19453 | |11;stanford-crypto-ccm;108;103;110;106;113;109;114;104;103;109 07:33:59 INFO - PID 19453 | |12;stanford-crypto-pbkdf2;151;151;157;154;151;153;151;151;150;159 07:33:59 INFO - PID 19453 | |13;stanford-crypto-sha256-iterative;62;60;59;69;61;60;67;60;67;60 07:33:59 INFO - PID 19453 | __end_tp_report 07:33:59 INFO - PID 19453 | __start_cc_report 07:33:59 INFO - PID 19453 | _x_x_mozilla_cycle_collect,710 07:33:59 INFO - PID 19453 | __end_cc_report 07:33:59 INFO - PID 19453 | __startTimestamp1505918039253__endTimestamp 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | ------- Summary: start ------- 07:33:59 INFO - PID 19453 | Number of tests: 14 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#0] ai-astar Cycles:10 Average:105.70 Median:105.00 stddev:1.34 (1.3%) stddev-sans-first:1.33 07:33:59 INFO - PID 19453 | Values: 107.0 105.0 105.0 105.0 105.0 109.0 106.0 105.0 105.0 105.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:113.50 stddev:8.02 (7.1%) stddev-sans-first:8.40 07:33:59 INFO - PID 19453 | Values: 112.0 114.0 113.0 112.0 116.0 112.0 112.0 138.0 114.0 112.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:2.13 (1.3%) stddev-sans-first:2.15 07:33:59 INFO - PID 19453 | Values: 160.0 161.0 160.0 161.0 160.0 163.0 162.0 163.0 162.0 167.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#3] audio-fft Cycles:10 Average:78.20 Median:73.50 stddev:11.95 (16.3%) stddev-sans-first:12.53 07:33:59 INFO - PID 19453 | Values: 73.0 74.0 76.0 73.0 83.0 111.0 74.0 73.0 72.0 73.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:78.00 stddev:2.33 (3.0%) stddev-sans-first:2.45 07:33:59 INFO - PID 19453 | Values: 77.0 78.0 84.0 77.0 77.0 78.0 78.0 78.0 75.0 77.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.39 07:33:59 INFO - PID 19453 | Values: 114.0 113.0 110.0 114.0 114.0 114.0 113.0 113.0 113.0 115.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:33:59 INFO - PID 19453 | Values: 151.0 149.0 151.0 149.0 150.0 150.0 150.0 150.0 151.0 150.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:33:59 INFO - PID 19453 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:45.00 stddev:0.42 (0.9%) stddev-sans-first:0.44 07:33:59 INFO - PID 19453 | Values: 45.0 45.0 44.0 45.0 44.0 45.0 45.0 45.0 45.0 45.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 07:33:59 INFO - PID 19453 | Values: 37.0 37.0 37.0 36.0 37.0 36.0 37.0 37.0 37.0 37.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:2.46 (3.4%) stddev-sans-first:2.60 07:33:59 INFO - PID 19453 | Values: 72.0 70.0 70.0 70.0 77.0 76.0 72.0 73.0 71.0 73.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#11] stanford-crypto-ccm Cycles:10 Average:107.90 Median:109.00 stddev:3.90 (3.6%) stddev-sans-first:4.14 07:33:59 INFO - PID 19453 | Values: 108.0 103.0 110.0 106.0 113.0 109.0 114.0 104.0 103.0 109.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:152.00 stddev:3.01 (2.0%) stddev-sans-first:3.12 07:33:59 INFO - PID 19453 | Values: 151.0 151.0 157.0 154.0 151.0 153.0 151.0 151.0 150.0 159.0 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:61.50 stddev:3.69 (6.0%) stddev-sans-first:3.91 07:33:59 INFO - PID 19453 | Values: 62.0 60.0 59.0 69.0 61.0 60.0 67.0 60.0 67.0 60.0 07:33:59 INFO - PID 19453 | -------- Summary: end -------- 07:33:59 INFO - PID 19453 | 07:33:59 INFO - PID 19453 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:33:59 INFO - TEST-INFO | 19453: exit 0 07:33:59 INFO - TEST-OK | kraken | took 58710ms 07:33:59 INFO - SUITE-END | took 1166s 07:33:59 INFO - Completed test suite (00:19:26) 07:33:59 INFO - javascript benchmark 07:33:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8934.377854898707, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3890.6692931100856, 3911.863084792032, 3914.0214946263436, 3923.254581629492, 3923.568407475177, 6193.876122477548, 6256.186695729549, 6296.937030629692, 6328.5886417382835, 6348.301686814447, 6261.906071408933, 6302.4012718791755, 6305.274893387262, 6328.177336946202, 6345.0, 5602.8599285018, 5604.607677462579, 5642.548596112311, 5645.858853528674, 5674.432556744334, 5591.049521581321, 5695.259616249882, 5700.686462244575, 5709.600327977043, 5724.685142317192, 5639.6334238274385, 5665.943340566583, 5735.426457354252, 5749.05140651794, 5767.019606666856, 5519.586031047687, 5630.8029218977135, 5700.572457065695, 5767.452092051249, 5779.3642699303255, 5618.943810561883, 5623.718814059322, 5647.745851436695, 5664.716764161775, 5690.317161940552, 6243.500519958392, 6256.092866534327, 6330.3669633036325, 6341.239051313826, 6399.968000160016, 6712.53012289135, 6772.55978361405, 6803.183617965876, 6845.657717114124, 6901.861962760767, 6787.864242715118, 6847.965760171217, 6876.793696189123, 6894.0, 6894.586324820527, 6279.963805972055, 6368.29948705642, 6381.106645069647, 6384.361563843625, 6386.904196437057, 6983.057287266256, 6994.370506654425, 7066.646667666699, 7070.92929070713, 7080.858382832417, 6607.339266073451, 6653.2681405045405, 6684.231313398924, 6730.461563074942, 6733.259341472434, 6830.146231721035, 6840.794776156723, 6936.7225310987, 6959.791206263821, 6962.965185174143, 6772.288909664513, 6790.117284752951, 6869.622170780555, 6882.4149947254045, 6883.621400822903, 6783.694733736994, 6818.045473633695, 6822.215445223863, 6877.6217308047535, 6902.8619427612175, 4927.211646136601, 4940.0, 4944.703317800943, 4963.726995015237, 4965.875853103701, 4439.977800110979, 4462.330650402466, 4488.663350248745, 4506.864794056183, 4517.503074661785, 6257.530685198628, 6284.0, 6295.496360291166, 6385.45723613498, 6399.0, 6827.6244806536115, 6853.143357080365, 6916.0, 6922.480813938974, 6932.549384290005, 6210.347913469021, 6287.622742635365, 6328.335524769833, 6339.619622822645, 6371.808845734636, 5525.889482210333, 5543.0, 5575.860603484945, 5581.804636837691, 5583.748731307101, 7060.470464715167, 7065.2228254891925, 7077.858442831218, 7165.104361954755, 7181.96409017962, 6757.831054223684, 6771.3905748482875, 6877.209120951155, 6887.690053947485, 6901.516893817385, 7132.251113632994, 7168.56988580666, 7178.318059784312, 7192.460565457507, 7193.568385896654, 6751.763688270887, 6766.120404347404, 6795.660216989229, 6851.931480685129, 6869.244383117753, 6721.831954201184, 6841.863162736817, 6853.965730171517, 6866.828329291808, 6963.895541566779, 6536.705848236746, 6580.341965803382, 6597.472202223715, 6598.703058362481, 6599.109120268894, 6607.603543787388, 6620.337966203341, 6661.367170118831, 6677.432418244503, 6684.899726504009, 6528.934710652833, 6542.443892269211, 6548.410643042149, 6614.503912206507, 6643.701033453603, 6520.641364724986, 6621.867562648624, 6639.900401494078, 6665.433438157811, 6687.832804179934, 6493.610383377012, 6507.577007494498, 6509.153810004669, 6519.706613202512, 6537.803865884031], "value": 6243.889292096308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.9433034017959, 955.9378640388378, 973.7468258252853, 1008.697390782765, 1010.7574182196275, 42734.35898461522, 43401.0, 43412.78293608536, 43427.13145737084, 43490.34764478532, 39907.60092399075, 39908.0, 40035.79982100085, 40423.595764042424, 40434.19131617366, 7727.690892364313, 7874.803129921769, 7876.0, 7881.96059019707, 7896.881546776803, 7756.18560051195, 7817.6091195440285, 7849.921500784976, 7852.254035866584, 7854.803629909269, 7834.647440865147, 7859.331956783681, 7860.842783144334, 8294.3779216559, 8504.532250726208, 8351.498910065386, 8407.201315874981, 8416.537090460022, 8416.747497575114, 8418.494890306602, 8295.543745094017, 8377.37169712274, 8388.538630375328, 8390.160983901562, 8392.622331995075, 39642.20715585672, 40051.0, 40149.799251003555, 40208.0, 40348.39477407841, 3783.3190025795348, 3820.3123437781187, 3824.521934758155, 3828.7894165820867, 3828.885133446001, 32919.34161316784, 32968.505472417935, 32969.505457418156, 32976.835115824506, 33002.504962425584, 5361.865953351158, 5363.6245462817615, 5390.9191362129595, 5400.432954539756, 5421.891562168774, 195096.0, 195696.0, 195790.0, 195872.0, 195997.0, 50463.24305135426, 50623.0, 50636.74681626568, 50759.49240507548, 50902.23646645303, 53268.0, 53317.733411332694, 53503.46496534985, 53520.73239633777, 53522.19716704253, 13332.73334533304, 13497.325133743274, 13559.86440135586, 13645.044846860625, 13668.93165534166, 10666.0, 10754.300970436896, 10762.892371076188, 10765.30025548337, 10788.0, 15157.242137893281, 15340.079595224322, 15442.536723898302, 15455.227238638248, 15530.767038494432, 6072.271327440647, 6139.754409823647, 6157.012819616125, 6210.099535567318, 6228.408301211378, 1107.7839821234943, 1123.5618108937358, 1125.8198688209848, 1135.8807325230732, 1136.579465597734, 25735.0, 25795.742042579335, 25859.0, 25862.482750345265, 26121.085761998238, 1185.9940700296443, 1198.1074099795708, 1198.9160758746978, 1202.5370232460566, 1222.1383924333502, 13236.867631323756, 13493.0, 13652.180869147884, 13876.167429954236, 13884.4446222152, 276292.0, 276985.0, 277036.0, 278685.0, 279676.0, 55476.16785748217, 55603.165952510746, 58610.0, 59100.70449647724, 61619.0, 1466.552701426054, 1496.0799108548165, 1496.1172907984123, 1498.4455751371845, 1519.225195150481, 30119.247018824706, 30221.0, 30379.544306835858, 30490.0, 30760.846195768878, 41660.37509437421, 42176.57823421727, 42201.78899105485, 42233.0, 42256.788716057454, 238666.0, 239820.0, 240064.0, 241239.0, 241377.0, 35550.11124721799, 35664.465033024004, 35702.0, 35723.10692232715, 36052.639473604926, 43448.56551434572, 45018.77490612526, 45357.319640206086, 45423.54576454193, 45442.0, 33249.168770780925, 33636.32727345488, 33770.49344259887, 34072.14819629529, 34112.14719632029, 32886.342273153925, 33093.0, 33193.502097468074, 33418.164545886546, 33731.49402758911, 36713.0, 37881.43177852279, 38120.428193577674, 38131.04672383213, 38436.0, 32287.677123228466, 32414.35171296608, 32561.674383255864, 32620.510692340107, 33350.666493335724, 24257.39356516101, 24489.3877653053, 24692.876535617925, 25128.24615261545, 25428.74571254338], "value": 18201.771333112738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.1943995046637, 602.8342205893379, 613.8189234175924, 620.491197218281, 630.3822254190893, 23306.88346558267, 23962.880185599046, 24119.39701507463, 24123.15568955087, 24157.879210603944, 24672.75327246727, 26250.0, 26320.868395658043, 26364.604530932003, 26391.736082639214, 6580.572262802926, 6775.254721980578, 6781.660916954157, 6784.72861085556, 6818.249992500821, 6530.542861999662, 6723.09238252837, 6794.3545363190415, 6809.387155156035, 6819.522633415663, 6768.0, 6768.52620316578, 6771.085903403052, 6775.932240677579, 6777.932220677804, 6556.770513032068, 6700.631465269408, 6712.060311556386, 6743.797686069402, 6781.694823732944, 6307.936920630781, 6336.46140078094, 6344.04839274108, 6352.650604216767, 6353.809385718389, 30404.54393184104, 30860.53709194364, 30946.226344341347, 31086.689133108604, 31124.0, 2221.533477969628, 2269.205777977711, 2272.488690044727, 2276.8747718875456, 2277.1005452846034, 20703.171873125208, 21381.786182138134, 21489.46276343088, 21608.675869861963, 21630.24294149713, 2565.4484285878625, 2570.139003433852, 2607.1266125847865, 2616.908408205704, 2619.580867061261, 128788.0, 133679.33160334235, 148087.0, 155145.22427387792, 155571.22214388856, 15680.0, 16003.839961600468, 16026.759598605797, 16184.352625894833, 16428.917855410884, 25865.870670646527, 25918.74081259201, 25934.0, 25940.0, 25961.480770384485, 8868.290536757173, 8950.283977281802, 8953.552322383855, 9029.41308814925, 9087.22758565516, 7623.656935437808, 7641.732539361095, 7711.53730776144, 7743.45795794289, 7796.4542482026845, 9940.900590994142, 9948.502574871227, 10067.244956628283, 10070.144037756727, 10152.492375381202, 2860.2134413036583, 2879.6544414670375, 2888.4511942730815, 2897.9275518111795, 2925.1078421081347, 1049.3861091261697, 1051.7948999944938, 1063.500154927183, 1066.2376400873413, 1081.5835903177333, 21483.892580536998, 21665.56668866614, 21949.0, 21972.0, 22111.115555377928, 1098.3464838421128, 1099.5546803544578, 1109.5007246738999, 1111.572044762756, 1112.1547623805805, 12021.699457513632, 12110.878891211152, 12129.818052729217, 12150.939245303716, 12156.635300940987, 552153.0, 563118.0, 567047.0, 576646.0, 576684.0, 123814.0, 125226.0, 125673.37163314308, 126795.0, 129224.0, 1105.1545567640762, 1151.4933429291086, 1170.2627344772739, 1218.4212499062874, 1236.0605939485877, 22109.889450552644, 22198.334049978526, 22510.212142574932, 22772.886135569217, 22814.543709126057, 62010.37989620046, 62521.0, 62791.0, 63491.36508635039, 64169.0, 78374.608126959, 78656.60671696605, 79292.0, 79552.2044779568, 79723.2027679739, 15592.37630494813, 15875.0, 15955.361785528448, 16050.598735031717, 16091.436799711953, 24705.752942471063, 24709.629355560042, 24797.62803557984, 25017.0, 25063.0, 18902.810971890103, 19748.210071596975, 20156.29452969139, 20396.388108356772, 20438.591228175057, 17027.318907244065, 17491.47525574235, 17871.463856084338, 18015.549611259823, 18250.817491824913, 19502.0, 19559.804401955796, 19565.217391304188, 19662.115204816102, 19769.40691779249, 15592.688146237238, 15701.685966280838, 15725.370985160465, 15788.842111579197, 15850.52448426549, 20505.692414613495, 20586.588268234253, 20696.379108626767, 20697.58604827865, 20731.58536829225], "value": 12740.265585751747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.0640777087121, 1447.435500154939, 1474.5576327101867, 1481.1187343530596, 1497.8726808221302, 16050.83949160508, 16774.245158967846, 16810.24353904074, 16845.41041063563, 16878.91560542197, 16628.58428539284, 16765.245563949622, 16798.748018779697, 16801.159942002912, 16846.0, 2665.840049597021, 2679.102500662276, 2721.7822574194115, 2731.01683393978, 2731.6312297839736, 2797.958030629542, 2836.702146274632, 2844.104107206234, 2846.5872448494956, 2846.629938108043, 2759.4205216904475, 2763.115802943059, 2773.8058335916494, 2965.303153758865, 2966.33257517058, 2940.3825196708717, 2950.8819647214086, 2967.3471836196004, 2973.4647763402577, 2975.1966968918377, 2712.864356782153, 2714.0636480414228, 2716.0765339784566, 2773.778097752175, 2904.2158617173245, 16432.096234707085, 16479.670406591802, 16531.173441327886, 16562.83437165637, 16577.83422165775, 8476.83046339076, 8737.694180703646, 8757.649694012232, 8769.736907892773, 8778.956105219497, 5919.467247947662, 5997.7001149942325, 6065.696715164224, 6105.99251123564, 6158.3841615838055, 2064.834813214954, 2072.3782865140397, 2078.3972647932083, 2093.811556959881, 2122.7028216049766, 29586.408271834443, 29762.851185744148, 29901.70098299011, 29945.401091978256, 29945.401091978256, 7002.614856182857, 7058.470614703918, 7157.7136914522835, 7255.600941948138, 7304.306090921354, 18839.90580047091, 18883.90558047201, 18906.716399254023, 18976.81023189778, 18986.240550377832, 8107.351411887035, 8288.378371622153, 8317.459365141367, 8322.29260512851, 8328.70849520276, 7547.773566793005, 7654.502457340255, 7724.613769311624, 7740.574268415178, 7746.49647772893, 5578.944210557924, 5661.915071273934, 5699.601027928005, 5741.712914354349, 5980.820575382745, 1660.8256133106092, 1686.9662606747797, 1687.7130887749113, 1706.496583507868, 1707.069647042365, 939.1453777062976, 952.8380175370204, 963.3545524498603, 965.6571916969515, 967.2938754709102, 8051.879221811678, 8068.596570171468, 8072.394570407243, 8095.595220239083, 8108.1891810819625, 761.2653789093551, 783.1581050370875, 794.6662401791261, 796.3430170109683, 799.5043073294595, 4776.928346074812, 4988.201887697951, 5407.756650950638, 5452.890942181134, 5515.310586176728, 23442.06231750745, 23641.527169456516, 24497.0, 24977.125800596892, 24997.250082497554, 23309.18417855367, 23485.17801876926, 23656.645150322758, 23663.0, 23691.052357905835, 11514.30914145154, 11665.650030499099, 12110.455029523693, 12112.21270617407, 12225.510979560719, 8803.735887923373, 9067.637294508146, 9128.132827381389, 9210.125038121369, 9260.953695231481, 20793.376198714064, 20954.0, 21026.158953641683, 21154.894225528773, 21726.89136554307, 21704.565908681423, 21822.672659910433, 21940.561188775817, 21944.231951881608, 22354.217602384488, 12074.637760867188, 12211.633650990485, 12241.69395765113, 12364.0, 12374.75250494967, 15212.315445804745, 15315.15766632846, 15363.38546458174, 15371.923140384673, 15390.230488475307, 11633.709157271136, 11716.179867409199, 11753.941230293794, 12019.699507512381, 12064.095192860395, 11839.644810655695, 11860.881391186324, 11941.16411851162, 12024.33866137371, 12209.267443953391, 9255.07449255096, 9269.72190834276, 9389.43663380172, 9405.20055795265, 9436.858447123435, 7481.438892083007, 7591.924080759342, 7665.3101220890385, 7667.808304792425, 7689.807754806175, 7656.0, 7754.88367674474, 7761.0, 7823.8435231293915, 7952.522848629101], "value": 7103.000571885695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.974936127874, 567.3532173322412, 575.8128608202335, 581.1457157977771, 583.4369833111049, 5941.554383421245, 5988.281406231247, 6098.634081955081, 6268.874622507547, 6291.622502649844, 6184.814455566329, 6230.84422889428, 6261.906071408921, 6266.248050233967, 6303.117563541108, 5245.186996015605, 5247.737613119348, 5256.6057545684225, 5264.8157314494, 5265.605079619025, 4867.075255701406, 5048.091343558158, 5197.350331208599, 5210.947890521104, 5245.842624721246, 4993.400791904976, 5024.346834911456, 5024.723640199788, 5031.924521132186, 5040.0, 4971.154903666367, 4977.228529577921, 4979.601631869442, 5006.424261209971, 5018.121828679985, 4522.276435770261, 4530.864074077783, 4536.523665015159, 4541.296099104644, 4575.839845605387, 6227.785581811503, 6249.312575616678, 6251.12484252205, 6272.498200144023, 6283.7172327244925, 5833.766649334021, 5861.296644402656, 5869.413058694139, 5924.022536281508, 5938.198343223653, 6532.542722009462, 6554.442872355856, 6561.212654481445, 6567.343265673395, 6652.201735791736, 4689.7655117244, 5020.648554601179, 5039.370078740158, 5042.470540593222, 5043.949560504421, 6767.864642707167, 6821.2155602105895, 6839.213490448612, 6918.377346038881, 6942.19502929237, 5079.31429257053, 5146.176611742103, 5151.690898546024, 5192.714400707921, 5224.895502090013, 5168.431472538018, 5247.396549396792, 5265.262863199156, 5278.788848446019, 5287.180487024518, 5755.532339253464, 5796.94203057964, 5810.215620891126, 5814.563907706939, 5866.794662186803, 6545.2800191979795, 6556.311587283267, 6659.0, 6667.833304167435, 6669.0, 1757.4815429448342, 1780.6705759434547, 1801.261482792049, 1830.6704793137362, 1834.0921243984312, 1226.5400474821943, 1264.1530174782918, 1265.8797414245632, 1273.1533530202496, 1277.1698396042461, 6093.222202234554, 6099.268087829489, 6165.1985241919165, 6168.352323006109, 6200.596961197508, 6517.185351831021, 6596.406323430914, 6719.496037797185, 6730.528862979544, 6744.595324280559, 5903.468687818117, 6045.0, 6123.418275263843, 6145.594558556928, 6225.252969643581, 3503.0366649171683, 3511.227529943408, 3548.982255088708, 3575.1598374382, 3581.3732596795458, 6822.761203357859, 6886.208086070066, 6928.960655901655, 6933.861322773516, 6934.341237582422, 6829.658517074126, 6883.8967415488805, 6886.0, 6888.965555172192, 6986.965065174743, 6852.554583952027, 6874.793756187322, 6970.128733908262, 6980.616066116412, 6991.615461149686, 6570.375814297634, 6644.970029645413, 6732.8653426930205, 6741.089952856498, 6747.705780034812, 6571.408573228432, 6578.638174900235, 6582.860570314762, 6654.534182607171, 6659.334066593302, 6922.861542769016, 6957.443404527525, 7016.473764467583, 7017.473689473412, 7018.789436316919, 5208.687478751287, 5214.400343960341, 5214.921776173284, 5221.295125158055, 5242.737863106906, 6556.213254409501, 6663.433608143362, 6730.528862979544, 6740.427063699444, 6837.487188460786, 6411.166548348685, 6493.253275873146, 6500.447461965786, 6579.046038324512, 6616.8345791355605, 6369.267534233622, 6407.295197528175, 6434.774782882764, 6447.967760161169, 6464.22429308486, 6363.745450182126, 6414.294427612866, 6421.165248517849, 6489.772857950138, 6495.967520162369, 6439.484841212786, 6551.279359270572, 6551.344865513601, 6570.630530697033, 6645.468362531083, 6284.120223168668, 6321.936780632319, 6333.1317261407075, 6375.904361434675, 6453.322401147811], "value": 5163.400298505353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.8651695504147, 976.1409959235875, 977.8288799460092, 996.995015024925, 1006.260398607024, 20132.496687582818, 20608.79391206091, 20729.792702072995, 20833.479163020933, 20860.269890553835, 17858.464246072606, 17884.0, 17970.4608861734, 18841.717374239397, 18923.0, 1041.5677493840046, 1062.102523367757, 1064.1539975719322, 1065.7388939709742, 1066.0245875024382, 1049.1973640165243, 1091.4379094766202, 1092.3282181458426, 1092.5247517329947, 1101.3777215873047, 1148.6726283009343, 1150.7928572856883, 1151.4127794824617, 1153.6250718516474, 1162.511745067074, 1139.595443617512, 1141.4349896801054, 1147.2829481574017, 1148.3741360958297, 1157.438642258504, 849.7918010087507, 851.8679604661287, 852.6802449081595, 853.0616322045762, 854.0520022774715, 19847.007649617462, 20074.899625501777, 20271.89864050685, 20295.188192472284, 21043.894780526152, 22563.435914102116, 22665.886670566542, 22887.198948036737, 22941.885290573606, 22959.77040229593, 17656.382026629006, 17740.822591774046, 17769.822301776945, 17772.022538760364, 17790.733139002925, 3579.8568057277676, 3737.9813100934593, 3786.6970642348547, 3790.0524868782804, 3799.6580307772156, 141341.1731765359, 155038.22480887637, 159875.0, 161027.99999999884, 162478.0, 18206.726899096524, 18277.817221827612, 18375.90812045958, 18751.624967500848, 18769.1553880073, 33482.3303533928, 33940.49089263663, 34116.97649070532, 34176.658233417846, 34252.486212706826, 9225.40034897743, 9305.674301399418, 9333.113354231336, 9353.859692104625, 9366.812663746687, 4459.509453960061, 4505.909881802346, 4512.774361281923, 4520.9095818084115, 4555.908881822345, 6142.324344322121, 6250.281217660027, 6260.373962603794, 6268.592541484789, 6270.028145637433, 1169.128998895811, 1175.2419689300352, 1175.9412029398495, 1182.6156499137815, 1183.1126655008743, 665.311402698205, 674.5480528046221, 690.3648643248123, 697.4629535257823, 698.6925752668911, 11784.94107529474, 12273.69315767113, 12279.69300767488, 13408.463661453628, 13426.328683565978, 652.4095693397483, 654.7511945460694, 657.4181849063613, 669.5246375073655, 673.0274752981894, 5077.907069419011, 5118.513741194581, 5118.59051275897, 5137.660272338704, 5178.637495375363, 149893.25053374883, 154469.0, 155148.0, 155787.0, 157298.0, 131496.0, 131688.0, 132196.0, 134986.32506837402, 136293.0, 105920.0, 105931.0, 106192.93807061986, 108862.0, 110215.0, 9250.167484926389, 9486.762830929281, 9576.76058098553, 9681.564329605326, 9718.465484398426, 53873.73063134816, 54263.72868135634, 54945.72527137339, 55594.72202638961, 56416.43583564276, 69464.0, 70330.64834675794, 71053.644731776, 74090.62954685192, 74524.0, 15744.685106298039, 16143.919280403523, 16191.514254572381, 16200.918995404947, 16238.26927788276, 18728.625427491646, 18907.338243161423, 18920.52698682544, 18999.0, 19107.90446047761, 16255.837441625905, 16276.10481423533, 16286.185690715654, 16414.09722465276, 16423.67152656964, 17337.826621734126, 17347.132643368033, 17361.652766944844, 17470.0, 17571.385001524886, 16778.832211677727, 16991.40530081441, 17016.57458563546, 17246.91376543109, 17248.137593120544, 11509.884901150881, 11591.6522504325, 11777.587784427848, 11875.168738188244, 11890.405479725807, 10979.1216702662, 11005.559777608805, 11016.779664406507, 11115.72210694739, 11250.0], "value": 9577.110076836243, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 105.0, 105.0, 109.0, 106.0, 105.0, 105.0, 105.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 112.0, 116.0, 112.0, 112.0, 138.0, 114.0, 112.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 160.0, 163.0, 162.0, 163.0, 162.0, 167.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 73.0, 83.0, 111.0, 74.0, 73.0, 72.0, 73.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 84.0, 77.0, 77.0, 78.0, 78.0, 78.0, 75.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 115.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 151.0, 149.0, 150.0, 150.0, 150.0, 150.0, 151.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 44.0, 45.0, 44.0, 45.0, 45.0, 45.0, 45.0, 45.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 36.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 70.0, 77.0, 76.0, 72.0, 73.0, 71.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 103.0, 110.0, 106.0, 113.0, 109.0, 114.0, 104.0, 103.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 157.0, 154.0, 151.0, 153.0, 151.0, 151.0, 150.0, 159.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 69.0, 61.0, 60.0, 67.0, 60.0, 67.0, 60.0], "value": 62.5, "unit": "score"}]}]} 07:33:59 INFO - Return code: 0 07:34:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:34:00 INFO - # TBPL SUCCESS # 07:34:00 INFO - Running post-action listener: _package_coverage_data 07:34:00 INFO - Running post-action listener: _resource_record_post_action 07:34:00 INFO - [mozharness: 2017-09-20 14:34:00.050227Z] Finished run-tests step (success) 07:34:00 INFO - Running post-run listener: _resource_record_post_run 07:34:00 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328376320; Read time: 12; Write time: 168064 07:34:00 INFO - TinderboxPrint: CPU usage
13.1% 07:34:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:34:00 INFO - TinderboxPrint: I/O write bytes / time
328,376,320 / 168,064 07:34:00 INFO - TinderboxPrint: CPU idle
8,214.5 (86.9%) 07:34:00 INFO - TinderboxPrint: CPU user
1,186.2 (12.6%) 07:34:00 INFO - TinderboxPrint: Swap in / out
0 / 0 07:34:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 11190272; Read time: 0; Write time: 2040 07:34:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:34:00 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315351040; Read time: 12; Write time: 165948 07:34:00 INFO - Running post-run listener: _upload_blobber_files 07:34:00 INFO - Blob upload gear active. 07:34:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:00 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 07:34:00 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'] 07:34:00 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 07:34:01 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:34:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:34:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:01 INFO - (blobuploader) - INFO - Done attempting. 07:34:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:03 INFO - (blobuploader) - INFO - Done attempting. 07:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:06 INFO - (blobuploader) - INFO - Done attempting. 07:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:07 INFO - (blobuploader) - INFO - Done attempting. 07:34:07 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:07 INFO - Return code: 0 07:34:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b37df7f43880271c1e3e74b533ba599b272ef776f87ed6ef1a42624d53601193def8d549f01fa3ff72b3a011ed9f9b11a0a24596d095f6966b833b42453a5e25", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd6ff52f8574e32257adf63b4968a8638e532ba8246f1495ab03d863943d1b6f55d19eb844be8e0302c5a8930f4455ecb92390a48b1ad1e38a001f654f59a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218bc47bbebe2223d9848384ae155948365f65387eff6b69fb1039fcfc6c510fa92fd5f6b709d02fe98e6a3cedda41e9f0198fba4fe551ed9ebbe8e73ca1b965", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc563c5a7f3c191a3888cff8b39e8b6eb2234e358efa373e0f16679e6c177e29c4fff10016b8986015f3cfcc0dd04033ccb237a113c534ef183bfe89b8451cf9"} 07:34:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:07 INFO - Contents: 07:34:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b37df7f43880271c1e3e74b533ba599b272ef776f87ed6ef1a42624d53601193def8d549f01fa3ff72b3a011ed9f9b11a0a24596d095f6966b833b42453a5e25", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd6ff52f8574e32257adf63b4968a8638e532ba8246f1495ab03d863943d1b6f55d19eb844be8e0302c5a8930f4455ecb92390a48b1ad1e38a001f654f59a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218bc47bbebe2223d9848384ae155948365f65387eff6b69fb1039fcfc6c510fa92fd5f6b709d02fe98e6a3cedda41e9f0198fba4fe551ed9ebbe8e73ca1b965", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc563c5a7f3c191a3888cff8b39e8b6eb2234e358efa373e0f16679e6c177e29c4fff10016b8986015f3cfcc0dd04033ccb237a113c534ef183bfe89b8451cf9"} 07:34:07 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:07 INFO - Copying logs to upload dir... 07:34:07 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.865714 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-20 07:34:07.742399) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:34:07.750238) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 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/b37df7f43880271c1e3e74b533ba599b272ef776f87ed6ef1a42624d53601193def8d549f01fa3ff72b3a011ed9f9b11a0a24596d095f6966b833b42453a5e25", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd6ff52f8574e32257adf63b4968a8638e532ba8246f1495ab03d863943d1b6f55d19eb844be8e0302c5a8930f4455ecb92390a48b1ad1e38a001f654f59a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218bc47bbebe2223d9848384ae155948365f65387eff6b69fb1039fcfc6c510fa92fd5f6b709d02fe98e6a3cedda41e9f0198fba4fe551ed9ebbe8e73ca1b965", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc563c5a7f3c191a3888cff8b39e8b6eb2234e358efa373e0f16679e6c177e29c4fff10016b8986015f3cfcc0dd04033ccb237a113c534ef183bfe89b8451cf9"} build_url:https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/P20qr_HwSXq27OAkk440Sw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b37df7f43880271c1e3e74b533ba599b272ef776f87ed6ef1a42624d53601193def8d549f01fa3ff72b3a011ed9f9b11a0a24596d095f6966b833b42453a5e25", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afd6ff52f8574e32257adf63b4968a8638e532ba8246f1495ab03d863943d1b6f55d19eb844be8e0302c5a8930f4455ecb92390a48b1ad1e38a001f654f59a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218bc47bbebe2223d9848384ae155948365f65387eff6b69fb1039fcfc6c510fa92fd5f6b709d02fe98e6a3cedda41e9f0198fba4fe551ed9ebbe8e73ca1b965", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc563c5a7f3c191a3888cff8b39e8b6eb2234e358efa373e0f16679e6c177e29c4fff10016b8986015f3cfcc0dd04033ccb237a113c534ef183bfe89b8451cf9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:34:07.781531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:34:07.781894) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1505911216.55971-153429715 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:34:07.864655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:34:07.865898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:34:07.866264) ========= ========= Total master_lag: 0.21 =========