builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1505622892.07 results: success (0) revision: be5bddf32db0a1ed27251295b7711d06f9189b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.067287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.069783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.070122) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.207936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.208320) ========= 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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 21:34:52-- 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% 35.9M=0s 2017-09-16 21:34:52 (35.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093567 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.357682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.357983) ========= 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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020643 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:52.438492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:34:52.438879) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be5bddf32db0a1ed27251295b7711d06f9189b11 --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 be5bddf32db0a1ed27251295b7711d06f9189b11 --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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 21:34:52,499 truncating revision to first 12 chars 2017-09-16 21:34:52,500 Setting DEBUG logging. 2017-09-16 21:34:52,500 attempt 1/10 2017-09-16 21:34:52,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be5bddf32db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 21:34:53,424 unpacking tar archive at: mozilla-central-be5bddf32db0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 21:34:53.741126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:53.741450) ========= script_repo_revision: be5bddf32db0a1ed27251295b7711d06f9189b11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:53.741876) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:53.742285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 21:34:53.756062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 21:34:53.756770) ========= /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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:53 INFO - MultiFileLogger online at 20170916 21:34:53 in /builds/slave/test 21:34:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:34:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:53 INFO - {'append_to_log': False, 21:34:53 INFO - 'base_work_dir': '/builds/slave/test', 21:34:53 INFO - 'blob_upload_branch': 'Firefox', 21:34:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:53 INFO - 'branch': 'Firefox', 21:34:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:53 INFO - 'code_coverage': False, 21:34:53 INFO - 'config_files': ('talos/linux_config.py',), 21:34:53 INFO - 'default_actions': ('clobber', 21:34:53 INFO - 'read-buildbot-config', 21:34:53 INFO - 'download-and-extract', 21:34:53 INFO - 'populate-webroot', 21:34:53 INFO - 'create-virtualenv', 21:34:53 INFO - 'install', 21:34:53 INFO - 'setup-mitmproxy', 21:34:53 INFO - 'run-tests'), 21:34:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:53 INFO - 'disable_ccov_upload': False, 21:34:53 INFO - 'disable_stylo': False, 21:34:53 INFO - 'download_minidump_stackwalk': True, 21:34:53 INFO - 'download_symbols': 'ondemand', 21:34:53 INFO - 'enable_stylo': False, 21:34:53 INFO - 'enable_webrender': False, 21:34:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 21:34:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:53 INFO - 'gecko_profile': False, 21:34:53 INFO - 'gecko_profile_interval': 0, 21:34:53 INFO - 'installer_path': 'installer.exe', 21:34:53 INFO - 'log_level': 'info', 21:34:53 INFO - 'log_name': 'talos', 21:34:53 INFO - 'log_to_console': True, 21:34:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:53 INFO - 'opt_config_files': (), 21:34:53 INFO - 'pip_index': False, 21:34:53 INFO - 'suite': 'dromaeojs-e10s', 21:34:53 INFO - 'system_bits': '32', 21:34:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:53 INFO - 'title': 'talos-linux64-ix-045', 21:34:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:53 INFO - 'use_talos_json': True, 21:34:53 INFO - 'verify': 'False', 21:34:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:53 INFO - 'work_dir': 'build'} 21:34:53 INFO - [mozharness: 2017-09-17 04:34:53.956008Z] Running clobber step. 21:34:53 INFO - Running pre-action listener: _resource_record_pre_action 21:34:53 INFO - Running main action method: clobber 21:34:53 INFO - rmtree: /builds/slave/test/build 21:34:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:54 INFO - Running post-action listener: _resource_record_post_action 21:34:54 INFO - [mozharness: 2017-09-17 04:34:54.946672Z] Finished clobber step (success) 21:34:54 INFO - [mozharness: 2017-09-17 04:34:54.946769Z] Running read-buildbot-config step. 21:34:54 INFO - Running pre-action listener: _resource_record_pre_action 21:34:54 INFO - Running main action method: read_buildbot_config 21:34:54 INFO - Using buildbot properties: 21:34:54 INFO - { 21:34:54 INFO - "project": "", 21:34:54 INFO - "product": "firefox", 21:34:54 INFO - "who": "ryanvm@gmail.com", 21:34:54 INFO - "installer_path": "public/build/target.tar.bz2", 21:34:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:34:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:34:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:34:54 INFO - "stage_platform": "linux64-pgo", 21:34:54 INFO - "basedir": "/builds/slave/test", 21:34:54 INFO - "buildnumber": 191, 21:34:54 INFO - "platform": "ubuntu64_hw", 21:34:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:34:54 INFO - "slavebuilddir": "test", 21:34:54 INFO - "taskId": "AMk9jMQ_RTutw2bQ7GXr1A", 21:34:54 INFO - "branch": "mozilla-central", 21:34:54 INFO - "script_repo_revision": "production", 21:34:54 INFO - "revision": "be5bddf32db0a1ed27251295b7711d06f9189b11", 21:34:54 INFO - "slavename": "talos-linux64-ix-045", 21:34:54 INFO - "repo_path": "mozilla-central" 21:34:54 INFO - } 21:34:54 INFO - Finding installer, test and symbols from parent task. 21:34:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMk9jMQ_RTutw2bQ7GXr1A'}, attempt #1 21:34:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMk9jMQ_RTutw2bQ7GXr1A'}, attempt #1 21:34:55 INFO - Task dependencies: FH5rI8fZSoORX0XmnXiq8A 21:34:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A'}, attempt #1 21:34:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:34:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json 21:34:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip 21:34:56 INFO - Running post-action listener: _resource_record_post_action 21:34:56 INFO - [mozharness: 2017-09-17 04:34:56.304668Z] Finished read-buildbot-config step (success) 21:34:56 INFO - [mozharness: 2017-09-17 04:34:56.304885Z] Running download-and-extract step. 21:34:56 INFO - Running pre-action listener: _resource_record_pre_action 21:34:56 INFO - Running main action method: download_and_extract 21:34:56 INFO - mkdir: /builds/slave/test/build/tests 21:34: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')]} 21:34:56 INFO - trying https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json 21:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:34:56 INFO - Downloaded 989 bytes. 21:34:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:34:56 INFO - Using the following test package requirements: 21:34:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:34:56 INFO - u'common': [u'target.common.tests.zip'], 21:34:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:34:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:34:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:34:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:34:56 INFO - u'mozbase': [u'target.common.tests.zip'], 21:34:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:34:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:34:56 INFO - u'web-platform': [u'target.common.tests.zip', 21:34:56 INFO - u'target.web-platform.tests.tar.gz'], 21:34:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:34:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 21:34:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip 21:34:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:34:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.common.tests.zip into memory 21:34:59 INFO - Content-Length response header: 55323758 21:34:59 INFO - Bytes received: 55323758 21:35:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip 21:35:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:35:09 INFO - Fetch https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.talos.tests.zip into memory 21:35:11 INFO - Content-Length response header: 14508748 21:35:11 INFO - Bytes received: 14508748 21:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:11 INFO - trying https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:35:15 INFO - Downloaded 62187569 bytes. 21:35:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:15 INFO - mkdir: /builds/slave/test/properties 21:35:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:15 INFO - Contents: 21:35:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 21:35:15 INFO - Running post-action listener: _resource_record_post_action 21:35:15 INFO - Running post-action listener: find_tests_for_verification 21:35:15 INFO - Running post-action listener: set_extra_try_arguments 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.648864Z] Finished download-and-extract step (success) 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.649092Z] Running populate-webroot step. 21:35:15 INFO - Running pre-action listener: _resource_record_pre_action 21:35:15 INFO - Running main action method: populate_webroot 21:35:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:15 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tresize', 21:35:15 INFO - 'tcanvasmark']}, 21:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:15 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['dromaeo_css', 21:35:15 INFO - 'kraken']}, 21:35:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:15 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['damp', 'tps']}, 21:35:15 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['damp', 'tps']}, 21:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:15 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['dromaeo_dom']}, 21:35:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:35:15 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['basic_compositor_video', 21:35:15 INFO - 'glvideo']}, 21:35:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:35:15 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['ts_paint_webext', 21:35:15 INFO - 'tp5o_webext']}, 21:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:15 INFO - 'ts_paint', 21:35:15 INFO - 'tpaint', 21:35:15 INFO - 'sessionrestore', 21:35:15 INFO - 'sessionrestore_many_windows', 21:35:15 INFO - 'sessionrestore_no_auto_restore', 21:35:15 INFO - 'tabpaint']}, 21:35:15 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['a11yr', 21:35:15 INFO - 'ts_paint', 21:35:15 INFO - 'tpaint', 21:35:15 INFO - 'sessionrestore', 21:35:15 INFO - 'sessionrestore_many_windows', 21:35:15 INFO - 'sessionrestore_no_auto_restore', 21:35:15 INFO - 'tabpaint']}, 21:35:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:35:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 21:35:15 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['perf_reftest_singletons']}, 21:35:15 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['bloom_basic']}, 21:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:15 INFO - 'tsvgr_opacity', 21:35:15 INFO - 'tart', 21:35:15 INFO - 'tscrollx', 21:35:15 INFO - 'tsvg_static']}, 21:35:15 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tsvgx', 21:35:15 INFO - 'tsvgr_opacity', 21:35:15 INFO - 'tart', 21:35:15 INFO - 'tscrollx', 21:35:15 INFO - 'tsvg_static']}, 21:35:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:35:15 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo'], 21:35:15 INFO - 'tests': ['tp5o']}, 21:35:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo', 21:35:15 INFO - '--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:35:15 INFO - 'talos_options': ['--stylo-threads=1', 21:35:15 INFO - '--mitmproxy', 21:35:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:35:15 INFO - '--firstNonBlankPaint'], 21:35:15 INFO - 'tests': ['tp6_google', 21:35:15 INFO - 'tp6_youtube', 21:35:15 INFO - 'tp6_amazon', 21:35:15 INFO - 'tp6_facebook']}, 21:35:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--xperf_path', 21:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:15 INFO - 'tests': ['tp5n']}, 21:35:15 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 21:35:15 INFO - 'talos_options': ['--disable-stylo', 21:35:15 INFO - '--xperf_path', 21:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:15 INFO - 'tests': ['tp5n']}}} 21:35:15 INFO - Running post-action listener: _resource_record_post_action 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.671395Z] Finished populate-webroot step (success) 21:35:15 INFO - [mozharness: 2017-09-17 04:35:15.671502Z] Running create-virtualenv step. 21:35:15 INFO - Running pre-action listener: _resource_record_pre_action 21:35:15 INFO - Running main action method: create_virtualenv 21:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:15 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:35:15 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 21:35:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:16 INFO - Installing pip...............done. 21:35:16 INFO - Return code: 0 21:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:16 INFO - Reading from file tmpfile_stdout 21:35:16 INFO - Output received: 21:35:16 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 21:35:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:16 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:35:16 INFO - Using env: {'DISPLAY': ':0', 21:35:16 INFO - 'HOME': '/home/cltbld', 21:35:16 INFO - 'LANG': 'en_US.UTF-8', 21:35:16 INFO - 'LANGUAGE': 'en_US:en', 21:35:16 INFO - 'LOGNAME': 'cltbld', 21:35:16 INFO - 'MAIL': '/var/mail/cltbld', 21:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:16 INFO - 'MOZ_NO_REMOTE': '1', 21:35:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:16 INFO - 'NO_EM_RESTART': '1', 21:35:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:16 INFO - 'PWD': '/builds/slave/test', 21:35:16 INFO - 'SHELL': '/bin/bash', 21:35:16 INFO - 'SHLVL': '1', 21:35:16 INFO - 'TERM': 'linux', 21:35:16 INFO - 'TMOUT': '86400', 21:35:16 INFO - 'USER': 'cltbld', 21:35:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:16 INFO - '_': '/tools/buildbot/bin/python'} 21:35:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 21:35:17 INFO - Downloading/unpacking pip>=1.5 21:35:17 INFO - Running setup.py egg_info for package pip 21:35:17 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:17 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:17 INFO - Installing collected packages: pip 21:35:17 INFO - Found existing installation: pip 1.1 21:35:17 INFO - Uninstalling pip: 21:35:17 INFO - Successfully uninstalled pip 21:35:17 INFO - Running setup.py install for pip 21:35:17 INFO - warning: no files found matching 'pip/cacert.pem' 21:35:17 INFO - warning: no files found matching '*.html' under directory 'docs' 21:35:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 21:35:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 21:35:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 21:35:17 INFO - Successfully installed pip 21:35:17 INFO - Cleaning up... 21:35:17 INFO - Return code: 0 21:35:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:17 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:35:17 INFO - Using env: {'DISPLAY': ':0', 21:35:17 INFO - 'HOME': '/home/cltbld', 21:35:17 INFO - 'LANG': 'en_US.UTF-8', 21:35:17 INFO - 'LANGUAGE': 'en_US:en', 21:35:17 INFO - 'LOGNAME': 'cltbld', 21:35:17 INFO - 'MAIL': '/var/mail/cltbld', 21:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:17 INFO - 'MOZ_NO_REMOTE': '1', 21:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:17 INFO - 'NO_EM_RESTART': '1', 21:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:17 INFO - 'PWD': '/builds/slave/test', 21:35:17 INFO - 'SHELL': '/bin/bash', 21:35:17 INFO - 'SHLVL': '1', 21:35:17 INFO - 'TERM': 'linux', 21:35:17 INFO - 'TMOUT': '86400', 21:35:17 INFO - 'USER': 'cltbld', 21:35:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:17 INFO - '_': '/tools/buildbot/bin/python'} 21:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:18 INFO - Downloading/unpacking psutil>=3.1.1 21:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:19 INFO - Installing collected packages: psutil 21:35:19 INFO - Running setup.py install for psutil 21:35:19 INFO - building 'psutil._psutil_linux' extension 21:35:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:35:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:35:19 INFO - building 'psutil._psutil_posix' extension 21:35:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:35:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:19 INFO - Successfully installed psutil 21:35:19 INFO - Cleaning up... 21:35:19 INFO - Return code: 0 21:35:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:19 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:35:19 INFO - Using env: {'DISPLAY': ':0', 21:35:19 INFO - 'HOME': '/home/cltbld', 21:35:19 INFO - 'LANG': 'en_US.UTF-8', 21:35:19 INFO - 'LANGUAGE': 'en_US:en', 21:35:19 INFO - 'LOGNAME': 'cltbld', 21:35:19 INFO - 'MAIL': '/var/mail/cltbld', 21:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:19 INFO - 'MOZ_NO_REMOTE': '1', 21:35:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:19 INFO - 'NO_EM_RESTART': '1', 21:35:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:19 INFO - 'PWD': '/builds/slave/test', 21:35:19 INFO - 'SHELL': '/bin/bash', 21:35:19 INFO - 'SHLVL': '1', 21:35:19 INFO - 'TERM': 'linux', 21:35:19 INFO - 'TMOUT': '86400', 21:35:19 INFO - 'USER': 'cltbld', 21:35:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:19 INFO - '_': '/tools/buildbot/bin/python'} 21:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:21 INFO - Installing collected packages: mozsystemmonitor 21:35:21 INFO - Running setup.py install for mozsystemmonitor 21:35:21 INFO - Successfully installed mozsystemmonitor 21:35:21 INFO - Cleaning up... 21:35:21 INFO - Return code: 0 21:35:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:21 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:35:21 INFO - Using env: {'DISPLAY': ':0', 21:35:21 INFO - 'HOME': '/home/cltbld', 21:35:21 INFO - 'LANG': 'en_US.UTF-8', 21:35:21 INFO - 'LANGUAGE': 'en_US:en', 21:35:21 INFO - 'LOGNAME': 'cltbld', 21:35:21 INFO - 'MAIL': '/var/mail/cltbld', 21:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:21 INFO - 'MOZ_NO_REMOTE': '1', 21:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:21 INFO - 'NO_EM_RESTART': '1', 21:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:21 INFO - 'PWD': '/builds/slave/test', 21:35:21 INFO - 'SHELL': '/bin/bash', 21:35:21 INFO - 'SHLVL': '1', 21:35:21 INFO - 'TERM': 'linux', 21:35:21 INFO - 'TMOUT': '86400', 21:35:21 INFO - 'USER': 'cltbld', 21:35:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:21 INFO - '_': '/tools/buildbot/bin/python'} 21:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:22 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:23 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:23 INFO - warning: no files found matching '*.txt' 21:35:23 INFO - no previously-included directories found matching 'build' 21:35:23 INFO - no previously-included directories found matching 'dist' 21:35:23 INFO - no previously-included directories found matching '.git*' 21:35:23 INFO - Installing collected packages: jsonschema, functools32 21:35:23 INFO - Running setup.py install for functools32 21:35:23 INFO - warning: no files found matching '*.txt' 21:35:23 INFO - no previously-included directories found matching 'build' 21:35:23 INFO - no previously-included directories found matching 'dist' 21:35:23 INFO - no previously-included directories found matching '.git*' 21:35:24 INFO - Successfully installed jsonschema functools32 21:35:24 INFO - Cleaning up... 21:35:24 INFO - Return code: 0 21:35:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:24 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:35:24 INFO - Using env: {'DISPLAY': ':0', 21:35:24 INFO - 'HOME': '/home/cltbld', 21:35:24 INFO - 'LANG': 'en_US.UTF-8', 21:35:24 INFO - 'LANGUAGE': 'en_US:en', 21:35:24 INFO - 'LOGNAME': 'cltbld', 21:35:24 INFO - 'MAIL': '/var/mail/cltbld', 21:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:24 INFO - 'MOZ_NO_REMOTE': '1', 21:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:24 INFO - 'NO_EM_RESTART': '1', 21:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:24 INFO - 'PWD': '/builds/slave/test', 21:35:24 INFO - 'SHELL': '/bin/bash', 21:35:24 INFO - 'SHLVL': '1', 21:35:24 INFO - 'TERM': 'linux', 21:35:24 INFO - 'TMOUT': '86400', 21:35:24 INFO - 'USER': 'cltbld', 21:35:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:24 INFO - '_': '/tools/buildbot/bin/python'} 21:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:24 INFO - Cleaning up... 21:35:24 INFO - Return code: 0 21:35:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:24 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:35:24 INFO - Using env: {'DISPLAY': ':0', 21:35:24 INFO - 'HOME': '/home/cltbld', 21:35:24 INFO - 'LANG': 'en_US.UTF-8', 21:35:24 INFO - 'LANGUAGE': 'en_US:en', 21:35:24 INFO - 'LOGNAME': 'cltbld', 21:35:24 INFO - 'MAIL': '/var/mail/cltbld', 21:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:24 INFO - 'MOZ_NO_REMOTE': '1', 21:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:24 INFO - 'NO_EM_RESTART': '1', 21:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:24 INFO - 'PWD': '/builds/slave/test', 21:35:24 INFO - 'SHELL': '/bin/bash', 21:35:24 INFO - 'SHLVL': '1', 21:35:24 INFO - 'TERM': 'linux', 21:35:24 INFO - 'TMOUT': '86400', 21:35:24 INFO - 'USER': 'cltbld', 21:35:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:24 INFO - '_': '/tools/buildbot/bin/python'} 21:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:24 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:26 INFO - Downloading docopt-0.6.1.tar.gz 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:26 INFO - Running setup.py install for blobuploader 21:35:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:26 INFO - Running setup.py install for requests 21:35:26 INFO - Running setup.py install for docopt 21:35:26 INFO - Successfully installed blobuploader requests docopt 21:35:26 INFO - Cleaning up... 21:35:26 INFO - Return code: 0 21:35:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:26 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:26 INFO - Using env: {'DISPLAY': ':0', 21:35:26 INFO - 'HOME': '/home/cltbld', 21:35:26 INFO - 'LANG': 'en_US.UTF-8', 21:35:26 INFO - 'LANGUAGE': 'en_US:en', 21:35:26 INFO - 'LOGNAME': 'cltbld', 21:35:26 INFO - 'MAIL': '/var/mail/cltbld', 21:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:26 INFO - 'MOZ_NO_REMOTE': '1', 21:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:26 INFO - 'NO_EM_RESTART': '1', 21:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:26 INFO - 'PWD': '/builds/slave/test', 21:35:26 INFO - 'SHELL': '/bin/bash', 21:35:26 INFO - 'SHLVL': '1', 21:35:26 INFO - 'TERM': 'linux', 21:35:26 INFO - 'TMOUT': '86400', 21:35:26 INFO - 'USER': 'cltbld', 21:35:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:26 INFO - '_': '/tools/buildbot/bin/python'} 21:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Running setup.py (path:/tmp/pip-fwprJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Running setup.py (path:/tmp/pip-lZLhBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Running setup.py (path:/tmp/pip-9I3pKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:27 INFO - Running setup.py (path:/tmp/pip-txokip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:27 INFO - Running setup.py (path:/tmp/pip-F4MstE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:27 INFO - Running setup.py (path:/tmp/pip-1OkpRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:27 INFO - Running setup.py (path:/tmp/pip-aTNjkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:27 INFO - Running setup.py (path:/tmp/pip-VoIuiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:27 INFO - Running setup.py (path:/tmp/pip-tpLwwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:27 INFO - Running setup.py (path:/tmp/pip-OMLVZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:27 INFO - Running setup.py (path:/tmp/pip-tFmmge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:27 INFO - Running setup.py (path:/tmp/pip-B2sKu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:27 INFO - Running setup.py (path:/tmp/pip-DkQyrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:27 INFO - Running setup.py (path:/tmp/pip-RYHAut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Running setup.py (path:/tmp/pip-lAsArA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Running setup.py (path:/tmp/pip-MDodGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Running setup.py (path:/tmp/pip-geRqQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:28 INFO - Running setup.py install for manifestparser 21:35:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozcrash 21:35:28 INFO - Running setup.py install for mozdebug 21:35:28 INFO - Running setup.py install for mozdevice 21:35:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozfile 21:35:28 INFO - Running setup.py install for mozhttpd 21:35:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozinfo 21:35:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozInstall 21:35:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:28 INFO - Running setup.py install for mozleak 21:35:29 INFO - Running setup.py install for mozlog 21:35:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for moznetwork 21:35:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozprocess 21:35:29 INFO - Running setup.py install for mozprofile 21:35:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozrunner 21:35:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Running setup.py install for mozscreenshot 21:35:29 INFO - Running setup.py install for moztest 21:35:29 INFO - Running setup.py install for mozversion 21:35:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:29 INFO - Cleaning up... 21:35:29 INFO - Return code: 0 21:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:29 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:29 INFO - Using env: {'DISPLAY': ':0', 21:35:29 INFO - 'HOME': '/home/cltbld', 21:35:29 INFO - 'LANG': 'en_US.UTF-8', 21:35:29 INFO - 'LANGUAGE': 'en_US:en', 21:35:29 INFO - 'LOGNAME': 'cltbld', 21:35:29 INFO - 'MAIL': '/var/mail/cltbld', 21:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:29 INFO - 'MOZ_NO_REMOTE': '1', 21:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:29 INFO - 'NO_EM_RESTART': '1', 21:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:29 INFO - 'PWD': '/builds/slave/test', 21:35:29 INFO - 'SHELL': '/bin/bash', 21:35:29 INFO - 'SHLVL': '1', 21:35:29 INFO - 'TERM': 'linux', 21:35:29 INFO - 'TMOUT': '86400', 21:35:29 INFO - 'USER': 'cltbld', 21:35:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:29 INFO - '_': '/tools/buildbot/bin/python'} 21:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:30 INFO - Running setup.py (path:/tmp/pip-6QLOJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:30 INFO - Running setup.py (path:/tmp/pip-oG6AeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:30 INFO - Running setup.py (path:/tmp/pip-PdFDCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:30 INFO - Running setup.py (path:/tmp/pip-dJoCJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:30 INFO - Running setup.py (path:/tmp/pip-MQfyor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:30 INFO - Running setup.py (path:/tmp/pip-nZ6e9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:30 INFO - Running setup.py (path:/tmp/pip-IHb4Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:30 INFO - Running setup.py (path:/tmp/pip-x_I58K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:30 INFO - Running setup.py (path:/tmp/pip-GfMaOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:30 INFO - Running setup.py (path:/tmp/pip-_XjZUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:30 INFO - Running setup.py (path:/tmp/pip-lbJ2L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:30 INFO - Running setup.py (path:/tmp/pip-lG4PIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 INFO - Running setup.py (path:/tmp/pip-qOMSNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 INFO - Running setup.py (path:/tmp/pip-eO5qma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:31 INFO - Running setup.py (path:/tmp/pip-HabIno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:31 INFO - Running setup.py (path:/tmp/pip-OUirS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:31 INFO - Running setup.py (path:/tmp/pip-7BAtgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:35:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:32 INFO - Downloading blessings-1.6.tar.gz 21:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:32 INFO - Installing collected packages: blessings 21:35:32 INFO - Running setup.py install for blessings 21:35:32 INFO - Successfully installed blessings 21:35:32 INFO - Cleaning up... 21:35:32 INFO - Return code: 0 21:35:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:32 INFO - Reading from file tmpfile_stdout 21:35:32 INFO - Current package versions: 21:35:32 INFO - argparse == 1.2.1 21:35:32 INFO - blessings == 1.6 21:35:32 INFO - blobuploader == 1.2.4 21:35:32 INFO - docopt == 0.6.1 21:35:32 INFO - functools32 == 3.2.3-2 21:35:32 INFO - jsonschema == 2.5.1 21:35:32 INFO - manifestparser == 1.1 21:35:32 INFO - mozInstall == 1.13 21:35:32 INFO - mozcrash == 1.0 21:35:32 INFO - mozdebug == 0.1 21:35:32 INFO - mozdevice == 0.51 21:35:32 INFO - mozfile == 1.2 21:35:32 INFO - mozhttpd == 0.7 21:35:32 INFO - mozinfo == 0.10 21:35:32 INFO - mozleak == 0.1 21:35:32 INFO - mozlog == 3.5 21:35:32 INFO - moznetwork == 0.27 21:35:32 INFO - mozprocess == 0.25 21:35:32 INFO - mozprofile == 0.28 21:35:32 INFO - mozrunner == 6.13 21:35:32 INFO - mozscreenshot == 0.1 21:35:32 INFO - mozsystemmonitor == 0.3 21:35:32 INFO - moztest == 0.8 21:35:32 INFO - mozversion == 1.4 21:35:32 INFO - psutil == 3.1.1 21:35:32 INFO - requests == 1.2.3 21:35:32 INFO - wsgiref == 0.1.2 21:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35: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')]} 21:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:32 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:32 INFO - Using env: {'DISPLAY': ':0', 21:35:32 INFO - 'HOME': '/home/cltbld', 21:35:32 INFO - 'LANG': 'en_US.UTF-8', 21:35:32 INFO - 'LANGUAGE': 'en_US:en', 21:35:32 INFO - 'LOGNAME': 'cltbld', 21:35:32 INFO - 'MAIL': '/var/mail/cltbld', 21:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:32 INFO - 'MOZ_NO_REMOTE': '1', 21:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:32 INFO - 'NO_EM_RESTART': '1', 21:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:33 INFO - 'PWD': '/builds/slave/test', 21:35:33 INFO - 'SHELL': '/bin/bash', 21:35:33 INFO - 'SHLVL': '1', 21:35:33 INFO - 'TERM': 'linux', 21:35:33 INFO - 'TMOUT': '86400', 21:35:33 INFO - 'USER': 'cltbld', 21:35:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:33 INFO - '_': '/tools/buildbot/bin/python'} 21:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:35:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:35:34 INFO - Installing collected packages: simplejson 21:35:34 INFO - Running setup.py install for simplejson 21:35:34 INFO - building 'simplejson._speedups' extension 21:35:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 21:35:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 21:35:35 INFO - Successfully installed simplejson 21:35:35 INFO - Cleaning up... 21:35:35 INFO - Return code: 0 21:35:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:35 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 0x24941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2800a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, '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': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:35:35 INFO - Using env: {'DISPLAY': ':0', 21:35:35 INFO - 'HOME': '/home/cltbld', 21:35:35 INFO - 'LANG': 'en_US.UTF-8', 21:35:35 INFO - 'LANGUAGE': 'en_US:en', 21:35:35 INFO - 'LOGNAME': 'cltbld', 21:35:35 INFO - 'MAIL': '/var/mail/cltbld', 21:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:35 INFO - 'MOZ_NO_REMOTE': '1', 21:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:35 INFO - 'NO_EM_RESTART': '1', 21:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:35 INFO - 'PWD': '/builds/slave/test', 21:35:35 INFO - 'SHELL': '/bin/bash', 21:35:35 INFO - 'SHLVL': '1', 21:35:35 INFO - 'TERM': 'linux', 21:35:35 INFO - 'TMOUT': '86400', 21:35:35 INFO - 'USER': 'cltbld', 21:35:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:35 INFO - '_': '/tools/buildbot/bin/python'} 21:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:35 INFO - Cleaning up... 21:35:35 INFO - Return code: 0 21:35:35 INFO - Running post-action listener: _resource_record_post_action 21:35:35 INFO - Running post-action listener: _start_resource_monitoring 21:35:35 INFO - Starting resource monitoring. 21:35:35 INFO - [mozharness: 2017-09-17 04:35:35.706080Z] Finished create-virtualenv step (success) 21:35:35 INFO - [mozharness: 2017-09-17 04:35:35.706550Z] Running install step. 21:35:35 INFO - Running pre-action listener: _resource_record_pre_action 21:35:35 INFO - Running main action method: install 21:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:35 INFO - Reading from file tmpfile_stdout 21:35:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:36 INFO - Reading from file tmpfile_stdout 21:35:36 INFO - Output received: 21:35:36 INFO - Usage: mozinstall [options] installer 21:35:36 INFO - Options: 21:35:36 INFO - -h, --help show this help message and exit 21:35:36 INFO - -d DEST, --destination=DEST 21:35:36 INFO - Directory to install application into. [default: 21:35:36 INFO - "/builds/slave/test"] 21:35:36 INFO - --app=APP Application being installed. [default: firefox] 21:35:36 INFO - mkdir: /builds/slave/test/build/application 21:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:35:53 INFO - Reading from file tmpfile_stdout 21:35:53 INFO - Output received: 21:35:53 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:53 INFO - Running post-action listener: _resource_record_post_action 21:35:53 INFO - [mozharness: 2017-09-17 04:35:53.697639Z] Finished install step (success) 21:35:53 INFO - [mozharness: 2017-09-17 04:35:53.697927Z] Running setup-mitmproxy step. 21:35:53 INFO - Running pre-action listener: _resource_record_pre_action 21:35:53 INFO - Running main action method: setup_mitmproxy 21:35:53 INFO - Skipping: mitmproxy is not required 21:35:53 INFO - Running post-action listener: _resource_record_post_action 21:35:53 INFO - [mozharness: 2017-09-17 04:35:53.699058Z] Finished setup-mitmproxy step (success) 21:35:53 INFO - [mozharness: 2017-09-17 04:35:53.699277Z] Running run-tests step. 21:35:53 INFO - Running pre-action listener: _resource_record_pre_action 21:35:53 INFO - Running pre-action listener: _set_gcov_prefix 21:35:53 INFO - Running main action method: run_tests 21:35:53 WARNING - Try message not found. 21:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:53 INFO - Python 2.7.3 21:35:53 INFO - Return code: 0 21:35:53 INFO - grabbing minidump binary from tooltool 21:35:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:53 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 0x2804090>, '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 0x2804d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27fef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:35:53 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:35:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:35:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:53 INFO - Return code: 0 21:35:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:53 INFO - ENV: RUST_BACKTRACE is now full 21:35:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:53 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:35:53 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:35:53 INFO - Using env: {'DISPLAY': ':0', 21:35:53 INFO - 'HOME': '/home/cltbld', 21:35:53 INFO - 'LANG': 'en_US.UTF-8', 21:35:53 INFO - 'LANGUAGE': 'en_US:en', 21:35:53 INFO - 'LOGNAME': 'cltbld', 21:35:53 INFO - 'MAIL': '/var/mail/cltbld', 21:35:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:53 INFO - 'MOZ_NO_REMOTE': '1', 21:35:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:53 INFO - 'NO_EM_RESTART': '1', 21:35:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:53 INFO - 'PWD': '/builds/slave/test', 21:35:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:53 INFO - 'RUST_BACKTRACE': 'full', 21:35:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:35:53 INFO - 'SHELL': '/bin/bash', 21:35:53 INFO - 'SHLVL': '1', 21:35:53 INFO - 'TERM': 'linux', 21:35:53 INFO - 'TMOUT': '86400', 21:35:53 INFO - 'USER': 'cltbld', 21:35:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:53 INFO - '_': '/tools/buildbot/bin/python'} 21:35:53 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/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:35:54 INFO - mozversion application_buildid: 20170917031344 21:35:54 INFO - mozversion application_changeset: be5bddf32db0a1ed27251295b7711d06f9189b11 21:35:54 INFO - mozversion application_display_name: Nightly 21:35:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:54 INFO - mozversion application_name: Firefox 21:35:54 INFO - mozversion application_remotingname: firefox 21:35:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:35:54 INFO - mozversion application_vendor: Mozilla 21:35:54 INFO - mozversion application_version: 57.0a1 21:35:54 INFO - mozversion platform_buildid: 20170917031344 21:35:54 INFO - mozversion platform_changeset: be5bddf32db0a1ed27251295b7711d06f9189b11 21:35:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:35:54 INFO - mozversion platform_version: 57.0a1 21:35:54 INFO - using testdate: 1505622954 21:35:54 INFO - actual date: 1505622954 21:35:54 INFO - starting webserver on 'localhost:56465' 21:35:54 INFO - SUITE-START | Running 2 tests 21:35:54 INFO - TEST-START | dromaeo_css 21:35:54 INFO - Initialising browser for dromaeo_css test... 21:35:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56465/getInfo.html -profile /tmp/tmplGduBn/profile 21:35:54 INFO - TEST-INFO | started process 7008 (/builds/slave/test/build/application/firefox/firefox http://localhost:56465/getInfo.html) 21:36:00 INFO - TEST-INFO | 7008: exit 0 21:36:00 INFO - Browser initialized. 21:36:00 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:00 INFO - Using env: {'DISPLAY': ':0', 21:36:00 INFO - 'HOME': '/home/cltbld', 21:36:00 INFO - 'JSGC_DISABLE_POISONING': '1', 21:36:00 INFO - 'LANG': 'en_US.UTF-8', 21:36:00 INFO - 'LANGUAGE': 'en_US:en', 21:36:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:36:00 INFO - 'LOGNAME': 'cltbld', 21:36:00 INFO - 'MAIL': '/var/mail/cltbld', 21:36:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:36:00 INFO - 'MOZ_CRASHREPORTER': '1', 21:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:36:00 INFO - 'MOZ_NO_REMOTE': '1', 21:36:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:36:00 INFO - 'NO_EM_RESTART': '1', 21:36:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:00 INFO - 'PWD': '/builds/slave/test', 21:36:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:00 INFO - 'RUST_BACKTRACE': 'full', 21:36:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:36:00 INFO - 'SHELL': '/bin/bash', 21:36:00 INFO - 'SHLVL': '1', 21:36:00 INFO - 'TERM': 'linux', 21:36:00 INFO - 'TMOUT': '86400', 21:36:00 INFO - 'USER': 'cltbld', 21:36:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:00 INFO - '_': '/tools/buildbot/bin/python'} 21:36:00 INFO - TEST-INFO | started process 7247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplGduBn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:00 INFO - PID 7247 | 21:36:00 INFO - PID 7247 | (/builds/slave/test/build/application/firefox/firefox:7296): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:36:00 INFO - PID 7247 | 21:36:11 INFO - PID 7247 | RSS: Main: 148463616 21:36:11 INFO - PID 7247 | 21:39:08 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56465/tests/dromaeo/cssquery-ext.html) 21:39:10 INFO - PID 7247 | RSS: Main: 148488192 21:39:10 INFO - PID 7247 | 21:42:11 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-ext.html (next: http://localhost:56465/tests/dromaeo/cssquery-jquery.html) 21:42:12 INFO - PID 7247 | RSS: Main: 148365312 21:42:12 INFO - PID 7247 | 21:45:13 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56465/tests/dromaeo/cssquery-mootools.html) 21:45:14 INFO - PID 7247 | RSS: Main: 150581248 21:45:14 INFO - PID 7247 | 21:48:15 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56465/tests/dromaeo/cssquery-prototype.html) 21:48:16 INFO - PID 7247 | RSS: Main: 148471808 21:48:16 INFO - PID 7247 | 21:51:19 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56465/tests/dromaeo/cssquery-yui.html) 21:51:20 INFO - PID 7247 | RSS: Main: 149962752 21:51:20 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | Cycle 1(1): loaded http://localhost:56465/tests/dromaeo/cssquery-yui.html (next: http://localhost:56465/tests/dromaeo/cssquery-dojo.html) 21:54:21 INFO - PID 7247 | RSS: Main: 153026560 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | __start_tp_report 21:54:21 INFO - PID 7247 | _x_x_mozilla_page_load 21:54:21 INFO - PID 7247 | _x_x_mozilla_page_load_details 21:54:21 INFO - PID 7247 | |i|pagename|runs| 21:54:21 INFO - PID 7247 | |0;dojo.html;3823.330917089509;3853.5183102112237;3872.244912242112;3874.4575759393674;3882.8835134945944;6018.127371531125;6115.357887421824;6144.170536977513;6165.445109940105;6215.347388524202;6180.660063696495;6180.938190618092;6185.474234690046;6192;6192.78325258616;5557.083081291582;5611.354694210157;5629.127485239795;5636.7181640918;5652.971735141318;5486.1222204447095;5621.072523033695;5642.774289028454;5647.29408823897;5706.9429305707035;5495.340559132909;5514.338279406476;5537.612367134302;5573.777048918038;5588;5536.75084621193;5544.1960915667405;5591.10542313232;5614.185943038277;5618.971905140448;5444.673319600836;5512.145617429305;5525.917111243334;5556;5561.610687251894;6137.551362348903;6161.969190154021;6170.81487555374;6178.5366097542865;6188.164597779287;6639.86720265592;6648.8670226595195;6707.798766037026;6713.832154196135;6747.898781518281;6667.833304167386;6690.866182676368;6704.061431399608;6769.120014398146;6801.387875091265;6205.162303089025;6211.130441738115;6219.036049412348;6221.626702397825;6232.501399887998;6755.2906944771075;6849.931500685029;6852.143482064742;6863.519553631198;6891.896621550681;6608.4052435281055;6643.1031810704935;6714.563553369113;6715.664216789141;6728.629925354055;6748.6963086660235;6777.796666100025;6825.112735344473;6830.521863469608;6866;6489.513286503531;6590.176227971504;6607.471402287805;6689.5986240825705;6730.0241464988285;6678.365555272241;6735.360140786617;6738.090357801732;6749.797506074826;6771.356721111487;4805.7597120143855;4840.322354870321;4870.634702397334;4871.951280487221;4881.096997055556;4388;4443.488998765183;4450.265706158448;4452.109578084396;4464.933026004613;6087.634741915499;6101.420365065312;6156.199694039746;6163.7842675506145;6177.62934223948;6583.07836902834;6642.136522252076;6673.766418175341;6713.664316784141;6745.5952642841585;6138.109974053827;6152.815415537541;6162.26052873658;6190.102435146879;6191.5665903387235;5349.384820745586;5349.518543331119;5407.729613519387;5410.431904650034;5420.701861397582;6877.828054298582;6879.621620810904;6932.584044957319;6982.685779139951;6992.056072430259;6721.428678562279;6755.7973260802255;6767.830804229934;6788.2193547742645;6792.966035169792;6953.235144134243;6960.930390696029;6963.4777391694815;6973.19808222061;7045.048918395951;6533.150690410216;6644.501662375244;6644.601323920387;6727.428168605723;6733.293004234681;6728;6737.831554211184;6760.256371799;6760.256371799;6811.523193376416;6438.6458744767615;6440.806775796734;6473.061406095995;6499.610023398611;6506.837329066622;6397.360263973565;6406.391392817675;6417.069524918954;6483.286838447672;6498.220213574401;6308.589941653778;6328.778492752732;6342.080398342307;6412.35876412355;6413.615183089029;6477.514186435942;6489.318621544669;6490.772822951174;6503.544751867324;6548.869022619616;6358.745650173942;6387.361263873576;6435.292117867125;6459.418652321314;6476.352364763675 21:54:21 INFO - PID 7247 | |1;ext.html;942.3215284994806;968.9418634881907;999.4103478947421;1001.4692213127046;1001.9949900250498;42835.78582107089;43561;43606.56393436069;43710.78144609276;43746.56253437464;41560.58439415605;43849.34225986613;44671.55328446715;44689.776551117284;44722;8123.715669951553;8184.468009579388;8224.588770561479;8227.259546640802;8250.793730156764;8089.635966381497;8109.310708589777;8145.1854814518665;8178.059523154824;8236.423450358478;8253.876191857127;8268.627911743955;8290.41967062306;8301.958490207571;8302.958485207566;8223.177682231788;8239.134890836496;8239.83520329593;8242.464239824392;8269.751907442786;8069.878951815727;8128.75613731589;8131.186881311881;8134.1052484227275;8138.877916831252;39923.40114898279;40179.59820401788;40345.394819077446;40535.39196912049;40602.390964135564;3677.099110717891;3697.5932647408763;3717.4052151655874;3721.5720192177973;3721.9627803721887;32592;32730.672693273;32780.508292375634;32820.507692384635;32841.50737738936;5319.46805319465;5469.835904922858;5482.972585137089;5511.53151982082;5581.776728930838;215725;217781;218626;219059.9999999984;219654;51306.23040654393;51943.480565193866;51952.48047519552;52090.21864672033;52094.47905520972;54244.45755542394;54639.72680136653;54758.17862732062;54760.17859732107;54776;14391.928040359731;14566.781498277534;14571.562853114423;14605.12369257848;14699.92650036743;11577.363245021605;11577.826332605018;11653.359065251492;11663.941680291713;11699.06407487399;13151.736965260832;13234.73530529384;13274;13278.2074419954;13443.05898587109;5323.387810401853;5349.331333583302;5395.163749618815;5428.891422171613;5465.371482279509;1080.2992518703243;1102.691246450995;1102.7904698107334;1113.760541483585;1124.9100071994221;25501.48997020049;25673.358166045997;25752.227433177035;25787.613185802227;25897.870510647324;1203.536638394207;1205.1443475132753;1209.371127013948;1210.189173253922;1214.2107630040543;13449.260290684106;13540.052196346162;13739.175649461064;13813.723725525635;13877.791833122512;281262;282022;283188;283269;283427;55898;56058.439415605324;56109.71945140248;56630.716846416326;56644.71677641668;1476.343027352839;1495.9925200373928;1509.5471358592597;1522.5051858146146;1543.3672194400242;24792.25623231306;24856.757162141457;24877.88049537739;24883.87558062198;25012.124575640493;36872.63127368799;36900;36974;36999.63000369962;37033;171136;173007;173170;173559;174065;31457.685423145474;32144;34734.826325868205;35228;35330.470042948866;45230.54769452395;45452.54547454483;45643.315350269106;46190.53809461863;46224.7688761554;33470.832645836614;33493.16267093342;33849.49225761665;34120;34630.480542792386;33331.333373331916;33532.83233583914;33570.496442552896;33601.327973439904;34001;38784.418233725955;39023.80488097541;39163;39284.60715392924;39399.40900886431;32467.402707698267;32558.34883302368;33085.83457082699;33159.17102072467;33284.833575831966;24613.507729844943;25174.370640734127;25260.368490787143;25839;26166 21:54:21 INFO - PID 7247 | |2;jquery.html;571.9599628026037;586.8620874094589;606.7542645228684;622.191151503046;627.6516533324004;23548.764512354872;24330.635040474386;24353.14763983261;24353.63469547958;24360.39099022521;21486.462838429008;25214.621780673304;25503.234902952896;25620;25663.871680641572;6607.405333519982;6753.932460675404;6755.324467553254;6755.9662201688925;6760.1549806274215;6604.471642268631;6682.398584127428;6922.134733158356;6924.757633482829;6945.930540694604;6798.252192258848;6848.657567121649;6865.588064716133;6866.244713081557;6868.896966545481;6521.250056243545;6811;6814.52298339114;6832.043513908056;6879.071325371061;6353.142325786052;6353.269374022;6355.491560675135;6355.555111142222;6365.936340636581;30088.24779380533;30357.848210758806;30525;30532.694673053207;30561.388772224655;2260.0959616153505;2282.06435361501;2286.314105768263;2290.118304452781;2305.1470955746313;19585.314513991943;20223.79776202234;20389.388318350473;20403.591928161353;20445.386638400872;2138.3050508584615;2160.4922843131853;2182.1707751054655;2188.72640919885;2304.5506126305377;131431;135855;137770;140211;155422.22288888483;15182.240887955779;15757.290921908541;15765.842341576437;16065;16203;24953.750462495143;25101.4979700405;25109.748902511106;25117.87441062783;25167.24498265055;10444.843327350096;10518.615830173383;10523;10659.413732244646;10743.78512429747;9352.579133938989;9359.812803744024;9532.761680958032;9557.23542116629;9585.616575337048;9527.857082143773;9631.71104866841;9645.614175432904;10001.749956251006;10021.699349019542;2778.2359851041124;2847.1743194473784;2874.3389020525397;2888.8589007341984;2935;1035.7928414317166;1050.954300471021;1055.3140458701753;1065.4193464561833;1068.4711068021224;20863;21100.366988990354;21129.788702112783;21238.681419778717;21377.67933480999;1105.165599972016;1109.672646569264;1114.5374669512223;1127.3912087472672;1134.6142311614092;11576.131790115774;11719.238249513754;11738.765224695459;11767.52929882795;11826.586069487526;588774;612693;614669;618579;618867;130146;130539;131560;133106.33446832703;133993;1106.6679996001167;1164.295601161302;1214.5870404062662;1216.6775804411839;1281.2888846690362;21384.503084783915;21588.488805783443;21691.891540542198;21869.562608748056;21969.011394486966;61157.69421152866;63125;63363.36636633759;64041;65106.67446662926;77370;77584;79150.6042469784;81752.59123704344;82400.58799705963;14802.925985370004;15096.54710358691;15166.469173578871;15197.088174709554;15220.315085821387;22765.544689106457;23211.535769284183;23282.301530954097;23516;23662.29013129609;18956.620867582846;19320.8067919319;19428.611427771084;19436.222551098363;19458.31895883637;16601.003939763654;16968.57578560546;17140.314387424365;17561.648767024843;17707.911460442614;18923.243070277036;19806.405807825788;19938.60122797565;20116.497087572927;20225.19099236014;14794.408223670933;14813.111213327235;14891.255437228312;14891.851081489047;14932.253387330808;18591.628167436305;18705.53236169107;18791.34230301933;19218.61562768709;19312 21:54:21 INFO - PID 7247 | |3;mootools.html;1335.7261761338927;1436.3392839293924;1450.282110355374;1454.0693955868246;1484.4581727669404;16468.58828529286;17134.314627414904;17142.14289285537;17163.313467461317;17174.141292935365;16671.33314667412;16783.41258055968;16873;16873.662526749456;16893.91553042236;2805.116388337677;2838.943221135576;2887.4513842369884;2899.709629215;2900.651921769391;2830.193394882459;2856.785741069418;2864.3268831824503;2870.6842247352774;2871.109955913663;2717.361420066283;2813.015444594386;2824.2233385818963;2839.1198728394265;2840.1763488588285;2823.68939416664;2828.0667379764627;2851.0876519513763;2852.044565070704;2852.258412812673;2671.5859041848544;2680.6917204521533;2736.849473278969;2756.2420334408;2771.9722802772117;16174.838251617568;16319.510414687578;16323;16331.101789401579;16351.018938863706;8301.792455188668;8668.783280417976;8673.653053877837;8674.6096425661;8687.26158276541;5507.531859791922;5534.972325138388;5598.664080155204;5678.687672178028;5679.176519404663;2115.524007098406;2122.8620139691025;2124.3414541492034;2135.7116789233564;2169.0022589608798;29699.70300296991;29985.850070749726;30049.699503004907;30261.697383026327;30289.24276893051;7050;7083.787486375314;7159.105111861018;7306.890396644055;7337.523061001018;18079.819201808077;18094.45716628477;18227.72658410125;18242.361517346828;18265.817341826678;8283.83432331362;8449.619767110495;8462.153784621612;8469.618867150994;8475.533845638425;7502.774916752506;7564.773056808304;7629.847403051908;7630.122535908331;7637.885431718529;5481.848811749577;5605.495505404533;5687.573431992617;5705.515031222392;5725.599208055396;1611.0736326612011;1642.9096399697892;1647.8599319058014;1655.1393275496675;1682.5625337412362;954.9379290346105;968.3221744778683;978.9608415663293;982.268210183418;995.6017592962728;8279.710210142615;8297.170282971776;8318.37612179089;8368.790780230544;8417.494950303002;784.7645706288091;794.3803833010261;802.2378740196837;806.4757907360146;818.4107442641408;5044.772985215674;5166.225066240094;5715.457031581993;5786.952634496961;5792.536597072224;24351.391215219763;25064;25359.366015849384;25360;25599.232023039338;24215.757842421703;24888.004479820604;25550.361240969123;25572.488550228893;25725.614115788278;11870.94064529689;12032.639020829389;12152;12206.938965305117;12245.387730613435;8308.418410711192;8871.157240062184;8975.551222438982;9027.638894444148;9097;20744.688829667266;20849.687254691496;20940.790592093883;21048;21223.257185998416;21492.14031438725;21697.240596579042;21698;21824;21863.89068054713;11801.409929503663;12041.277523348626;12114.333711645944;12136.150469467406;12141;13986.790198147239;14701.264936753334;14906.254687265377;14925.55223343258;14932.253387330373;10937.289076210021;11808.586699465477;11843.407829608313;12066.396680166132;12066.939665301617;11732.413379330828;11772.823407649063;12019.459124339252;12063.21589096706;12112.21270617407;9880.85178722334;10122.89877101249;10274.948625256826;10281.897181028095;10294.124999375137;7827.099883513469;7844.9607751960875;7894.921050789419;7937.444378893653;8022.598870056357;8186.97662792151;8234.094249632655;8241.79395515093;8260.586970651324;8380.07819139882 21:54:21 INFO - PID 7247 | |4;prototype.html;557.3228527339284;564.4919572384856;575.1028395702704;583.3175185033513;589.2869627750422;6137.324894261627;6167.074938759189;6297.685115744217;6300.684965751706;6317.526185536086;6101.481374083197;6110.938890611093;6173.697072066446;6213.751449942009;6234.844128896769;5078.923816142761;5089.949100509003;5096.617753668471;5127.33344665193;5127.359080114967;5071.898562028758;5080.41575218849;5108.948910510903;5119.820806271781;5183.922241166386;4679.766011699418;4840.878978025542;4854.854354369357;4870.43989941156;4918.89324901896;4841.975790121027;4949.851504454854;4961.486746542303;4962.702237865739;4969.676970996874;4461.442319710036;4463.642908567339;4469.262571675669;4492.8876778080485;4502.639788816887;5876.353601103875;6019.668918209497;6025.126356678257;6121.724522396503;6122.663253521055;5714.200011998323;5762.88474230513;5799.623024503394;5832.533397328203;5879.7648094076185;6554.80335589933;6611.669416529202;6612.801615951529;6613.669316534154;6641.900371494431;5016.724080175589;5049.823256186016;5061.620378471593;5063.898722025576;5073.441921388681;6697.665116744143;6817.761378351734;6843.152348865829;6908.550944188662;6972.930270697329;5015.924761128586;5054.9241761373605;5109.3613298337705;5155.819546315861;5161.819336323286;5190.974045129826;5191.532762051434;5193.37679478465;5231.71225582589;5242.475752424803;5648.576356773258;5748.396418376094;5805.448482394166;5817.418258174149;5855.473007429352;6520.380563846427;6643.335666433318;6671;6679.031540426611;6679.131712877295;1735.9305627775;1752.9824701753075;1785.5000599832067;1791.7401976713563;1797.164318591861;1250.2491262353;1252.1735654468007;1274.4583551990368;1281.7949128139453;1281.8397700287464;6094.939050609526;6106.6336019838955;6159.907601385983;6162.938370616236;6210.223722034746;6643.734250629921;6661.766838160641;6677.165354330708;6689.397954184049;6704.865902681919;6011.788396807459;6129.659335662075;6160.969195153995;6185.969070154621;6196.907046394308;3430.4168291390024;3488.8081155536183;3502.6689857854362;3505.614382417932;3538.398472259722;6897.48268879826;6899.724011039602;6915.654217289115;6935.133108361455;7024.613646249403;6730.293319201512;6860.588364698134;6862.245153033262;6866.141732283465;6917.584944903322;6748.561343512656;6920.858058420305;6996.195437524546;7022.157341119098;7029.29707029293;6642.800715978528;6660.866782664222;6667.43326817226;6694.129763130762;6735.360140786617;6508.251551071498;6521.3698274225835;6665.166854143232;6670.366315200048;6684.4652427804685;6759.459243260429;6816.079829223189;6830.45356371499;6858.610489286761;6882.552634078769;5043.773030213576;5069.92395114081;5073.720945348041;5085.262636917701;5091.236314552847;6456.806295811133;6606.570572912745;6657.966710166418;6680.5991640501725;6764.289749576224;6064.272287325549;6315.873682526232;6443.903341449975;6473.2232132144445;6486.254080780582;6501.414872661483;6505.674716264262;6506.722647073487;6508.381703738138;6544.640044797582;6460.160179176677;6475.579087359307;6480.481561474976;6494.805155845333;6545.639989800607;6424.518161138027;6512.446442052289;6574.868502630016;6575.00299772167;6577.769778057745;6210.192674952227;6258.904691678847;6279.654618995816;6291.591046581958;6293.559450838397 21:54:21 INFO - PID 7247 | |5;yui.html;990.6428193375075;1007.098646711193;1008.7478130467383;1010.1615659003028;1012.0688966151142;20544.89727551362;20849.37451876444;20947.581048379023;21063.2627858025;21159.682604760903;20190.49523761903;20560.07479663415;20560.280390186348;20575.485612859688;20593;1064;1080.8540846985634;1081.7133459633203;1081.7187531241893;1082.1505118481994;1078.8651418572679;1116.681745702475;1126.9098472122212;1127.5489804078393;1130.0789856267115;1161.6863446869384;1164.1385374822612;1168.3574034281112;1168.8947994680477;1170.075640244206;1103.7516558774253;1139.6182278936567;1140.6635042662435;1143.9142064345165;1158.9768204635945;823.1028179284608;831.4969443486664;831.584207896052;831.6216121664688;831.6423937706784;21004.579908401745;21943.890280548654;21947.122115115377;22061.779382206132;22180.445488862748;23207.303780886432;23614.76385236143;23877.880610596836;23898;23910.282691519107;18496.63006739871;18503.81496185048;18585.628287434312;18633.906830465898;18648.906755466134;3910.804459777;3933.350997085506;3950.0519875230025;3986.362182050858;4020.557738648746;159728.20135899363;161697.20770062556;163194;163671;167171;17225.483235502954;17610.38363657266;17766.46700598984;17767.555811104827;17793.7330940036;34719.65280347215;35080.12299692477;35254.118647033516;35709;35719.4642080369;8498.532580707997;8534.359923005799;8642;8660.566971651393;8662.30701543875;4354.629856462237;4425.026494171278;4449.710768800018;4485.887852803706;4493.775311234425;5811.680357580373;5874.73563689635;5890.4993075589055;5916.7337469813965;5957.910631340534;1009.848522721583;1038.7922415516775;1054.4727636181908;1054.852320675106;1056.5826498533036;639.8560323927079;650.0703993289546;664.4518272425269;673.2224280955504;674.8312921769558;13071.738565228643;13587.388567514485;13792.448302067805;13903.79144312836;13920.37358318878;736.3851184261202;740.9925900741032;741.0810594862332;749.4603885202646;761.2539711083059;6045.455908968214;6075.5747097703625;6160.691965401712;6192.845178870474;6249.843753906189;156820.21589892206;157387;157809;157838;157944;118367;134803;134966;135298.3235083818;137264;117971;119252;119425.40287298508;121999.39000304764;122176;14973.925130374279;15059.472918447802;15328.080315181125;15524;15534.844651553793;53680.73159634177;53860.461395385544;54246.45753542414;54870;55114.72442637761;70926.64536677283;72008;72133.639331803;72903;73767;20307.898460507604;20529.89735051375;21308.36074917755;21310.14759409668;21367.679484807428;23201.535969280183;23496.647550286416;23638.17266395668;23899.761002389754;23923.16268930579;21776;21824.12703491906;21875.343739687836;22073.227437039626;22240.110395583997;18332.816671833112;18487.53781155482;18548;18566;18674.906625466785;18732.344367947055;18770.24919003279;18875;18969.810301896803;19058.332958346393;15448.922755386151;15540.922295388451;15627.531174064796;15640.687186255984;15732.68534629324;15505.84494155044;15761.527154185393;16084.43704470338;16227.107509087113;16272.267747951608 21:54:21 INFO - PID 7247 | __end_tp_report 21:54:21 INFO - PID 7247 | __start_cc_report 21:54:21 INFO - PID 7247 | _x_x_mozilla_cycle_collect,275 21:54:21 INFO - PID 7247 | __end_cc_report 21:54:21 INFO - PID 7247 | __startTimestamp1505624061959__endTimestamp 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | ------- Summary: start ------- 21:54:21 INFO - PID 7247 | Number of tests: 6 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#0] dojo.html Cycles:165 Average:6166.79 Median:6412.36 stddev:731.12 (11.4%) stddev-sans-first:709.88 21:54:21 INFO - PID 7247 | Values: 3823.3 3853.5 3872.2 3874.5 3882.9 6018.1 6115.4 6144.2 6165.4 6215.3 6180.7 6180.9 6185.5 6192.0 6192.8 5557.1 5611.4 5629.1 5636.7 5653.0 5486.1 5621.1 5642.8 5647.3 5706.9 5495.3 5514.3 5537.6 5573.8 5588.0 5536.8 5544.2 5591.1 5614.2 5619.0 5444.7 5512.1 5525.9 5556.0 5561.6 6137.6 6162.0 6170.8 6178.5 6188.2 6639.9 6648.9 6707.8 6713.8 6747.9 6667.8 6690.9 6704.1 6769.1 6801.4 6205.2 6211.1 6219.0 6221.6 6232.5 6755.3 6849.9 6852.1 6863.5 6891.9 6608.4 6643.1 6714.6 6715.7 6728.6 6748.7 6777.8 6825.1 6830.5 6866.0 6489.5 6590.2 6607.5 6689.6 6730.0 6678.4 6735.4 6738.1 6749.8 6771.4 4805.8 4840.3 4870.6 4872.0 4881.1 4388.0 4443.5 4450.3 4452.1 4464.9 6087.6 6101.4 6156.2 6163.8 6177.6 6583.1 6642.1 6673.8 6713.7 6745.6 6138.1 6152.8 6162.3 6190.1 6191.6 5349.4 5349.5 5407.7 5410.4 5420.7 6877.8 6879.6 6932.6 6982.7 6992.1 6721.4 6755.8 6767.8 6788.2 6793.0 6953.2 6960.9 6963.5 6973.2 7045.0 6533.2 6644.5 6644.6 6727.4 6733.3 6728.0 6737.8 6760.3 6760.3 6811.5 6438.6 6440.8 6473.1 6499.6 6506.8 6397.4 6406.4 6417.1 6483.3 6498.2 6308.6 6328.8 6342.1 6412.4 6413.6 6477.5 6489.3 6490.8 6503.5 6548.9 6358.7 6387.4 6435.3 6459.4 6476.4 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#1] ext.html Cycles:180 Average:40073.25 Median:35279.24 stddev:59679.70 (169.2%) stddev-sans-first:59774.78 21:54:21 INFO - PID 7247 | Values: 942.3 968.9 999.4 1001.5 1002.0 42835.8 43561.0 43606.6 43710.8 43746.6 41560.6 43849.3 44671.6 44689.8 44722.0 8123.7 8184.5 8224.6 8227.3 8250.8 8089.6 8109.3 8145.2 8178.1 8236.4 8253.9 8268.6 8290.4 8302.0 8303.0 8223.2 8239.1 8239.8 8242.5 8269.8 8069.9 8128.8 8131.2 8134.1 8138.9 39923.4 40179.6 40345.4 40535.4 40602.4 3677.1 3697.6 3717.4 3721.6 3722.0 32592.0 32730.7 32780.5 32820.5 32841.5 5319.5 5469.8 5483.0 5511.5 5581.8 215725.0 217781.0 218626.0 219060.0 219654.0 51306.2 51943.5 51952.5 52090.2 52094.5 54244.5 54639.7 54758.2 54760.2 54776.0 14391.9 14566.8 14571.6 14605.1 14699.9 11577.4 11577.8 11653.4 11663.9 11699.1 13151.7 13234.7 13274.0 13278.2 13443.1 5323.4 5349.3 5395.2 5428.9 5465.4 1080.3 1102.7 1102.8 1113.8 1124.9 25501.5 25673.4 25752.2 25787.6 25897.9 1203.5 1205.1 1209.4 1210.2 1214.2 13449.3 13540.1 13739.2 13813.7 13877.8 281262.0 282022.0 283188.0 283269.0 283427.0 55898.0 56058.4 56109.7 56630.7 56644.7 1476.3 1496.0 1509.5 1522.5 1543.4 24792.3 24856.8 24877.9 24883.9 25012.1 36872.6 36900.0 36974.0 36999.6 37033.0 171136.0 173007.0 173170.0 173559.0 174065.0 31457.7 32144.0 34734.8 35228.0 35330.5 45230.5 45452.5 45643.3 46190.5 46224.8 33470.8 33493.2 33849.5 34120.0 34630.5 33331.3 33532.8 33570.5 33601.3 34001.0 38784.4 39023.8 39163.0 39284.6 39399.4 32467.4 32558.3 33085.8 33159.2 33284.8 24613.5 25174.4 25260.4 25839.0 26166.0 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#2] jquery.html Cycles:180 Average:39551.27 Median:12078.87 stddev:101891.12 (843.5%) stddev-sans-first:102134.91 21:54:21 INFO - PID 7247 | Values: 572.0 586.9 606.8 622.2 627.7 23548.8 24330.6 24353.1 24353.6 24360.4 21486.5 25214.6 25503.2 25620.0 25663.9 6607.4 6753.9 6755.3 6756.0 6760.2 6604.5 6682.4 6922.1 6924.8 6945.9 6798.3 6848.7 6865.6 6866.2 6868.9 6521.3 6811.0 6814.5 6832.0 6879.1 6353.1 6353.3 6355.5 6355.6 6365.9 30088.2 30357.8 30525.0 30532.7 30561.4 2260.1 2282.1 2286.3 2290.1 2305.1 19585.3 20223.8 20389.4 20403.6 20445.4 2138.3 2160.5 2182.2 2188.7 2304.6 131431.0 135855.0 137770.0 140211.0 155422.2 15182.2 15757.3 15765.8 16065.0 16203.0 24953.8 25101.5 25109.7 25117.9 25167.2 10444.8 10518.6 10523.0 10659.4 10743.8 9352.6 9359.8 9532.8 9557.2 9585.6 9527.9 9631.7 9645.6 10001.7 10021.7 2778.2 2847.2 2874.3 2888.9 2935.0 1035.8 1051.0 1055.3 1065.4 1068.5 20863.0 21100.4 21129.8 21238.7 21377.7 1105.2 1109.7 1114.5 1127.4 1134.6 11576.1 11719.2 11738.8 11767.5 11826.6 588774.0 612693.0 614669.0 618579.0 618867.0 130146.0 130539.0 131560.0 133106.3 133993.0 1106.7 1164.3 1214.6 1216.7 1281.3 21384.5 21588.5 21691.9 21869.6 21969.0 61157.7 63125.0 63363.4 64041.0 65106.7 77370.0 77584.0 79150.6 81752.6 82400.6 14802.9 15096.5 15166.5 15197.1 15220.3 22765.5 23211.5 23282.3 23516.0 23662.3 18956.6 19320.8 19428.6 19436.2 19458.3 16601.0 16968.6 17140.3 17561.6 17707.9 18923.2 19806.4 19938.6 20116.5 20225.2 14794.4 14813.1 14891.3 14891.9 14932.3 18591.6 18705.5 18791.3 19218.6 19312.0 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#3] mootools.html Cycles:180 Average:10196.68 Median:2809.07 stddev:7616.43 (271.1%) stddev-sans-first:7608.70 21:54:21 INFO - PID 7247 | Values: 1335.7 1436.3 1450.3 1454.1 1484.5 16468.6 17134.3 17142.1 17163.3 17174.1 16671.3 16783.4 16873.0 16873.7 16893.9 2805.1 2838.9 2887.5 2899.7 2900.7 2830.2 2856.8 2864.3 2870.7 2871.1 2717.4 2813.0 2824.2 2839.1 2840.2 2823.7 2828.1 2851.1 2852.0 2852.3 2671.6 2680.7 2736.8 2756.2 2772.0 16174.8 16319.5 16323.0 16331.1 16351.0 8301.8 8668.8 8673.7 8674.6 8687.3 5507.5 5535.0 5598.7 5678.7 5679.2 2115.5 2122.9 2124.3 2135.7 2169.0 29699.7 29985.9 30049.7 30261.7 30289.2 7050.0 7083.8 7159.1 7306.9 7337.5 18079.8 18094.5 18227.7 18242.4 18265.8 8283.8 8449.6 8462.2 8469.6 8475.5 7502.8 7564.8 7629.8 7630.1 7637.9 5481.8 5605.5 5687.6 5705.5 5725.6 1611.1 1642.9 1647.9 1655.1 1682.6 954.9 968.3 979.0 982.3 995.6 8279.7 8297.2 8318.4 8368.8 8417.5 784.8 794.4 802.2 806.5 818.4 5044.8 5166.2 5715.5 5787.0 5792.5 24351.4 25064.0 25359.4 25360.0 25599.2 24215.8 24888.0 25550.4 25572.5 25725.6 11870.9 12032.6 12152.0 12206.9 12245.4 8308.4 8871.2 8975.6 9027.6 9097.0 20744.7 20849.7 20940.8 21048.0 21223.3 21492.1 21697.2 21698.0 21824.0 21863.9 11801.4 12041.3 12114.3 12136.2 12141.0 13986.8 14701.3 14906.3 14925.6 14932.3 10937.3 11808.6 11843.4 12066.4 12066.9 11732.4 11772.8 12019.5 12063.2 12112.2 9880.9 10122.9 10274.9 10281.9 10294.1 7827.1 7845.0 7894.9 7937.4 8022.6 8187.0 8234.1 8241.8 8260.6 8380.1 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#4] prototype.html Cycles:180 Average:5575.49 Median:6165.01 stddev:1556.95 (25.3%) stddev-sans-first:1515.08 21:54:21 INFO - PID 7247 | Values: 557.3 564.5 575.1 583.3 589.3 6137.3 6167.1 6297.7 6300.7 6317.5 6101.5 6110.9 6173.7 6213.8 6234.8 5078.9 5089.9 5096.6 5127.3 5127.4 5071.9 5080.4 5108.9 5119.8 5183.9 4679.8 4840.9 4854.9 4870.4 4918.9 4842.0 4949.9 4961.5 4962.7 4969.7 4461.4 4463.6 4469.3 4492.9 4502.6 5876.4 6019.7 6025.1 6121.7 6122.7 5714.2 5762.9 5799.6 5832.5 5879.8 6554.8 6611.7 6612.8 6613.7 6641.9 5016.7 5049.8 5061.6 5063.9 5073.4 6697.7 6817.8 6843.2 6908.6 6972.9 5015.9 5054.9 5109.4 5155.8 5161.8 5191.0 5191.5 5193.4 5231.7 5242.5 5648.6 5748.4 5805.4 5817.4 5855.5 6520.4 6643.3 6671.0 6679.0 6679.1 1735.9 1753.0 1785.5 1791.7 1797.2 1250.2 1252.2 1274.5 1281.8 1281.8 6094.9 6106.6 6159.9 6162.9 6210.2 6643.7 6661.8 6677.2 6689.4 6704.9 6011.8 6129.7 6161.0 6186.0 6196.9 3430.4 3488.8 3502.7 3505.6 3538.4 6897.5 6899.7 6915.7 6935.1 7024.6 6730.3 6860.6 6862.2 6866.1 6917.6 6748.6 6920.9 6996.2 7022.2 7029.3 6642.8 6660.9 6667.4 6694.1 6735.4 6508.3 6521.4 6665.2 6670.4 6684.5 6759.5 6816.1 6830.5 6858.6 6882.6 5043.8 5069.9 5073.7 5085.3 5091.2 6456.8 6606.6 6658.0 6680.6 6764.3 6064.3 6315.9 6443.9 6473.2 6486.3 6501.4 6505.7 6506.7 6508.4 6544.6 6460.2 6475.6 6480.5 6494.8 6545.6 6424.5 6512.4 6574.9 6575.0 6577.8 6210.2 6258.9 6279.7 6291.6 6293.6 21:54:21 INFO - PID 7247 | 21:54:21 INFO - PID 7247 | [#5] yui.html Cycles:180 Average:29455.12 Median:20418.90 stddev:43397.94 (212.5%) stddev-sans-first:43467.06 21:54:21 INFO - PID 7247 | Values: 990.6 1007.1 1008.7 1010.2 1012.1 20544.9 20849.4 20947.6 21063.3 21159.7 20190.5 20560.1 20560.3 20575.5 20593.0 1064.0 1080.9 1081.7 1081.7 1082.2 1078.9 1116.7 1126.9 1127.5 1130.1 1161.7 1164.1 1168.4 1168.9 1170.1 1103.8 1139.6 1140.7 1143.9 1159.0 823.1 831.5 831.6 831.6 831.6 21004.6 21943.9 21947.1 22061.8 22180.4 23207.3 23614.8 23877.9 23898.0 23910.3 18496.6 18503.8 18585.6 18633.9 18648.9 3910.8 3933.4 3950.1 3986.4 4020.6 159728.2 161697.2 163194.0 163671.0 167171.0 17225.5 17610.4 17766.5 17767.6 17793.7 34719.7 35080.1 35254.1 35709.0 35719.5 8498.5 8534.4 8642.0 8660.6 8662.3 4354.6 4425.0 4449.7 4485.9 4493.8 5811.7 5874.7 5890.5 5916.7 5957.9 1009.8 1038.8 1054.5 1054.9 1056.6 639.9 650.1 664.5 673.2 674.8 13071.7 13587.4 13792.4 13903.8 13920.4 736.4 741.0 741.1 749.5 761.3 6045.5 6075.6 6160.7 6192.8 6249.8 156820.2 157387.0 157809.0 157838.0 157944.0 118367.0 134803.0 134966.0 135298.3 137264.0 117971.0 119252.0 119425.4 121999.4 122176.0 14973.9 15059.5 15328.1 15524.0 15534.8 53680.7 53860.5 54246.5 54870.0 55114.7 70926.6 72008.0 72133.6 72903.0 73767.0 20307.9 20529.9 21308.4 21310.1 21367.7 23201.5 23496.6 23638.2 23899.8 23923.2 21776.0 21824.1 21875.3 22073.2 22240.1 18332.8 18487.5 18548.0 18566.0 18674.9 18732.3 18770.2 18875.0 18969.8 19058.3 15448.9 15540.9 15627.5 15640.7 15732.7 15505.8 15761.5 16084.4 16227.1 16272.3 21:54:21 INFO - PID 7247 | -------- Summary: end -------- 21:54:21 INFO - PID 7247 | 21:54:22 INFO - TEST-INFO | 7247: exit 0 21:54:22 INFO - TEST-OK | dromaeo_css | took 1108486ms 21:54:22 INFO - TEST-START | kraken 21:54:22 INFO - Initialising browser for kraken test... 21:54:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56465/getInfo.html -profile /tmp/tmpjAO7TQ/profile 21:54:22 INFO - TEST-INFO | started process 7622 (/builds/slave/test/build/application/firefox/firefox http://localhost:56465/getInfo.html) 21:54:28 INFO - TEST-INFO | 7622: exit 0 21:54:28 INFO - Browser initialized. 21:54:28 INFO - Running cycle 1/1 for kraken test... 21:54:28 INFO - Using env: {'DISPLAY': ':0', 21:54:28 INFO - 'HOME': '/home/cltbld', 21:54:28 INFO - 'JSGC_DISABLE_POISONING': '1', 21:54:28 INFO - 'LANG': 'en_US.UTF-8', 21:54:28 INFO - 'LANGUAGE': 'en_US:en', 21:54:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 21:54:28 INFO - 'LOGNAME': 'cltbld', 21:54:28 INFO - 'MAIL': '/var/mail/cltbld', 21:54:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:54:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:54:28 INFO - 'MOZ_CRASHREPORTER': '1', 21:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 21:54:28 INFO - 'MOZ_NO_REMOTE': '1', 21:54:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:28 INFO - 'NO_EM_RESTART': '1', 21:54:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:54:28 INFO - 'PWD': '/builds/slave/test', 21:54:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:54:28 INFO - 'RUST_BACKTRACE': 'full', 21:54:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:54:28 INFO - 'SHELL': '/bin/bash', 21:54:28 INFO - 'SHLVL': '1', 21:54:28 INFO - 'TERM': 'linux', 21:54:28 INFO - 'TMOUT': '86400', 21:54:28 INFO - 'USER': 'cltbld', 21:54:28 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1505622241.557488-1572689264', 21:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:28 INFO - '_': '/tools/buildbot/bin/python'} 21:54:28 INFO - TEST-INFO | started process 7862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAO7TQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:29 INFO - PID 7862 | 21:54:29 INFO - PID 7862 | (/builds/slave/test/build/application/firefox/firefox:7911): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:54:29 INFO - PID 7862 | 21:54:39 INFO - PID 7862 | RSS: Main: 148189184 21:54:39 INFO - PID 7862 | 21:54:41 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56465/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:42 INFO - PID 7862 | RSS: Main: 153460736 21:54:42 INFO - PID 7862 | 21:54:45 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56465/tests/kraken/driver.html?testName=audio-dft) 21:54:45 INFO - PID 7862 | RSS: Main: 153833472 21:54:45 INFO - PID 7862 | 21:54:48 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56465/tests/kraken/driver.html?testName=audio-fft) 21:54:49 INFO - PID 7862 | RSS: Main: 150786048 21:54:49 INFO - PID 7862 | 21:54:51 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56465/tests/kraken/driver.html?testName=audio-oscillator) 21:54:52 INFO - PID 7862 | RSS: Main: 151564288 21:54:52 INFO - PID 7862 | 21:54:54 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:54 INFO - PID 7862 | RSS: Main: 150908928 21:54:54 INFO - PID 7862 | 21:54:57 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56465/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:58 INFO - PID 7862 | RSS: Main: 151040000 21:54:58 INFO - PID 7862 | 21:55:01 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56465/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:02 INFO - PID 7862 | RSS: Main: 152592384 21:55:02 INFO - PID 7862 | 21:55:05 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56465/tests/kraken/driver.html?testName=json-parse-financial) 21:55:06 INFO - PID 7862 | RSS: Main: 154058752 21:55:06 INFO - PID 7862 | 21:55:07 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:08 INFO - PID 7862 | RSS: Main: 153698304 21:55:08 INFO - PID 7862 | 21:55:09 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:10 INFO - PID 7862 | RSS: Main: 153808896 21:55:10 INFO - PID 7862 | 21:55:12 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:13 INFO - PID 7862 | RSS: Main: 150908928 21:55:13 INFO - PID 7862 | 21:55:15 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:16 INFO - PID 7862 | RSS: Main: 150831104 21:55:16 INFO - PID 7862 | 21:55:18 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:19 INFO - PID 7862 | RSS: Main: 151719936 21:55:19 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | Cycle 1(1): loaded http://localhost:56465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56465/tests/kraken/driver.html?testName=ai-astar) 21:55:21 INFO - PID 7862 | RSS: Main: 153128960 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | __start_tp_report 21:55:21 INFO - PID 7862 | _x_x_mozilla_page_load 21:55:21 INFO - PID 7862 | _x_x_mozilla_page_load_details 21:55:21 INFO - PID 7862 | |i|pagename|runs| 21:55:21 INFO - PID 7862 | |0;ai-astar;105;105;104;106;108;106;109;105;106;107 21:55:21 INFO - PID 7862 | |1;audio-beat-detection;113;111;114;112;112;119;113;114;140;110 21:55:21 INFO - PID 7862 | |2;audio-dft;163;164;162;160;161;164;161;162;161;165 21:55:21 INFO - PID 7862 | |3;audio-fft;74;74;76;74;73;77;74;74;73;72 21:55:21 INFO - PID 7862 | |4;audio-oscillator;79;78;77;77;77;77;79;78;77;77 21:55:21 INFO - PID 7862 | |5;imaging-gaussian-blur;113;117;116;113;111;114;115;114;111;114 21:55:21 INFO - PID 7862 | |6;imaging-darkroom;150;152;152;150;149;149;150;149;153;149 21:55:21 INFO - PID 7862 | |7;imaging-desaturate;94;95;95;93;95;94;94;94;94;94 21:55:21 INFO - PID 7862 | |8;json-parse-financial;44;44;44;45;46;45;43;42;43;45 21:55:21 INFO - PID 7862 | |9;json-stringify-tinderbox;38;38;38;39;38;38;39;38;37;38 21:55:21 INFO - PID 7862 | |10;stanford-crypto-aes;70;74;72;80;71;75;79;75;75;75 21:55:21 INFO - PID 7862 | |11;stanford-crypto-ccm;109;103;113;106;107;113;108;108;104;113 21:55:21 INFO - PID 7862 | |12;stanford-crypto-pbkdf2;154;152;153;156;153;156;159;160;156;153 21:55:21 INFO - PID 7862 | |13;stanford-crypto-sha256-iterative;60;59;59;60;60;59;58;60;60;61 21:55:21 INFO - PID 7862 | __end_tp_report 21:55:21 INFO - PID 7862 | __start_cc_report 21:55:21 INFO - PID 7862 | _x_x_mozilla_cycle_collect,717 21:55:21 INFO - PID 7862 | __end_cc_report 21:55:21 INFO - PID 7862 | __startTimestamp1505624121331__endTimestamp 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | ------- Summary: start ------- 21:55:21 INFO - PID 7862 | Number of tests: 14 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#0] ai-astar Cycles:10 Average:106.10 Median:106.00 stddev:1.52 (1.4%) stddev-sans-first:1.56 21:55:21 INFO - PID 7862 | Values: 105.0 105.0 104.0 106.0 108.0 106.0 109.0 105.0 106.0 107.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:113.50 stddev:8.84 (7.8%) stddev-sans-first:9.32 21:55:21 INFO - PID 7862 | Values: 113.0 111.0 114.0 112.0 112.0 119.0 113.0 114.0 140.0 110.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.64 (1.0%) stddev-sans-first:1.72 21:55:21 INFO - PID 7862 | Values: 163.0 164.0 162.0 160.0 161.0 164.0 161.0 162.0 161.0 165.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 21:55:21 INFO - PID 7862 | Values: 74.0 74.0 76.0 74.0 73.0 77.0 74.0 74.0 73.0 72.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.50 stddev:0.84 (1.1%) stddev-sans-first:0.73 21:55:21 INFO - PID 7862 | Values: 79.0 78.0 77.0 77.0 77.0 77.0 79.0 78.0 77.0 77.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.93 (1.7%) stddev-sans-first:2.03 21:55:21 INFO - PID 7862 | Values: 113.0 117.0 116.0 113.0 111.0 114.0 115.0 114.0 111.0 114.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 21:55:21 INFO - PID 7862 | Values: 150.0 152.0 152.0 150.0 149.0 149.0 150.0 149.0 153.0 149.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:55:21 INFO - PID 7862 | Values: 94.0 95.0 95.0 93.0 95.0 94.0 94.0 94.0 94.0 94.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.50 stddev:1.20 (2.7%) stddev-sans-first:1.27 21:55:21 INFO - PID 7862 | Values: 44.0 44.0 44.0 45.0 46.0 45.0 43.0 42.0 43.0 45.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 21:55:21 INFO - PID 7862 | Values: 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 37.0 38.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:3.17 (4.2%) stddev-sans-first:2.89 21:55:21 INFO - PID 7862 | Values: 70.0 74.0 72.0 80.0 71.0 75.0 79.0 75.0 75.0 75.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#11] stanford-crypto-ccm Cycles:10 Average:108.40 Median:108.50 stddev:3.66 (3.4%) stddev-sans-first:3.87 21:55:21 INFO - PID 7862 | Values: 109.0 103.0 113.0 106.0 107.0 113.0 108.0 108.0 104.0 113.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:2.70 (1.7%) stddev-sans-first:2.83 21:55:21 INFO - PID 7862 | Values: 154.0 152.0 153.0 156.0 153.0 156.0 159.0 160.0 156.0 153.0 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:60.00 stddev:0.84 (1.4%) stddev-sans-first:0.88 21:55:21 INFO - PID 7862 | Values: 60.0 59.0 59.0 60.0 60.0 59.0 58.0 60.0 60.0 61.0 21:55:21 INFO - PID 7862 | -------- Summary: end -------- 21:55:21 INFO - PID 7862 | 21:55:21 INFO - PID 7862 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 21:55:21 INFO - TEST-INFO | 7862: exit 0 21:55:21 INFO - TEST-OK | kraken | took 59394ms 21:55:21 INFO - SUITE-END | took 1167s 21:55:21 INFO - Completed test suite (00:19:27) 21:55:21 INFO - javascript benchmark 21:55:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8981.450436299543, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3823.330917089509, 3853.5183102112237, 3872.244912242112, 3874.4575759393674, 3882.8835134945944, 6018.127371531125, 6115.357887421824, 6144.170536977513, 6165.445109940105, 6215.347388524202, 6180.660063696495, 6180.938190618092, 6185.474234690046, 6192.0, 6192.78325258616, 5557.083081291582, 5611.354694210157, 5629.127485239795, 5636.7181640918, 5652.971735141318, 5486.1222204447095, 5621.072523033695, 5642.774289028454, 5647.29408823897, 5706.9429305707035, 5495.340559132909, 5514.338279406476, 5537.612367134302, 5573.777048918038, 5588.0, 5536.75084621193, 5544.1960915667405, 5591.10542313232, 5614.185943038277, 5618.971905140448, 5444.673319600836, 5512.145617429305, 5525.917111243334, 5556.0, 5561.610687251894, 6137.551362348903, 6161.969190154021, 6170.81487555374, 6178.5366097542865, 6188.164597779287, 6639.86720265592, 6648.8670226595195, 6707.798766037026, 6713.832154196135, 6747.898781518281, 6667.833304167386, 6690.866182676368, 6704.061431399608, 6769.120014398146, 6801.387875091265, 6205.162303089025, 6211.130441738115, 6219.036049412348, 6221.626702397825, 6232.501399887998, 6755.2906944771075, 6849.931500685029, 6852.143482064742, 6863.519553631198, 6891.896621550681, 6608.4052435281055, 6643.1031810704935, 6714.563553369113, 6715.664216789141, 6728.629925354055, 6748.6963086660235, 6777.796666100025, 6825.112735344473, 6830.521863469608, 6866.0, 6489.513286503531, 6590.176227971504, 6607.471402287805, 6689.5986240825705, 6730.0241464988285, 6678.365555272241, 6735.360140786617, 6738.090357801732, 6749.797506074826, 6771.356721111487, 4805.7597120143855, 4840.322354870321, 4870.634702397334, 4871.951280487221, 4881.096997055556, 4388.0, 4443.488998765183, 4450.265706158448, 4452.109578084396, 4464.933026004613, 6087.634741915499, 6101.420365065312, 6156.199694039746, 6163.7842675506145, 6177.62934223948, 6583.07836902834, 6642.136522252076, 6673.766418175341, 6713.664316784141, 6745.5952642841585, 6138.109974053827, 6152.815415537541, 6162.26052873658, 6190.102435146879, 6191.5665903387235, 5349.384820745586, 5349.518543331119, 5407.729613519387, 5410.431904650034, 5420.701861397582, 6877.828054298582, 6879.621620810904, 6932.584044957319, 6982.685779139951, 6992.056072430259, 6721.428678562279, 6755.7973260802255, 6767.830804229934, 6788.2193547742645, 6792.966035169792, 6953.235144134243, 6960.930390696029, 6963.4777391694815, 6973.19808222061, 7045.048918395951, 6533.150690410216, 6644.501662375244, 6644.601323920387, 6727.428168605723, 6733.293004234681, 6728.0, 6737.831554211184, 6760.256371799, 6760.256371799, 6811.523193376416, 6438.6458744767615, 6440.806775796734, 6473.061406095995, 6499.610023398611, 6506.837329066622, 6397.360263973565, 6406.391392817675, 6417.069524918954, 6483.286838447672, 6498.220213574401, 6308.589941653778, 6328.778492752732, 6342.080398342307, 6412.35876412355, 6413.615183089029, 6477.514186435942, 6489.318621544669, 6490.772822951174, 6503.544751867324, 6548.869022619616, 6358.745650173942, 6387.361263873576, 6435.292117867125, 6459.418652321314, 6476.352364763675], "value": 6117.358135899798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.3215284994806, 968.9418634881907, 999.4103478947421, 1001.4692213127046, 1001.9949900250498, 42835.78582107089, 43561.0, 43606.56393436069, 43710.78144609276, 43746.56253437464, 41560.58439415605, 43849.34225986613, 44671.55328446715, 44689.776551117284, 44722.0, 8123.715669951553, 8184.468009579388, 8224.588770561479, 8227.259546640802, 8250.793730156764, 8089.635966381497, 8109.310708589777, 8145.1854814518665, 8178.059523154824, 8236.423450358478, 8253.876191857127, 8268.627911743955, 8290.41967062306, 8301.958490207571, 8302.958485207566, 8223.177682231788, 8239.134890836496, 8239.83520329593, 8242.464239824392, 8269.751907442786, 8069.878951815727, 8128.75613731589, 8131.186881311881, 8134.1052484227275, 8138.877916831252, 39923.40114898279, 40179.59820401788, 40345.394819077446, 40535.39196912049, 40602.390964135564, 3677.099110717891, 3697.5932647408763, 3717.4052151655874, 3721.5720192177973, 3721.9627803721887, 32592.0, 32730.672693273, 32780.508292375634, 32820.507692384635, 32841.50737738936, 5319.46805319465, 5469.835904922858, 5482.972585137089, 5511.53151982082, 5581.776728930838, 215725.0, 217781.0, 218626.0, 219059.9999999984, 219654.0, 51306.23040654393, 51943.480565193866, 51952.48047519552, 52090.21864672033, 52094.47905520972, 54244.45755542394, 54639.72680136653, 54758.17862732062, 54760.17859732107, 54776.0, 14391.928040359731, 14566.781498277534, 14571.562853114423, 14605.12369257848, 14699.92650036743, 11577.363245021605, 11577.826332605018, 11653.359065251492, 11663.941680291713, 11699.06407487399, 13151.736965260832, 13234.73530529384, 13274.0, 13278.2074419954, 13443.05898587109, 5323.387810401853, 5349.331333583302, 5395.163749618815, 5428.891422171613, 5465.371482279509, 1080.2992518703243, 1102.691246450995, 1102.7904698107334, 1113.760541483585, 1124.9100071994221, 25501.48997020049, 25673.358166045997, 25752.227433177035, 25787.613185802227, 25897.870510647324, 1203.536638394207, 1205.1443475132753, 1209.371127013948, 1210.189173253922, 1214.2107630040543, 13449.260290684106, 13540.052196346162, 13739.175649461064, 13813.723725525635, 13877.791833122512, 281262.0, 282022.0, 283188.0, 283269.0, 283427.0, 55898.0, 56058.439415605324, 56109.71945140248, 56630.716846416326, 56644.71677641668, 1476.343027352839, 1495.9925200373928, 1509.5471358592597, 1522.5051858146146, 1543.3672194400242, 24792.25623231306, 24856.757162141457, 24877.88049537739, 24883.87558062198, 25012.124575640493, 36872.63127368799, 36900.0, 36974.0, 36999.63000369962, 37033.0, 171136.0, 173007.0, 173170.0, 173559.0, 174065.0, 31457.685423145474, 32144.0, 34734.826325868205, 35228.0, 35330.470042948866, 45230.54769452395, 45452.54547454483, 45643.315350269106, 46190.53809461863, 46224.7688761554, 33470.832645836614, 33493.16267093342, 33849.49225761665, 34120.0, 34630.480542792386, 33331.333373331916, 33532.83233583914, 33570.496442552896, 33601.327973439904, 34001.0, 38784.418233725955, 39023.80488097541, 39163.0, 39284.60715392924, 39399.40900886431, 32467.402707698267, 32558.34883302368, 33085.83457082699, 33159.17102072467, 33284.833575831966, 24613.507729844943, 25174.370640734127, 25260.368490787143, 25839.0, 26166.0], "value": 17967.878133293743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9599628026037, 586.8620874094589, 606.7542645228684, 622.191151503046, 627.6516533324004, 23548.764512354872, 24330.635040474386, 24353.14763983261, 24353.63469547958, 24360.39099022521, 21486.462838429008, 25214.621780673304, 25503.234902952896, 25620.0, 25663.871680641572, 6607.405333519982, 6753.932460675404, 6755.324467553254, 6755.9662201688925, 6760.1549806274215, 6604.471642268631, 6682.398584127428, 6922.134733158356, 6924.757633482829, 6945.930540694604, 6798.252192258848, 6848.657567121649, 6865.588064716133, 6866.244713081557, 6868.896966545481, 6521.250056243545, 6811.0, 6814.52298339114, 6832.043513908056, 6879.071325371061, 6353.142325786052, 6353.269374022, 6355.491560675135, 6355.555111142222, 6365.936340636581, 30088.24779380533, 30357.848210758806, 30525.0, 30532.694673053207, 30561.388772224655, 2260.0959616153505, 2282.06435361501, 2286.314105768263, 2290.118304452781, 2305.1470955746313, 19585.314513991943, 20223.79776202234, 20389.388318350473, 20403.591928161353, 20445.386638400872, 2138.3050508584615, 2160.4922843131853, 2182.1707751054655, 2188.72640919885, 2304.5506126305377, 131431.0, 135855.0, 137770.0, 140211.0, 155422.22288888483, 15182.240887955779, 15757.290921908541, 15765.842341576437, 16065.0, 16203.0, 24953.750462495143, 25101.4979700405, 25109.748902511106, 25117.87441062783, 25167.24498265055, 10444.843327350096, 10518.615830173383, 10523.0, 10659.413732244646, 10743.78512429747, 9352.579133938989, 9359.812803744024, 9532.761680958032, 9557.23542116629, 9585.616575337048, 9527.857082143773, 9631.71104866841, 9645.614175432904, 10001.749956251006, 10021.699349019542, 2778.2359851041124, 2847.1743194473784, 2874.3389020525397, 2888.8589007341984, 2935.0, 1035.7928414317166, 1050.954300471021, 1055.3140458701753, 1065.4193464561833, 1068.4711068021224, 20863.0, 21100.366988990354, 21129.788702112783, 21238.681419778717, 21377.67933480999, 1105.165599972016, 1109.672646569264, 1114.5374669512223, 1127.3912087472672, 1134.6142311614092, 11576.131790115774, 11719.238249513754, 11738.765224695459, 11767.52929882795, 11826.586069487526, 588774.0, 612693.0, 614669.0, 618579.0, 618867.0, 130146.0, 130539.0, 131560.0, 133106.33446832703, 133993.0, 1106.6679996001167, 1164.295601161302, 1214.5870404062662, 1216.6775804411839, 1281.2888846690362, 21384.503084783915, 21588.488805783443, 21691.891540542198, 21869.562608748056, 21969.011394486966, 61157.69421152866, 63125.0, 63363.36636633759, 64041.0, 65106.67446662926, 77370.0, 77584.0, 79150.6042469784, 81752.59123704344, 82400.58799705963, 14802.925985370004, 15096.54710358691, 15166.469173578871, 15197.088174709554, 15220.315085821387, 22765.544689106457, 23211.535769284183, 23282.301530954097, 23516.0, 23662.29013129609, 18956.620867582846, 19320.8067919319, 19428.611427771084, 19436.222551098363, 19458.31895883637, 16601.003939763654, 16968.57578560546, 17140.314387424365, 17561.648767024843, 17707.911460442614, 18923.243070277036, 19806.405807825788, 19938.60122797565, 20116.497087572927, 20225.19099236014, 14794.408223670933, 14813.111213327235, 14891.255437228312, 14891.851081489047, 14932.253387330808, 18591.628167436305, 18705.53236169107, 18791.34230301933, 19218.61562768709, 19312.0], "value": 12648.822521542368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.7261761338927, 1436.3392839293924, 1450.282110355374, 1454.0693955868246, 1484.4581727669404, 16468.58828529286, 17134.314627414904, 17142.14289285537, 17163.313467461317, 17174.141292935365, 16671.33314667412, 16783.41258055968, 16873.0, 16873.662526749456, 16893.91553042236, 2805.116388337677, 2838.943221135576, 2887.4513842369884, 2899.709629215, 2900.651921769391, 2830.193394882459, 2856.785741069418, 2864.3268831824503, 2870.6842247352774, 2871.109955913663, 2717.361420066283, 2813.015444594386, 2824.2233385818963, 2839.1198728394265, 2840.1763488588285, 2823.68939416664, 2828.0667379764627, 2851.0876519513763, 2852.044565070704, 2852.258412812673, 2671.5859041848544, 2680.6917204521533, 2736.849473278969, 2756.2420334408, 2771.9722802772117, 16174.838251617568, 16319.510414687578, 16323.0, 16331.101789401579, 16351.018938863706, 8301.792455188668, 8668.783280417976, 8673.653053877837, 8674.6096425661, 8687.26158276541, 5507.531859791922, 5534.972325138388, 5598.664080155204, 5678.687672178028, 5679.176519404663, 2115.524007098406, 2122.8620139691025, 2124.3414541492034, 2135.7116789233564, 2169.0022589608798, 29699.70300296991, 29985.850070749726, 30049.699503004907, 30261.697383026327, 30289.24276893051, 7050.0, 7083.787486375314, 7159.105111861018, 7306.890396644055, 7337.523061001018, 18079.819201808077, 18094.45716628477, 18227.72658410125, 18242.361517346828, 18265.817341826678, 8283.83432331362, 8449.619767110495, 8462.153784621612, 8469.618867150994, 8475.533845638425, 7502.774916752506, 7564.773056808304, 7629.847403051908, 7630.122535908331, 7637.885431718529, 5481.848811749577, 5605.495505404533, 5687.573431992617, 5705.515031222392, 5725.599208055396, 1611.0736326612011, 1642.9096399697892, 1647.8599319058014, 1655.1393275496675, 1682.5625337412362, 954.9379290346105, 968.3221744778683, 978.9608415663293, 982.268210183418, 995.6017592962728, 8279.710210142615, 8297.170282971776, 8318.37612179089, 8368.790780230544, 8417.494950303002, 784.7645706288091, 794.3803833010261, 802.2378740196837, 806.4757907360146, 818.4107442641408, 5044.772985215674, 5166.225066240094, 5715.457031581993, 5786.952634496961, 5792.536597072224, 24351.391215219763, 25064.0, 25359.366015849384, 25360.0, 25599.232023039338, 24215.757842421703, 24888.004479820604, 25550.361240969123, 25572.488550228893, 25725.614115788278, 11870.94064529689, 12032.639020829389, 12152.0, 12206.938965305117, 12245.387730613435, 8308.418410711192, 8871.157240062184, 8975.551222438982, 9027.638894444148, 9097.0, 20744.688829667266, 20849.687254691496, 20940.790592093883, 21048.0, 21223.257185998416, 21492.14031438725, 21697.240596579042, 21698.0, 21824.0, 21863.89068054713, 11801.409929503663, 12041.277523348626, 12114.333711645944, 12136.150469467406, 12141.0, 13986.790198147239, 14701.264936753334, 14906.254687265377, 14925.55223343258, 14932.253387330373, 10937.289076210021, 11808.586699465477, 11843.407829608313, 12066.396680166132, 12066.939665301617, 11732.413379330828, 11772.823407649063, 12019.459124339252, 12063.21589096706, 12112.21270617407, 9880.85178722334, 10122.89877101249, 10274.948625256826, 10281.897181028095, 10294.124999375137, 7827.099883513469, 7844.9607751960875, 7894.921050789419, 7937.444378893653, 8022.598870056357, 8186.97662792151, 8234.094249632655, 8241.79395515093, 8260.586970651324, 8380.07819139882], "value": 7133.431372718619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3228527339284, 564.4919572384856, 575.1028395702704, 583.3175185033513, 589.2869627750422, 6137.324894261627, 6167.074938759189, 6297.685115744217, 6300.684965751706, 6317.526185536086, 6101.481374083197, 6110.938890611093, 6173.697072066446, 6213.751449942009, 6234.844128896769, 5078.923816142761, 5089.949100509003, 5096.617753668471, 5127.33344665193, 5127.359080114967, 5071.898562028758, 5080.41575218849, 5108.948910510903, 5119.820806271781, 5183.922241166386, 4679.766011699418, 4840.878978025542, 4854.854354369357, 4870.43989941156, 4918.89324901896, 4841.975790121027, 4949.851504454854, 4961.486746542303, 4962.702237865739, 4969.676970996874, 4461.442319710036, 4463.642908567339, 4469.262571675669, 4492.8876778080485, 4502.639788816887, 5876.353601103875, 6019.668918209497, 6025.126356678257, 6121.724522396503, 6122.663253521055, 5714.200011998323, 5762.88474230513, 5799.623024503394, 5832.533397328203, 5879.7648094076185, 6554.80335589933, 6611.669416529202, 6612.801615951529, 6613.669316534154, 6641.900371494431, 5016.724080175589, 5049.823256186016, 5061.620378471593, 5063.898722025576, 5073.441921388681, 6697.665116744143, 6817.761378351734, 6843.152348865829, 6908.550944188662, 6972.930270697329, 5015.924761128586, 5054.9241761373605, 5109.3613298337705, 5155.819546315861, 5161.819336323286, 5190.974045129826, 5191.532762051434, 5193.37679478465, 5231.71225582589, 5242.475752424803, 5648.576356773258, 5748.396418376094, 5805.448482394166, 5817.418258174149, 5855.473007429352, 6520.380563846427, 6643.335666433318, 6671.0, 6679.031540426611, 6679.131712877295, 1735.9305627775, 1752.9824701753075, 1785.5000599832067, 1791.7401976713563, 1797.164318591861, 1250.2491262353, 1252.1735654468007, 1274.4583551990368, 1281.7949128139453, 1281.8397700287464, 6094.939050609526, 6106.6336019838955, 6159.907601385983, 6162.938370616236, 6210.223722034746, 6643.734250629921, 6661.766838160641, 6677.165354330708, 6689.397954184049, 6704.865902681919, 6011.788396807459, 6129.659335662075, 6160.969195153995, 6185.969070154621, 6196.907046394308, 3430.4168291390024, 3488.8081155536183, 3502.6689857854362, 3505.614382417932, 3538.398472259722, 6897.48268879826, 6899.724011039602, 6915.654217289115, 6935.133108361455, 7024.613646249403, 6730.293319201512, 6860.588364698134, 6862.245153033262, 6866.141732283465, 6917.584944903322, 6748.561343512656, 6920.858058420305, 6996.195437524546, 7022.157341119098, 7029.29707029293, 6642.800715978528, 6660.866782664222, 6667.43326817226, 6694.129763130762, 6735.360140786617, 6508.251551071498, 6521.3698274225835, 6665.166854143232, 6670.366315200048, 6684.4652427804685, 6759.459243260429, 6816.079829223189, 6830.45356371499, 6858.610489286761, 6882.552634078769, 5043.773030213576, 5069.92395114081, 5073.720945348041, 5085.262636917701, 5091.236314552847, 6456.806295811133, 6606.570572912745, 6657.966710166418, 6680.5991640501725, 6764.289749576224, 6064.272287325549, 6315.873682526232, 6443.903341449975, 6473.2232132144445, 6486.254080780582, 6501.414872661483, 6505.674716264262, 6506.722647073487, 6508.381703738138, 6544.640044797582, 6460.160179176677, 6475.579087359307, 6480.481561474976, 6494.805155845333, 6545.639989800607, 6424.518161138027, 6512.446442052289, 6574.868502630016, 6575.00299772167, 6577.769778057745, 6210.192674952227, 6258.904691678847, 6279.654618995816, 6291.591046581958, 6293.559450838397], "value": 5129.760587016639, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [990.6428193375075, 1007.098646711193, 1008.7478130467383, 1010.1615659003028, 1012.0688966151142, 20544.89727551362, 20849.37451876444, 20947.581048379023, 21063.2627858025, 21159.682604760903, 20190.49523761903, 20560.07479663415, 20560.280390186348, 20575.485612859688, 20593.0, 1064.0, 1080.8540846985634, 1081.7133459633203, 1081.7187531241893, 1082.1505118481994, 1078.8651418572679, 1116.681745702475, 1126.9098472122212, 1127.5489804078393, 1130.0789856267115, 1161.6863446869384, 1164.1385374822612, 1168.3574034281112, 1168.8947994680477, 1170.075640244206, 1103.7516558774253, 1139.6182278936567, 1140.6635042662435, 1143.9142064345165, 1158.9768204635945, 823.1028179284608, 831.4969443486664, 831.584207896052, 831.6216121664688, 831.6423937706784, 21004.579908401745, 21943.890280548654, 21947.122115115377, 22061.779382206132, 22180.445488862748, 23207.303780886432, 23614.76385236143, 23877.880610596836, 23898.0, 23910.282691519107, 18496.63006739871, 18503.81496185048, 18585.628287434312, 18633.906830465898, 18648.906755466134, 3910.804459777, 3933.350997085506, 3950.0519875230025, 3986.362182050858, 4020.557738648746, 159728.20135899363, 161697.20770062556, 163194.0, 163671.0, 167171.0, 17225.483235502954, 17610.38363657266, 17766.46700598984, 17767.555811104827, 17793.7330940036, 34719.65280347215, 35080.12299692477, 35254.118647033516, 35709.0, 35719.4642080369, 8498.532580707997, 8534.359923005799, 8642.0, 8660.566971651393, 8662.30701543875, 4354.629856462237, 4425.026494171278, 4449.710768800018, 4485.887852803706, 4493.775311234425, 5811.680357580373, 5874.73563689635, 5890.4993075589055, 5916.7337469813965, 5957.910631340534, 1009.848522721583, 1038.7922415516775, 1054.4727636181908, 1054.852320675106, 1056.5826498533036, 639.8560323927079, 650.0703993289546, 664.4518272425269, 673.2224280955504, 674.8312921769558, 13071.738565228643, 13587.388567514485, 13792.448302067805, 13903.79144312836, 13920.37358318878, 736.3851184261202, 740.9925900741032, 741.0810594862332, 749.4603885202646, 761.2539711083059, 6045.455908968214, 6075.5747097703625, 6160.691965401712, 6192.845178870474, 6249.843753906189, 156820.21589892206, 157387.0, 157809.0, 157838.0, 157944.0, 118367.0, 134803.0, 134966.0, 135298.3235083818, 137264.0, 117971.0, 119252.0, 119425.40287298508, 121999.39000304764, 122176.0, 14973.925130374279, 15059.472918447802, 15328.080315181125, 15524.0, 15534.844651553793, 53680.73159634177, 53860.461395385544, 54246.45753542414, 54870.0, 55114.72442637761, 70926.64536677283, 72008.0, 72133.639331803, 72903.0, 73767.0, 20307.898460507604, 20529.89735051375, 21308.36074917755, 21310.14759409668, 21367.679484807428, 23201.535969280183, 23496.647550286416, 23638.17266395668, 23899.761002389754, 23923.16268930579, 21776.0, 21824.12703491906, 21875.343739687836, 22073.227437039626, 22240.110395583997, 18332.816671833112, 18487.53781155482, 18548.0, 18566.0, 18674.906625466785, 18732.344367947055, 18770.24919003279, 18875.0, 18969.810301896803, 19058.332958346393, 15448.922755386151, 15540.922295388451, 15627.531174064796, 15640.687186255984, 15732.68534629324, 15505.84494155044, 15761.527154185393, 16084.43704470338, 16227.107509087113, 16272.267747951608], "value": 10316.811090817577, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1374.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 104.0, 106.0, 108.0, 106.0, 109.0, 105.0, 106.0, 107.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 114.0, 112.0, 112.0, 119.0, 113.0, 114.0, 140.0, 110.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 160.0, 161.0, 164.0, 161.0, 162.0, 161.0, 165.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 74.0, 73.0, 77.0, 74.0, 74.0, 73.0, 72.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 77.0, 77.0, 77.0, 79.0, 78.0, 77.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 113.0, 111.0, 114.0, 115.0, 114.0, 111.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 152.0, 150.0, 149.0, 149.0, 150.0, 149.0, 153.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 93.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": [44.0, 44.0, 44.0, 45.0, 46.0, 45.0, 43.0, 42.0, 43.0, 45.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0, 37.0, 38.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 72.0, 80.0, 71.0, 75.0, 79.0, 75.0, 75.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 113.0, 106.0, 107.0, 113.0, 108.0, 108.0, 104.0, 113.0], "value": 108.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 153.0, 156.0, 153.0, 156.0, 159.0, 160.0, 156.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 60.0, 59.0, 58.0, 60.0, 60.0, 61.0], "value": 59.6, "unit": "score"}]}]} 21:55:22 INFO - Return code: 0 21:55:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:22 INFO - # TBPL SUCCESS # 21:55:22 INFO - Running post-action listener: _package_coverage_data 21:55:22 INFO - Running post-action listener: _resource_record_post_action 21:55:22 INFO - [mozharness: 2017-09-17 04:55:22.099264Z] Finished run-tests step (success) 21:55:22 INFO - Running post-run listener: _resource_record_post_run 21:55:22 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333807616; Read time: 12; Write time: 237292 21:55:22 INFO - TinderboxPrint: CPU usage
13.1% 21:55:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:55:22 INFO - TinderboxPrint: I/O write bytes / time
333,807,616 / 237,292 21:55:22 INFO - TinderboxPrint: CPU idle
8,220.1 (86.9%) 21:55:22 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 21:55:22 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12587008; Read time: 0; Write time: 3036 21:55:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 21:55:22 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320196608; Read time: 12; Write time: 234232 21:55:22 INFO - Running post-run listener: _upload_blobber_files 21:55:22 INFO - Blob upload gear active. 21:55:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:55:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:55:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:55:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:24 INFO - (blobuploader) - INFO - Done attempting. 21:55:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:31 INFO - (blobuploader) - INFO - Done attempting. 21:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:55:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:32 INFO - (blobuploader) - INFO - Done attempting. 21:55:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:55:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:33 INFO - (blobuploader) - INFO - Done attempting. 21:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:33 INFO - Return code: 0 21:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbecb7827456d8286e54302213064695983badcfc3d9df173a1198860267e638358f2ed424ee1afba16535c8f57ad189ede73ad7180992d48af6136b76edc5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a845e7eefd610f8e4d25782c2996f0e0cc7d3094b5332b6d62007a91ed3e12ef47d3c33cfd272cc13fe9a23958f96c04b91fb4d9f3e3813880ea3c4d606881cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4879b0cf78ec0cea83180412e1fd2913bc7beec7ec927caa31ad0a5455a3a9fc15fb8f49b143566677d5deccd0e8a3ecb4f9913e87545052d28ece73239adc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5021a978a87801cf08a48e1e40aff9eb5c59e95af8f3129deb0f0e031e5d851106b655a70afa8fc3261e8fa444e18cbced451c007d86a0c3801c6c6ec1420de"} 21:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:33 INFO - Contents: 21:55:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbecb7827456d8286e54302213064695983badcfc3d9df173a1198860267e638358f2ed424ee1afba16535c8f57ad189ede73ad7180992d48af6136b76edc5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a845e7eefd610f8e4d25782c2996f0e0cc7d3094b5332b6d62007a91ed3e12ef47d3c33cfd272cc13fe9a23958f96c04b91fb4d9f3e3813880ea3c4d606881cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4879b0cf78ec0cea83180412e1fd2913bc7beec7ec927caa31ad0a5455a3a9fc15fb8f49b143566677d5deccd0e8a3ecb4f9913e87545052d28ece73239adc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5021a978a87801cf08a48e1e40aff9eb5c59e95af8f3129deb0f0e031e5d851106b655a70afa8fc3261e8fa444e18cbced451c007d86a0c3801c6c6ec1420de"} 21:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:33 INFO - Copying logs to upload dir... 21:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.655992 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-16 21:55:33.444604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:33.447882) ========= 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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 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/d8dbecb7827456d8286e54302213064695983badcfc3d9df173a1198860267e638358f2ed424ee1afba16535c8f57ad189ede73ad7180992d48af6136b76edc5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a845e7eefd610f8e4d25782c2996f0e0cc7d3094b5332b6d62007a91ed3e12ef47d3c33cfd272cc13fe9a23958f96c04b91fb4d9f3e3813880ea3c4d606881cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4879b0cf78ec0cea83180412e1fd2913bc7beec7ec927caa31ad0a5455a3a9fc15fb8f49b143566677d5deccd0e8a3ecb4f9913e87545052d28ece73239adc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5021a978a87801cf08a48e1e40aff9eb5c59e95af8f3129deb0f0e031e5d851106b655a70afa8fc3261e8fa444e18cbced451c007d86a0c3801c6c6ec1420de"} build_url:https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/FH5rI8fZSoORX0XmnXiq8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8dbecb7827456d8286e54302213064695983badcfc3d9df173a1198860267e638358f2ed424ee1afba16535c8f57ad189ede73ad7180992d48af6136b76edc5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a845e7eefd610f8e4d25782c2996f0e0cc7d3094b5332b6d62007a91ed3e12ef47d3c33cfd272cc13fe9a23958f96c04b91fb4d9f3e3813880ea3c4d606881cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d4879b0cf78ec0cea83180412e1fd2913bc7beec7ec927caa31ad0a5455a3a9fc15fb8f49b143566677d5deccd0e8a3ecb4f9913e87545052d28ece73239adc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5021a978a87801cf08a48e1e40aff9eb5c59e95af8f3129deb0f0e031e5d851106b655a70afa8fc3261e8fa444e18cbced451c007d86a0c3801c6c6ec1420de"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:33.476763) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:33.477110) ========= 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=4300f881736b422476174874000001bc-1505622241.557488-1572689264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 21:55:33.560418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:55:33.560750) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 21:55:33.561106) ========= ========= Total master_lag: 0.27 =========