builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1505369577.08 results: success (0) revision: 6f08f91f8db00d385e5d564b0102bf0dece39f6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.084287) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.089123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.089422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.135293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.135578) ========= 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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 23:12:57-- 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% 66.5K=0.2s 2017-09-13 23:12:57 (66.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.302891 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.458565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.458898) ========= 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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019776 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.510943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:57.511252) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6f08f91f8db00d385e5d564b0102bf0dece39f6f --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 6f08f91f8db00d385e5d564b0102bf0dece39f6f --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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 23:12:57,581 truncating revision to first 12 chars 2017-09-13 23:12:57,581 Setting DEBUG logging. 2017-09-13 23:12:57,582 attempt 1/10 2017-09-13 23:12:57,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6f08f91f8db0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 23:12:57,946 unpacking tar archive at: mozilla-central-6f08f91f8db0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:58.187760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:58.188070) ========= script_repo_revision: 6f08f91f8db00d385e5d564b0102bf0dece39f6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:58.188454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:58.188776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 23:12:58.202584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 23:12:58.203022) ========= /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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:12:58 INFO - MultiFileLogger online at 20170913 23:12:58 in /builds/slave/test 23:12:58 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 23:12:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:12:58 INFO - {'append_to_log': False, 23:12:58 INFO - 'base_work_dir': '/builds/slave/test', 23:12:58 INFO - 'blob_upload_branch': 'Firefox', 23:12:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:12:58 INFO - 'branch': 'Firefox', 23:12:58 INFO - 'buildbot_json_path': 'buildprops.json', 23:12:58 INFO - 'code_coverage': False, 23:12:58 INFO - 'config_files': ('talos/linux_config.py',), 23:12:58 INFO - 'default_actions': ('clobber', 23:12:58 INFO - 'read-buildbot-config', 23:12:58 INFO - 'download-and-extract', 23:12:58 INFO - 'populate-webroot', 23:12:58 INFO - 'create-virtualenv', 23:12:58 INFO - 'install', 23:12:58 INFO - 'setup-mitmproxy', 23:12:58 INFO - 'run-tests'), 23:12:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:12:58 INFO - 'disable_ccov_upload': False, 23:12:58 INFO - 'disable_stylo': False, 23:12:58 INFO - 'download_minidump_stackwalk': True, 23:12:58 INFO - 'download_symbols': 'ondemand', 23:12:58 INFO - 'enable_stylo': False, 23:12:58 INFO - 'enable_webrender': False, 23:12:58 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 23:12:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:12:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:12:58 INFO - 'gecko_profile': False, 23:12:58 INFO - 'gecko_profile_interval': 0, 23:12:58 INFO - 'installer_path': 'installer.exe', 23:12:58 INFO - 'log_level': 'info', 23:12:58 INFO - 'log_name': 'talos', 23:12:58 INFO - 'log_to_console': True, 23:12:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:12:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:12:58 INFO - 'opt_config_files': (), 23:12:58 INFO - 'pip_index': False, 23:12:58 INFO - 'suite': 'dromaeojs-e10s', 23:12:58 INFO - 'system_bits': '32', 23:12:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:12:58 INFO - 'title': 'talos-linux64-ix-050', 23:12:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:12:58 INFO - 'use_talos_json': True, 23:12:58 INFO - 'verify': 'False', 23:12:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:12:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:12:58 INFO - 'work_dir': 'build'} 23:12:58 INFO - [mozharness: 2017-09-14 06:12:58.414781Z] Running clobber step. 23:12:58 INFO - Running pre-action listener: _resource_record_pre_action 23:12:58 INFO - Running main action method: clobber 23:12:58 INFO - rmtree: /builds/slave/test/build 23:12:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:12:59 INFO - Running post-action listener: _resource_record_post_action 23:12:59 INFO - [mozharness: 2017-09-14 06:12:59.407011Z] Finished clobber step (success) 23:12:59 INFO - [mozharness: 2017-09-14 06:12:59.407108Z] Running read-buildbot-config step. 23:12:59 INFO - Running pre-action listener: _resource_record_pre_action 23:12:59 INFO - Running main action method: read_buildbot_config 23:12:59 INFO - Using buildbot properties: 23:12:59 INFO - { 23:12:59 INFO - "project": "", 23:12:59 INFO - "product": "firefox", 23:12:59 INFO - "who": "jdolske@mozilla.com", 23:12:59 INFO - "installer_path": "public/build/target.tar.bz2", 23:12:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:12:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:12:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 23:12:59 INFO - "stage_platform": "linux64-pgo", 23:12:59 INFO - "basedir": "/builds/slave/test", 23:12:59 INFO - "buildnumber": 153, 23:12:59 INFO - "platform": "ubuntu64_hw", 23:12:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:12:59 INFO - "slavebuilddir": "test", 23:12:59 INFO - "taskId": "WC0ZemTDSsSJVrirS52NVg", 23:12:59 INFO - "branch": "mozilla-central", 23:12:59 INFO - "script_repo_revision": "production", 23:12:59 INFO - "revision": "6f08f91f8db00d385e5d564b0102bf0dece39f6f", 23:12:59 INFO - "slavename": "talos-linux64-ix-050", 23:12:59 INFO - "repo_path": "mozilla-central" 23:12:59 INFO - } 23:12:59 INFO - Finding installer, test and symbols from parent task. 23:12:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WC0ZemTDSsSJVrirS52NVg'}, attempt #1 23:12:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WC0ZemTDSsSJVrirS52NVg'}, attempt #1 23:13:00 INFO - Task dependencies: TUtDcFL-SUiSRm6PvaFZsA 23:13:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA'}, attempt #1 23:13:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 23:13:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.test_packages.json 23:13:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.crashreporter-symbols.zip 23:13:00 INFO - Running post-action listener: _resource_record_post_action 23:13:00 INFO - [mozharness: 2017-09-14 06:13:00.853759Z] Finished read-buildbot-config step (success) 23:13:00 INFO - [mozharness: 2017-09-14 06:13:00.853976Z] Running download-and-extract step. 23:13:00 INFO - Running pre-action listener: _resource_record_pre_action 23:13:00 INFO - Running main action method: download_and_extract 23:13:00 INFO - mkdir: /builds/slave/test/build/tests 23:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:00 INFO - trying https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.test_packages.json 23:13:00 INFO - Downloading https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:13:01 INFO - Downloaded 989 bytes. 23:13:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:13:01 INFO - Using the following test package requirements: 23:13:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:13:01 INFO - u'common': [u'target.common.tests.zip'], 23:13:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:13:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:13:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:13:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:13:01 INFO - u'mozbase': [u'target.common.tests.zip'], 23:13:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:13:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:13:01 INFO - u'web-platform': [u'target.common.tests.zip', 23:13:01 INFO - u'target.web-platform.tests.tar.gz'], 23:13:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:13:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 23:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.common.tests.zip 23:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.common.tests.zip into memory 23:13:03 INFO - Content-Length response header: 55170481 23:13:03 INFO - Bytes received: 55170481 23:13:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.talos.tests.zip 23:13:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:13:14 INFO - Fetch https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.talos.tests.zip into memory 23:13:16 INFO - Content-Length response header: 14500356 23:13:16 INFO - Bytes received: 14500356 23:13: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')]} 23:13:16 INFO - trying https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 23:13:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:13:19 INFO - Downloaded 62138877 bytes. 23:13:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 23:13:19 INFO - mkdir: /builds/slave/test/properties 23:13:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:13:19 INFO - Writing to file /builds/slave/test/properties/build_url 23:13:19 INFO - Contents: 23:13:19 INFO - build_url:https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 23:13:19 INFO - Running post-action listener: _resource_record_post_action 23:13:19 INFO - Running post-action listener: find_tests_for_verification 23:13:19 INFO - Running post-action listener: set_extra_try_arguments 23:13:19 INFO - [mozharness: 2017-09-14 06:13:19.353374Z] Finished download-and-extract step (success) 23:13:19 INFO - [mozharness: 2017-09-14 06:13:19.353473Z] Running populate-webroot step. 23:13:19 INFO - Running pre-action listener: _resource_record_pre_action 23:13:19 INFO - Running main action method: populate_webroot 23:13:19 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:13:19 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['tresize', 23:13:19 INFO - 'tcanvasmark']}, 23:13:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:13:19 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['dromaeo_css', 23:13:19 INFO - 'kraken']}, 23:13:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:13:19 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:13:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'tests': ['damp', 'tps']}, 23:13:19 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['damp', 'tps']}, 23:13:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:13:19 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['dromaeo_dom']}, 23:13:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:13:19 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['basic_compositor_video', 23:13:19 INFO - 'glvideo']}, 23:13:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:13:19 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['ts_paint_webext', 23:13:19 INFO - 'tp5o_webext']}, 23:13:19 INFO - 'other-e10s': {'tests': ['a11yr', 23:13:19 INFO - 'ts_paint', 23:13:19 INFO - 'tpaint', 23:13:19 INFO - 'sessionrestore', 23:13:19 INFO - 'sessionrestore_many_windows', 23:13:19 INFO - 'sessionrestore_no_auto_restore', 23:13:19 INFO - 'tabpaint']}, 23:13:19 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['a11yr', 23:13:19 INFO - 'ts_paint', 23:13:19 INFO - 'tpaint', 23:13:19 INFO - 'sessionrestore', 23:13:19 INFO - 'sessionrestore_many_windows', 23:13:19 INFO - 'sessionrestore_no_auto_restore', 23:13:19 INFO - 'tabpaint']}, 23:13:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:13:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:13:19 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['bloom_basic_singleton']}, 23:13:19 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['bloom_basic']}, 23:13:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:13:19 INFO - 'tsvgr_opacity', 23:13:19 INFO - 'tart', 23:13:19 INFO - 'tscrollx', 23:13:19 INFO - 'tsvg_static']}, 23:13:19 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['tsvgx', 23:13:19 INFO - 'tsvgr_opacity', 23:13:19 INFO - 'tart', 23:13:19 INFO - 'tscrollx', 23:13:19 INFO - 'tsvg_static']}, 23:13:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:13:19 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo'], 23:13:19 INFO - 'tests': ['tp5o']}, 23:13:19 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:13:19 INFO - 'talos_options': ['--mitmproxy', 23:13:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:13:19 INFO - '--firstNonBlankPaint'], 23:13:19 INFO - 'tests': ['tp6_google', 23:13:19 INFO - 'tp6_youtube', 23:13:19 INFO - 'tp6_amazon', 23:13:19 INFO - 'tp6_facebook']}, 23:13:19 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo', 23:13:19 INFO - '--mitmproxy', 23:13:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:13:19 INFO - '--firstNonBlankPaint'], 23:13:19 INFO - 'tests': ['tp6_google', 23:13:19 INFO - 'tp6_youtube', 23:13:19 INFO - 'tp6_amazon', 23:13:19 INFO - 'tp6_facebook']}, 23:13:19 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:13:19 INFO - 'talos_options': ['--stylo-threads=1', 23:13:19 INFO - '--mitmproxy', 23:13:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:13:19 INFO - '--firstNonBlankPaint'], 23:13:19 INFO - 'tests': ['tp6_google', 23:13:19 INFO - 'tp6_youtube', 23:13:19 INFO - 'tp6_amazon', 23:13:19 INFO - 'tp6_facebook']}, 23:13:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--xperf_path', 23:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:13:19 INFO - 'tests': ['tp5n']}, 23:13:19 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 23:13:19 INFO - 'talos_options': ['--disable-stylo', 23:13:19 INFO - '--xperf_path', 23:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:13:19 INFO - 'tests': ['tp5n']}}} 23:13:19 INFO - Running post-action listener: _resource_record_post_action 23:13:19 INFO - [mozharness: 2017-09-14 06:13:19.368413Z] Finished populate-webroot step (success) 23:13:19 INFO - [mozharness: 2017-09-14 06:13:19.368503Z] Running create-virtualenv step. 23:13:19 INFO - Running pre-action listener: _resource_record_pre_action 23:13:19 INFO - Running main action method: create_virtualenv 23:13:19 INFO - Creating virtualenv /builds/slave/test/build/venv 23:13:19 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:13:19 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 23:13:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:13:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:13:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:13:19 INFO - Installing distribute.............................................................................................................................................................................................done. 23:13:20 INFO - Installing pip...............done. 23:13:20 INFO - Return code: 0 23:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:13:20 INFO - Reading from file tmpfile_stdout 23:13:20 INFO - Output received: 23:13:20 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 23:13:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:13:20 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')]} 23:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:20 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')]} 23:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:20 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:20 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 23:13:20 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 23:13:20 INFO - Using env: {'DISPLAY': ':0', 23:13:20 INFO - 'HOME': '/home/cltbld', 23:13:20 INFO - 'LANG': 'en_US.UTF-8', 23:13:20 INFO - 'LANGUAGE': 'en_US:en', 23:13:20 INFO - 'LOGNAME': 'cltbld', 23:13:20 INFO - 'MAIL': '/var/mail/cltbld', 23:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:20 INFO - 'MOZ_NO_REMOTE': '1', 23:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:20 INFO - 'NO_EM_RESTART': '1', 23:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:20 INFO - 'PWD': '/builds/slave/test', 23:13:20 INFO - 'SHELL': '/bin/bash', 23:13:20 INFO - 'SHLVL': '1', 23:13:20 INFO - 'TERM': 'linux', 23:13:20 INFO - 'TMOUT': '86400', 23:13:20 INFO - 'USER': 'cltbld', 23:13:20 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:20 INFO - '_': '/tools/buildbot/bin/python'} 23:13:21 INFO - Ignoring indexes: http://pypi.python.org/simple/ 23:13:21 INFO - Downloading/unpacking pip>=1.5 23:13:21 INFO - Running setup.py egg_info for package pip 23:13:21 INFO - warning: no files found matching 'pip/cacert.pem' 23:13:21 INFO - warning: no files found matching '*.html' under directory 'docs' 23:13:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:13:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:13:21 INFO - Installing collected packages: pip 23:13:21 INFO - Found existing installation: pip 1.1 23:13:21 INFO - Uninstalling pip: 23:13:21 INFO - Successfully uninstalled pip 23:13:21 INFO - Running setup.py install for pip 23:13:21 INFO - warning: no files found matching 'pip/cacert.pem' 23:13:21 INFO - warning: no files found matching '*.html' under directory 'docs' 23:13:21 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 23:13:21 INFO - no previously-included directories found matching 'docs/_build/_sources' 23:13:21 INFO - Installing pip script to /builds/slave/test/build/venv/bin 23:13:21 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 23:13:21 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 23:13:21 INFO - Successfully installed pip 23:13:21 INFO - Cleaning up... 23:13:21 INFO - Return code: 0 23:13:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:13: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')]} 23:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13: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')]} 23:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13: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', '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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:13: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 psutil>=3.1.1 23:13:21 INFO - Using env: {'DISPLAY': ':0', 23:13:21 INFO - 'HOME': '/home/cltbld', 23:13:21 INFO - 'LANG': 'en_US.UTF-8', 23:13:21 INFO - 'LANGUAGE': 'en_US:en', 23:13:21 INFO - 'LOGNAME': 'cltbld', 23:13:21 INFO - 'MAIL': '/var/mail/cltbld', 23:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:21 INFO - 'MOZ_NO_REMOTE': '1', 23:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:21 INFO - 'NO_EM_RESTART': '1', 23:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:21 INFO - 'PWD': '/builds/slave/test', 23:13:21 INFO - 'SHELL': '/bin/bash', 23:13:21 INFO - 'SHLVL': '1', 23:13:21 INFO - 'TERM': 'linux', 23:13:21 INFO - 'TMOUT': '86400', 23:13:21 INFO - 'USER': 'cltbld', 23:13:21 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:21 INFO - '_': '/tools/buildbot/bin/python'} 23:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:21 INFO - Downloading/unpacking psutil>=3.1.1 23:13:21 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 23:13:21 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 23:13:21 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 23:13:21 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 23:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:13:22 INFO - Installing collected packages: psutil 23:13:22 INFO - Running setup.py install for psutil 23:13:23 INFO - building 'psutil._psutil_linux' extension 23:13:23 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 23:13:23 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 23:13:23 INFO - building 'psutil._psutil_posix' extension 23:13:23 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 23:13:23 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 23:13:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:13:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:13:23 INFO - Successfully installed psutil 23:13:23 INFO - Cleaning up... 23:13:23 INFO - Return code: 0 23:13:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:13:23 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')]} 23:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:23 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')]} 23:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:23 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:23 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 23:13:23 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 23:13:23 INFO - Using env: {'DISPLAY': ':0', 23:13:23 INFO - 'HOME': '/home/cltbld', 23:13:23 INFO - 'LANG': 'en_US.UTF-8', 23:13:23 INFO - 'LANGUAGE': 'en_US:en', 23:13:23 INFO - 'LOGNAME': 'cltbld', 23:13:23 INFO - 'MAIL': '/var/mail/cltbld', 23:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:23 INFO - 'MOZ_NO_REMOTE': '1', 23:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:23 INFO - 'NO_EM_RESTART': '1', 23:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:23 INFO - 'PWD': '/builds/slave/test', 23:13:23 INFO - 'SHELL': '/bin/bash', 23:13:23 INFO - 'SHLVL': '1', 23:13:23 INFO - 'TERM': 'linux', 23:13:23 INFO - 'TMOUT': '86400', 23:13:23 INFO - 'USER': 'cltbld', 23:13:23 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:23 INFO - '_': '/tools/buildbot/bin/python'} 23:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:13: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 23:13: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 23:13: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 23:13: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 23:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:13:24 INFO - Installing collected packages: mozsystemmonitor 23:13:24 INFO - Running setup.py install for mozsystemmonitor 23:13:25 INFO - Successfully installed mozsystemmonitor 23:13:25 INFO - Cleaning up... 23:13:25 INFO - Return code: 0 23:13:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:13:25 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')]} 23:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:25 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')]} 23:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:25 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:25 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 23:13:25 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 23:13:25 INFO - Using env: {'DISPLAY': ':0', 23:13:25 INFO - 'HOME': '/home/cltbld', 23:13:25 INFO - 'LANG': 'en_US.UTF-8', 23:13:25 INFO - 'LANGUAGE': 'en_US:en', 23:13:25 INFO - 'LOGNAME': 'cltbld', 23:13:25 INFO - 'MAIL': '/var/mail/cltbld', 23:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:25 INFO - 'MOZ_NO_REMOTE': '1', 23:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:25 INFO - 'NO_EM_RESTART': '1', 23:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:25 INFO - 'PWD': '/builds/slave/test', 23:13:25 INFO - 'SHELL': '/bin/bash', 23:13:25 INFO - 'SHLVL': '1', 23:13:25 INFO - 'TERM': 'linux', 23:13:25 INFO - 'TMOUT': '86400', 23:13:25 INFO - 'USER': 'cltbld', 23:13:25 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:25 INFO - '_': '/tools/buildbot/bin/python'} 23:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 23:13: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 23:13: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 23:13: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 23:13: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 23:13:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:13:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 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 23:13:27 INFO - Downloading functools32-3.2.3-2.tar.gz 23:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:13:27 INFO - warning: no files found matching '*.txt' 23:13:27 INFO - no previously-included directories found matching 'build' 23:13:27 INFO - no previously-included directories found matching 'dist' 23:13:27 INFO - no previously-included directories found matching '.git*' 23:13:27 INFO - Installing collected packages: jsonschema, functools32 23:13:27 INFO - Running setup.py install for functools32 23:13:28 INFO - warning: no files found matching '*.txt' 23:13:28 INFO - no previously-included directories found matching 'build' 23:13:28 INFO - no previously-included directories found matching 'dist' 23:13:28 INFO - no previously-included directories found matching '.git*' 23:13:28 INFO - Successfully installed jsonschema functools32 23:13:28 INFO - Cleaning up... 23:13:28 INFO - Return code: 0 23:13:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:13:28 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')]} 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:28 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')]} 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:28 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:28 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 23:13:28 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 23:13:28 INFO - Using env: {'DISPLAY': ':0', 23:13:28 INFO - 'HOME': '/home/cltbld', 23:13:28 INFO - 'LANG': 'en_US.UTF-8', 23:13:28 INFO - 'LANGUAGE': 'en_US:en', 23:13:28 INFO - 'LOGNAME': 'cltbld', 23:13:28 INFO - 'MAIL': '/var/mail/cltbld', 23:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:28 INFO - 'MOZ_NO_REMOTE': '1', 23:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:28 INFO - 'NO_EM_RESTART': '1', 23:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:28 INFO - 'PWD': '/builds/slave/test', 23:13:28 INFO - 'SHELL': '/bin/bash', 23:13:28 INFO - 'SHLVL': '1', 23:13:28 INFO - 'TERM': 'linux', 23:13:28 INFO - 'TMOUT': '86400', 23:13:28 INFO - 'USER': 'cltbld', 23:13:28 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:28 INFO - '_': '/tools/buildbot/bin/python'} 23:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:13:28 INFO - Cleaning up... 23:13:28 INFO - Return code: 0 23:13:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:13:28 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')]} 23:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:28 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')]} 23:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:28 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:28 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 23:13:28 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 23:13:28 INFO - Using env: {'DISPLAY': ':0', 23:13:28 INFO - 'HOME': '/home/cltbld', 23:13:28 INFO - 'LANG': 'en_US.UTF-8', 23:13:28 INFO - 'LANGUAGE': 'en_US:en', 23:13:28 INFO - 'LOGNAME': 'cltbld', 23:13:28 INFO - 'MAIL': '/var/mail/cltbld', 23:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:28 INFO - 'MOZ_NO_REMOTE': '1', 23:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:28 INFO - 'NO_EM_RESTART': '1', 23:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:28 INFO - 'PWD': '/builds/slave/test', 23:13:28 INFO - 'SHELL': '/bin/bash', 23:13:28 INFO - 'SHLVL': '1', 23:13:28 INFO - 'TERM': 'linux', 23:13:28 INFO - 'TMOUT': '86400', 23:13:28 INFO - 'USER': 'cltbld', 23:13:28 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:28 INFO - '_': '/tools/buildbot/bin/python'} 23:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:28 INFO - Downloading/unpacking blobuploader==1.2.4 23:13:28 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 23:13:28 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 23:13:28 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 23:13:28 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 23:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 23:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:13:29 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 23:13:29 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 23:13:29 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 23:13:29 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 23:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:13:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:13:30 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 23:13:30 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 23:13:30 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 23:13:30 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 23:13:30 INFO - Downloading docopt-0.6.1.tar.gz 23:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 23:13:30 INFO - Running setup.py install for blobuploader 23:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:13:30 INFO - Running setup.py install for requests 23:13:30 INFO - Running setup.py install for docopt 23:13:30 INFO - Successfully installed blobuploader requests docopt 23:13:30 INFO - Cleaning up... 23:13:30 INFO - Return code: 0 23:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13:30 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')]} 23:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:30 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')]} 23:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:30 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:30 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 23:13:30 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 23:13:30 INFO - Using env: {'DISPLAY': ':0', 23:13:30 INFO - 'HOME': '/home/cltbld', 23:13:30 INFO - 'LANG': 'en_US.UTF-8', 23:13:30 INFO - 'LANGUAGE': 'en_US:en', 23:13:30 INFO - 'LOGNAME': 'cltbld', 23:13:30 INFO - 'MAIL': '/var/mail/cltbld', 23:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:30 INFO - 'MOZ_NO_REMOTE': '1', 23:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:30 INFO - 'NO_EM_RESTART': '1', 23:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:30 INFO - 'PWD': '/builds/slave/test', 23:13:30 INFO - 'SHELL': '/bin/bash', 23:13:30 INFO - 'SHLVL': '1', 23:13:30 INFO - 'TERM': 'linux', 23:13:30 INFO - 'TMOUT': '86400', 23:13:30 INFO - 'USER': 'cltbld', 23:13:30 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:30 INFO - '_': '/tools/buildbot/bin/python'} 23:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:13:31 INFO - Running setup.py (path:/tmp/pip-mfjx0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:13:31 INFO - Running setup.py (path:/tmp/pip-zoImPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:13:31 INFO - Running setup.py (path:/tmp/pip-_ObzEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:13:31 INFO - Running setup.py (path:/tmp/pip-r14Kq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:13:31 INFO - Running setup.py (path:/tmp/pip-Z4Y7I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:13:31 INFO - Running setup.py (path:/tmp/pip-dkNscS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:13:31 INFO - Running setup.py (path:/tmp/pip-8x4hCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:13:31 INFO - Running setup.py (path:/tmp/pip-s3xS6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:13:31 INFO - Running setup.py (path:/tmp/pip-2k4sgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:13:31 INFO - Running setup.py (path:/tmp/pip-kuomdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:13:31 INFO - Running setup.py (path:/tmp/pip-E13R_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:13:31 INFO - Running setup.py (path:/tmp/pip-W_DHEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:13:31 INFO - Running setup.py (path:/tmp/pip-Q72M2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:13:31 INFO - Running setup.py (path:/tmp/pip-W0Kb81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:32 INFO - Running setup.py (path:/tmp/pip-VHtKwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:13:32 INFO - Running setup.py (path:/tmp/pip-HgNrKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:13:32 INFO - Running setup.py (path:/tmp/pip-oud3XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:13:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:13:32 INFO - Running setup.py install for manifestparser 23:13:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Running setup.py install for mozcrash 23:13:32 INFO - Running setup.py install for mozdebug 23:13:32 INFO - Running setup.py install for mozdevice 23:13:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Running setup.py install for mozfile 23:13:32 INFO - Running setup.py install for mozhttpd 23:13:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Running setup.py install for mozinfo 23:13:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Running setup.py install for mozInstall 23:13:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:13:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Running setup.py install for mozleak 23:13:33 INFO - Running setup.py install for mozlog 23:13:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Running setup.py install for moznetwork 23:13:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Running setup.py install for mozprocess 23:13:33 INFO - Running setup.py install for mozprofile 23:13:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Running setup.py install for mozrunner 23:13:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Running setup.py install for mozscreenshot 23:13:33 INFO - Running setup.py install for moztest 23:13:33 INFO - Running setup.py install for mozversion 23:13:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:13:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:13:33 INFO - Cleaning up... 23:13:33 INFO - Return code: 0 23:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:33 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:33 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 23:13:33 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 23:13:33 INFO - Using env: {'DISPLAY': ':0', 23:13:33 INFO - 'HOME': '/home/cltbld', 23:13:33 INFO - 'LANG': 'en_US.UTF-8', 23:13:33 INFO - 'LANGUAGE': 'en_US:en', 23:13:33 INFO - 'LOGNAME': 'cltbld', 23:13:33 INFO - 'MAIL': '/var/mail/cltbld', 23:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:33 INFO - 'MOZ_NO_REMOTE': '1', 23:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:33 INFO - 'NO_EM_RESTART': '1', 23:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:33 INFO - 'PWD': '/builds/slave/test', 23:13:33 INFO - 'SHELL': '/bin/bash', 23:13:33 INFO - 'SHLVL': '1', 23:13:33 INFO - 'TERM': 'linux', 23:13:33 INFO - 'TMOUT': '86400', 23:13:33 INFO - 'USER': 'cltbld', 23:13:33 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:33 INFO - '_': '/tools/buildbot/bin/python'} 23:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:13:34 INFO - Running setup.py (path:/tmp/pip-6cfwaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:13:34 INFO - Running setup.py (path:/tmp/pip-sAypF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:13:34 INFO - Running setup.py (path:/tmp/pip-XG9IuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:13:34 INFO - Running setup.py (path:/tmp/pip-Cdgwhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:13:34 INFO - Running setup.py (path:/tmp/pip-x4rWaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:13:34 INFO - Running setup.py (path:/tmp/pip-imETsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:13:34 INFO - Running setup.py (path:/tmp/pip-8p_2zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:13:34 INFO - Running setup.py (path:/tmp/pip-p3fSme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:13:34 INFO - Running setup.py (path:/tmp/pip-ZUh1TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:13:34 INFO - Running setup.py (path:/tmp/pip-4Ffopu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:13:34 INFO - Running setup.py (path:/tmp/pip-933w4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:13:34 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)) 23:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:13:34 INFO - Running setup.py (path:/tmp/pip-8V77cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:13:35 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)) 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:13:35 INFO - Running setup.py (path:/tmp/pip-WwkaYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:13:35 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)) 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:13:35 INFO - Running setup.py (path:/tmp/pip-HTFVqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:13:35 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)) 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:35 INFO - Running setup.py (path:/tmp/pip-KIOsqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:13:35 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)) 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:13:35 INFO - Running setup.py (path:/tmp/pip-mRQo8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:13:35 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)) 23:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:13:35 INFO - Running setup.py (path:/tmp/pip-GUpeqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:13:35 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)) 23:13:35 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)) 23:13:35 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)) 23:13:35 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)) 23:13:35 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)) 23:13:35 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)) 23:13:35 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)) 23:13:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:13:35 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 23:13:35 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 23:13:35 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 23:13:35 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 23:13:36 INFO - Downloading blessings-1.6.tar.gz 23:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:13:36 INFO - Installing collected packages: blessings 23:13:36 INFO - Running setup.py install for blessings 23:13:36 INFO - Successfully installed blessings 23:13:36 INFO - Cleaning up... 23:13:36 INFO - Return code: 0 23:13:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:36 INFO - Reading from file tmpfile_stdout 23:13:36 INFO - Current package versions: 23:13:36 INFO - argparse == 1.2.1 23:13:36 INFO - blessings == 1.6 23:13:36 INFO - blobuploader == 1.2.4 23:13:36 INFO - docopt == 0.6.1 23:13:36 INFO - functools32 == 3.2.3-2 23:13:36 INFO - jsonschema == 2.5.1 23:13:36 INFO - manifestparser == 1.1 23:13:36 INFO - mozInstall == 1.13 23:13:36 INFO - mozcrash == 1.0 23:13:36 INFO - mozdebug == 0.1 23:13:36 INFO - mozdevice == 0.51 23:13:36 INFO - mozfile == 1.2 23:13:36 INFO - mozhttpd == 0.7 23:13:36 INFO - mozinfo == 0.10 23:13:36 INFO - mozleak == 0.1 23:13:36 INFO - mozlog == 3.5 23:13:36 INFO - moznetwork == 0.27 23:13:36 INFO - mozprocess == 0.25 23:13:36 INFO - mozprofile == 0.28 23:13:36 INFO - mozrunner == 6.13 23:13:36 INFO - mozscreenshot == 0.1 23:13:36 INFO - mozsystemmonitor == 0.3 23:13:36 INFO - moztest == 0.8 23:13:36 INFO - mozversion == 1.4 23:13:36 INFO - psutil == 3.1.1 23:13:36 INFO - requests == 1.2.3 23:13:36 INFO - wsgiref == 0.1.2 23:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:36 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:36 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 23:13:36 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 23:13:36 INFO - Using env: {'DISPLAY': ':0', 23:13:36 INFO - 'HOME': '/home/cltbld', 23:13:36 INFO - 'LANG': 'en_US.UTF-8', 23:13:36 INFO - 'LANGUAGE': 'en_US:en', 23:13:36 INFO - 'LOGNAME': 'cltbld', 23:13:36 INFO - 'MAIL': '/var/mail/cltbld', 23:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:36 INFO - 'MOZ_NO_REMOTE': '1', 23:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:36 INFO - 'NO_EM_RESTART': '1', 23:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:36 INFO - 'PWD': '/builds/slave/test', 23:13:36 INFO - 'SHELL': '/bin/bash', 23:13:36 INFO - 'SHLVL': '1', 23:13:36 INFO - 'TERM': 'linux', 23:13:36 INFO - 'TMOUT': '86400', 23:13:36 INFO - 'USER': 'cltbld', 23:13:36 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:36 INFO - '_': '/tools/buildbot/bin/python'} 23:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 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)) 23:13:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:13:37 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 23:13:37 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 23:13:37 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 23:13:37 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 23:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:13:38 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)) 23:13:38 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)) 23:13:38 INFO - Installing collected packages: simplejson 23:13:38 INFO - Running setup.py install for simplejson 23:13:38 INFO - building 'simplejson._speedups' extension 23:13:38 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 23:13:39 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 23:13:39 INFO - Successfully installed simplejson 23:13:39 INFO - Cleaning up... 23:13:39 INFO - Return code: 0 23:13:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:13:39 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')]} 23:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:39 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')]} 23:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:39 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 0x14211f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x178da60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, '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': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', '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 23:13:39 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 23:13:39 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 23:13:39 INFO - Using env: {'DISPLAY': ':0', 23:13:39 INFO - 'HOME': '/home/cltbld', 23:13:39 INFO - 'LANG': 'en_US.UTF-8', 23:13:39 INFO - 'LANGUAGE': 'en_US:en', 23:13:39 INFO - 'LOGNAME': 'cltbld', 23:13:39 INFO - 'MAIL': '/var/mail/cltbld', 23:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:39 INFO - 'MOZ_NO_REMOTE': '1', 23:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:39 INFO - 'NO_EM_RESTART': '1', 23:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:39 INFO - 'PWD': '/builds/slave/test', 23:13:39 INFO - 'SHELL': '/bin/bash', 23:13:39 INFO - 'SHLVL': '1', 23:13:39 INFO - 'TERM': 'linux', 23:13:39 INFO - 'TMOUT': '86400', 23:13:39 INFO - 'USER': 'cltbld', 23:13:39 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:39 INFO - '_': '/tools/buildbot/bin/python'} 23:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:13:39 INFO - Cleaning up... 23:13:39 INFO - Return code: 0 23:13:39 INFO - Running post-action listener: _resource_record_post_action 23:13:39 INFO - Running post-action listener: _start_resource_monitoring 23:13:39 INFO - Starting resource monitoring. 23:13:39 INFO - [mozharness: 2017-09-14 06:13:39.674242Z] Finished create-virtualenv step (success) 23:13:39 INFO - [mozharness: 2017-09-14 06:13:39.674755Z] Running install step. 23:13:39 INFO - Running pre-action listener: _resource_record_pre_action 23:13:39 INFO - Running main action method: install 23:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:39 INFO - Reading from file tmpfile_stdout 23:13:39 INFO - Detecting whether we're running mozinstall >=1.0... 23:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:13:40 INFO - Reading from file tmpfile_stdout 23:13:40 INFO - Output received: 23:13:40 INFO - Usage: mozinstall [options] installer 23:13:40 INFO - Options: 23:13:40 INFO - -h, --help show this help message and exit 23:13:40 INFO - -d DEST, --destination=DEST 23:13:40 INFO - Directory to install application into. [default: 23:13:40 INFO - "/builds/slave/test"] 23:13:40 INFO - --app=APP Application being installed. [default: firefox] 23:13:40 INFO - mkdir: /builds/slave/test/build/application 23:13:40 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'] 23:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:13:57 INFO - Reading from file tmpfile_stdout 23:13:57 INFO - Output received: 23:13:57 INFO - /builds/slave/test/build/application/firefox/firefox 23:13:57 INFO - Running post-action listener: _resource_record_post_action 23:13:57 INFO - [mozharness: 2017-09-14 06:13:57.596097Z] Finished install step (success) 23:13:57 INFO - [mozharness: 2017-09-14 06:13:57.596352Z] Running setup-mitmproxy step. 23:13:57 INFO - Running pre-action listener: _resource_record_pre_action 23:13:57 INFO - Running main action method: setup_mitmproxy 23:13:57 INFO - Skipping: mitmproxy is not required 23:13:57 INFO - Running post-action listener: _resource_record_post_action 23:13:57 INFO - [mozharness: 2017-09-14 06:13:57.597537Z] Finished setup-mitmproxy step (success) 23:13:57 INFO - [mozharness: 2017-09-14 06:13:57.597757Z] Running run-tests step. 23:13:57 INFO - Running pre-action listener: _resource_record_pre_action 23:13:57 INFO - Running pre-action listener: _set_gcov_prefix 23:13:57 INFO - Running main action method: run_tests 23:13:57 WARNING - Try message not found. 23:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:13:57 INFO - Python 2.7.3 23:13:57 INFO - Return code: 0 23:13:57 INFO - grabbing minidump binary from tooltool 23:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:57 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 0x1791090>, '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 0x1791d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178bf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:13:57 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 23:13:57 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 23:13:57 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 23:13:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:13:57 INFO - Return code: 0 23:13:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:13:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:13:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:13:57 INFO - ENV: RUST_BACKTRACE is now full 23:13:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:13:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:13:57 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/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:13:57 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/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 23:13:57 INFO - Using env: {'DISPLAY': ':0', 23:13:57 INFO - 'HOME': '/home/cltbld', 23:13:57 INFO - 'LANG': 'en_US.UTF-8', 23:13:57 INFO - 'LANGUAGE': 'en_US:en', 23:13:57 INFO - 'LOGNAME': 'cltbld', 23:13:57 INFO - 'MAIL': '/var/mail/cltbld', 23:13:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:13:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:57 INFO - 'MOZ_NO_REMOTE': '1', 23:13:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:13:57 INFO - 'NO_EM_RESTART': '1', 23:13:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:57 INFO - 'PWD': '/builds/slave/test', 23:13:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:13:57 INFO - 'RUST_BACKTRACE': 'full', 23:13:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:13:57 INFO - 'SHELL': '/bin/bash', 23:13:57 INFO - 'SHLVL': '1', 23:13:57 INFO - 'TERM': 'linux', 23:13:57 INFO - 'TMOUT': '86400', 23:13:57 INFO - 'USER': 'cltbld', 23:13:57 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:57 INFO - '_': '/tools/buildbot/bin/python'} 23:13:57 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/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:13:57 INFO - mozversion application_buildid: 20170914045317 23:13:57 INFO - mozversion application_changeset: 6f08f91f8db00d385e5d564b0102bf0dece39f6f 23:13:57 INFO - mozversion application_display_name: Nightly 23:13:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:13:57 INFO - mozversion application_name: Firefox 23:13:57 INFO - mozversion application_remotingname: firefox 23:13:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:13:57 INFO - mozversion application_vendor: Mozilla 23:13:57 INFO - mozversion application_version: 57.0a1 23:13:57 INFO - mozversion platform_buildid: 20170914045317 23:13:57 INFO - mozversion platform_changeset: 6f08f91f8db00d385e5d564b0102bf0dece39f6f 23:13:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:13:57 INFO - mozversion platform_version: 57.0a1 23:13:57 INFO - using testdate: 1505369637 23:13:57 INFO - actual date: 1505369637 23:13:57 INFO - starting webserver on 'localhost:51467' 23:13:57 INFO - SUITE-START | Running 2 tests 23:13:57 INFO - TEST-START | dromaeo_css 23:13:57 INFO - Initialising browser for dromaeo_css test... 23:13:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51467/getInfo.html -profile /tmp/tmp1n8kfH/profile 23:13:57 INFO - TEST-INFO | started process 2146 (/builds/slave/test/build/application/firefox/firefox http://localhost:51467/getInfo.html) 23:14:03 INFO - TEST-INFO | 2146: exit 0 23:14:03 INFO - Browser initialized. 23:14:03 INFO - Running cycle 1/1 for dromaeo_css test... 23:14:03 INFO - Using env: {'DISPLAY': ':0', 23:14:03 INFO - 'HOME': '/home/cltbld', 23:14:03 INFO - 'JSGC_DISABLE_POISONING': '1', 23:14:03 INFO - 'LANG': 'en_US.UTF-8', 23:14:03 INFO - 'LANGUAGE': 'en_US:en', 23:14:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:14:03 INFO - 'LOGNAME': 'cltbld', 23:14:03 INFO - 'MAIL': '/var/mail/cltbld', 23:14:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:14:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:14:03 INFO - 'MOZ_CRASHREPORTER': '1', 23:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:14:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:14:03 INFO - 'MOZ_NO_REMOTE': '1', 23:14:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:14:03 INFO - 'NO_EM_RESTART': '1', 23:14:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:14:03 INFO - 'PWD': '/builds/slave/test', 23:14:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:14:03 INFO - 'RUST_BACKTRACE': 'full', 23:14:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:14:03 INFO - 'SHELL': '/bin/bash', 23:14:03 INFO - 'SHLVL': '1', 23:14:03 INFO - 'TERM': 'linux', 23:14:03 INFO - 'TMOUT': '86400', 23:14:03 INFO - 'USER': 'cltbld', 23:14:03 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:14:03 INFO - '_': '/tools/buildbot/bin/python'} 23:14:03 INFO - TEST-INFO | started process 2379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1n8kfH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:04 INFO - PID 2379 | 23:14:04 INFO - PID 2379 | (/builds/slave/test/build/application/firefox/firefox:2428): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:14:04 INFO - PID 2379 | 23:14:14 INFO - PID 2379 | RSS: Main: 169332736 23:14:14 INFO - PID 2379 | 23:17:11 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51467/tests/dromaeo/cssquery-ext.html) 23:17:12 INFO - PID 2379 | RSS: Main: 171520000 23:17:12 INFO - PID 2379 | 23:20:14 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-ext.html (next: http://localhost:51467/tests/dromaeo/cssquery-jquery.html) 23:20:14 INFO - PID 2379 | RSS: Main: 168595456 23:20:14 INFO - PID 2379 | 23:23:16 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51467/tests/dromaeo/cssquery-mootools.html) 23:23:16 INFO - PID 2379 | RSS: Main: 170696704 23:23:16 INFO - PID 2379 | 23:26:18 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51467/tests/dromaeo/cssquery-prototype.html) 23:26:19 INFO - PID 2379 | RSS: Main: 169172992 23:26:19 INFO - PID 2379 | 23:29:22 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51467/tests/dromaeo/cssquery-yui.html) 23:29:22 INFO - PID 2379 | RSS: Main: 170311680 23:29:22 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | Cycle 1(1): loaded http://localhost:51467/tests/dromaeo/cssquery-yui.html (next: http://localhost:51467/tests/dromaeo/cssquery-dojo.html) 23:32:24 INFO - PID 2379 | RSS: Main: 173408256 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | __start_tp_report 23:32:24 INFO - PID 2379 | _x_x_mozilla_page_load 23:32:24 INFO - PID 2379 | _x_x_mozilla_page_load_details 23:32:24 INFO - PID 2379 | |i|pagename|runs| 23:32:24 INFO - PID 2379 | |0;dojo.html;3781.5084039074923;3836.9448401689533;3856.0167157374867;3872.5352957645086;3899.863504777333;6154.938450615493;6285.560010799246;6310.053491976194;6382.074599183122;6401.711922963466;6244.313125556197;6358.268799088106;6362.650054247015;6387.616742995424;6429.35706429358;5677.233573467591;5681.091025435931;5724.856878578038;5728.914066289009;5763.0779075347955;179.9154397433206;5634.239377684001;5643.153526970947;5777.1623114648355;5806.912896306559;5587.106063029916;5648.943510564904;5700.543956483471;5731.541476681856;5746.994276001704;5640.0693885508845;5663.716814159276;5698.772049118031;5725.713714314267;5745.368009518991;5620.4660557247;5645.407232240637;5705.315362156526;5721.6853073080965;5725.255716756837;6294.244690637152;6311.179546658951;6348.333424990402;6354.650494222816;6395.680215989229;6738.191417029939;6807.523473356867;6828.931710682879;6886.552374095668;6902.6203558804245;6936.79189624307;6956.5478243913985;7001.82495437613;7007.4394048476;7010.158780946319;6381;6399.392057754552;6409;6476.481881449473;6499.6100233985635;6952.991816186725;7045.11936007999;7049;7062.858742825115;7166.283371662897;6719.193696756322;6732.899006514906;6738.393544581011;6741.561798483083;6742.629155396402;6834.111565496553;6920.204176519765;6984.301569842975;6989.4408447324095;6997.790066298019;6795.150606174228;6797.966010169917;6877.518573699893;6884.277150899184;6887.276835932155;6783.084283621648;6798.626075565891;6805.285445028201;6883.793486195422;6888.517803753689;4980.651354405157;4991.5258050485145;4993.226049962262;5010.649254552146;5073;4470.597646211857;4540.841070562515;4571.314302854598;4589.862304130881;4614.446266448048;6224.813255602339;6240.937590624127;6297.527685423612;6303.684815759286;6318.178636777189;6845.726170953206;6857.108575885203;6860.451163906875;6935.098437203132;6936.583804971718;6219.315875253718;6280.937190628127;6300.432961033529;6331.081993110973;6349.841253968688;5510.228568000403;5528.695921724263;5578.219049333096;5580.91628625571;5593.356763972114;6967.930320696728;7062.611556364449;7160.427165826722;7163.212046674862;7173.6413179340825;6764.458843292525;6765.695543700447;6790.1851777786;6835.453163746789;6880.827979300358;7205.495615307088;7219.9892015116875;7223;7227.27727227273;7227.891581626385;6705.698243579148;6774.559653622498;6792.864142717019;6798.694058767466;6844.863102737818;6894.345037221456;6928.237893831573;6982.197047339621;7001.544899581511;7003.089598352385;6497.545171837926;6588.341165883373;6602.636854973022;6625.337466253336;6711.798646040626;6562.3109573496;6659.167604049494;6660.966695166493;6672.132622759011;6674.899876501953;6513.869722605426;6514.511411644051;6610.2398224204835;6616.139901812926;6624.966875165594;6596.57122287069;6615.5038372123245;6639.468842492685;6670.232923213698;6747.797566073025;6373.521985851173;6420.26166990802;6441.1304473895425;6451.741930322734;6516.804495865132 23:32:24 INFO - PID 2379 | |1;ext.html;879.9032106468289;897.8159477307153;902.2466240689024;908.3913777768898;917.6329468212718;44630.33054504185;44898.55101448984;44908.999999999956;45230.54769452305;45659.771701141486;43014.35478467825;43254.134917301635;43284.134317313634;43323.78338108305;43348;7437.962810185955;7491.812704682399;7497.3252407283335;7498.47510674253;7504.5872477013745;7322.707091716325;7379.298966598165;7382.409407247407;7384.778456646282;7385.039944807168;8156.551389673566;8360.372972027122;8365.874511882326;8366.121557236494;8367.372447066464;8098.3926205534235;8259.132791056973;8294.212049855285;8354.540500272482;8367.079621241659;7786.221377862168;7852.17552157021;7859.449838511307;7863.882041769378;7868.6065696715505;40783.796081019704;41047.794761026;41055;41066.79466602648;41246.1750764986;3798.2023775007005;3842.231553689245;3846.0961674006585;3847.769133851978;3848.6536211741077;33394.83302583496;33411.6658833411;33592.32815343704;33624.831875840464;33683.49474757881;5508.338999320067;5520.033994051065;5552.583556233259;5554;5637.830865074055;217415;217831;218208;218649;218938.90530547404;46142.30786538205;46602;53404.19362257415;54066.45933540614;54183;58603.41396585979;58614.41385586175;59180;59180;59228;17128.14359282031;17254;17267.309307627555;17268;17275.222614982355;13834.169949803045;14063.226522541358;14073;14073.366698498592;14075.085119467201;15480.303386347416;15526.378944842305;15550.533483995498;15553;15669.843301567067;5957.1362152487645;5993.760249589967;5998;6184.392058064936;6220.253569571681;1086.5002099034375;1098.2970898624887;1099.7470581766079;1121.2543658467027;1132.9660110196708;25756.484870302487;25952.61071083935;26076.217713468628;26087.08695195659;26215.73784262133;1203.2299328429813;1205.4394706461537;1224.155332820351;1224.6938265433641;1226.9815952760716;13676.726465470634;13755.79366309506;13776.93111534456;13812.723745525032;14028;278552;278571;279109;280569;281110;59147;59170.704146478995;62782;65392.67303663546;65420;1519.3618680154361;1538.2155100898622;1555.098043134979;1555.984440155584;1577.6371434570112;30600.31698256617;30667;31377;31451.68548314579;31556.36887262196;42585.574144258164;42662.146757065304;42765.57234427616;42809.35785963275;42896.35655465233;231787;232172;232271;232930;233315;36416.635833641325;37644.2471150581;40195.39706904457;40485.39271910983;40584.79707601443;51111;51121;51889;52098.21852672137;52427;36279.27441451209;37193.44209836909;37269.25461490701;37279.44080838736;37302.440463393614;36504;36602;37244;37251.254974899806;37484.06289842776;43513.56486435095;43576.56423435852;43905.34141987809;44045.33931990959;44498.55501444944;35325.82337088298;35408.46887296641;35575.46636800502;35877.82061089678;36228.36972336198;26266.474670506865;26945;27135.59296610513;27263.454730904876;27461.588076178472 23:32:24 INFO - PID 2379 | |2;jquery.html;583.6031498580966;599.7091410665827;606.396635347829;610.3804638292135;617.9073139029147;22578.66132008019;23271.534569308624;23294;23365.013973812245;23367.1821486248;24944.376390590245;27209.863950680217;27215.319617009536;27222.727772722268;27310;6421.42207201353;6640.535162538624;6652.866942661144;6659;6661.467082633402;6364.968175159118;6612.107365505667;6667.366600172976;6673.199216094075;6673.833154171136;6613.43785778207;6615.933840661604;6620.04009418634;6632;6640.501962352819;6459.483241340681;6618.966905165467;6678.766243181465;6682.599044057372;6685.665716714194;6193.783217587408;6222;6227.09707092469;6230.43926046658;6236.844078898019;30668.539971900438;31079.689203107904;31226.375472490425;31236.68763312383;31330.686693133004;2138;2191.980728961025;2220.666899965002;2222.2444368914485;2227.3429338345227;20807;21726.34820955374;21732.456688582755;21774.237901673525;21887;2466.7656572625574;2499.0628514307136;2555.0418593027616;2579.496998085374;2585.8060645451665;135054;140302;144764;155366;161447;15181.013234139966;15489.999999999774;15818.683626327409;15939.203039847962;16453.42413015539;25773.484530309288;25805.870970645028;25848.224553263433;25956.480870382486;25972.480550388886;10796.352218866894;10895.346279223271;10914.290571112851;11026.669199924016;11194.328340299608;10040.899591003996;10088.949555252177;10127.594896204217;10143.23925705575;10161.441120738431;9654.372465789702;9727.756806079904;9792.510374481248;9938.403695778132;9994.850077248848;2810.9156725298276;2822.223888430698;2901.361700425903;2946.499095153829;3004.354063876277;1050.7110544600143;1063.4363787192801;1066.6320119558895;1067.0769784136667;1076.5048077884105;21162.365129046153;21623.67564486534;21865;21890;22233.444163895707;1124.1175677093606;1124.3815901254277;1131.4512461456188;1135.8693750218831;1141.6004398460473;11717.472713727902;11767.058635309155;11835.11236657254;11839.467223974942;11955.52177912891;622402;627328;630625;666551;674997;125240;126430;126438;127746;129365.35317323353;1100.1693721240572;1133.2747041893194;1170.4068509675215;1188.9048876090064;1227.975440491203;22521.211757588404;22628.886855566274;22672.84144897559;22833.33166788221;22834;62652.68673656785;63230.68384658231;63409.04886426799;64235.678821605594;64262;76158;77797.222027779;80561.3887722254;81176;81246;15161.317740701474;15460.5361839145;15519.84480155184;15597.220138992778;15629.843701562839;22286.554268914857;24212.273631791075;24330;24350;24615.01539938454;19898.60202795965;20187.697184542536;20268.89865550663;20322.79677203268;20326.288579899632;17334.219960101575;17363.3922812706;17619.823801761817;17707.46877593674;17739.645207096044;19722.90138549298;19984.20063197456;20022.89988550048;20178;20270;15278.312475938386;15301.158436285667;15305.693886121993;15339.156346401054;15345.0025748326;19352.516187095436;19708.802911970695;19775;19839.900800495907;19996.30012949598 23:32:24 INFO - PID 2379 | |3;mootools.html;1441.2361448432332;1472.7496325624643;1487.754520504117;1492.097281144908;1502.6468779836732;16297.674046519063;16972;17198.226079826407;17217.13914304283;17217.741733873972;16654.333826646918;16705.331786728515;16752.748708769377;16794.244259008345;16824.32702691891;2854.900078497253;2908.5927970084203;2910.228789370808;2910.8544572771384;2911.912642620725;2766.8201566898188;2874.928126796826;2875.971240287591;2876.4390943765975;2876.9280767980863;2730.4539092181544;2817.1548535439388;2922.1087568291664;2924.8830046798103;2928.6924872888358;2865.7277558631895;2876.913692589226;2887.4946884295164;2904.5352743561034;2915.3586211033644;2730.385663225778;2831.4620222157723;2840.8437535935514;2846.245744877609;2852.9001484948135;16452.259648315736;16501.83498165015;16513.091779952098;16545.420910268083;16566.83433165677;8527.95736021322;8784;8787.560621968876;8828.117188281185;8833.646654133827;5188.766505507261;5218.269442278084;5326;5382.2464854920345;5385.946140538623;2008.6083213773175;2047.4369548374316;2072.171131547378;2074.8651337663155;2123.9044243009103;29664.110076697732;30012;30149.547756783664;30170;30196.849015755;7123.786286411416;7207.711691532385;7218.927810721931;7352.154502232205;7409.592472414069;19613.31353402624;19637.901810490857;19661;19661.115249813793;19661.213551457782;8900.465972041698;9111;9116.225120864668;9132.223760980258;9137.177654011171;7926.960365198137;7989.161138080534;8042.235987581171;8068.193180682002;8102.270795628422;5453.481919217747;5592.944070559242;5607.158926161109;5641.605087643908;5673.375928647845;1573.1111921764166;1576.7634854771875;1589.6025993501626;1597.1295643874116;1600.447845493303;934.6915517879083;949.1694767078806;955.9187469065068;958.1951161024773;965.8116667249819;8159.388045896581;8169.79575510617;8558.700445484377;8798.516081615573;8802.515861627544;767.5318055985845;771.5524995502595;777.296546625305;784.5841703896943;791.5646394483011;4964.304997300381;5269.394019687708;5352.19717042439;5353.785848566014;5383.730813459311;22164.778352216596;24267.757322426904;24351.634725479133;24463.877680611484;24598.262052138463;23557.29328120159;23928.40178995539;24155.63766543503;24284.514309713708;24595;12371.381430928597;12395.75208495825;12530.686732831753;12564.87435125637;12620.495180192873;8938.821223575362;9021.90978090237;9049.321300902327;9062.546872656472;9121.631755236767;20743.1702731889;20800.167993280098;21011.474713132295;21012.894935525226;21348;21332.466688332916;21470.141194352676;21614.243501477373;21628;21710.240141594968;11971.64085077449;12017.519299228283;12145.878541214475;12146.210496317712;12182.634520964386;15386.769198461809;15516;15519.301631426388;15667.686646267239;15679;12400.875991239973;12414.875851241733;12507.187032842836;12518.311492867615;12826.55107071248;12160.939195304321;12182.512699492276;12330.445129968994;12380.380980951097;12463;10895.509702063267;11159.10727141843;11252.26860254081;11267.211295209585;11278.154138439486;7835.059792824897;7929.207079292025;7936.2857342839425;7965.044194696674;8067.112617611941;8189.50862948225;8237.670493180445;8243.381746369167;8261.710840120568;8303.252707256375 23:32:24 INFO - PID 2379 | |4;prototype.html;551.2310327093707;552.6380220955273;564.9011423000975;583.6177303865967;586.5805948746645;6166.599171053878;6221.502279817621;6251.187345645059;6268.498520118391;6334.588251763632;6177.814665560029;6181.350958149397;6197.597156184856;6212.689365531716;6246.781362652308;4795.160846851804;5121.692698438087;5141.717205553702;5145.382554093514;5151.871203219912;4909.975450122763;4944.901101977958;4966.379202599675;4974.328465657144;4977.377827771528;4892.119418504668;4893.559579637832;4938.259261110827;4948.876278093058;4952.5047495250365;4921.114199444099;4923.236898280772;4954.207326827708;4965.0069986002945;4986.152354099811;4499.75251361175;4515.864524064284;4544.954550454486;4560.749158796265;4561.657875659305;6050.727717252734;6130.785422510236;6213.87572248557;6216.627002379872;6270.6864656766975;5760.942390576082;5844.824655260349;5848.298204215522;5854.662842179959;5888.941110588925;6613.148318470836;6618.768343108016;6631.7347306107695;6641.907799043334;6680.665966701694;4984.800607975677;4993.750312484398;5020.899582008376;5022.84931452057;5086.821961231339;6827.829304267383;6868.278830722802;6868.62222577758;6905.551139175937;6999.5450295731125;5164.664296820694;5168.638195326291;5186.40356359016;5200.141976573898;5212;5201.037808005531;5209.453007434241;5231.607629427732;5237.764300606482;5290.7354632269;5738.167965644958;5766.88466230673;5776.711164441761;5809.2738407699035;5815.302163740378;6395.52033597482;6561.80314590563;6621.9006714899315;6645.501587380966;6678.33216678338;1792.3726695656417;1794.5693033672085;1802.9716568860033;1810.520212143783;1810.755548001003;1161.8315344275034;1257.3713143428286;1264.76601828662;1273.3824095313767;1280.571008712092;6001.679630481287;6086.269647642312;6138.416850399205;6153.630782153085;6198.287196972406;6652.234992975869;6761.4590832733265;6777.288384719632;6813.182418109858;6831.248562658104;6146.6004709693725;6198.791235709084;6199.389552455035;6224.408681175281;6270;3525.219764019154;3558.6619271169197;3573.6783689468075;3590.9102272443397;3610.35013697537;6948.096747422803;6956.304369563104;6960;7054.753083642048;7070.646467676595;6814.182298124257;6840.213375461885;6850.38346548813;6864.283929017745;6943.097397338313;6886.931130688629;6944.930550694529;6947.826304342432;7050.788476345718;7056.682449289794;6638.53530252897;6666.699998499982;6686;6696.933030669826;6780.186377634715;6717.529772915849;6734.215432910185;6772.390484856386;6786.830329241611;6810.693518791567;6965.930340696528;6969.919662452328;6999.230084690578;7021.453052088793;7034.261402552658;5140.588752899834;5172.922406163835;5176.767045483038;5194.168932970858;5197.66215196011;6703.754242328874;6705.362990515893;6733.562318449285;6741;6800.897986530305;6544.770933017321;6561.507886908405;6582.506312026521;6584.76953306632;6605.979455613864;6458.61248325102;6560.9343906560325;6590.143281373391;6598.670066496752;6608.867822643617;6399.232092148972;6425.389587989133;6474.967625161844;6483.448906842971;6519.315471875385;6146.631202127886;6380.96809515968;6428.717805179094;6557.344265573404;6629.635370054693;6267.62394256346;6286.245650521967;6299.496040316855;6333.145025421509;6404.263509696445 23:32:24 INFO - PID 2379 | |5;yui.html;965.9613615455382;985.1332622069776;1004.0260946881523;1006.8590397344377;1009.5154325923556;20945.37163885084;21226.469338266532;21273.57452850942;21277.468063298424;21307.25424610135;19296.131674074666;19884;20176.092075856584;20240.493987650316;20258.39224823254;1032.793441311739;1071.3786004117594;1071.4589132488122;1071.59815069349;1071.9732006699817;1089.7711480589087;1093.7046997310722;1093.8249880019198;1094.179365475893;1095.2935356694927;1131.4738646529363;1167.130487786596;1174.6887074925153;1175.371176420615;1175.5944199251244;1169.4620474581702;1170.3153655111769;1171.5313874450203;1172.027217409548;1172.050638982427;801.2228138705447;826.3430572694722;829.7469271872077;831.3889291370838;832.8167803083372;20704.171833126657;20728.689069663968;20773.480662983395;20803.479913002146;20825.583488330147;22815.88592057029;23267.53464930692;24177.153799617106;24315.270541883772;24319.270421887195;16538;16655.167241637868;16738.079405632685;16752.41366552165;16782.664346713118;3854.0557563396865;3882.456456096149;3890.7860067696265;3893.493845800056;3897.9610203897882;132802;157750;159754;159784;163361.9999999988;18515.907420462812;18584.907075464536;18737.625247494972;18968.62062758737;18998;34658.13354666103;34729.30541389158;34885.476717849255;34953.47569786455;35290;9787.314887957775;9836.262280329003;9857.950710246403;9907.653232136841;9920.4543750093;4632.60622847055;4683.367745354401;4715.575598196178;4792.592629626451;4800.615950723934;6053.969730151409;6160.7535698571555;6169.8457538561;6193.163922870355;6203.379662033761;1184.797059513561;1197.7604479104214;1203.8856308650663;1219.0856857356982;1227.1042139238407;734.4418242136015;736.569107072358;748.827769612992;755.9546427214385;762.4510352546158;13577.660558485919;13855.653608659662;14397.352119154453;15101.848981510044;15238;741.0181509499935;747.7196051480695;748.1222132447596;753.7927070055669;754.864124457592;6450.838729031811;6586.71559045991;6596.80209593713;6602.60384376939;6603.603783772989;143078;143668;143856.28071859575;145332;145957;118233;118848;121744.39127804482;122298;126591;103718;105926;106626.99999999844;107996.46001769941;109990.45004774925;12172.878271217529;12177.756444871231;12230.816537752118;12328.260304381407;12439.937800310941;52661;54036.459635403146;54192.45807541874;54974.72512637411;56017.99999999837;66069.33930660631;66686.66656666686;66910;67759.3224067753;70171.64914175397;17051.147442628066;17371.913140434215;17372.391966281626;17416.04211768365;17427.215775290395;20251;20350.01099406304;20357.592848142656;20364.898175509028;20421.897890510452;18138.093095345444;18227.817721822612;18312.72530912011;18314.542136446697;18420.17109230061;16390.344386224417;16503.587410314838;16518.83481165173;16726.665466690356;16740.330386784393;17760.467185984442;17783.644327113645;17849.910750446164;17921;18113.728294075863;12521.248725076524;12688.23870567769;12818.230906145662;13009.349532523525;13219.272939988008;13711.725765484834;13795.448182072605;13857.30713464343;13870.098443601133;13881.514147004806 23:32:24 INFO - PID 2379 | __end_tp_report 23:32:24 INFO - PID 2379 | __start_cc_report 23:32:24 INFO - PID 2379 | _x_x_mozilla_cycle_collect,358 23:32:24 INFO - PID 2379 | __end_cc_report 23:32:24 INFO - PID 2379 | __startTimestamp1505370744501__endTimestamp 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | ------- Summary: start ------- 23:32:24 INFO - PID 2379 | Number of tests: 6 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#0] dojo.html Cycles:165 Average:6281.47 Median:6516.80 stddev:895.41 (13.7%) stddev-sans-first:876.41 23:32:24 INFO - PID 2379 | Values: 3781.5 3836.9 3856.0 3872.5 3899.9 6154.9 6285.6 6310.1 6382.1 6401.7 6244.3 6358.3 6362.7 6387.6 6429.4 5677.2 5681.1 5724.9 5728.9 5763.1 179.9 5634.2 5643.2 5777.2 5806.9 5587.1 5648.9 5700.5 5731.5 5747.0 5640.1 5663.7 5698.8 5725.7 5745.4 5620.5 5645.4 5705.3 5721.7 5725.3 6294.2 6311.2 6348.3 6354.7 6395.7 6738.2 6807.5 6828.9 6886.6 6902.6 6936.8 6956.5 7001.8 7007.4 7010.2 6381.0 6399.4 6409.0 6476.5 6499.6 6953.0 7045.1 7049.0 7062.9 7166.3 6719.2 6732.9 6738.4 6741.6 6742.6 6834.1 6920.2 6984.3 6989.4 6997.8 6795.2 6798.0 6877.5 6884.3 6887.3 6783.1 6798.6 6805.3 6883.8 6888.5 4980.7 4991.5 4993.2 5010.6 5073.0 4470.6 4540.8 4571.3 4589.9 4614.4 6224.8 6240.9 6297.5 6303.7 6318.2 6845.7 6857.1 6860.5 6935.1 6936.6 6219.3 6280.9 6300.4 6331.1 6349.8 5510.2 5528.7 5578.2 5580.9 5593.4 6967.9 7062.6 7160.4 7163.2 7173.6 6764.5 6765.7 6790.2 6835.5 6880.8 7205.5 7220.0 7223.0 7227.3 7227.9 6705.7 6774.6 6792.9 6798.7 6844.9 6894.3 6928.2 6982.2 7001.5 7003.1 6497.5 6588.3 6602.6 6625.3 6711.8 6562.3 6659.2 6661.0 6672.1 6674.9 6513.9 6514.5 6610.2 6616.1 6625.0 6596.6 6615.5 6639.5 6670.2 6747.8 6373.5 6420.3 6441.1 6451.7 6516.8 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#1] ext.html Cycles:180 Average:43248.35 Median:3848.21 stddev:63613.11 (1653.1%) stddev-sans-first:63712.02 23:32:24 INFO - PID 2379 | Values: 879.9 897.8 902.2 908.4 917.6 44630.3 44898.6 44909.0 45230.5 45659.8 43014.4 43254.1 43284.1 43323.8 43348.0 7438.0 7491.8 7497.3 7498.5 7504.6 7322.7 7379.3 7382.4 7384.8 7385.0 8156.6 8360.4 8365.9 8366.1 8367.4 8098.4 8259.1 8294.2 8354.5 8367.1 7786.2 7852.2 7859.4 7863.9 7868.6 40783.8 41047.8 41055.0 41066.8 41246.2 3798.2 3842.2 3846.1 3847.8 3848.7 33394.8 33411.7 33592.3 33624.8 33683.5 5508.3 5520.0 5552.6 5554.0 5637.8 217415.0 217831.0 218208.0 218649.0 218938.9 46142.3 46602.0 53404.2 54066.5 54183.0 58603.4 58614.4 59180.0 59180.0 59228.0 17128.1 17254.0 17267.3 17268.0 17275.2 13834.2 14063.2 14073.0 14073.4 14075.1 15480.3 15526.4 15550.5 15553.0 15669.8 5957.1 5993.8 5998.0 6184.4 6220.3 1086.5 1098.3 1099.7 1121.3 1133.0 25756.5 25952.6 26076.2 26087.1 26215.7 1203.2 1205.4 1224.2 1224.7 1227.0 13676.7 13755.8 13776.9 13812.7 14028.0 278552.0 278571.0 279109.0 280569.0 281110.0 59147.0 59170.7 62782.0 65392.7 65420.0 1519.4 1538.2 1555.1 1556.0 1577.6 30600.3 30667.0 31377.0 31451.7 31556.4 42585.6 42662.1 42765.6 42809.4 42896.4 231787.0 232172.0 232271.0 232930.0 233315.0 36416.6 37644.2 40195.4 40485.4 40584.8 51111.0 51121.0 51889.0 52098.2 52427.0 36279.3 37193.4 37269.3 37279.4 37302.4 36504.0 36602.0 37244.0 37251.3 37484.1 43513.6 43576.6 43905.3 44045.3 44498.6 35325.8 35408.5 35575.5 35877.8 36228.4 26266.5 26945.0 27135.6 27263.5 27461.6 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#2] jquery.html Cycles:180 Average:40827.08 Median:22403.88 stddev:107257.86 (478.7%) stddev-sans-first:107516.19 23:32:24 INFO - PID 2379 | Values: 583.6 599.7 606.4 610.4 617.9 22578.7 23271.5 23294.0 23365.0 23367.2 24944.4 27209.9 27215.3 27222.7 27310.0 6421.4 6640.5 6652.9 6659.0 6661.5 6365.0 6612.1 6667.4 6673.2 6673.8 6613.4 6615.9 6620.0 6632.0 6640.5 6459.5 6619.0 6678.8 6682.6 6685.7 6193.8 6222.0 6227.1 6230.4 6236.8 30668.5 31079.7 31226.4 31236.7 31330.7 2138.0 2192.0 2220.7 2222.2 2227.3 20807.0 21726.3 21732.5 21774.2 21887.0 2466.8 2499.1 2555.0 2579.5 2585.8 135054.0 140302.0 144764.0 155366.0 161447.0 15181.0 15490.0 15818.7 15939.2 16453.4 25773.5 25805.9 25848.2 25956.5 25972.5 10796.4 10895.3 10914.3 11026.7 11194.3 10040.9 10088.9 10127.6 10143.2 10161.4 9654.4 9727.8 9792.5 9938.4 9994.9 2810.9 2822.2 2901.4 2946.5 3004.4 1050.7 1063.4 1066.6 1067.1 1076.5 21162.4 21623.7 21865.0 21890.0 22233.4 1124.1 1124.4 1131.5 1135.9 1141.6 11717.5 11767.1 11835.1 11839.5 11955.5 622402.0 627328.0 630625.0 666551.0 674997.0 125240.0 126430.0 126438.0 127746.0 129365.4 1100.2 1133.3 1170.4 1188.9 1228.0 22521.2 22628.9 22672.8 22833.3 22834.0 62652.7 63230.7 63409.0 64235.7 64262.0 76158.0 77797.2 80561.4 81176.0 81246.0 15161.3 15460.5 15519.8 15597.2 15629.8 22286.6 24212.3 24330.0 24350.0 24615.0 19898.6 20187.7 20268.9 20322.8 20326.3 17334.2 17363.4 17619.8 17707.5 17739.6 19722.9 19984.2 20022.9 20178.0 20270.0 15278.3 15301.2 15305.7 15339.2 15345.0 19352.5 19708.8 19775.0 19839.9 19996.3 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#3] mootools.html Cycles:180 Average:10302.42 Median:2843.54 stddev:7563.58 (266.0%) stddev-sans-first:7555.49 23:32:24 INFO - PID 2379 | Values: 1441.2 1472.7 1487.8 1492.1 1502.6 16297.7 16972.0 17198.2 17217.1 17217.7 16654.3 16705.3 16752.7 16794.2 16824.3 2854.9 2908.6 2910.2 2910.9 2911.9 2766.8 2874.9 2876.0 2876.4 2876.9 2730.5 2817.2 2922.1 2924.9 2928.7 2865.7 2876.9 2887.5 2904.5 2915.4 2730.4 2831.5 2840.8 2846.2 2852.9 16452.3 16501.8 16513.1 16545.4 16566.8 8528.0 8784.0 8787.6 8828.1 8833.6 5188.8 5218.3 5326.0 5382.2 5385.9 2008.6 2047.4 2072.2 2074.9 2123.9 29664.1 30012.0 30149.5 30170.0 30196.8 7123.8 7207.7 7218.9 7352.2 7409.6 19613.3 19637.9 19661.0 19661.1 19661.2 8900.5 9111.0 9116.2 9132.2 9137.2 7927.0 7989.2 8042.2 8068.2 8102.3 5453.5 5592.9 5607.2 5641.6 5673.4 1573.1 1576.8 1589.6 1597.1 1600.4 934.7 949.2 955.9 958.2 965.8 8159.4 8169.8 8558.7 8798.5 8802.5 767.5 771.6 777.3 784.6 791.6 4964.3 5269.4 5352.2 5353.8 5383.7 22164.8 24267.8 24351.6 24463.9 24598.3 23557.3 23928.4 24155.6 24284.5 24595.0 12371.4 12395.8 12530.7 12564.9 12620.5 8938.8 9021.9 9049.3 9062.5 9121.6 20743.2 20800.2 21011.5 21012.9 21348.0 21332.5 21470.1 21614.2 21628.0 21710.2 11971.6 12017.5 12145.9 12146.2 12182.6 15386.8 15516.0 15519.3 15667.7 15679.0 12400.9 12414.9 12507.2 12518.3 12826.6 12160.9 12182.5 12330.4 12380.4 12463.0 10895.5 11159.1 11252.3 11267.2 11278.2 7835.1 7929.2 7936.3 7965.0 8067.1 8189.5 8237.7 8243.4 8261.7 8303.3 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#4] prototype.html Cycles:180 Average:5613.18 Median:6213.28 stddev:1571.56 (25.3%) stddev-sans-first:1529.36 23:32:24 INFO - PID 2379 | Values: 551.2 552.6 564.9 583.6 586.6 6166.6 6221.5 6251.2 6268.5 6334.6 6177.8 6181.4 6197.6 6212.7 6246.8 4795.2 5121.7 5141.7 5145.4 5151.9 4910.0 4944.9 4966.4 4974.3 4977.4 4892.1 4893.6 4938.3 4948.9 4952.5 4921.1 4923.2 4954.2 4965.0 4986.2 4499.8 4515.9 4545.0 4560.7 4561.7 6050.7 6130.8 6213.9 6216.6 6270.7 5760.9 5844.8 5848.3 5854.7 5888.9 6613.1 6618.8 6631.7 6641.9 6680.7 4984.8 4993.8 5020.9 5022.8 5086.8 6827.8 6868.3 6868.6 6905.6 6999.5 5164.7 5168.6 5186.4 5200.1 5212.0 5201.0 5209.5 5231.6 5237.8 5290.7 5738.2 5766.9 5776.7 5809.3 5815.3 6395.5 6561.8 6621.9 6645.5 6678.3 1792.4 1794.6 1803.0 1810.5 1810.8 1161.8 1257.4 1264.8 1273.4 1280.6 6001.7 6086.3 6138.4 6153.6 6198.3 6652.2 6761.5 6777.3 6813.2 6831.2 6146.6 6198.8 6199.4 6224.4 6270.0 3525.2 3558.7 3573.7 3590.9 3610.4 6948.1 6956.3 6960.0 7054.8 7070.6 6814.2 6840.2 6850.4 6864.3 6943.1 6886.9 6944.9 6947.8 7050.8 7056.7 6638.5 6666.7 6686.0 6696.9 6780.2 6717.5 6734.2 6772.4 6786.8 6810.7 6965.9 6969.9 6999.2 7021.5 7034.3 5140.6 5172.9 5176.8 5194.2 5197.7 6703.8 6705.4 6733.6 6741.0 6800.9 6544.8 6561.5 6582.5 6584.8 6606.0 6458.6 6560.9 6590.1 6598.7 6608.9 6399.2 6425.4 6475.0 6483.4 6519.3 6146.6 6381.0 6428.7 6557.3 6629.6 6267.6 6286.2 6299.5 6333.1 6404.3 23:32:24 INFO - PID 2379 | 23:32:24 INFO - PID 2379 | [#5] yui.html Cycles:180 Average:27484.71 Median:18313.63 stddev:40147.97 (219.2%) stddev-sans-first:40211.22 23:32:24 INFO - PID 2379 | Values: 966.0 985.1 1004.0 1006.9 1009.5 20945.4 21226.5 21273.6 21277.5 21307.3 19296.1 19884.0 20176.1 20240.5 20258.4 1032.8 1071.4 1071.5 1071.6 1072.0 1089.8 1093.7 1093.8 1094.2 1095.3 1131.5 1167.1 1174.7 1175.4 1175.6 1169.5 1170.3 1171.5 1172.0 1172.1 801.2 826.3 829.7 831.4 832.8 20704.2 20728.7 20773.5 20803.5 20825.6 22815.9 23267.5 24177.2 24315.3 24319.3 16538.0 16655.2 16738.1 16752.4 16782.7 3854.1 3882.5 3890.8 3893.5 3898.0 132802.0 157750.0 159754.0 159784.0 163362.0 18515.9 18584.9 18737.6 18968.6 18998.0 34658.1 34729.3 34885.5 34953.5 35290.0 9787.3 9836.3 9858.0 9907.7 9920.5 4632.6 4683.4 4715.6 4792.6 4800.6 6054.0 6160.8 6169.8 6193.2 6203.4 1184.8 1197.8 1203.9 1219.1 1227.1 734.4 736.6 748.8 756.0 762.5 13577.7 13855.7 14397.4 15101.8 15238.0 741.0 747.7 748.1 753.8 754.9 6450.8 6586.7 6596.8 6602.6 6603.6 143078.0 143668.0 143856.3 145332.0 145957.0 118233.0 118848.0 121744.4 122298.0 126591.0 103718.0 105926.0 106627.0 107996.5 109990.5 12172.9 12177.8 12230.8 12328.3 12439.9 52661.0 54036.5 54192.5 54974.7 56018.0 66069.3 66686.7 66910.0 67759.3 70171.6 17051.1 17371.9 17372.4 17416.0 17427.2 20251.0 20350.0 20357.6 20364.9 20421.9 18138.1 18227.8 18312.7 18314.5 18420.2 16390.3 16503.6 16518.8 16726.7 16740.3 17760.5 17783.6 17849.9 17921.0 18113.7 12521.2 12688.2 12818.2 13009.3 13219.3 13711.7 13795.4 13857.3 13870.1 13881.5 23:32:24 INFO - PID 2379 | -------- Summary: end -------- 23:32:24 INFO - PID 2379 | 23:32:25 INFO - TEST-INFO | 2379: exit 0 23:32:25 INFO - TEST-OK | dromaeo_css | took 1107195ms 23:32:25 INFO - TEST-START | kraken 23:32:25 INFO - Initialising browser for kraken test... 23:32:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51467/getInfo.html -profile /tmp/tmpurN5Cp/profile 23:32:25 INFO - TEST-INFO | started process 2843 (/builds/slave/test/build/application/firefox/firefox http://localhost:51467/getInfo.html) 23:32:30 INFO - TEST-INFO | 2843: exit 0 23:32:30 INFO - Browser initialized. 23:32:30 INFO - Running cycle 1/1 for kraken test... 23:32:30 INFO - Using env: {'DISPLAY': ':0', 23:32:30 INFO - 'HOME': '/home/cltbld', 23:32:30 INFO - 'JSGC_DISABLE_POISONING': '1', 23:32:30 INFO - 'LANG': 'en_US.UTF-8', 23:32:30 INFO - 'LANGUAGE': 'en_US:en', 23:32:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 23:32:30 INFO - 'LOGNAME': 'cltbld', 23:32:30 INFO - 'MAIL': '/var/mail/cltbld', 23:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:32:30 INFO - 'MOZ_CRASHREPORTER': '1', 23:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 23:32:30 INFO - 'MOZ_NO_REMOTE': '1', 23:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:30 INFO - 'NO_EM_RESTART': '1', 23:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:30 INFO - 'PWD': '/builds/slave/test', 23:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:32:30 INFO - 'RUST_BACKTRACE': 'full', 23:32:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:32:30 INFO - 'SHELL': '/bin/bash', 23:32:30 INFO - 'SHLVL': '1', 23:32:30 INFO - 'TERM': 'linux', 23:32:30 INFO - 'TMOUT': '86400', 23:32:30 INFO - 'USER': 'cltbld', 23:32:30 INFO - 'XDG_SESSION_COOKIE': 'ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270', 23:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:30 INFO - '_': '/tools/buildbot/bin/python'} 23:32:30 INFO - TEST-INFO | started process 3180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpurN5Cp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:32:31 INFO - PID 3180 | 23:32:31 INFO - PID 3180 | (/builds/slave/test/build/application/firefox/firefox:3232): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:32:31 INFO - PID 3180 | 23:32:41 INFO - PID 3180 | RSS: Main: 169304064 23:32:41 INFO - PID 3180 | 23:32:44 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51467/tests/kraken/driver.html?testName=audio-beat-detection) 23:32:44 INFO - PID 3180 | RSS: Main: 174026752 23:32:44 INFO - PID 3180 | 23:32:47 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51467/tests/kraken/driver.html?testName=audio-dft) 23:32:48 INFO - PID 3180 | RSS: Main: 174252032 23:32:48 INFO - PID 3180 | 23:32:51 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51467/tests/kraken/driver.html?testName=audio-fft) 23:32:51 INFO - PID 3180 | RSS: Main: 169840640 23:32:51 INFO - PID 3180 | 23:32:53 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51467/tests/kraken/driver.html?testName=audio-oscillator) 23:32:54 INFO - PID 3180 | RSS: Main: 170762240 23:32:54 INFO - PID 3180 | 23:32:56 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51467/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:32:57 INFO - PID 3180 | RSS: Main: 170827776 23:32:57 INFO - PID 3180 | 23:33:00 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51467/tests/kraken/driver.html?testName=imaging-darkroom) 23:33:00 INFO - PID 3180 | RSS: Main: 174166016 23:33:00 INFO - PID 3180 | 23:33:04 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51467/tests/kraken/driver.html?testName=imaging-desaturate) 23:33:05 INFO - PID 3180 | RSS: Main: 173654016 23:33:05 INFO - PID 3180 | 23:33:07 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51467/tests/kraken/driver.html?testName=json-parse-financial) 23:33:08 INFO - PID 3180 | RSS: Main: 173383680 23:33:08 INFO - PID 3180 | 23:33:10 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51467/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:33:10 INFO - PID 3180 | RSS: Main: 173699072 23:33:10 INFO - PID 3180 | 23:33:12 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:33:12 INFO - PID 3180 | RSS: Main: 174432256 23:33:12 INFO - PID 3180 | 23:33:14 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:33:15 INFO - PID 3180 | RSS: Main: 170639360 23:33:15 INFO - PID 3180 | 23:33:18 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:33:18 INFO - PID 3180 | RSS: Main: 170786816 23:33:18 INFO - PID 3180 | 23:33:21 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:33:22 INFO - PID 3180 | RSS: Main: 171196416 23:33:22 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | Cycle 1(1): loaded http://localhost:51467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51467/tests/kraken/driver.html?testName=ai-astar) 23:33:23 INFO - PID 3180 | RSS: Main: 172699648 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | __start_tp_report 23:33:23 INFO - PID 3180 | _x_x_mozilla_page_load 23:33:23 INFO - PID 3180 | _x_x_mozilla_page_load_details 23:33:23 INFO - PID 3180 | |i|pagename|runs| 23:33:23 INFO - PID 3180 | |0;ai-astar;107;106;106;106;106;106;98;106;105;105 23:33:23 INFO - PID 3180 | |1;audio-beat-detection;112;113;120;138;118;116;112;148;115;115 23:33:23 INFO - PID 3180 | |2;audio-dft;163;163;163;161;162;163;163;163;162;170 23:33:23 INFO - PID 3180 | |3;audio-fft;73;77;73;72;72;72;74;78;76;87 23:33:23 INFO - PID 3180 | |4;audio-oscillator;78;78;82;79;77;77;79;79;79;79 23:33:23 INFO - PID 3180 | |5;imaging-gaussian-blur;113;115;114;112;117;113;113;114;114;113 23:33:23 INFO - PID 3180 | |6;imaging-darkroom;150;149;150;150;149;148;149;149;151;149 23:33:23 INFO - PID 3180 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;94;94 23:33:23 INFO - PID 3180 | |8;json-parse-financial;46;43;44;46;46;45;45;44;44;43 23:33:23 INFO - PID 3180 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;38;39;38 23:33:23 INFO - PID 3180 | |10;stanford-crypto-aes;73;70;71;72;73;71;75;72;71;75 23:33:23 INFO - PID 3180 | |11;stanford-crypto-ccm;110;104;103;105;111;106;109;106;116;104 23:33:23 INFO - PID 3180 | |12;stanford-crypto-pbkdf2;156;154;155;157;155;157;158;156;162;158 23:33:23 INFO - PID 3180 | |13;stanford-crypto-sha256-iterative;64;59;60;62;61;58;60;61;59;61 23:33:23 INFO - PID 3180 | __end_tp_report 23:33:23 INFO - PID 3180 | __start_cc_report 23:33:23 INFO - PID 3180 | _x_x_mozilla_cycle_collect,876 23:33:23 INFO - PID 3180 | __end_cc_report 23:33:23 INFO - PID 3180 | __startTimestamp1505370803963__endTimestamp 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | ------- Summary: start ------- 23:33:23 INFO - PID 3180 | Number of tests: 14 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#0] ai-astar Cycles:10 Average:105.10 Median:106.00 stddev:2.56 (2.4%) stddev-sans-first:2.62 23:33:23 INFO - PID 3180 | Values: 107.0 106.0 106.0 106.0 106.0 106.0 98.0 106.0 105.0 105.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:117.00 stddev:12.25 (10.5%) stddev-sans-first:12.58 23:33:23 INFO - PID 3180 | Values: 112.0 113.0 120.0 138.0 118.0 116.0 112.0 148.0 115.0 115.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.45 (1.5%) stddev-sans-first:2.60 23:33:23 INFO - PID 3180 | Values: 163.0 163.0 163.0 161.0 162.0 163.0 163.0 163.0 162.0 170.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#3] audio-fft Cycles:10 Average:75.40 Median:75.00 stddev:4.62 (6.2%) stddev-sans-first:4.82 23:33:23 INFO - PID 3180 | Values: 73.0 77.0 73.0 72.0 72.0 72.0 74.0 78.0 76.0 87.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:79.00 stddev:1.42 (1.8%) stddev-sans-first:1.48 23:33:23 INFO - PID 3180 | Values: 78.0 78.0 82.0 79.0 77.0 77.0 79.0 79.0 79.0 79.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.40 (1.2%) stddev-sans-first:1.45 23:33:23 INFO - PID 3180 | Values: 113.0 115.0 114.0 112.0 117.0 113.0 113.0 114.0 114.0 113.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 23:33:23 INFO - PID 3180 | Values: 150.0 149.0 150.0 150.0 149.0 148.0 149.0 149.0 151.0 149.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:33:23 INFO - PID 3180 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#8] json-parse-financial Cycles:10 Average:44.60 Median:45.00 stddev:1.17 (2.6%) stddev-sans-first:1.13 23:33:23 INFO - PID 3180 | Values: 46.0 43.0 44.0 46.0 46.0 45.0 45.0 44.0 44.0 43.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 23:33:23 INFO - PID 3180 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#10] stanford-crypto-aes Cycles:10 Average:72.30 Median:72.50 stddev:1.70 (2.3%) stddev-sans-first:1.79 23:33:23 INFO - PID 3180 | Values: 73.0 70.0 71.0 72.0 73.0 71.0 75.0 72.0 71.0 75.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#11] stanford-crypto-ccm Cycles:10 Average:107.40 Median:107.50 stddev:4.06 (3.8%) stddev-sans-first:4.20 23:33:23 INFO - PID 3180 | Values: 110.0 104.0 103.0 105.0 111.0 106.0 109.0 106.0 116.0 104.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.00 stddev:2.25 (1.4%) stddev-sans-first:2.37 23:33:23 INFO - PID 3180 | Values: 156.0 154.0 155.0 157.0 155.0 157.0 158.0 156.0 162.0 158.0 23:33:23 INFO - PID 3180 | 23:33:23 INFO - PID 3180 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.72 (2.8%) stddev-sans-first:1.27 23:33:23 INFO - PID 3180 | Values: 64.0 59.0 60.0 62.0 61.0 58.0 60.0 61.0 59.0 61.0 23:33:23 INFO - PID 3180 | -------- Summary: end -------- 23:33:23 INFO - PID 3180 | 23:33:24 INFO - PID 3180 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 23:33:24 INFO - TEST-INFO | 3180: exit 0 23:33:24 INFO - TEST-OK | kraken | took 59501ms 23:33:24 INFO - SUITE-END | took 1166s 23:33:25 INFO - Completed test suite (00:19:27) 23:33:25 INFO - javascript benchmark 23:33:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9091.056056513098, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3781.5084039074923, 3836.9448401689533, 3856.0167157374867, 3872.5352957645086, 3899.863504777333, 6154.938450615493, 6285.560010799246, 6310.053491976194, 6382.074599183122, 6401.711922963466, 6244.313125556197, 6358.268799088106, 6362.650054247015, 6387.616742995424, 6429.35706429358, 5677.233573467591, 5681.091025435931, 5724.856878578038, 5728.914066289009, 5763.0779075347955, 179.9154397433206, 5634.239377684001, 5643.153526970947, 5777.1623114648355, 5806.912896306559, 5587.106063029916, 5648.943510564904, 5700.543956483471, 5731.541476681856, 5746.994276001704, 5640.0693885508845, 5663.716814159276, 5698.772049118031, 5725.713714314267, 5745.368009518991, 5620.4660557247, 5645.407232240637, 5705.315362156526, 5721.6853073080965, 5725.255716756837, 6294.244690637152, 6311.179546658951, 6348.333424990402, 6354.650494222816, 6395.680215989229, 6738.191417029939, 6807.523473356867, 6828.931710682879, 6886.552374095668, 6902.6203558804245, 6936.79189624307, 6956.5478243913985, 7001.82495437613, 7007.4394048476, 7010.158780946319, 6381.0, 6399.392057754552, 6409.0, 6476.481881449473, 6499.6100233985635, 6952.991816186725, 7045.11936007999, 7049.0, 7062.858742825115, 7166.283371662897, 6719.193696756322, 6732.899006514906, 6738.393544581011, 6741.561798483083, 6742.629155396402, 6834.111565496553, 6920.204176519765, 6984.301569842975, 6989.4408447324095, 6997.790066298019, 6795.150606174228, 6797.966010169917, 6877.518573699893, 6884.277150899184, 6887.276835932155, 6783.084283621648, 6798.626075565891, 6805.285445028201, 6883.793486195422, 6888.517803753689, 4980.651354405157, 4991.5258050485145, 4993.226049962262, 5010.649254552146, 5073.0, 4470.597646211857, 4540.841070562515, 4571.314302854598, 4589.862304130881, 4614.446266448048, 6224.813255602339, 6240.937590624127, 6297.527685423612, 6303.684815759286, 6318.178636777189, 6845.726170953206, 6857.108575885203, 6860.451163906875, 6935.098437203132, 6936.583804971718, 6219.315875253718, 6280.937190628127, 6300.432961033529, 6331.081993110973, 6349.841253968688, 5510.228568000403, 5528.695921724263, 5578.219049333096, 5580.91628625571, 5593.356763972114, 6967.930320696728, 7062.611556364449, 7160.427165826722, 7163.212046674862, 7173.6413179340825, 6764.458843292525, 6765.695543700447, 6790.1851777786, 6835.453163746789, 6880.827979300358, 7205.495615307088, 7219.9892015116875, 7223.0, 7227.27727227273, 7227.891581626385, 6705.698243579148, 6774.559653622498, 6792.864142717019, 6798.694058767466, 6844.863102737818, 6894.345037221456, 6928.237893831573, 6982.197047339621, 7001.544899581511, 7003.089598352385, 6497.545171837926, 6588.341165883373, 6602.636854973022, 6625.337466253336, 6711.798646040626, 6562.3109573496, 6659.167604049494, 6660.966695166493, 6672.132622759011, 6674.899876501953, 6513.869722605426, 6514.511411644051, 6610.2398224204835, 6616.139901812926, 6624.966875165594, 6596.57122287069, 6615.5038372123245, 6639.468842492685, 6670.232923213698, 6747.797566073025, 6373.521985851173, 6420.26166990802, 6441.1304473895425, 6451.741930322734, 6516.804495865132], "value": 6221.958533740346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.9032106468289, 897.8159477307153, 902.2466240689024, 908.3913777768898, 917.6329468212718, 44630.33054504185, 44898.55101448984, 44908.999999999956, 45230.54769452305, 45659.771701141486, 43014.35478467825, 43254.134917301635, 43284.134317313634, 43323.78338108305, 43348.0, 7437.962810185955, 7491.812704682399, 7497.3252407283335, 7498.47510674253, 7504.5872477013745, 7322.707091716325, 7379.298966598165, 7382.409407247407, 7384.778456646282, 7385.039944807168, 8156.551389673566, 8360.372972027122, 8365.874511882326, 8366.121557236494, 8367.372447066464, 8098.3926205534235, 8259.132791056973, 8294.212049855285, 8354.540500272482, 8367.079621241659, 7786.221377862168, 7852.17552157021, 7859.449838511307, 7863.882041769378, 7868.6065696715505, 40783.796081019704, 41047.794761026, 41055.0, 41066.79466602648, 41246.1750764986, 3798.2023775007005, 3842.231553689245, 3846.0961674006585, 3847.769133851978, 3848.6536211741077, 33394.83302583496, 33411.6658833411, 33592.32815343704, 33624.831875840464, 33683.49474757881, 5508.338999320067, 5520.033994051065, 5552.583556233259, 5554.0, 5637.830865074055, 217415.0, 217831.0, 218208.0, 218649.0, 218938.90530547404, 46142.30786538205, 46602.0, 53404.19362257415, 54066.45933540614, 54183.0, 58603.41396585979, 58614.41385586175, 59180.0, 59180.0, 59228.0, 17128.14359282031, 17254.0, 17267.309307627555, 17268.0, 17275.222614982355, 13834.169949803045, 14063.226522541358, 14073.0, 14073.366698498592, 14075.085119467201, 15480.303386347416, 15526.378944842305, 15550.533483995498, 15553.0, 15669.843301567067, 5957.1362152487645, 5993.760249589967, 5998.0, 6184.392058064936, 6220.253569571681, 1086.5002099034375, 1098.2970898624887, 1099.7470581766079, 1121.2543658467027, 1132.9660110196708, 25756.484870302487, 25952.61071083935, 26076.217713468628, 26087.08695195659, 26215.73784262133, 1203.2299328429813, 1205.4394706461537, 1224.155332820351, 1224.6938265433641, 1226.9815952760716, 13676.726465470634, 13755.79366309506, 13776.93111534456, 13812.723745525032, 14028.0, 278552.0, 278571.0, 279109.0, 280569.0, 281110.0, 59147.0, 59170.704146478995, 62782.0, 65392.67303663546, 65420.0, 1519.3618680154361, 1538.2155100898622, 1555.098043134979, 1555.984440155584, 1577.6371434570112, 30600.31698256617, 30667.0, 31377.0, 31451.68548314579, 31556.36887262196, 42585.574144258164, 42662.146757065304, 42765.57234427616, 42809.35785963275, 42896.35655465233, 231787.0, 232172.0, 232271.0, 232930.0, 233315.0, 36416.635833641325, 37644.2471150581, 40195.39706904457, 40485.39271910983, 40584.79707601443, 51111.0, 51121.0, 51889.0, 52098.21852672137, 52427.0, 36279.27441451209, 37193.44209836909, 37269.25461490701, 37279.44080838736, 37302.440463393614, 36504.0, 36602.0, 37244.0, 37251.254974899806, 37484.06289842776, 43513.56486435095, 43576.56423435852, 43905.34141987809, 44045.33931990959, 44498.55501444944, 35325.82337088298, 35408.46887296641, 35575.46636800502, 35877.82061089678, 36228.36972336198, 26266.474670506865, 26945.0, 27135.59296610513, 27263.454730904876, 27461.588076178472], "value": 19005.057117045453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.6031498580966, 599.7091410665827, 606.396635347829, 610.3804638292135, 617.9073139029147, 22578.66132008019, 23271.534569308624, 23294.0, 23365.013973812245, 23367.1821486248, 24944.376390590245, 27209.863950680217, 27215.319617009536, 27222.727772722268, 27310.0, 6421.42207201353, 6640.535162538624, 6652.866942661144, 6659.0, 6661.467082633402, 6364.968175159118, 6612.107365505667, 6667.366600172976, 6673.199216094075, 6673.833154171136, 6613.43785778207, 6615.933840661604, 6620.04009418634, 6632.0, 6640.501962352819, 6459.483241340681, 6618.966905165467, 6678.766243181465, 6682.599044057372, 6685.665716714194, 6193.783217587408, 6222.0, 6227.09707092469, 6230.43926046658, 6236.844078898019, 30668.539971900438, 31079.689203107904, 31226.375472490425, 31236.68763312383, 31330.686693133004, 2138.0, 2191.980728961025, 2220.666899965002, 2222.2444368914485, 2227.3429338345227, 20807.0, 21726.34820955374, 21732.456688582755, 21774.237901673525, 21887.0, 2466.7656572625574, 2499.0628514307136, 2555.0418593027616, 2579.496998085374, 2585.8060645451665, 135054.0, 140302.0, 144764.0, 155366.0, 161447.0, 15181.013234139966, 15489.999999999774, 15818.683626327409, 15939.203039847962, 16453.42413015539, 25773.484530309288, 25805.870970645028, 25848.224553263433, 25956.480870382486, 25972.480550388886, 10796.352218866894, 10895.346279223271, 10914.290571112851, 11026.669199924016, 11194.328340299608, 10040.899591003996, 10088.949555252177, 10127.594896204217, 10143.23925705575, 10161.441120738431, 9654.372465789702, 9727.756806079904, 9792.510374481248, 9938.403695778132, 9994.850077248848, 2810.9156725298276, 2822.223888430698, 2901.361700425903, 2946.499095153829, 3004.354063876277, 1050.7110544600143, 1063.4363787192801, 1066.6320119558895, 1067.0769784136667, 1076.5048077884105, 21162.365129046153, 21623.67564486534, 21865.0, 21890.0, 22233.444163895707, 1124.1175677093606, 1124.3815901254277, 1131.4512461456188, 1135.8693750218831, 1141.6004398460473, 11717.472713727902, 11767.058635309155, 11835.11236657254, 11839.467223974942, 11955.52177912891, 622402.0, 627328.0, 630625.0, 666551.0, 674997.0, 125240.0, 126430.0, 126438.0, 127746.0, 129365.35317323353, 1100.1693721240572, 1133.2747041893194, 1170.4068509675215, 1188.9048876090064, 1227.975440491203, 22521.211757588404, 22628.886855566274, 22672.84144897559, 22833.33166788221, 22834.0, 62652.68673656785, 63230.68384658231, 63409.04886426799, 64235.678821605594, 64262.0, 76158.0, 77797.222027779, 80561.3887722254, 81176.0, 81246.0, 15161.317740701474, 15460.5361839145, 15519.84480155184, 15597.220138992778, 15629.843701562839, 22286.554268914857, 24212.273631791075, 24330.0, 24350.0, 24615.01539938454, 19898.60202795965, 20187.697184542536, 20268.89865550663, 20322.79677203268, 20326.288579899632, 17334.219960101575, 17363.3922812706, 17619.823801761817, 17707.46877593674, 17739.645207096044, 19722.90138549298, 19984.20063197456, 20022.89988550048, 20178.0, 20270.0, 15278.312475938386, 15301.158436285667, 15305.693886121993, 15339.156346401054, 15345.0025748326, 19352.516187095436, 19708.802911970695, 19775.0, 19839.900800495907, 19996.30012949598], "value": 12860.754918591045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.2361448432332, 1472.7496325624643, 1487.754520504117, 1492.097281144908, 1502.6468779836732, 16297.674046519063, 16972.0, 17198.226079826407, 17217.13914304283, 17217.741733873972, 16654.333826646918, 16705.331786728515, 16752.748708769377, 16794.244259008345, 16824.32702691891, 2854.900078497253, 2908.5927970084203, 2910.228789370808, 2910.8544572771384, 2911.912642620725, 2766.8201566898188, 2874.928126796826, 2875.971240287591, 2876.4390943765975, 2876.9280767980863, 2730.4539092181544, 2817.1548535439388, 2922.1087568291664, 2924.8830046798103, 2928.6924872888358, 2865.7277558631895, 2876.913692589226, 2887.4946884295164, 2904.5352743561034, 2915.3586211033644, 2730.385663225778, 2831.4620222157723, 2840.8437535935514, 2846.245744877609, 2852.9001484948135, 16452.259648315736, 16501.83498165015, 16513.091779952098, 16545.420910268083, 16566.83433165677, 8527.95736021322, 8784.0, 8787.560621968876, 8828.117188281185, 8833.646654133827, 5188.766505507261, 5218.269442278084, 5326.0, 5382.2464854920345, 5385.946140538623, 2008.6083213773175, 2047.4369548374316, 2072.171131547378, 2074.8651337663155, 2123.9044243009103, 29664.110076697732, 30012.0, 30149.547756783664, 30170.0, 30196.849015755, 7123.786286411416, 7207.711691532385, 7218.927810721931, 7352.154502232205, 7409.592472414069, 19613.31353402624, 19637.901810490857, 19661.0, 19661.115249813793, 19661.213551457782, 8900.465972041698, 9111.0, 9116.225120864668, 9132.223760980258, 9137.177654011171, 7926.960365198137, 7989.161138080534, 8042.235987581171, 8068.193180682002, 8102.270795628422, 5453.481919217747, 5592.944070559242, 5607.158926161109, 5641.605087643908, 5673.375928647845, 1573.1111921764166, 1576.7634854771875, 1589.6025993501626, 1597.1295643874116, 1600.447845493303, 934.6915517879083, 949.1694767078806, 955.9187469065068, 958.1951161024773, 965.8116667249819, 8159.388045896581, 8169.79575510617, 8558.700445484377, 8798.516081615573, 8802.515861627544, 767.5318055985845, 771.5524995502595, 777.296546625305, 784.5841703896943, 791.5646394483011, 4964.304997300381, 5269.394019687708, 5352.19717042439, 5353.785848566014, 5383.730813459311, 22164.778352216596, 24267.757322426904, 24351.634725479133, 24463.877680611484, 24598.262052138463, 23557.29328120159, 23928.40178995539, 24155.63766543503, 24284.514309713708, 24595.0, 12371.381430928597, 12395.75208495825, 12530.686732831753, 12564.87435125637, 12620.495180192873, 8938.821223575362, 9021.90978090237, 9049.321300902327, 9062.546872656472, 9121.631755236767, 20743.1702731889, 20800.167993280098, 21011.474713132295, 21012.894935525226, 21348.0, 21332.466688332916, 21470.141194352676, 21614.243501477373, 21628.0, 21710.240141594968, 11971.64085077449, 12017.519299228283, 12145.878541214475, 12146.210496317712, 12182.634520964386, 15386.769198461809, 15516.0, 15519.301631426388, 15667.686646267239, 15679.0, 12400.875991239973, 12414.875851241733, 12507.187032842836, 12518.311492867615, 12826.55107071248, 12160.939195304321, 12182.512699492276, 12330.445129968994, 12380.380980951097, 12463.0, 10895.509702063267, 11159.10727141843, 11252.26860254081, 11267.211295209585, 11278.154138439486, 7835.059792824897, 7929.207079292025, 7936.2857342839425, 7965.044194696674, 8067.112617611941, 8189.50862948225, 8237.670493180445, 8243.381746369167, 8261.710840120568, 8303.252707256375], "value": 7203.539422638384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.2310327093707, 552.6380220955273, 564.9011423000975, 583.6177303865967, 586.5805948746645, 6166.599171053878, 6221.502279817621, 6251.187345645059, 6268.498520118391, 6334.588251763632, 6177.814665560029, 6181.350958149397, 6197.597156184856, 6212.689365531716, 6246.781362652308, 4795.160846851804, 5121.692698438087, 5141.717205553702, 5145.382554093514, 5151.871203219912, 4909.975450122763, 4944.901101977958, 4966.379202599675, 4974.328465657144, 4977.377827771528, 4892.119418504668, 4893.559579637832, 4938.259261110827, 4948.876278093058, 4952.5047495250365, 4921.114199444099, 4923.236898280772, 4954.207326827708, 4965.0069986002945, 4986.152354099811, 4499.75251361175, 4515.864524064284, 4544.954550454486, 4560.749158796265, 4561.657875659305, 6050.727717252734, 6130.785422510236, 6213.87572248557, 6216.627002379872, 6270.6864656766975, 5760.942390576082, 5844.824655260349, 5848.298204215522, 5854.662842179959, 5888.941110588925, 6613.148318470836, 6618.768343108016, 6631.7347306107695, 6641.907799043334, 6680.665966701694, 4984.800607975677, 4993.750312484398, 5020.899582008376, 5022.84931452057, 5086.821961231339, 6827.829304267383, 6868.278830722802, 6868.62222577758, 6905.551139175937, 6999.5450295731125, 5164.664296820694, 5168.638195326291, 5186.40356359016, 5200.141976573898, 5212.0, 5201.037808005531, 5209.453007434241, 5231.607629427732, 5237.764300606482, 5290.7354632269, 5738.167965644958, 5766.88466230673, 5776.711164441761, 5809.2738407699035, 5815.302163740378, 6395.52033597482, 6561.80314590563, 6621.9006714899315, 6645.501587380966, 6678.33216678338, 1792.3726695656417, 1794.5693033672085, 1802.9716568860033, 1810.520212143783, 1810.755548001003, 1161.8315344275034, 1257.3713143428286, 1264.76601828662, 1273.3824095313767, 1280.571008712092, 6001.679630481287, 6086.269647642312, 6138.416850399205, 6153.630782153085, 6198.287196972406, 6652.234992975869, 6761.4590832733265, 6777.288384719632, 6813.182418109858, 6831.248562658104, 6146.6004709693725, 6198.791235709084, 6199.389552455035, 6224.408681175281, 6270.0, 3525.219764019154, 3558.6619271169197, 3573.6783689468075, 3590.9102272443397, 3610.35013697537, 6948.096747422803, 6956.304369563104, 6960.0, 7054.753083642048, 7070.646467676595, 6814.182298124257, 6840.213375461885, 6850.38346548813, 6864.283929017745, 6943.097397338313, 6886.931130688629, 6944.930550694529, 6947.826304342432, 7050.788476345718, 7056.682449289794, 6638.53530252897, 6666.699998499982, 6686.0, 6696.933030669826, 6780.186377634715, 6717.529772915849, 6734.215432910185, 6772.390484856386, 6786.830329241611, 6810.693518791567, 6965.930340696528, 6969.919662452328, 6999.230084690578, 7021.453052088793, 7034.261402552658, 5140.588752899834, 5172.922406163835, 5176.767045483038, 5194.168932970858, 5197.66215196011, 6703.754242328874, 6705.362990515893, 6733.562318449285, 6741.0, 6800.897986530305, 6544.770933017321, 6561.507886908405, 6582.506312026521, 6584.76953306632, 6605.979455613864, 6458.61248325102, 6560.9343906560325, 6590.143281373391, 6598.670066496752, 6608.867822643617, 6399.232092148972, 6425.389587989133, 6474.967625161844, 6483.448906842971, 6519.315471875385, 6146.631202127886, 6380.96809515968, 6428.717805179094, 6557.344265573404, 6629.635370054693, 6267.62394256346, 6286.245650521967, 6299.496040316855, 6333.145025421509, 6404.263509696445], "value": 5160.454390032764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [965.9613615455382, 985.1332622069776, 1004.0260946881523, 1006.8590397344377, 1009.5154325923556, 20945.37163885084, 21226.469338266532, 21273.57452850942, 21277.468063298424, 21307.25424610135, 19296.131674074666, 19884.0, 20176.092075856584, 20240.493987650316, 20258.39224823254, 1032.793441311739, 1071.3786004117594, 1071.4589132488122, 1071.59815069349, 1071.9732006699817, 1089.7711480589087, 1093.7046997310722, 1093.8249880019198, 1094.179365475893, 1095.2935356694927, 1131.4738646529363, 1167.130487786596, 1174.6887074925153, 1175.371176420615, 1175.5944199251244, 1169.4620474581702, 1170.3153655111769, 1171.5313874450203, 1172.027217409548, 1172.050638982427, 801.2228138705447, 826.3430572694722, 829.7469271872077, 831.3889291370838, 832.8167803083372, 20704.171833126657, 20728.689069663968, 20773.480662983395, 20803.479913002146, 20825.583488330147, 22815.88592057029, 23267.53464930692, 24177.153799617106, 24315.270541883772, 24319.270421887195, 16538.0, 16655.167241637868, 16738.079405632685, 16752.41366552165, 16782.664346713118, 3854.0557563396865, 3882.456456096149, 3890.7860067696265, 3893.493845800056, 3897.9610203897882, 132802.0, 157750.0, 159754.0, 159784.0, 163361.9999999988, 18515.907420462812, 18584.907075464536, 18737.625247494972, 18968.62062758737, 18998.0, 34658.13354666103, 34729.30541389158, 34885.476717849255, 34953.47569786455, 35290.0, 9787.314887957775, 9836.262280329003, 9857.950710246403, 9907.653232136841, 9920.4543750093, 4632.60622847055, 4683.367745354401, 4715.575598196178, 4792.592629626451, 4800.615950723934, 6053.969730151409, 6160.7535698571555, 6169.8457538561, 6193.163922870355, 6203.379662033761, 1184.797059513561, 1197.7604479104214, 1203.8856308650663, 1219.0856857356982, 1227.1042139238407, 734.4418242136015, 736.569107072358, 748.827769612992, 755.9546427214385, 762.4510352546158, 13577.660558485919, 13855.653608659662, 14397.352119154453, 15101.848981510044, 15238.0, 741.0181509499935, 747.7196051480695, 748.1222132447596, 753.7927070055669, 754.864124457592, 6450.838729031811, 6586.71559045991, 6596.80209593713, 6602.60384376939, 6603.603783772989, 143078.0, 143668.0, 143856.28071859575, 145332.0, 145957.0, 118233.0, 118848.0, 121744.39127804482, 122298.0, 126591.0, 103718.0, 105926.0, 106626.99999999844, 107996.46001769941, 109990.45004774925, 12172.878271217529, 12177.756444871231, 12230.816537752118, 12328.260304381407, 12439.937800310941, 52661.0, 54036.459635403146, 54192.45807541874, 54974.72512637411, 56017.99999999837, 66069.33930660631, 66686.66656666686, 66910.0, 67759.3224067753, 70171.64914175397, 17051.147442628066, 17371.913140434215, 17372.391966281626, 17416.04211768365, 17427.215775290395, 20251.0, 20350.01099406304, 20357.592848142656, 20364.898175509028, 20421.897890510452, 18138.093095345444, 18227.817721822612, 18312.72530912011, 18314.542136446697, 18420.17109230061, 16390.344386224417, 16503.587410314838, 16518.83481165173, 16726.665466690356, 16740.330386784393, 17760.467185984442, 17783.644327113645, 17849.910750446164, 17921.0, 18113.728294075863, 12521.248725076524, 12688.23870567769, 12818.230906145662, 13009.349532523525, 13219.272939988008, 13711.725765484834, 13795.448182072605, 13857.30713464343, 13870.098443601133, 13881.514147004806], "value": 9985.312332598382, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1380.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 106.0, 106.0, 106.0, 98.0, 106.0, 105.0, 105.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 120.0, 138.0, 118.0, 116.0, 112.0, 148.0, 115.0, 115.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 170.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 73.0, 72.0, 72.0, 72.0, 74.0, 78.0, 76.0, 87.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 82.0, 79.0, 77.0, 77.0, 79.0, 79.0, 79.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 112.0, 117.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 149.0, 148.0, 149.0, 149.0, 151.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 43.0, 44.0, 46.0, 46.0, 45.0, 45.0, 44.0, 44.0, 43.0], "value": 44.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 71.0, 72.0, 73.0, 71.0, 75.0, 72.0, 71.0, 75.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 103.0, 105.0, 111.0, 106.0, 109.0, 106.0, 116.0, 104.0], "value": 107.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 155.0, 157.0, 155.0, 157.0, 158.0, 156.0, 162.0, 158.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 59.0, 60.0, 62.0, 61.0, 58.0, 60.0, 61.0, 59.0, 61.0], "value": 60.5, "unit": "score"}]}]} 23:33:25 INFO - Return code: 0 23:33:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:33:25 INFO - # TBPL SUCCESS # 23:33:25 INFO - Running post-action listener: _package_coverage_data 23:33:25 INFO - Running post-action listener: _resource_record_post_action 23:33:25 INFO - [mozharness: 2017-09-14 06:33:25.288112Z] Finished run-tests step (success) 23:33:25 INFO - Running post-run listener: _resource_record_post_run 23:33:25 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 335003648; Read time: 0; Write time: 218328 23:33:25 INFO - TinderboxPrint: CPU usage
13.1% 23:33:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:33:25 INFO - TinderboxPrint: I/O write bytes / time
335,003,648 / 218,328 23:33:25 INFO - TinderboxPrint: CPU idle
8,211.9 (86.9%) 23:33:25 INFO - TinderboxPrint: CPU user
1,187.7 (12.6%) 23:33:25 INFO - TinderboxPrint: Swap in / out
0 / 0 23:33:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9465856; Read time: 0; Write time: 836 23:33:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 23:33:25 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 0; Write bytes: 324923392; Read time: 0; Write time: 217492 23:33:25 INFO - Running post-run listener: _upload_blobber_files 23:33:25 INFO - Blob upload gear active. 23:33:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:33:25 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 23:33:25 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'] 23:33:25 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 23:33:26 INFO - (blobuploader) - INFO - Open directory for files ... 23:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:27 INFO - (blobuploader) - INFO - Done attempting. 23:33:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:33:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:34 INFO - (blobuploader) - INFO - Done attempting. 23:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:35 INFO - (blobuploader) - INFO - Done attempting. 23:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:37 INFO - (blobuploader) - INFO - Done attempting. 23:33:37 INFO - (blobuploader) - INFO - Iteration through files over. 23:33:37 INFO - Return code: 0 23:33:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:33:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:33:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9daa7a6c3e329dbdd3f9c3f63b253188b2c79e2b0636252e1a91eac54c922b4e5af2838af7e0fe8615d1888e35bfcf4e447f7ebeb5d53c49342d57d3fed81cf4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510d87c5b80113fc22b1c24b8b198385c934ca29f27e022b081b892ce46ac8c0c1422c051e5194dfb4b08b9374f54ae539dd7a946ecf2dc9362d81ed85280480", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e71fbf95dbe54284aa85316209236c2285e99912c9f3a45c69d338362705f426cb792a1922a76e1d57915b15c6d70597b911e4d9b01708cab81d225851bb2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f511e1dba8c0bf6eb15e557c22b420ca7a5afaf32c8e50a9d3bd339cde405f62e70a47438bc7124fae1f5ea3476792e04ea32fb876edc99800f6ebf8f9bac"} 23:33:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:33:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:33:37 INFO - Contents: 23:33:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9daa7a6c3e329dbdd3f9c3f63b253188b2c79e2b0636252e1a91eac54c922b4e5af2838af7e0fe8615d1888e35bfcf4e447f7ebeb5d53c49342d57d3fed81cf4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510d87c5b80113fc22b1c24b8b198385c934ca29f27e022b081b892ce46ac8c0c1422c051e5194dfb4b08b9374f54ae539dd7a946ecf2dc9362d81ed85280480", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e71fbf95dbe54284aa85316209236c2285e99912c9f3a45c69d338362705f426cb792a1922a76e1d57915b15c6d70597b911e4d9b01708cab81d225851bb2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f511e1dba8c0bf6eb15e557c22b420ca7a5afaf32c8e50a9d3bd339cde405f62e70a47438bc7124fae1f5ea3476792e04ea32fb876edc99800f6ebf8f9bac"} 23:33:37 INFO - Running post-run listener: copy_logs_to_upload_dir 23:33:37 INFO - Copying logs to upload dir... 23:33:37 INFO - mkdir: /builds/slave/test/build/upload/logs 23:33:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.989651 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-13 23:33:37.756530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:33:37.765102) ========= 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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 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/9daa7a6c3e329dbdd3f9c3f63b253188b2c79e2b0636252e1a91eac54c922b4e5af2838af7e0fe8615d1888e35bfcf4e447f7ebeb5d53c49342d57d3fed81cf4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510d87c5b80113fc22b1c24b8b198385c934ca29f27e022b081b892ce46ac8c0c1422c051e5194dfb4b08b9374f54ae539dd7a946ecf2dc9362d81ed85280480", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e71fbf95dbe54284aa85316209236c2285e99912c9f3a45c69d338362705f426cb792a1922a76e1d57915b15c6d70597b911e4d9b01708cab81d225851bb2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f511e1dba8c0bf6eb15e557c22b420ca7a5afaf32c8e50a9d3bd339cde405f62e70a47438bc7124fae1f5ea3476792e04ea32fb876edc99800f6ebf8f9bac"} build_url:https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/TUtDcFL-SUiSRm6PvaFZsA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9daa7a6c3e329dbdd3f9c3f63b253188b2c79e2b0636252e1a91eac54c922b4e5af2838af7e0fe8615d1888e35bfcf4e447f7ebeb5d53c49342d57d3fed81cf4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/510d87c5b80113fc22b1c24b8b198385c934ca29f27e022b081b892ce46ac8c0c1422c051e5194dfb4b08b9374f54ae539dd7a946ecf2dc9362d81ed85280480", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/088e71fbf95dbe54284aa85316209236c2285e99912c9f3a45c69d338362705f426cb792a1922a76e1d57915b15c6d70597b911e4d9b01708cab81d225851bb2", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a1f511e1dba8c0bf6eb15e557c22b420ca7a5afaf32c8e50a9d3bd339cde405f62e70a47438bc7124fae1f5ea3476792e04ea32fb876edc99800f6ebf8f9bac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 23:33:37.793096) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:33:37.793425) ========= 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=ca6c2627acea03e666270f68000001e0-1505369416.616167-874921270 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 23:33:37.847567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:33:37.849621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 23:33:37.851955) ========= ========= Total master_lag: 0.70 =========