builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1506441342.47 results: success (0) revision: cc652dcb13dba40ae3f263ae89ce3e610a34165f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.471368) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.471778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.472060) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.489827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.490136) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 08:55:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.4M=0s 2017-09-26 08:55:42 (36.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.623582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.623915) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017739 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:42.673763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 08:55:42.677144) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cc652dcb13dba40ae3f263ae89ce3e610a34165f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cc652dcb13dba40ae3f263ae89ce3e610a34165f --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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 08:55:42,711 truncating revision to first 12 chars 2017-09-26 08:55:42,711 Setting DEBUG logging. 2017-09-26 08:55:42,711 attempt 1/10 2017-09-26 08:55:42,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cc652dcb13db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 08:55:43,811 unpacking tar archive at: mozilla-beta-cc652dcb13db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-26 08:55:44.076222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:44.076540) ========= script_repo_revision: cc652dcb13dba40ae3f263ae89ce3e610a34165f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:44.076895) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:44.077167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 08:55:44.092995) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-26 08:55:44.093350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:55:44 INFO - MultiFileLogger online at 20170926 08:55:44 in /builds/slave/test 08:55:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 08:55:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:44 INFO - {'append_to_log': False, 08:55:44 INFO - 'base_work_dir': '/builds/slave/test', 08:55:44 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:55:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:44 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:55:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:44 INFO - 'code_coverage': False, 08:55:44 INFO - 'config_files': ('talos/linux_config.py',), 08:55:44 INFO - 'default_actions': ('clobber', 08:55:44 INFO - 'read-buildbot-config', 08:55:44 INFO - 'download-and-extract', 08:55:44 INFO - 'populate-webroot', 08:55:44 INFO - 'create-virtualenv', 08:55:44 INFO - 'install', 08:55:44 INFO - 'setup-mitmproxy', 08:55:44 INFO - 'run-tests'), 08:55:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:44 INFO - 'disable_ccov_upload': False, 08:55:44 INFO - 'disable_stylo': False, 08:55:44 INFO - 'download_minidump_stackwalk': True, 08:55:44 INFO - 'download_symbols': 'ondemand', 08:55:44 INFO - 'enable_stylo': False, 08:55:44 INFO - 'enable_webrender': False, 08:55:44 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:55:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:44 INFO - 'gecko_profile': False, 08:55:44 INFO - 'gecko_profile_interval': 0, 08:55:44 INFO - 'installer_path': 'installer.exe', 08:55:44 INFO - 'log_level': 'info', 08:55:44 INFO - 'log_name': 'talos', 08:55:44 INFO - 'log_to_console': True, 08:55:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:55:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:55:44 INFO - 'opt_config_files': (), 08:55:44 INFO - 'pip_index': False, 08:55:44 INFO - 'suite': 'dromaeojs-e10s', 08:55:44 INFO - 'system_bits': '32', 08:55:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:44 INFO - 'title': 'talos-linux64-ix-039', 08:55:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:44 INFO - 'use_talos_json': True, 08:55:44 INFO - 'verify': 'False', 08:55:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:44 INFO - 'work_dir': 'build'} 08:55:44 INFO - [mozharness: 2017-09-26 15:55:44.272913Z] Running clobber step. 08:55:44 INFO - Running pre-action listener: _resource_record_pre_action 08:55:44 INFO - Running main action method: clobber 08:55:44 INFO - rmtree: /builds/slave/test/build 08:55:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:45 INFO - Running post-action listener: _resource_record_post_action 08:55:45 INFO - [mozharness: 2017-09-26 15:55:45.405617Z] Finished clobber step (success) 08:55:45 INFO - [mozharness: 2017-09-26 15:55:45.405714Z] Running read-buildbot-config step. 08:55:45 INFO - Running pre-action listener: _resource_record_pre_action 08:55:45 INFO - Running main action method: read_buildbot_config 08:55:45 INFO - Using buildbot properties: 08:55:45 INFO - { 08:55:45 INFO - "project": "", 08:55:45 INFO - "product": "firefox", 08:55:45 INFO - "who": "Callek@gmail.com", 08:55:45 INFO - "installer_path": "public/build/target.tar.bz2", 08:55:45 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:55:45 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:55:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:55:45 INFO - "stage_platform": "linux64", 08:55:45 INFO - "basedir": "/builds/slave/test", 08:55:45 INFO - "buildnumber": 127, 08:55:45 INFO - "platform": "ubuntu64_hw", 08:55:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:55:45 INFO - "slavebuilddir": "test", 08:55:45 INFO - "taskId": "CM8GXKeWTne0Izwyrfcm5g", 08:55:45 INFO - "branch": "mozilla-beta", 08:55:45 INFO - "script_repo_revision": "production", 08:55:45 INFO - "revision": "cc652dcb13dba40ae3f263ae89ce3e610a34165f", 08:55:45 INFO - "slavename": "talos-linux64-ix-039", 08:55:45 INFO - "repo_path": "releases/mozilla-beta" 08:55:45 INFO - } 08:55:45 INFO - Finding installer, test and symbols from parent task. 08:55:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CM8GXKeWTne0Izwyrfcm5g'}, attempt #1 08:55:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CM8GXKeWTne0Izwyrfcm5g'}, attempt #1 08:55:46 INFO - Task dependencies: ER9NEPuWR2OZYMpC2mabvQ 08:55:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ'}, attempt #1 08:55:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 08:55:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.test_packages.json 08:55:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.crashreporter-symbols.zip 08:55:46 INFO - Running post-action listener: _resource_record_post_action 08:55:46 INFO - [mozharness: 2017-09-26 15:55:46.717742Z] Finished read-buildbot-config step (success) 08:55:46 INFO - [mozharness: 2017-09-26 15:55:46.717959Z] Running download-and-extract step. 08:55:46 INFO - Running pre-action listener: _resource_record_pre_action 08:55:46 INFO - Running main action method: download_and_extract 08:55:46 INFO - mkdir: /builds/slave/test/build/tests 08:55:46 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')]} 08:55:46 INFO - trying https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.test_packages.json 08:55:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:55:47 INFO - Downloaded 989 bytes. 08:55:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:55:47 INFO - Using the following test package requirements: 08:55:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:55:47 INFO - u'common': [u'target.common.tests.zip'], 08:55:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:55:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:55:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:55:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:55:47 INFO - u'mozbase': [u'target.common.tests.zip'], 08:55:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:55:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:55:47 INFO - u'web-platform': [u'target.common.tests.zip', 08:55:47 INFO - u'target.web-platform.tests.tar.gz'], 08:55:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:55:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:55:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.common.tests.zip 08:55:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:55:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.common.tests.zip into memory 08:55:48 INFO - Content-Length response header: 55181468 08:55:48 INFO - Bytes received: 55181468 08:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.talos.tests.zip 08:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.talos.tests.zip into memory 08:55:59 INFO - Content-Length response header: 14509184 08:55:59 INFO - Bytes received: 14509184 08:56: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')]} 08:56:00 INFO - trying https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 08:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:56:01 INFO - Downloaded 53502593 bytes. 08:56:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 08:56:01 INFO - mkdir: /builds/slave/test/properties 08:56:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:01 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:01 INFO - Contents: 08:56:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 08:56:01 INFO - Running post-action listener: _resource_record_post_action 08:56:01 INFO - Running post-action listener: find_tests_for_verification 08:56:01 INFO - Running post-action listener: set_extra_try_arguments 08:56:01 INFO - [mozharness: 2017-09-26 15:56:01.312197Z] Finished download-and-extract step (success) 08:56:01 INFO - [mozharness: 2017-09-26 15:56:01.312292Z] Running populate-webroot step. 08:56:01 INFO - Running pre-action listener: _resource_record_pre_action 08:56:01 INFO - Running main action method: populate_webroot 08:56:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:01 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['tresize', 08:56:01 INFO - 'tcanvasmark']}, 08:56:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:01 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['dromaeo_css', 08:56:01 INFO - 'kraken']}, 08:56:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:01 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'tests': ['damp', 'tps']}, 08:56:01 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['damp', 'tps']}, 08:56:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:01 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['dromaeo_dom']}, 08:56:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:56:01 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['basic_compositor_video', 08:56:01 INFO - 'glvideo']}, 08:56:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:56:01 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['ts_paint_webext', 08:56:01 INFO - 'tp5o_webext']}, 08:56:01 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:01 INFO - 'ts_paint', 08:56:01 INFO - 'tpaint', 08:56:01 INFO - 'sessionrestore', 08:56:01 INFO - 'sessionrestore_many_windows', 08:56:01 INFO - 'sessionrestore_no_auto_restore', 08:56:01 INFO - 'tabpaint']}, 08:56:01 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['a11yr', 08:56:01 INFO - 'ts_paint', 08:56:01 INFO - 'tpaint', 08:56:01 INFO - 'sessionrestore', 08:56:01 INFO - 'sessionrestore_many_windows', 08:56:01 INFO - 'sessionrestore_no_auto_restore', 08:56:01 INFO - 'tabpaint']}, 08:56:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:56:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:56:01 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['perf_reftest_singletons']}, 08:56:01 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['bloom_basic']}, 08:56:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:01 INFO - 'tsvgr_opacity', 08:56:01 INFO - 'tart', 08:56:01 INFO - 'tscrollx', 08:56:01 INFO - 'tsvg_static']}, 08:56:01 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['tsvgx', 08:56:01 INFO - 'tsvgr_opacity', 08:56:01 INFO - 'tart', 08:56:01 INFO - 'tscrollx', 08:56:01 INFO - 'tsvg_static']}, 08:56:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:56:01 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo'], 08:56:01 INFO - 'tests': ['tp5o']}, 08:56:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:56:01 INFO - 'talos_options': ['--mitmproxy', 08:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:56:01 INFO - '--firstNonBlankPaint'], 08:56:01 INFO - 'tests': ['tp6_google', 08:56:01 INFO - 'tp6_youtube', 08:56:01 INFO - 'tp6_amazon', 08:56:01 INFO - 'tp6_facebook']}, 08:56:01 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo', 08:56:01 INFO - '--mitmproxy', 08:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:56:01 INFO - '--firstNonBlankPaint'], 08:56:01 INFO - 'tests': ['tp6_google', 08:56:01 INFO - 'tp6_youtube', 08:56:01 INFO - 'tp6_amazon', 08:56:01 INFO - 'tp6_facebook']}, 08:56:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:56:01 INFO - 'talos_options': ['--stylo-threads=1', 08:56:01 INFO - '--mitmproxy', 08:56:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:56:01 INFO - '--firstNonBlankPaint'], 08:56:01 INFO - 'tests': ['tp6_google', 08:56:01 INFO - 'tp6_youtube', 08:56:01 INFO - 'tp6_amazon', 08:56:01 INFO - 'tp6_facebook']}, 08:56:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--xperf_path', 08:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:01 INFO - 'tests': ['tp5n']}, 08:56:01 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:56:01 INFO - 'talos_options': ['--disable-stylo', 08:56:01 INFO - '--xperf_path', 08:56:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:01 INFO - 'tests': ['tp5n']}}} 08:56:01 INFO - Running post-action listener: _resource_record_post_action 08:56:01 INFO - [mozharness: 2017-09-26 15:56:01.327230Z] Finished populate-webroot step (success) 08:56:01 INFO - [mozharness: 2017-09-26 15:56:01.327319Z] Running create-virtualenv step. 08:56:01 INFO - Running pre-action listener: _resource_record_pre_action 08:56:01 INFO - Running main action method: create_virtualenv 08:56:01 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:01 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:56:01 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:56:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:56:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:02 INFO - Installing pip...............done. 08:56:02 INFO - Return code: 0 08:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:02 INFO - Reading from file tmpfile_stdout 08:56:02 INFO - Output received: 08:56:02 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:56:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:02 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:02 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 08:56:02 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 08:56:02 INFO - Using env: {'DISPLAY': ':0', 08:56:02 INFO - 'HOME': '/home/cltbld', 08:56:02 INFO - 'LANG': 'en_US.UTF-8', 08:56:02 INFO - 'LANGUAGE': 'en_US:en', 08:56:02 INFO - 'LOGNAME': 'cltbld', 08:56:02 INFO - 'MAIL': '/var/mail/cltbld', 08:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:02 INFO - 'MOZ_NO_REMOTE': '1', 08:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:02 INFO - 'NO_EM_RESTART': '1', 08:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:02 INFO - 'PWD': '/builds/slave/test', 08:56:02 INFO - 'SHELL': '/bin/bash', 08:56:02 INFO - 'SHLVL': '1', 08:56:02 INFO - 'TERM': 'linux', 08:56:02 INFO - 'TMOUT': '86400', 08:56:02 INFO - 'USER': 'cltbld', 08:56:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:02 INFO - '_': '/tools/buildbot/bin/python'} 08:56:03 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:56:03 INFO - Downloading/unpacking pip>=1.5 08:56:03 INFO - Running setup.py egg_info for package pip 08:56:03 INFO - warning: no files found matching 'pip/cacert.pem' 08:56:03 INFO - warning: no files found matching '*.html' under directory 'docs' 08:56:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:56:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:56:03 INFO - Installing collected packages: pip 08:56:03 INFO - Found existing installation: pip 1.1 08:56:03 INFO - Uninstalling pip: 08:56:03 INFO - Successfully uninstalled pip 08:56:03 INFO - Running setup.py install for pip 08:56:03 INFO - warning: no files found matching 'pip/cacert.pem' 08:56:03 INFO - warning: no files found matching '*.html' under directory 'docs' 08:56:03 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:56:03 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:56:03 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:56:03 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:56:03 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:56:03 INFO - Successfully installed pip 08:56:03 INFO - Cleaning up... 08:56:03 INFO - Return code: 0 08:56:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:03 INFO - Using env: {'DISPLAY': ':0', 08:56:03 INFO - 'HOME': '/home/cltbld', 08:56:03 INFO - 'LANG': 'en_US.UTF-8', 08:56:03 INFO - 'LANGUAGE': 'en_US:en', 08:56:03 INFO - 'LOGNAME': 'cltbld', 08:56:03 INFO - 'MAIL': '/var/mail/cltbld', 08:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:03 INFO - 'MOZ_NO_REMOTE': '1', 08:56:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:03 INFO - 'NO_EM_RESTART': '1', 08:56:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:03 INFO - 'PWD': '/builds/slave/test', 08:56:03 INFO - 'SHELL': '/bin/bash', 08:56:03 INFO - 'SHLVL': '1', 08:56:03 INFO - 'TERM': 'linux', 08:56:03 INFO - 'TMOUT': '86400', 08:56:03 INFO - 'USER': 'cltbld', 08:56:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:03 INFO - '_': '/tools/buildbot/bin/python'} 08:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:03 INFO - Downloading/unpacking psutil>=3.1.1 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:05 INFO - Installing collected packages: psutil 08:56:05 INFO - Running setup.py install for psutil 08:56:05 INFO - building 'psutil._psutil_linux' extension 08:56:05 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 08:56:05 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 08:56:05 INFO - building 'psutil._psutil_posix' extension 08:56:05 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 08:56:05 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 08:56:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:05 INFO - Successfully installed psutil 08:56:05 INFO - Cleaning up... 08:56:05 INFO - Return code: 0 08:56:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:05 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:05 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 08:56:05 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 08:56:05 INFO - Using env: {'DISPLAY': ':0', 08:56:05 INFO - 'HOME': '/home/cltbld', 08:56:05 INFO - 'LANG': 'en_US.UTF-8', 08:56:05 INFO - 'LANGUAGE': 'en_US:en', 08:56:05 INFO - 'LOGNAME': 'cltbld', 08:56:05 INFO - 'MAIL': '/var/mail/cltbld', 08:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:05 INFO - 'MOZ_NO_REMOTE': '1', 08:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:05 INFO - 'NO_EM_RESTART': '1', 08:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:05 INFO - 'PWD': '/builds/slave/test', 08:56:05 INFO - 'SHELL': '/bin/bash', 08:56:05 INFO - 'SHLVL': '1', 08:56:05 INFO - 'TERM': 'linux', 08:56:05 INFO - 'TMOUT': '86400', 08:56:05 INFO - 'USER': 'cltbld', 08:56:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:05 INFO - '_': '/tools/buildbot/bin/python'} 08:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:05 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 08:56:05 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 08:56:05 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 08:56:05 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 08:56:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:07 INFO - Installing collected packages: mozsystemmonitor 08:56:07 INFO - Running setup.py install for mozsystemmonitor 08:56:07 INFO - Successfully installed mozsystemmonitor 08:56:07 INFO - Cleaning up... 08:56:07 INFO - Return code: 0 08:56:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:07 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')]} 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:07 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')]} 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:07 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:07 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 08:56:07 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 08:56:08 INFO - Using env: {'DISPLAY': ':0', 08:56:08 INFO - 'HOME': '/home/cltbld', 08:56:08 INFO - 'LANG': 'en_US.UTF-8', 08:56:08 INFO - 'LANGUAGE': 'en_US:en', 08:56:08 INFO - 'LOGNAME': 'cltbld', 08:56:08 INFO - 'MAIL': '/var/mail/cltbld', 08:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:08 INFO - 'MOZ_NO_REMOTE': '1', 08:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:08 INFO - 'NO_EM_RESTART': '1', 08:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:08 INFO - 'PWD': '/builds/slave/test', 08:56:08 INFO - 'SHELL': '/bin/bash', 08:56:08 INFO - 'SHLVL': '1', 08:56:08 INFO - 'TERM': 'linux', 08:56:08 INFO - 'TMOUT': '86400', 08:56:08 INFO - 'USER': 'cltbld', 08:56:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:08 INFO - '_': '/tools/buildbot/bin/python'} 08:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:08 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:09 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 08:56:09 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 08:56:09 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 08:56:09 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 08:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:09 INFO - warning: no files found matching '*.txt' 08:56:09 INFO - no previously-included directories found matching 'build' 08:56:09 INFO - no previously-included directories found matching 'dist' 08:56:09 INFO - no previously-included directories found matching '.git*' 08:56:09 INFO - Installing collected packages: jsonschema, functools32 08:56:09 INFO - Running setup.py install for functools32 08:56:11 INFO - warning: no files found matching '*.txt' 08:56:11 INFO - no previously-included directories found matching 'build' 08:56:11 INFO - no previously-included directories found matching 'dist' 08:56:11 INFO - no previously-included directories found matching '.git*' 08:56:11 INFO - Successfully installed jsonschema functools32 08:56:11 INFO - Cleaning up... 08:56:11 INFO - Return code: 0 08:56:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:11 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:11 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 08:56:11 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 08:56:11 INFO - Using env: {'DISPLAY': ':0', 08:56:11 INFO - 'HOME': '/home/cltbld', 08:56:11 INFO - 'LANG': 'en_US.UTF-8', 08:56:11 INFO - 'LANGUAGE': 'en_US:en', 08:56:11 INFO - 'LOGNAME': 'cltbld', 08:56:11 INFO - 'MAIL': '/var/mail/cltbld', 08:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:11 INFO - 'MOZ_NO_REMOTE': '1', 08:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:11 INFO - 'NO_EM_RESTART': '1', 08:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:11 INFO - 'PWD': '/builds/slave/test', 08:56:11 INFO - 'SHELL': '/bin/bash', 08:56:11 INFO - 'SHLVL': '1', 08:56:11 INFO - 'TERM': 'linux', 08:56:11 INFO - 'TMOUT': '86400', 08:56:11 INFO - 'USER': 'cltbld', 08:56:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:11 INFO - '_': '/tools/buildbot/bin/python'} 08:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:12 INFO - Cleaning up... 08:56:12 INFO - Return code: 0 08:56:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:12 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')]} 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:12 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')]} 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:12 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:12 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 08:56:12 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 08:56:12 INFO - Using env: {'DISPLAY': ':0', 08:56:12 INFO - 'HOME': '/home/cltbld', 08:56:12 INFO - 'LANG': 'en_US.UTF-8', 08:56:12 INFO - 'LANGUAGE': 'en_US:en', 08:56:12 INFO - 'LOGNAME': 'cltbld', 08:56:12 INFO - 'MAIL': '/var/mail/cltbld', 08:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:12 INFO - 'MOZ_NO_REMOTE': '1', 08:56:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:12 INFO - 'NO_EM_RESTART': '1', 08:56:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:12 INFO - 'PWD': '/builds/slave/test', 08:56:12 INFO - 'SHELL': '/bin/bash', 08:56:12 INFO - 'SHLVL': '1', 08:56:12 INFO - 'TERM': 'linux', 08:56:12 INFO - 'TMOUT': '86400', 08:56:12 INFO - 'USER': 'cltbld', 08:56:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:12 INFO - '_': '/tools/buildbot/bin/python'} 08:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:14 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 08:56:14 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 08:56:14 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 08:56:14 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 08:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:14 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 08:56:14 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 08:56:14 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 08:56:14 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 08:56:14 INFO - Downloading docopt-0.6.1.tar.gz 08:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:14 INFO - Running setup.py install for blobuploader 08:56:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:14 INFO - Running setup.py install for requests 08:56:15 INFO - Running setup.py install for docopt 08:56:15 INFO - Successfully installed blobuploader requests docopt 08:56:15 INFO - Cleaning up... 08:56:15 INFO - Return code: 0 08:56:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:15 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')]} 08:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:15 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')]} 08:56:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:15 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:15 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 08:56:15 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 08:56:15 INFO - Using env: {'DISPLAY': ':0', 08:56:15 INFO - 'HOME': '/home/cltbld', 08:56:15 INFO - 'LANG': 'en_US.UTF-8', 08:56:15 INFO - 'LANGUAGE': 'en_US:en', 08:56:15 INFO - 'LOGNAME': 'cltbld', 08:56:15 INFO - 'MAIL': '/var/mail/cltbld', 08:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:15 INFO - 'MOZ_NO_REMOTE': '1', 08:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:15 INFO - 'NO_EM_RESTART': '1', 08:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:15 INFO - 'PWD': '/builds/slave/test', 08:56:15 INFO - 'SHELL': '/bin/bash', 08:56:15 INFO - 'SHLVL': '1', 08:56:15 INFO - 'TERM': 'linux', 08:56:15 INFO - 'TMOUT': '86400', 08:56:15 INFO - 'USER': 'cltbld', 08:56:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:15 INFO - '_': '/tools/buildbot/bin/python'} 08:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:15 INFO - Running setup.py (path:/tmp/pip-7UziuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:15 INFO - Running setup.py (path:/tmp/pip-IoFR6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:15 INFO - Running setup.py (path:/tmp/pip-l2rCoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:15 INFO - Running setup.py (path:/tmp/pip-kQmMEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:15 INFO - Running setup.py (path:/tmp/pip-Lv_wpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:15 INFO - Running setup.py (path:/tmp/pip-ZyvzUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:15 INFO - Running setup.py (path:/tmp/pip-YeUQc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:15 INFO - Running setup.py (path:/tmp/pip-gqafyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:15 INFO - Running setup.py (path:/tmp/pip-DTfpIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:16 INFO - Running setup.py (path:/tmp/pip-klDE6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:16 INFO - Running setup.py (path:/tmp/pip-nnNb2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:16 INFO - Running setup.py (path:/tmp/pip-2ENwf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:16 INFO - Running setup.py (path:/tmp/pip-qwA7I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:16 INFO - Running setup.py (path:/tmp/pip-urB4FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:16 INFO - Running setup.py (path:/tmp/pip-PP64GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:16 INFO - Running setup.py (path:/tmp/pip-Ra88UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:16 INFO - Running setup.py (path:/tmp/pip-DmJIX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:16 INFO - Running setup.py install for manifestparser 08:56:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for mozcrash 08:56:16 INFO - Running setup.py install for mozdebug 08:56:16 INFO - Running setup.py install for mozdevice 08:56:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozfile 08:56:17 INFO - Running setup.py install for mozhttpd 08:56:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozinfo 08:56:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozInstall 08:56:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozleak 08:56:17 INFO - Running setup.py install for mozlog 08:56:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for moznetwork 08:56:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozprocess 08:56:17 INFO - Running setup.py install for mozprofile 08:56:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:17 INFO - Running setup.py install for mozrunner 08:56:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:18 INFO - Running setup.py install for mozscreenshot 08:56:18 INFO - Running setup.py install for moztest 08:56:18 INFO - Running setup.py install for mozversion 08:56:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:18 INFO - Cleaning up... 08:56:18 INFO - Return code: 0 08:56:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:18 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')]} 08:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:18 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')]} 08:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:18 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:18 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 08:56:18 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 08:56:18 INFO - Using env: {'DISPLAY': ':0', 08:56:18 INFO - 'HOME': '/home/cltbld', 08:56:18 INFO - 'LANG': 'en_US.UTF-8', 08:56:18 INFO - 'LANGUAGE': 'en_US:en', 08:56:18 INFO - 'LOGNAME': 'cltbld', 08:56:18 INFO - 'MAIL': '/var/mail/cltbld', 08:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:18 INFO - 'MOZ_NO_REMOTE': '1', 08:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:18 INFO - 'NO_EM_RESTART': '1', 08:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:18 INFO - 'PWD': '/builds/slave/test', 08:56:18 INFO - 'SHELL': '/bin/bash', 08:56:18 INFO - 'SHLVL': '1', 08:56:18 INFO - 'TERM': 'linux', 08:56:18 INFO - 'TMOUT': '86400', 08:56:18 INFO - 'USER': 'cltbld', 08:56:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:18 INFO - '_': '/tools/buildbot/bin/python'} 08:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:18 INFO - Running setup.py (path:/tmp/pip-VsajMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:18 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)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:18 INFO - Running setup.py (path:/tmp/pip-qwET6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:18 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)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:18 INFO - Running setup.py (path:/tmp/pip-ZNBKmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:18 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)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:18 INFO - Running setup.py (path:/tmp/pip-ewxHls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:18 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)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:18 INFO - Running setup.py (path:/tmp/pip-mEhiZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:18 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)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:18 INFO - Running setup.py (path:/tmp/pip-Q6uyCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:19 INFO - Running setup.py (path:/tmp/pip-xmAUHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:19 INFO - Running setup.py (path:/tmp/pip-7EawiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:19 INFO - Running setup.py (path:/tmp/pip-w8eR98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:19 INFO - Running setup.py (path:/tmp/pip-DpFx_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:19 INFO - Running setup.py (path:/tmp/pip-B5f1ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:19 INFO - Running setup.py (path:/tmp/pip-1ocyBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:19 INFO - Running setup.py (path:/tmp/pip-Bdenbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:19 INFO - Running setup.py (path:/tmp/pip-Qi9JdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:19 INFO - Running setup.py (path:/tmp/pip-S6RE0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:19 INFO - Running setup.py (path:/tmp/pip-TDxOaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:19 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)) 08:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:19 INFO - Running setup.py (path:/tmp/pip-OXlFNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:19 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)) 08:56:19 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)) 08:56:19 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)) 08:56:19 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)) 08:56:19 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)) 08:56:19 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)) 08:56:19 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)) 08:56:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:19 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 08:56:19 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 08:56:19 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 08:56:19 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 08:56:23 INFO - Downloading blessings-1.6.tar.gz 08:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:24 INFO - Installing collected packages: blessings 08:56:24 INFO - Running setup.py install for blessings 08:56:24 INFO - Successfully installed blessings 08:56:24 INFO - Cleaning up... 08:56:24 INFO - Return code: 0 08:56:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:24 INFO - Reading from file tmpfile_stdout 08:56:24 INFO - Current package versions: 08:56:24 INFO - argparse == 1.2.1 08:56:24 INFO - blessings == 1.6 08:56:24 INFO - blobuploader == 1.2.4 08:56:24 INFO - docopt == 0.6.1 08:56:24 INFO - functools32 == 3.2.3-2 08:56:24 INFO - jsonschema == 2.5.1 08:56:24 INFO - manifestparser == 1.1 08:56:24 INFO - mozInstall == 1.13 08:56:24 INFO - mozcrash == 1.0 08:56:24 INFO - mozdebug == 0.1 08:56:24 INFO - mozdevice == 0.51 08:56:24 INFO - mozfile == 1.2 08:56:24 INFO - mozhttpd == 0.7 08:56:24 INFO - mozinfo == 0.10 08:56:24 INFO - mozleak == 0.1 08:56:24 INFO - mozlog == 3.5 08:56:24 INFO - moznetwork == 0.27 08:56:24 INFO - mozprocess == 0.25 08:56:24 INFO - mozprofile == 0.28 08:56:24 INFO - mozrunner == 6.13 08:56:24 INFO - mozscreenshot == 0.1 08:56:24 INFO - mozsystemmonitor == 0.3 08:56:24 INFO - moztest == 0.8 08:56:24 INFO - mozversion == 1.4 08:56:24 INFO - psutil == 3.1.1 08:56:24 INFO - requests == 1.2.3 08:56:24 INFO - wsgiref == 0.1.2 08:56:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:24 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:24 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 08:56:24 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 08:56:24 INFO - Using env: {'DISPLAY': ':0', 08:56:24 INFO - 'HOME': '/home/cltbld', 08:56:24 INFO - 'LANG': 'en_US.UTF-8', 08:56:24 INFO - 'LANGUAGE': 'en_US:en', 08:56:24 INFO - 'LOGNAME': 'cltbld', 08:56:24 INFO - 'MAIL': '/var/mail/cltbld', 08:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:24 INFO - 'MOZ_NO_REMOTE': '1', 08:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:24 INFO - 'NO_EM_RESTART': '1', 08:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:24 INFO - 'PWD': '/builds/slave/test', 08:56:24 INFO - 'SHELL': '/bin/bash', 08:56:24 INFO - 'SHLVL': '1', 08:56:24 INFO - 'TERM': 'linux', 08:56:24 INFO - 'TMOUT': '86400', 08:56:24 INFO - 'USER': 'cltbld', 08:56:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:24 INFO - '_': '/tools/buildbot/bin/python'} 08:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 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)) 08:56:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:56:25 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)) 08:56:25 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)) 08:56:25 INFO - Installing collected packages: simplejson 08:56:25 INFO - Running setup.py install for simplejson 08:56:25 INFO - building 'simplejson._speedups' extension 08:56:25 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 08:56:26 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 08:56:26 INFO - Successfully installed simplejson 08:56:26 INFO - Cleaning up... 08:56:26 INFO - Return code: 0 08:56:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:26 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 0x27b61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b21a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, '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': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', '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 08:56:26 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 08:56:26 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 08:56:26 INFO - Using env: {'DISPLAY': ':0', 08:56:26 INFO - 'HOME': '/home/cltbld', 08:56:26 INFO - 'LANG': 'en_US.UTF-8', 08:56:26 INFO - 'LANGUAGE': 'en_US:en', 08:56:26 INFO - 'LOGNAME': 'cltbld', 08:56:26 INFO - 'MAIL': '/var/mail/cltbld', 08:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:26 INFO - 'MOZ_NO_REMOTE': '1', 08:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:26 INFO - 'NO_EM_RESTART': '1', 08:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:26 INFO - 'PWD': '/builds/slave/test', 08:56:26 INFO - 'SHELL': '/bin/bash', 08:56:26 INFO - 'SHLVL': '1', 08:56:26 INFO - 'TERM': 'linux', 08:56:26 INFO - 'TMOUT': '86400', 08:56:26 INFO - 'USER': 'cltbld', 08:56:26 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:26 INFO - '_': '/tools/buildbot/bin/python'} 08:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:27 INFO - Cleaning up... 08:56:27 INFO - Return code: 0 08:56:27 INFO - Running post-action listener: _resource_record_post_action 08:56:27 INFO - Running post-action listener: _start_resource_monitoring 08:56:27 INFO - Starting resource monitoring. 08:56:27 INFO - [mozharness: 2017-09-26 15:56:27.070377Z] Finished create-virtualenv step (success) 08:56:27 INFO - [mozharness: 2017-09-26 15:56:27.070898Z] Running install step. 08:56:27 INFO - Running pre-action listener: _resource_record_pre_action 08:56:27 INFO - Running main action method: install 08:56:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:27 INFO - Reading from file tmpfile_stdout 08:56:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:27 INFO - Reading from file tmpfile_stdout 08:56:27 INFO - Output received: 08:56:27 INFO - Usage: mozinstall [options] installer 08:56:27 INFO - Options: 08:56:27 INFO - -h, --help show this help message and exit 08:56:27 INFO - -d DEST, --destination=DEST 08:56:27 INFO - Directory to install application into. [default: 08:56:27 INFO - "/builds/slave/test"] 08:56:27 INFO - --app=APP Application being installed. [default: firefox] 08:56:27 INFO - mkdir: /builds/slave/test/build/application 08:56:27 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'] 08:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:56:41 INFO - Reading from file tmpfile_stdout 08:56:41 INFO - Output received: 08:56:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:56:41 INFO - Running post-action listener: _resource_record_post_action 08:56:41 INFO - [mozharness: 2017-09-26 15:56:41.986779Z] Finished install step (success) 08:56:41 INFO - [mozharness: 2017-09-26 15:56:41.987028Z] Running setup-mitmproxy step. 08:56:41 INFO - Running pre-action listener: _resource_record_pre_action 08:56:41 INFO - Running main action method: setup_mitmproxy 08:56:41 INFO - Skipping: mitmproxy is not required 08:56:41 INFO - Running post-action listener: _resource_record_post_action 08:56:41 INFO - [mozharness: 2017-09-26 15:56:41.988155Z] Finished setup-mitmproxy step (success) 08:56:41 INFO - [mozharness: 2017-09-26 15:56:41.988375Z] Running run-tests step. 08:56:41 INFO - Running pre-action listener: _resource_record_pre_action 08:56:41 INFO - Running pre-action listener: _set_gcov_prefix 08:56:41 INFO - Running main action method: run_tests 08:56:41 WARNING - Try message not found. 08:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:41 INFO - Python 2.7.3 08:56:41 INFO - Return code: 0 08:56:41 INFO - grabbing minidump binary from tooltool 08:56:41 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')]} 08:56:41 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 0x2b25090>, '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 0x2b25d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b1ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:41 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 08:56:41 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 08:56:41 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 08:56:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:42 INFO - Return code: 0 08:56:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:56:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:42 INFO - ENV: RUST_BACKTRACE is now full 08:56:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:56:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 08:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 08:56:42 INFO - Using env: {'DISPLAY': ':0', 08:56:42 INFO - 'HOME': '/home/cltbld', 08:56:42 INFO - 'LANG': 'en_US.UTF-8', 08:56:42 INFO - 'LANGUAGE': 'en_US:en', 08:56:42 INFO - 'LOGNAME': 'cltbld', 08:56:42 INFO - 'MAIL': '/var/mail/cltbld', 08:56:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:42 INFO - 'MOZ_NO_REMOTE': '1', 08:56:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:42 INFO - 'NO_EM_RESTART': '1', 08:56:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:42 INFO - 'PWD': '/builds/slave/test', 08:56:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:42 INFO - 'RUST_BACKTRACE': 'full', 08:56:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:56:42 INFO - 'SHELL': '/bin/bash', 08:56:42 INFO - 'SHLVL': '1', 08:56:42 INFO - 'TERM': 'linux', 08:56:42 INFO - 'TMOUT': '86400', 08:56:42 INFO - 'USER': 'cltbld', 08:56:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:42 INFO - '_': '/tools/buildbot/bin/python'} 08:56:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 08:56:42 INFO - mozversion application_buildid: 20170926143237 08:56:42 INFO - mozversion application_changeset: cc652dcb13dba40ae3f263ae89ce3e610a34165f 08:56:42 INFO - mozversion application_display_name: Firefox 08:56:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:42 INFO - mozversion application_name: Firefox 08:56:42 INFO - mozversion application_remotingname: firefox 08:56:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:42 INFO - mozversion application_vendor: Mozilla 08:56:42 INFO - mozversion application_version: 57.0 08:56:42 INFO - mozversion platform_buildid: 20170926143237 08:56:42 INFO - mozversion platform_changeset: cc652dcb13dba40ae3f263ae89ce3e610a34165f 08:56:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:42 INFO - mozversion platform_version: 57.0 08:56:42 INFO - using testdate: 1506441402 08:56:42 INFO - actual date: 1506441402 08:56:42 INFO - starting webserver on 'localhost:33405' 08:56:42 INFO - SUITE-START | Running 2 tests 08:56:42 INFO - TEST-START | dromaeo_css 08:56:42 INFO - Initialising browser for dromaeo_css test... 08:56:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33405/getInfo.html -profile /tmp/tmp1_hxK_/profile 08:56:42 INFO - TEST-INFO | started process 3659 (/builds/slave/test/build/application/firefox/firefox http://localhost:33405/getInfo.html) 08:56:48 INFO - TEST-INFO | 3659: exit 0 08:56:48 INFO - Browser initialized. 08:56:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:48 INFO - Using env: {'DISPLAY': ':0', 08:56:48 INFO - 'HOME': '/home/cltbld', 08:56:48 INFO - 'JSGC_DISABLE_POISONING': '1', 08:56:48 INFO - 'LANG': 'en_US.UTF-8', 08:56:48 INFO - 'LANGUAGE': 'en_US:en', 08:56:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:56:48 INFO - 'LOGNAME': 'cltbld', 08:56:48 INFO - 'MAIL': '/var/mail/cltbld', 08:56:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:56:48 INFO - 'MOZ_CRASHREPORTER': '1', 08:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:56:48 INFO - 'MOZ_NO_REMOTE': '1', 08:56:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:48 INFO - 'NO_EM_RESTART': '1', 08:56:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:48 INFO - 'PWD': '/builds/slave/test', 08:56:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:48 INFO - 'RUST_BACKTRACE': 'full', 08:56:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:56:48 INFO - 'SHELL': '/bin/bash', 08:56:48 INFO - 'SHLVL': '1', 08:56:48 INFO - 'TERM': 'linux', 08:56:48 INFO - 'TMOUT': '86400', 08:56:48 INFO - 'USER': 'cltbld', 08:56:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 08:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:48 INFO - '_': '/tools/buildbot/bin/python'} 08:56:48 INFO - TEST-INFO | started process 3854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1_hxK_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:49 INFO - PID 3854 | 08:56:49 INFO - PID 3854 | (/builds/slave/test/build/application/firefox/firefox:3903): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:56:49 INFO - PID 3854 | 08:56:59 INFO - PID 3854 | RSS: Main: 141369344 08:56:59 INFO - PID 3854 | 08:59:57 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33405/tests/dromaeo/cssquery-ext.html) 08:59:58 INFO - PID 3854 | RSS: Main: 145240064 08:59:58 INFO - PID 3854 | 09:02:59 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-ext.html (next: http://localhost:33405/tests/dromaeo/cssquery-jquery.html) 09:03:00 INFO - PID 3854 | RSS: Main: 143990784 09:03:00 INFO - PID 3854 | 09:06:02 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33405/tests/dromaeo/cssquery-mootools.html) 09:06:02 INFO - PID 3854 | RSS: Main: 144961536 09:06:02 INFO - PID 3854 | 09:09:04 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33405/tests/dromaeo/cssquery-prototype.html) 09:09:04 INFO - PID 3854 | RSS: Main: 143286272 09:09:04 INFO - PID 3854 | 09:12:07 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33405/tests/dromaeo/cssquery-yui.html) 09:12:08 INFO - PID 3854 | RSS: Main: 146579456 09:12:08 INFO - PID 3854 | 09:15:09 INFO - PID 3854 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-yui.html (next: http://localhost:33405/tests/dromaeo/cssquery-dojo.html) 09:15:10 INFO - PID 3854 | RSS: Main: 149331968 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | __start_tp_report 09:15:10 INFO - PID 3854 | _x_x_mozilla_page_load 09:15:10 INFO - PID 3854 | _x_x_mozilla_page_load_details 09:15:10 INFO - PID 3854 | |i|pagename|runs| 09:15:10 INFO - PID 3854 | |0;dojo.html;4023.7786921719307;4047.736897101688;4067.5932406759307;4068.552459229486;4076.6127217914295;6537.9346206537975;6572.901406478894;6637.469002479802;6692.196936367636;6711.899321510181;6607.273199948002;6614.536982411233;6640.7343706251695;6672;6709.563878347904;5899.085641725539;5922.58541902067;5922.703864806764;5932.584719069645;5952.761889524414;5875.529957603381;5894.852628684296;5901.970490147543;5929.644221346712;6041.275046994345;5972.79095231667;5975.611585246967;6016;6031.065184896348;6042.365551617061;5901.23283973085;5960.8674351873005;5981.970090149565;6027.758889644409;6055.6063855849225;5825.15535247391;5861.238039054895;5901.3508514063415;5909.113632955091;5947.702614869282;6460.450861676763;6560.737570497222;6585.176852893388;6598.043283723833;6638.369354911276;7113.395361394288;7125.35871771543;7139.964300178466;7184.461165412615;7220.92779072213;6995.965020174917;7080.610566418845;7195.064641596559;7246.456515761286;7270.200277969419;6649.3350664933605;6685.799426017227;6719.092922455455;6724.966375168142;6745.7976260711275;7346.228645992094;7353.963230183815;7367.373773229228;7439.479236453396;7450.888236676454;6906.06768086312;6993.89509157363;7027.824304392431;7065.399441047569;7152.356287934111;7087.3267039631155;7132.322429369202;7133.393661538724;7146.499745017799;7155.928440715526;7064.152301723826;7076.540024898365;7095.290470952967;7128.144622645315;7203.279672032755;7134.857302854018;7145.249748776304;7193.9280607194305;7234.059572255573;7241;5246.658967167122;5264.368275806928;5328.333958255218;5340.279062326614;5369.677819330853;4727.95272047282;4769.76151192439;4777.474477807438;4827;4853.684510506806;6761.763338283235;6767.255601883789;6768.458523318122;6771.830704232433;6783.423409010191;7091.361777440055;7187.89218161728;7193.208747037822;7221.675024623904;7250.709971601077;6556.885329493997;6637.369449902348;6711.765088221889;6765.898511522331;6816.011678306618;5675.460831221028;5886.6173698709445;5983;5988.730507127189;6001.939980600226;7378.557286562824;7444.739434119888;7478.887816682754;7593.392528597699;7595.962020189863;7188.712451501881;7209.206987231505;7211.350978412073;7248.673809678683;7255.854882902418;7457.6271186441545;7462.701491940262;7476.476646634684;7561.3950883928055;7589.354904833151;6968.4076853465995;7003.229644738973;7067.081279433641;7143.749968751069;7196.676149573177;7115.395191408581;7202.49582529218;7216.061911951413;7239.674214660458;7289.562626242442;6712.39588437043;6923.376896079377;6939.236683964861;7016.122984626922;7040.3663670269925;6899.310068993061;6907;6955.061066756126;6988.231294557493;6999.650017499206;6660.933390666031;6786.253512113763;6819.727210911707;6852.965735171292;6906.620135892374;6926.549774264657;6946.16646002483;6951.374376306157;6981.197162326194;7048.506604537633;6698.497612679166;6778.762743304158;6794.082798822095;6812.965935170292;6883.139607549057 09:15:10 INFO - PID 3854 | |1;ext.html;966.9758256043602;975.3172779054659;1005.1004351105761;1027.8972102789717;1031.2162756305206;43365.78317108414;44098.77950610242;44101.33847992283;44111.11777764443;44150.33774493385;40728.185436291256;40734.18531629373;40796;40861.38707919384;40933.59066409335;8119.715809946653;8188.303994160504;8191.754247372588;8212.137725538822;8257.215564521392;7894.7236846710375;7910.762677119696;7954.244346787046;7970.800729981739;7978.9202107979045;8631.13688631135;8849.646014159425;8864;8879.156480134377;8884.466931984101;8732.345074119436;8762.211400973943;8762.649494020232;8780.912190878138;8830.911690883073;8579.699710510102;8592.312614990786;8593.656253749905;8611;8637.956810215908;39839.40240896389;39934.60065399338;40149.79925100385;40164.79917600423;40200.59799402027;3879.2823327684187;3885.6502914737525;3890.221955608861;3911.041794760302;3912.7065470089856;32797.18007049819;32912.17719557006;32935.50596741051;32935.6706432935;33002;5489.670619762787;5511.669299842022;5523.475269849358;5538.972305138489;5581.2186293918885;230665;230728;231406;232167;233366;51538;52002.739986300585;52061.7396913013;52249.216261756104;52319.476805232225;53335.733321333144;53428.465715343125;53499.732501338025;53599;53809.730951344995;17816.109194540222;18152.273909043754;18227;18321.541961450803;18327.541811454554;15226.543203703906;15301.693966120616;15333;15352.923235383752;15386.538403847902;14789.334479948428;15237.847621523864;15243.61890952713;15376.769348459558;15417.768733469007;5818.796342128006;5960.552958528127;5967.701614919237;5980.850478738066;5992;1082.5832054658856;1087.7117563845586;1124.2523721725124;1128.497818470789;1138.4364739453858;25876.611850822253;26184.34539136537;26442.6033609496;26484.60273095905;26601.33496662599;1211.5638370186725;1226.5400474821943;1234.8579913309904;1236.437420973455;1256.8114782782473;13803;13810.723785524233;14105.36525856339;14109.929450352887;14182.219977901108;283989;284486;284797;285908;286524;57639.13541296884;60505.69747151236;60921.08618370639;61105.694471528244;61174;1477.3942683499713;1515.0758037597057;1521.117751704009;1523.2840564934463;1529.6328881068464;30294.242643934078;30527.389452210387;30538.694613053583;30577.388452231276;30944.381112378076;40806.38790418087;41027.38458923059;41057.1788564233;41118.177636446504;41152;256417;258345;258442;259307;259329;34979.30041399209;34980.30039399147;35099.47350789689;35235.47146792749;35274;44405.11189776122;45779.54220457886;46054.309185362916;46112.53887461082;46165;34162.65837341595;34260;34651.30697385988;34964;35012.82493587516;34490;34567.4814877772;34622.82688586541;34658.30683386369;35299.29401411906;39512.40731388974;39866.80066599648;39894.80052599718;39897;40040.799796002;32651.34697306088;33294.33411331808;33673;33747.49378759271;34014.48978265378;25348.873255633604;25356;25421.61867572025;25883.61174582345;26202.344941376617 09:15:10 INFO - PID 3854 | |2;jquery.html;632.4118569730155;634.531839901252;642.4571237304476;651.3388910256091;652.9452102443823;24249.63625545616;24326.87836560817;24499.387515312083;24969;24969.126080587183;22939;23187;23210.303690889257;23253.534929301404;23272.534549309003;6767.763128290523;6885.931140688579;6945.930540694604;6955.826104347407;7193.100862392201;7127.786166415016;7163.247858974811;7163.964180179092;7166.247544007882;7171.067761191038;7024.2273349931465;7078.681459334317;7107.680154393039;7108.360247577717;7121.394681452083;7101.289871012883;7106.609136497491;7114.359707626312;7123.074000379969;7131.037309963141;6606.504512161559;6625.867482650368;6647.434968027724;6668.566543174678;6677.298883617199;29646.258843528867;31303;31471.213219669462;31496.68503314983;31524.842375788205;2357.5520651076413;2417.3714834143075;2419.8669073200967;2420.782129608344;2431.7203521595065;20618.381448556567;20653.8967305164;21306.680399794015;21348.252811151535;21535.56928861414;2591.663083799113;2629.6187052877417;2657.534931387019;2676.023251513184;2676.69218039924;140274;144878.27560862232;157495;165524.17237913853;166733.99999999878;16406.917965410095;16934.830651693326;17223.655526889394;17354.305827767;17589.29642814273;27671.30821729473;27680.723192767815;27686.723132768817;27695.861520692266;27696.723032769816;11329.376884271443;11602.18784685064;11614.128940329509;11648.184627076193;11749.951477328743;10478.161747060218;10493.737656558495;10515.84226236607;10590.470476476145;10684.786304273872;10557.419341936115;10689.35863848156;10740.570377184826;10741.355518668905;10755.193360497993;3006.864691088906;3079.337942342407;3085.783995120365;3090.90727278182;3160.004598551449;1055.7888422315414;1068.9037986581245;1077.2674581284803;1080.7082087836397;1096.4298564746446;21664.24175153862;21979.120835166734;21989.450263743536;22298.331050068526;22314.21900233484;1139.1570238023803;1146.0602306109076;1147.8163493840946;1156.2715489241891;1160.5415860734963;11865;12024.579139730067;12147.453364598437;12182.208156469802;12223.572174973833;602671;617007;619583;620373;620384;131406;133631;136385.318073409;137926;140325;1177.4230626992712;1180.1738782852037;1231.7905955987503;1237.7338872142352;1296.2481760578842;22748.862556871758;23062.308130756104;23085.65371519395;23183.420414489774;23450.648240276067;65923.67038164778;66947.3305266941;67707;67806.32193678197;68720.65639671769;77917.22082779327;81772.18227817645;82337.17662823535;82454;83286;16190.838091618933;16281;16351.182440878147;16392.344306227616;16542.42101526489;24468.877655611606;24757.381065473506;24808.503829922938;24900.501989960463;24971.75028249694;19889.60220795605;20432.79567204309;20576.69134962947;20782.06480708402;20798.37604871856;17080.91459542744;17903.283868645107;18025.459236222934;18035;18138.820976636478;20169.899150504152;20286.59426811426;20331.288404905757;20450.89774551177;20471.283505077252;15214.923925380303;15997.1201583914;16145.515634530982;16176.514704558882;16294.592635184215;20371.675841070282;20520.79479205189;20537.17851285932;20543;20552.38342849717 09:15:10 INFO - PID 3854 | |3;mootools.html;1437.2957250947036;1539.6535779449632;1547.7446221373477;1550.899191552549;1557.8052743407075;17972.640547189047;18429.723554146698;18563;18585.907070464647;18601.348952786655;18244.72632910504;18274.908625456887;18330.633387332244;18339.541511462186;18459.261629534834;3129.2176955761115;3223.419784438812;3224.7097761201485;3225.96774032259;3225.9838700806463;3150.1652062203534;3172.2703778131045;3190.457622204231;3192.5849639546827;3193.96806031939;3096.6593674695764;3117.7973431726978;3122.703343182394;3134.294783673678;3134.6081739782526;3013.0960711786597;3026.772992025596;3034.0746072447896;3034.651015133266;3036.05882176526;2951.896683616063;2972.7621790256726;2977.8064425812254;2984.582158497812;2985.880564777406;16679.24943377551;16977.83022169775;17026.74459883103;17049.48851534456;17088.231029603572;9004.099590041009;9472.526373681289;9477.952610236973;9481.47851868147;9482.573284202228;6077.1491991121275;6201.193844800147;6255.280642726099;6261.906071408933;6293.779717709858;2071.792820717931;2156.7304086989125;2159.211887661008;2192.199847055829;2195.9011844467036;29076.70923290761;29686.703132968825;31307.53038704421;31450.842745786354;31474.685253147403;8413.411061225655;8428.789280268042;8664.133586641412;8707.825843483095;8714.694985675598;23183;23304.76695233026;23389.53220935572;23410.7658923412;23441.7655823443;9441.905580944103;9586.712398628053;9646.18007469373;9652.855207171899;9658.372205806741;8200.507969521848;8399.8320033599;8566.700165494178;8624.094470080676;8636.17956294151;6642.6014439133805;6653.700583473756;6658.933410665928;6688.699008544627;6815.454763618898;2102.8107470327745;2105.136893873535;2105.557832855087;2106.4523223961573;2125.7342832145982;1021.3310281765456;1025.236199031726;1032.1278519650882;1032.7573020340214;1049.9947500262604;8793.692220772371;8883.955580222058;8915.37592368528;8927.419717718458;8934.642614295486;828.4780588229497;830.0620299062022;846.2087947768733;847.563504795031;849.9405041647026;5062.82280120194;5066.442691303953;5190.81832135881;5212.947870521246;5293.258943747878;24351.634725479133;25894.223173304832;26016.739832601812;26158.73841261601;26198;25582.744172558036;25703.48593028129;25718.228453146436;26329;26505.602415963775;11259.94370028161;12676.556320528738;12817.935910320388;12829.101962862696;12919.418626161845;10132.797344053226;10238.720159980003;10319.94840025825;10426.113780328453;10655.520501577292;21770.782292176875;21838.23566175176;22199.445013874138;22431.663525047465;22759.203427879944;22288.331350059525;22914.770852291265;23126.768732312463;23189;23229.3031209064;13861.376238069513;13952.232627205602;14026.649333766738;14138.717225655635;14167.291635418394;15733.370665173265;15823.762643560125;15906.7613985788;15907.363705451653;15925.840741592436;13112.606621801362;13162.210267383987;13304.866951330363;13329.266890321125;13369.866301337252;11397.886021139682;11562.190646654653;11671.12466564994;11820.349880756641;12034.338111403957;10290.228232882415;10515;10546.894531054591;10570.8414373786;10592.046715795615;8333.458325208841;8374.246317831425;8447.408681392244;8474.74575762728;8558.52928088961;8778.253848422955;8998.955005224932;9001.729948101567;9093.40892841963;9124.5437728112 09:15:10 INFO - PID 3854 | |4;prototype.html;539.2531344088436;581.4999100773337;594.1978329255504;618.0636335951034;622.2501885228301;6099.695015249242;6402.2957474677805;6402.615843049421;6427.196600424947;6482.870342593157;6267.341929097447;6378.3621637836195;6397.61614303141;6397.616143031421;6430.710618022188;5194.168932970716;5285;5296.708681022542;5331.733413329318;5353.678779273256;5080.669756465836;5125.410577783547;5154.74226288686;5171.637985341028;5326.973365133169;5115.335006449156;5136.409312929005;5142.897142057157;5171.327727395452;5175.353080864892;5053.69677819332;5104.923426148593;5120.846374608749;5137.7944882204665;5151.330327057496;4657.278121891112;4684.156851766681;4726.976365118152;4738.3603213566075;4769.284607308897;6347.682615869188;6373.681315934185;6392.456641185505;6396.26442959061;6401.455876250524;5977.801875996364;6001.279846418414;6034.6982650867285;6038.154658347835;6092.08618707193;6614.908540090879;6699.162604674416;6733.595984240912;6836.213835408892;6849.965750171267;5050.898982020376;5200.141976573861;5217.8173763918085;5264.2893209416625;5268.60485463588;6845.247022827485;6875.106236189314;6981.232064472904;7032.15614126303;7082.477267387537;5349.117395629755;5356.4107948125675;5356.625036247426;5399.649022813504;5430.755615997289;5426.538744206787;5449.929026969806;5507.614466987273;5509.3664228614225;5523.226748255248;6049.455549000523;6050.818475445743;6059.21230240066;6060.818175454743;6093.817185484442;6753.932460675429;6792.777300085933;6806.625635589991;6842.015815413474;6861.794146175623;1858.5818190907207;1859.6094820087662;1866;1877.27724825943;1896.1183049881872;1278;1291.14139097501;1344.1330341929402;1345.2332170662824;1378.9862101378858;6271.216097987752;6427.111597483548;6429.646369449725;6447.3552644735155;6522.608643481406;6864.519483636197;6883.380495755406;6910.825159722859;6915;6933.237343892168;6435.485161187094;6493.545451818327;6498.122753428227;6501.284858665543;6504.252011018793;3639.727020473475;3667.1748856507074;3669.229461812996;3691.557013158438;3704.518412606344;7179.3949566398;7227.457940654472;7230.9638451807405;7264.636768161677;7285.162206346338;6946.8610627788175;6950.200726916368;6982.79051628452;6987.720491180397;7089.610071446017;7099.183593886666;7123.608201548757;7133.5719856808755;7134.607596582237;7214.74748383804;6789.456843452611;6894;6895.931040689529;6898.310168983062;6901.3429829515;6866.450683945172;6890.552114112566;6954.408875245458;6955.23492415844;6970.546914450544;7225.710971561289;7273.599952002691;7313.963430182815;7334.926650733424;7368.300011498899;5360.624756267024;5366.168243922199;5410.296661433988;5426.67439953604;5438.483344082306;6768.7292508299115;6907.585544867324;6910.20532638753;6952.617606031717;6977.2673869243;6482.675866206765;6643.50173736962;6699.961505966583;6792.898106528307;6831.419329357061;6595.373439523238;6648.767293144717;6681.732730690913;6687.1975362956755;6726.899096513458;6450.516211284079;6533.346665333429;6635.369639884203;6658.300878407697;6764.966175169093;6633.900491492728;6732.697028633625;6778.2543920167755;6871.793846184622;6882.552634078769;6658.533902626963;6690.19717633887;6699.832504187434;6701.497387696039;6712.865742685217 09:15:10 INFO - PID 3854 | |5;yui.html;1006.7181189267003;1018.7249442650483;1039.2361614213557;1053.0838170791412;1054.3357684658663;19264.51838704033;21366.359009229727;21925;22019.559608807813;22044.33866983991;18777;18847.15187816548;18870.24519019241;18906.338278160267;18974.146163422643;1086.2124959404427;1105.7567335186286;1105.8838821923703;1107.7119948813286;1108.905743011845;1094;1098.7363032872092;1099.005400112899;1101.3226865477754;1104.2270410712492;1086.934783912964;1112.010310823368;1127.2560110327186;1127.7237076916167;1171.4318555500618;1116.2019156303281;1116.5198964445326;1117.1956191542158;1117.7485065860158;1118.3234143343282;795.9403044771665;804.778685861387;805.7139715401007;807.6648191000728;808.8503626829056;21740.782592174193;22418.77581224183;22710.205142819923;22729.659055114185;22921.77078229213;21309.36071917845;23163;23454.882725586434;23596.528069438686;23971.52056958851;19597.118129684197;19643.80356196434;19901.9004904976;19977.500562485908;19981.10085046162;4083.3874918762126;4129.091599848029;4130.834766609332;4133.483314585676;4139.77231252281;127975.36012319879;143509;159439.20280398524;161102;163508;19168.808311916982;19275;19490.415287541397;19917.701234481494;19933.401997940084;32363.352732945208;32827.835860820545;35593.466098008554;35651;35701.46447803285;9883.50582470888;9891.752706182404;9903.207743380512;10019.699409017741;10054.899451005396;4923.138450771101;4938.802447902043;4954.578860796801;4963.925541116886;4994.625403094782;6529.967350163314;6677.098591690156;6677.632730199788;6682.498812589075;6682.599044057372;1283.5250957145915;1292.9288889111;1315.9934200328937;1318.637374721959;1324.1194605587368;777.4907435629672;782.4014628808966;795.3716563914559;798.660569258063;804.8631732605471;11823.881761182278;12445.75108497825;13219.405126769318;13558.661033474242;13647.522336718366;784.2432053068702;784.4744021505605;787.5550314072646;796.0566728426833;801;5732.140178973187;5800.941990580124;5836.970815145897;5884.499817515559;5896.262967129109;138374.3081284587;138548;139609;142299;145582;122572.38713806374;123270.38364808119;127999;129640;132638.33680831533;114941;118406;119203;121027;122984.77015229913;13600.795988060385;13682.31588420595;14093;14172.078814877;14309.64225894361;52034.47965520448;55541;55785.442145578025;57150.7142464285;57477.71261143835;71393.64303178659;72994.63502682453;73106.26893730994;73376.63311683407;73384.26615733774;20091.698624520937;20858.791412085684;20925.26761563338;20990.790092099494;20996;23647.408814779767;23756.406089847893;23939.76060239375;24021;24151.792410379763;17747.73378399351;17789.733154002442;17833.286668533114;17871.195796189462;18021.639567208844;16591.17044147812;16776.748348774534;16788.58028549296;16843.663126737643;16888.81778275509;18113.275468981094;18124.546886327946;18127.90936045311;18224.271029159216;18271.451856444328;15491;15495.922520387327;15498;15548.378064877279;15773.132477713378;14415;14483.348249328596;14522.648083623693;14574.271286435423;14600.26998650042 09:15:10 INFO - PID 3854 | __end_tp_report 09:15:10 INFO - PID 3854 | __start_cc_report 09:15:10 INFO - PID 3854 | _x_x_mozilla_cycle_collect,244 09:15:10 INFO - PID 3854 | __end_cc_report 09:15:10 INFO - PID 3854 | __startTimestamp1506442510161__endTimestamp 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | ------- Summary: start ------- 09:15:10 INFO - PID 3854 | Number of tests: 6 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#0] dojo.html Cycles:165 Average:6610.48 Median:6819.73 stddev:779.71 (11.4%) stddev-sans-first:755.24 09:15:10 INFO - PID 3854 | Values: 4023.8 4047.7 4067.6 4068.6 4076.6 6537.9 6572.9 6637.5 6692.2 6711.9 6607.3 6614.5 6640.7 6672.0 6709.6 5899.1 5922.6 5922.7 5932.6 5952.8 5875.5 5894.9 5902.0 5929.6 6041.3 5972.8 5975.6 6016.0 6031.1 6042.4 5901.2 5960.9 5982.0 6027.8 6055.6 5825.2 5861.2 5901.4 5909.1 5947.7 6460.5 6560.7 6585.2 6598.0 6638.4 7113.4 7125.4 7140.0 7184.5 7220.9 6996.0 7080.6 7195.1 7246.5 7270.2 6649.3 6685.8 6719.1 6725.0 6745.8 7346.2 7354.0 7367.4 7439.5 7450.9 6906.1 6993.9 7027.8 7065.4 7152.4 7087.3 7132.3 7133.4 7146.5 7155.9 7064.2 7076.5 7095.3 7128.1 7203.3 7134.9 7145.2 7193.9 7234.1 7241.0 5246.7 5264.4 5328.3 5340.3 5369.7 4728.0 4769.8 4777.5 4827.0 4853.7 6761.8 6767.3 6768.5 6771.8 6783.4 7091.4 7187.9 7193.2 7221.7 7250.7 6556.9 6637.4 6711.8 6765.9 6816.0 5675.5 5886.6 5983.0 5988.7 6001.9 7378.6 7444.7 7478.9 7593.4 7596.0 7188.7 7209.2 7211.4 7248.7 7255.9 7457.6 7462.7 7476.5 7561.4 7589.4 6968.4 7003.2 7067.1 7143.7 7196.7 7115.4 7202.5 7216.1 7239.7 7289.6 6712.4 6923.4 6939.2 7016.1 7040.4 6899.3 6907.0 6955.1 6988.2 6999.7 6660.9 6786.3 6819.7 6853.0 6906.6 6926.5 6946.2 6951.4 6981.2 7048.5 6698.5 6778.8 6794.1 6813.0 6883.1 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#1] ext.html Cycles:180 Average:43640.92 Median:35254.74 stddev:67373.97 (191.1%) stddev-sans-first:67486.78 09:15:10 INFO - PID 3854 | Values: 967.0 975.3 1005.1 1027.9 1031.2 43365.8 44098.8 44101.3 44111.1 44150.3 40728.2 40734.2 40796.0 40861.4 40933.6 8119.7 8188.3 8191.8 8212.1 8257.2 7894.7 7910.8 7954.2 7970.8 7978.9 8631.1 8849.6 8864.0 8879.2 8884.5 8732.3 8762.2 8762.6 8780.9 8830.9 8579.7 8592.3 8593.7 8611.0 8638.0 39839.4 39934.6 40149.8 40164.8 40200.6 3879.3 3885.7 3890.2 3911.0 3912.7 32797.2 32912.2 32935.5 32935.7 33002.0 5489.7 5511.7 5523.5 5539.0 5581.2 230665.0 230728.0 231406.0 232167.0 233366.0 51538.0 52002.7 52061.7 52249.2 52319.5 53335.7 53428.5 53499.7 53599.0 53809.7 17816.1 18152.3 18227.0 18321.5 18327.5 15226.5 15301.7 15333.0 15352.9 15386.5 14789.3 15237.8 15243.6 15376.8 15417.8 5818.8 5960.6 5967.7 5980.9 5992.0 1082.6 1087.7 1124.3 1128.5 1138.4 25876.6 26184.3 26442.6 26484.6 26601.3 1211.6 1226.5 1234.9 1236.4 1256.8 13803.0 13810.7 14105.4 14109.9 14182.2 283989.0 284486.0 284797.0 285908.0 286524.0 57639.1 60505.7 60921.1 61105.7 61174.0 1477.4 1515.1 1521.1 1523.3 1529.6 30294.2 30527.4 30538.7 30577.4 30944.4 40806.4 41027.4 41057.2 41118.2 41152.0 256417.0 258345.0 258442.0 259307.0 259329.0 34979.3 34980.3 35099.5 35235.5 35274.0 44405.1 45779.5 46054.3 46112.5 46165.0 34162.7 34260.0 34651.3 34964.0 35012.8 34490.0 34567.5 34622.8 34658.3 35299.3 39512.4 39866.8 39894.8 39897.0 40040.8 32651.3 33294.3 33673.0 33747.5 34014.5 25348.9 25356.0 25421.6 25883.6 26202.3 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#2] jquery.html Cycles:180 Average:40949.68 Median:22843.93 stddev:103173.46 (451.6%) stddev-sans-first:103418.48 09:15:10 INFO - PID 3854 | Values: 632.4 634.5 642.5 651.3 652.9 24249.6 24326.9 24499.4 24969.0 24969.1 22939.0 23187.0 23210.3 23253.5 23272.5 6767.8 6885.9 6945.9 6955.8 7193.1 7127.8 7163.2 7164.0 7166.2 7171.1 7024.2 7078.7 7107.7 7108.4 7121.4 7101.3 7106.6 7114.4 7123.1 7131.0 6606.5 6625.9 6647.4 6668.6 6677.3 29646.3 31303.0 31471.2 31496.7 31524.8 2357.6 2417.4 2419.9 2420.8 2431.7 20618.4 20653.9 21306.7 21348.3 21535.6 2591.7 2629.6 2657.5 2676.0 2676.7 140274.0 144878.3 157495.0 165524.2 166734.0 16406.9 16934.8 17223.7 17354.3 17589.3 27671.3 27680.7 27686.7 27695.9 27696.7 11329.4 11602.2 11614.1 11648.2 11750.0 10478.2 10493.7 10515.8 10590.5 10684.8 10557.4 10689.4 10740.6 10741.4 10755.2 3006.9 3079.3 3085.8 3090.9 3160.0 1055.8 1068.9 1077.3 1080.7 1096.4 21664.2 21979.1 21989.5 22298.3 22314.2 1139.2 1146.1 1147.8 1156.3 1160.5 11865.0 12024.6 12147.5 12182.2 12223.6 602671.0 617007.0 619583.0 620373.0 620384.0 131406.0 133631.0 136385.3 137926.0 140325.0 1177.4 1180.2 1231.8 1237.7 1296.2 22748.9 23062.3 23085.7 23183.4 23450.6 65923.7 66947.3 67707.0 67806.3 68720.7 77917.2 81772.2 82337.2 82454.0 83286.0 16190.8 16281.0 16351.2 16392.3 16542.4 24468.9 24757.4 24808.5 24900.5 24971.8 19889.6 20432.8 20576.7 20782.1 20798.4 17080.9 17903.3 18025.5 18035.0 18138.8 20169.9 20286.6 20331.3 20450.9 20471.3 15214.9 15997.1 16145.5 16176.5 16294.6 20371.7 20520.8 20537.2 20543.0 20552.4 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#3] mootools.html Cycles:180 Average:11009.45 Median:26087.74 stddev:8020.20 (30.7%) stddev-sans-first:8010.46 09:15:10 INFO - PID 3854 | Values: 1437.3 1539.7 1547.7 1550.9 1557.8 17972.6 18429.7 18563.0 18585.9 18601.3 18244.7 18274.9 18330.6 18339.5 18459.3 3129.2 3223.4 3224.7 3226.0 3226.0 3150.2 3172.3 3190.5 3192.6 3194.0 3096.7 3117.8 3122.7 3134.3 3134.6 3013.1 3026.8 3034.1 3034.7 3036.1 2951.9 2972.8 2977.8 2984.6 2985.9 16679.2 16977.8 17026.7 17049.5 17088.2 9004.1 9472.5 9478.0 9481.5 9482.6 6077.1 6201.2 6255.3 6261.9 6293.8 2071.8 2156.7 2159.2 2192.2 2195.9 29076.7 29686.7 31307.5 31450.8 31474.7 8413.4 8428.8 8664.1 8707.8 8714.7 23183.0 23304.8 23389.5 23410.8 23441.8 9441.9 9586.7 9646.2 9652.9 9658.4 8200.5 8399.8 8566.7 8624.1 8636.2 6642.6 6653.7 6658.9 6688.7 6815.5 2102.8 2105.1 2105.6 2106.5 2125.7 1021.3 1025.2 1032.1 1032.8 1050.0 8793.7 8884.0 8915.4 8927.4 8934.6 828.5 830.1 846.2 847.6 849.9 5062.8 5066.4 5190.8 5212.9 5293.3 24351.6 25894.2 26016.7 26158.7 26198.0 25582.7 25703.5 25718.2 26329.0 26505.6 11259.9 12676.6 12817.9 12829.1 12919.4 10132.8 10238.7 10319.9 10426.1 10655.5 21770.8 21838.2 22199.4 22431.7 22759.2 22288.3 22914.8 23126.8 23189.0 23229.3 13861.4 13952.2 14026.6 14138.7 14167.3 15733.4 15823.8 15906.8 15907.4 15925.8 13112.6 13162.2 13304.9 13329.3 13369.9 11397.9 11562.2 11671.1 11820.3 12034.3 10290.2 10515.0 10546.9 10570.8 10592.0 8333.5 8374.2 8447.4 8474.7 8558.5 8778.3 8999.0 9001.7 9093.4 9124.5 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#4] prototype.html Cycles:180 Average:5797.99 Median:6430.18 stddev:1605.97 (25.0%) stddev-sans-first:1561.21 09:15:10 INFO - PID 3854 | Values: 539.3 581.5 594.2 618.1 622.3 6099.7 6402.3 6402.6 6427.2 6482.9 6267.3 6378.4 6397.6 6397.6 6430.7 5194.2 5285.0 5296.7 5331.7 5353.7 5080.7 5125.4 5154.7 5171.6 5327.0 5115.3 5136.4 5142.9 5171.3 5175.4 5053.7 5104.9 5120.8 5137.8 5151.3 4657.3 4684.2 4727.0 4738.4 4769.3 6347.7 6373.7 6392.5 6396.3 6401.5 5977.8 6001.3 6034.7 6038.2 6092.1 6614.9 6699.2 6733.6 6836.2 6850.0 5050.9 5200.1 5217.8 5264.3 5268.6 6845.2 6875.1 6981.2 7032.2 7082.5 5349.1 5356.4 5356.6 5399.6 5430.8 5426.5 5449.9 5507.6 5509.4 5523.2 6049.5 6050.8 6059.2 6060.8 6093.8 6753.9 6792.8 6806.6 6842.0 6861.8 1858.6 1859.6 1866.0 1877.3 1896.1 1278.0 1291.1 1344.1 1345.2 1379.0 6271.2 6427.1 6429.6 6447.4 6522.6 6864.5 6883.4 6910.8 6915.0 6933.2 6435.5 6493.5 6498.1 6501.3 6504.3 3639.7 3667.2 3669.2 3691.6 3704.5 7179.4 7227.5 7231.0 7264.6 7285.2 6946.9 6950.2 6982.8 6987.7 7089.6 7099.2 7123.6 7133.6 7134.6 7214.7 6789.5 6894.0 6895.9 6898.3 6901.3 6866.5 6890.6 6954.4 6955.2 6970.5 7225.7 7273.6 7314.0 7334.9 7368.3 5360.6 5366.2 5410.3 5426.7 5438.5 6768.7 6907.6 6910.2 6952.6 6977.3 6482.7 6643.5 6700.0 6792.9 6831.4 6595.4 6648.8 6681.7 6687.2 6726.9 6450.5 6533.3 6635.4 6658.3 6765.0 6633.9 6732.7 6778.3 6871.8 6882.6 6658.5 6690.2 6699.8 6701.5 6712.9 09:15:10 INFO - PID 3854 | 09:15:10 INFO - PID 3854 | [#5] yui.html Cycles:180 Average:28381.48 Median:18940.24 stddev:40772.43 (215.3%) stddev-sans-first:40835.00 09:15:10 INFO - PID 3854 | Values: 1006.7 1018.7 1039.2 1053.1 1054.3 19264.5 21366.4 21925.0 22019.6 22044.3 18777.0 18847.2 18870.2 18906.3 18974.1 1086.2 1105.8 1105.9 1107.7 1108.9 1094.0 1098.7 1099.0 1101.3 1104.2 1086.9 1112.0 1127.3 1127.7 1171.4 1116.2 1116.5 1117.2 1117.7 1118.3 795.9 804.8 805.7 807.7 808.9 21740.8 22418.8 22710.2 22729.7 22921.8 21309.4 23163.0 23454.9 23596.5 23971.5 19597.1 19643.8 19901.9 19977.5 19981.1 4083.4 4129.1 4130.8 4133.5 4139.8 127975.4 143509.0 159439.2 161102.0 163508.0 19168.8 19275.0 19490.4 19917.7 19933.4 32363.4 32827.8 35593.5 35651.0 35701.5 9883.5 9891.8 9903.2 10019.7 10054.9 4923.1 4938.8 4954.6 4963.9 4994.6 6530.0 6677.1 6677.6 6682.5 6682.6 1283.5 1292.9 1316.0 1318.6 1324.1 777.5 782.4 795.4 798.7 804.9 11823.9 12445.8 13219.4 13558.7 13647.5 784.2 784.5 787.6 796.1 801.0 5732.1 5800.9 5837.0 5884.5 5896.3 138374.3 138548.0 139609.0 142299.0 145582.0 122572.4 123270.4 127999.0 129640.0 132638.3 114941.0 118406.0 119203.0 121027.0 122984.8 13600.8 13682.3 14093.0 14172.1 14309.6 52034.5 55541.0 55785.4 57150.7 57477.7 71393.6 72994.6 73106.3 73376.6 73384.3 20091.7 20858.8 20925.3 20990.8 20996.0 23647.4 23756.4 23939.8 24021.0 24151.8 17747.7 17789.7 17833.3 17871.2 18021.6 16591.2 16776.7 16788.6 16843.7 16888.8 18113.3 18124.5 18127.9 18224.3 18271.5 15491.0 15495.9 15498.0 15548.4 15773.1 14415.0 14483.3 14522.6 14574.3 14600.3 09:15:10 INFO - PID 3854 | -------- Summary: end -------- 09:15:10 INFO - PID 3854 | 09:15:10 INFO - TEST-INFO | 3854: exit 0 09:15:10 INFO - TEST-OK | dromaeo_css | took 1108473ms 09:15:10 INFO - TEST-START | kraken 09:15:10 INFO - Initialising browser for kraken test... 09:15:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33405/getInfo.html -profile /tmp/tmpuWenQi/profile 09:15:10 INFO - TEST-INFO | started process 4222 (/builds/slave/test/build/application/firefox/firefox http://localhost:33405/getInfo.html) 09:15:15 INFO - TEST-INFO | 4222: exit 0 09:15:16 INFO - Browser initialized. 09:15:16 INFO - Running cycle 1/1 for kraken test... 09:15:16 INFO - Using env: {'DISPLAY': ':0', 09:15:16 INFO - 'HOME': '/home/cltbld', 09:15:16 INFO - 'JSGC_DISABLE_POISONING': '1', 09:15:16 INFO - 'LANG': 'en_US.UTF-8', 09:15:16 INFO - 'LANGUAGE': 'en_US:en', 09:15:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 09:15:16 INFO - 'LOGNAME': 'cltbld', 09:15:16 INFO - 'MAIL': '/var/mail/cltbld', 09:15:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:15:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:15:16 INFO - 'MOZ_CRASHREPORTER': '1', 09:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 09:15:16 INFO - 'MOZ_NO_REMOTE': '1', 09:15:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:16 INFO - 'NO_EM_RESTART': '1', 09:15:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:16 INFO - 'PWD': '/builds/slave/test', 09:15:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:15:16 INFO - 'RUST_BACKTRACE': 'full', 09:15:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:15:16 INFO - 'SHELL': '/bin/bash', 09:15:16 INFO - 'SHLVL': '1', 09:15:16 INFO - 'TERM': 'linux', 09:15:16 INFO - 'TMOUT': '86400', 09:15:16 INFO - 'USER': 'cltbld', 09:15:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470', 09:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:16 INFO - '_': '/tools/buildbot/bin/python'} 09:15:16 INFO - TEST-INFO | started process 4410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuWenQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:16 INFO - PID 4410 | 09:15:16 INFO - PID 4410 | (/builds/slave/test/build/application/firefox/firefox:4459): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:15:16 INFO - PID 4410 | 09:15:27 INFO - PID 4410 | RSS: Main: 142917632 09:15:27 INFO - PID 4410 | 09:15:29 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:30 INFO - PID 4410 | RSS: Main: 148819968 09:15:30 INFO - PID 4410 | 09:15:33 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-dft) 09:15:33 INFO - PID 4410 | RSS: Main: 149454848 09:15:33 INFO - PID 4410 | 09:15:36 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-fft) 09:15:37 INFO - PID 4410 | RSS: Main: 151089152 09:15:37 INFO - PID 4410 | 09:15:39 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-oscillator) 09:15:39 INFO - PID 4410 | RSS: Main: 150831104 09:15:39 INFO - PID 4410 | 09:15:41 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:42 INFO - PID 4410 | RSS: Main: 150872064 09:15:42 INFO - PID 4410 | 09:15:45 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:46 INFO - PID 4410 | RSS: Main: 150700032 09:15:46 INFO - PID 4410 | 09:15:49 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:50 INFO - PID 4410 | RSS: Main: 153350144 09:15:50 INFO - PID 4410 | 09:15:52 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33405/tests/kraken/driver.html?testName=json-parse-financial) 09:15:53 INFO - PID 4410 | RSS: Main: 153903104 09:15:53 INFO - PID 4410 | 09:15:55 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:15:55 INFO - PID 4410 | RSS: Main: 153489408 09:15:55 INFO - PID 4410 | 09:15:57 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:15:57 INFO - PID 4410 | RSS: Main: 153620480 09:15:57 INFO - PID 4410 | 09:15:59 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:00 INFO - PID 4410 | RSS: Main: 150827008 09:16:00 INFO - PID 4410 | 09:16:02 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:03 INFO - PID 4410 | RSS: Main: 151244800 09:16:03 INFO - PID 4410 | 09:16:06 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:06 INFO - PID 4410 | RSS: Main: 151351296 09:16:06 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33405/tests/kraken/driver.html?testName=ai-astar) 09:16:08 INFO - PID 4410 | RSS: Main: 152530944 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | __start_tp_report 09:16:08 INFO - PID 4410 | _x_x_mozilla_page_load 09:16:08 INFO - PID 4410 | _x_x_mozilla_page_load_details 09:16:08 INFO - PID 4410 | |i|pagename|runs| 09:16:08 INFO - PID 4410 | |0;ai-astar;105;104;104;105;104;105;109;105;106;105 09:16:08 INFO - PID 4410 | |1;audio-beat-detection;112;111;119;112;139;110;119;112;112;112 09:16:08 INFO - PID 4410 | |2;audio-dft;164;163;163;164;161;163;162;163;163;163 09:16:08 INFO - PID 4410 | |3;audio-fft;73;73;73;74;74;76;74;73;74;73 09:16:08 INFO - PID 4410 | |4;audio-oscillator;78;78;79;77;84;78;78;78;78;77 09:16:08 INFO - PID 4410 | |5;imaging-gaussian-blur;113;114;114;115;111;114;114;115;115;114 09:16:08 INFO - PID 4410 | |6;imaging-darkroom;148;148;147;150;149;149;147;149;148;148 09:16:08 INFO - PID 4410 | |7;imaging-desaturate;93;94;95;94;94;95;95;95;95;97 09:16:08 INFO - PID 4410 | |8;json-parse-financial;42;48;42;43;43;43;49;51;48;44 09:16:08 INFO - PID 4410 | |9;json-stringify-tinderbox;38;38;38;39;39;39;38;37;38;38 09:16:08 INFO - PID 4410 | |10;stanford-crypto-aes;72;76;71;69;73;75;75;71;72;73 09:16:08 INFO - PID 4410 | |11;stanford-crypto-ccm;103;104;108;111;104;106;105;111;111;102 09:16:08 INFO - PID 4410 | |12;stanford-crypto-pbkdf2;165;155;151;158;147;151;154;147;150;150 09:16:08 INFO - PID 4410 | |13;stanford-crypto-sha256-iterative;61;58;57;59;59;58;61;58;63;58 09:16:08 INFO - PID 4410 | __end_tp_report 09:16:08 INFO - PID 4410 | __start_cc_report 09:16:08 INFO - PID 4410 | _x_x_mozilla_cycle_collect,658 09:16:08 INFO - PID 4410 | __end_cc_report 09:16:08 INFO - PID 4410 | __startTimestamp1506442568705__endTimestamp 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | ------- Summary: start ------- 09:16:08 INFO - PID 4410 | Number of tests: 14 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#0] ai-astar Cycles:10 Average:105.20 Median:105.00 stddev:1.48 (1.4%) stddev-sans-first:1.56 09:16:08 INFO - PID 4410 | Values: 105.0 104.0 104.0 105.0 104.0 105.0 109.0 105.0 106.0 105.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:112.00 stddev:8.74 (7.8%) stddev-sans-first:9.16 09:16:08 INFO - PID 4410 | Values: 112.0 111.0 119.0 112.0 139.0 110.0 119.0 112.0 112.0 112.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 09:16:08 INFO - PID 4410 | Values: 164.0 163.0 163.0 164.0 161.0 163.0 162.0 163.0 163.0 163.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:0.95 (1.3%) stddev-sans-first:0.97 09:16:08 INFO - PID 4410 | Values: 73.0 73.0 73.0 74.0 74.0 76.0 74.0 73.0 74.0 73.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.00 stddev:2.01 (2.6%) stddev-sans-first:2.13 09:16:08 INFO - PID 4410 | Values: 78.0 78.0 79.0 77.0 84.0 78.0 78.0 78.0 78.0 77.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.22 09:16:08 INFO - PID 4410 | Values: 113.0 114.0 114.0 115.0 111.0 114.0 114.0 115.0 115.0 114.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:16:08 INFO - PID 4410 | Values: 148.0 148.0 147.0 150.0 149.0 149.0 147.0 149.0 148.0 148.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:0.93 09:16:08 INFO - PID 4410 | Values: 93.0 94.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 97.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:46.00 stddev:3.33 (7.2%) stddev-sans-first:3.32 09:16:08 INFO - PID 4410 | Values: 42.0 48.0 42.0 43.0 43.0 43.0 49.0 51.0 48.0 44.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 09:16:08 INFO - PID 4410 | Values: 38.0 38.0 38.0 39.0 39.0 39.0 38.0 37.0 38.0 38.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:2.16 (3.0%) stddev-sans-first:2.28 09:16:08 INFO - PID 4410 | Values: 72.0 76.0 71.0 69.0 73.0 75.0 75.0 71.0 72.0 73.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.00 stddev:3.50 (3.3%) stddev-sans-first:3.48 09:16:08 INFO - PID 4410 | Values: 103.0 104.0 108.0 111.0 104.0 106.0 105.0 111.0 111.0 102.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:152.50 stddev:5.49 (3.6%) stddev-sans-first:3.64 09:16:08 INFO - PID 4410 | Values: 165.0 155.0 151.0 158.0 147.0 151.0 154.0 147.0 150.0 150.0 09:16:08 INFO - PID 4410 | 09:16:08 INFO - PID 4410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:1.87 09:16:08 INFO - PID 4410 | Values: 61.0 58.0 57.0 59.0 59.0 58.0 61.0 58.0 63.0 58.0 09:16:08 INFO - PID 4410 | -------- Summary: end -------- 09:16:08 INFO - PID 4410 | 09:16:09 INFO - PID 4410 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:16:09 INFO - TEST-INFO | 4410: exit 0 09:16:09 INFO - TEST-OK | kraken | took 58570ms 09:16:09 INFO - SUITE-END | took 1167s 09:16:09 INFO - Completed test suite (00:19:27) 09:16:09 INFO - javascript benchmark 09:16:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9446.45128107946, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4023.7786921719307, 4047.736897101688, 4067.5932406759307, 4068.552459229486, 4076.6127217914295, 6537.9346206537975, 6572.901406478894, 6637.469002479802, 6692.196936367636, 6711.899321510181, 6607.273199948002, 6614.536982411233, 6640.7343706251695, 6672.0, 6709.563878347904, 5899.085641725539, 5922.58541902067, 5922.703864806764, 5932.584719069645, 5952.761889524414, 5875.529957603381, 5894.852628684296, 5901.970490147543, 5929.644221346712, 6041.275046994345, 5972.79095231667, 5975.611585246967, 6016.0, 6031.065184896348, 6042.365551617061, 5901.23283973085, 5960.8674351873005, 5981.970090149565, 6027.758889644409, 6055.6063855849225, 5825.15535247391, 5861.238039054895, 5901.3508514063415, 5909.113632955091, 5947.702614869282, 6460.450861676763, 6560.737570497222, 6585.176852893388, 6598.043283723833, 6638.369354911276, 7113.395361394288, 7125.35871771543, 7139.964300178466, 7184.461165412615, 7220.92779072213, 6995.965020174917, 7080.610566418845, 7195.064641596559, 7246.456515761286, 7270.200277969419, 6649.3350664933605, 6685.799426017227, 6719.092922455455, 6724.966375168142, 6745.7976260711275, 7346.228645992094, 7353.963230183815, 7367.373773229228, 7439.479236453396, 7450.888236676454, 6906.06768086312, 6993.89509157363, 7027.824304392431, 7065.399441047569, 7152.356287934111, 7087.3267039631155, 7132.322429369202, 7133.393661538724, 7146.499745017799, 7155.928440715526, 7064.152301723826, 7076.540024898365, 7095.290470952967, 7128.144622645315, 7203.279672032755, 7134.857302854018, 7145.249748776304, 7193.9280607194305, 7234.059572255573, 7241.0, 5246.658967167122, 5264.368275806928, 5328.333958255218, 5340.279062326614, 5369.677819330853, 4727.95272047282, 4769.76151192439, 4777.474477807438, 4827.0, 4853.684510506806, 6761.763338283235, 6767.255601883789, 6768.458523318122, 6771.830704232433, 6783.423409010191, 7091.361777440055, 7187.89218161728, 7193.208747037822, 7221.675024623904, 7250.709971601077, 6556.885329493997, 6637.369449902348, 6711.765088221889, 6765.898511522331, 6816.011678306618, 5675.460831221028, 5886.6173698709445, 5983.0, 5988.730507127189, 6001.939980600226, 7378.557286562824, 7444.739434119888, 7478.887816682754, 7593.392528597699, 7595.962020189863, 7188.712451501881, 7209.206987231505, 7211.350978412073, 7248.673809678683, 7255.854882902418, 7457.6271186441545, 7462.701491940262, 7476.476646634684, 7561.3950883928055, 7589.354904833151, 6968.4076853465995, 7003.229644738973, 7067.081279433641, 7143.749968751069, 7196.676149573177, 7115.395191408581, 7202.49582529218, 7216.061911951413, 7239.674214660458, 7289.562626242442, 6712.39588437043, 6923.376896079377, 6939.236683964861, 7016.122984626922, 7040.3663670269925, 6899.310068993061, 6907.0, 6955.061066756126, 6988.231294557493, 6999.650017499206, 6660.933390666031, 6786.253512113763, 6819.727210911707, 6852.965735171292, 6906.620135892374, 6926.549774264657, 6946.16646002483, 6951.374376306157, 6981.197162326194, 7048.506604537633, 6698.497612679166, 6778.762743304158, 6794.082798822095, 6812.965935170292, 6883.139607549057], "value": 6557.7724643991705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.9758256043602, 975.3172779054659, 1005.1004351105761, 1027.8972102789717, 1031.2162756305206, 43365.78317108414, 44098.77950610242, 44101.33847992283, 44111.11777764443, 44150.33774493385, 40728.185436291256, 40734.18531629373, 40796.0, 40861.38707919384, 40933.59066409335, 8119.715809946653, 8188.303994160504, 8191.754247372588, 8212.137725538822, 8257.215564521392, 7894.7236846710375, 7910.762677119696, 7954.244346787046, 7970.800729981739, 7978.9202107979045, 8631.13688631135, 8849.646014159425, 8864.0, 8879.156480134377, 8884.466931984101, 8732.345074119436, 8762.211400973943, 8762.649494020232, 8780.912190878138, 8830.911690883073, 8579.699710510102, 8592.312614990786, 8593.656253749905, 8611.0, 8637.956810215908, 39839.40240896389, 39934.60065399338, 40149.79925100385, 40164.79917600423, 40200.59799402027, 3879.2823327684187, 3885.6502914737525, 3890.221955608861, 3911.041794760302, 3912.7065470089856, 32797.18007049819, 32912.17719557006, 32935.50596741051, 32935.6706432935, 33002.0, 5489.670619762787, 5511.669299842022, 5523.475269849358, 5538.972305138489, 5581.2186293918885, 230665.0, 230728.0, 231406.0, 232167.0, 233366.0, 51538.0, 52002.739986300585, 52061.7396913013, 52249.216261756104, 52319.476805232225, 53335.733321333144, 53428.465715343125, 53499.732501338025, 53599.0, 53809.730951344995, 17816.109194540222, 18152.273909043754, 18227.0, 18321.541961450803, 18327.541811454554, 15226.543203703906, 15301.693966120616, 15333.0, 15352.923235383752, 15386.538403847902, 14789.334479948428, 15237.847621523864, 15243.61890952713, 15376.769348459558, 15417.768733469007, 5818.796342128006, 5960.552958528127, 5967.701614919237, 5980.850478738066, 5992.0, 1082.5832054658856, 1087.7117563845586, 1124.2523721725124, 1128.497818470789, 1138.4364739453858, 25876.611850822253, 26184.34539136537, 26442.6033609496, 26484.60273095905, 26601.33496662599, 1211.5638370186725, 1226.5400474821943, 1234.8579913309904, 1236.437420973455, 1256.8114782782473, 13803.0, 13810.723785524233, 14105.36525856339, 14109.929450352887, 14182.219977901108, 283989.0, 284486.0, 284797.0, 285908.0, 286524.0, 57639.13541296884, 60505.69747151236, 60921.08618370639, 61105.694471528244, 61174.0, 1477.3942683499713, 1515.0758037597057, 1521.117751704009, 1523.2840564934463, 1529.6328881068464, 30294.242643934078, 30527.389452210387, 30538.694613053583, 30577.388452231276, 30944.381112378076, 40806.38790418087, 41027.38458923059, 41057.1788564233, 41118.177636446504, 41152.0, 256417.0, 258345.0, 258442.0, 259307.0, 259329.0, 34979.30041399209, 34980.30039399147, 35099.47350789689, 35235.47146792749, 35274.0, 44405.11189776122, 45779.54220457886, 46054.309185362916, 46112.53887461082, 46165.0, 34162.65837341595, 34260.0, 34651.30697385988, 34964.0, 35012.82493587516, 34490.0, 34567.4814877772, 34622.82688586541, 34658.30683386369, 35299.29401411906, 39512.40731388974, 39866.80066599648, 39894.80052599718, 39897.0, 40040.799796002, 32651.34697306088, 33294.33411331808, 33673.0, 33747.49378759271, 34014.48978265378, 25348.873255633604, 25356.0, 25421.61867572025, 25883.61174582345, 26202.344941376617], "value": 18964.17646331888, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.4118569730155, 634.531839901252, 642.4571237304476, 651.3388910256091, 652.9452102443823, 24249.63625545616, 24326.87836560817, 24499.387515312083, 24969.0, 24969.126080587183, 22939.0, 23187.0, 23210.303690889257, 23253.534929301404, 23272.534549309003, 6767.763128290523, 6885.931140688579, 6945.930540694604, 6955.826104347407, 7193.100862392201, 7127.786166415016, 7163.247858974811, 7163.964180179092, 7166.247544007882, 7171.067761191038, 7024.2273349931465, 7078.681459334317, 7107.680154393039, 7108.360247577717, 7121.394681452083, 7101.289871012883, 7106.609136497491, 7114.359707626312, 7123.074000379969, 7131.037309963141, 6606.504512161559, 6625.867482650368, 6647.434968027724, 6668.566543174678, 6677.298883617199, 29646.258843528867, 31303.0, 31471.213219669462, 31496.68503314983, 31524.842375788205, 2357.5520651076413, 2417.3714834143075, 2419.8669073200967, 2420.782129608344, 2431.7203521595065, 20618.381448556567, 20653.8967305164, 21306.680399794015, 21348.252811151535, 21535.56928861414, 2591.663083799113, 2629.6187052877417, 2657.534931387019, 2676.023251513184, 2676.69218039924, 140274.0, 144878.27560862232, 157495.0, 165524.17237913853, 166733.99999999878, 16406.917965410095, 16934.830651693326, 17223.655526889394, 17354.305827767, 17589.29642814273, 27671.30821729473, 27680.723192767815, 27686.723132768817, 27695.861520692266, 27696.723032769816, 11329.376884271443, 11602.18784685064, 11614.128940329509, 11648.184627076193, 11749.951477328743, 10478.161747060218, 10493.737656558495, 10515.84226236607, 10590.470476476145, 10684.786304273872, 10557.419341936115, 10689.35863848156, 10740.570377184826, 10741.355518668905, 10755.193360497993, 3006.864691088906, 3079.337942342407, 3085.783995120365, 3090.90727278182, 3160.004598551449, 1055.7888422315414, 1068.9037986581245, 1077.2674581284803, 1080.7082087836397, 1096.4298564746446, 21664.24175153862, 21979.120835166734, 21989.450263743536, 22298.331050068526, 22314.21900233484, 1139.1570238023803, 1146.0602306109076, 1147.8163493840946, 1156.2715489241891, 1160.5415860734963, 11865.0, 12024.579139730067, 12147.453364598437, 12182.208156469802, 12223.572174973833, 602671.0, 617007.0, 619583.0, 620373.0, 620384.0, 131406.0, 133631.0, 136385.318073409, 137926.0, 140325.0, 1177.4230626992712, 1180.1738782852037, 1231.7905955987503, 1237.7338872142352, 1296.2481760578842, 22748.862556871758, 23062.308130756104, 23085.65371519395, 23183.420414489774, 23450.648240276067, 65923.67038164778, 66947.3305266941, 67707.0, 67806.32193678197, 68720.65639671769, 77917.22082779327, 81772.18227817645, 82337.17662823535, 82454.0, 83286.0, 16190.838091618933, 16281.0, 16351.182440878147, 16392.344306227616, 16542.42101526489, 24468.877655611606, 24757.381065473506, 24808.503829922938, 24900.501989960463, 24971.75028249694, 19889.60220795605, 20432.79567204309, 20576.69134962947, 20782.06480708402, 20798.37604871856, 17080.91459542744, 17903.283868645107, 18025.459236222934, 18035.0, 18138.820976636478, 20169.899150504152, 20286.59426811426, 20331.288404905757, 20450.89774551177, 20471.283505077252, 15214.923925380303, 15997.1201583914, 16145.515634530982, 16176.514704558882, 16294.592635184215, 20371.675841070282, 20520.79479205189, 20537.17851285932, 20543.0, 20552.38342849717], "value": 13341.898333814548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.2957250947036, 1539.6535779449632, 1547.7446221373477, 1550.899191552549, 1557.8052743407075, 17972.640547189047, 18429.723554146698, 18563.0, 18585.907070464647, 18601.348952786655, 18244.72632910504, 18274.908625456887, 18330.633387332244, 18339.541511462186, 18459.261629534834, 3129.2176955761115, 3223.419784438812, 3224.7097761201485, 3225.96774032259, 3225.9838700806463, 3150.1652062203534, 3172.2703778131045, 3190.457622204231, 3192.5849639546827, 3193.96806031939, 3096.6593674695764, 3117.7973431726978, 3122.703343182394, 3134.294783673678, 3134.6081739782526, 3013.0960711786597, 3026.772992025596, 3034.0746072447896, 3034.651015133266, 3036.05882176526, 2951.896683616063, 2972.7621790256726, 2977.8064425812254, 2984.582158497812, 2985.880564777406, 16679.24943377551, 16977.83022169775, 17026.74459883103, 17049.48851534456, 17088.231029603572, 9004.099590041009, 9472.526373681289, 9477.952610236973, 9481.47851868147, 9482.573284202228, 6077.1491991121275, 6201.193844800147, 6255.280642726099, 6261.906071408933, 6293.779717709858, 2071.792820717931, 2156.7304086989125, 2159.211887661008, 2192.199847055829, 2195.9011844467036, 29076.70923290761, 29686.703132968825, 31307.53038704421, 31450.842745786354, 31474.685253147403, 8413.411061225655, 8428.789280268042, 8664.133586641412, 8707.825843483095, 8714.694985675598, 23183.0, 23304.76695233026, 23389.53220935572, 23410.7658923412, 23441.7655823443, 9441.905580944103, 9586.712398628053, 9646.18007469373, 9652.855207171899, 9658.372205806741, 8200.507969521848, 8399.8320033599, 8566.700165494178, 8624.094470080676, 8636.17956294151, 6642.6014439133805, 6653.700583473756, 6658.933410665928, 6688.699008544627, 6815.454763618898, 2102.8107470327745, 2105.136893873535, 2105.557832855087, 2106.4523223961573, 2125.7342832145982, 1021.3310281765456, 1025.236199031726, 1032.1278519650882, 1032.7573020340214, 1049.9947500262604, 8793.692220772371, 8883.955580222058, 8915.37592368528, 8927.419717718458, 8934.642614295486, 828.4780588229497, 830.0620299062022, 846.2087947768733, 847.563504795031, 849.9405041647026, 5062.82280120194, 5066.442691303953, 5190.81832135881, 5212.947870521246, 5293.258943747878, 24351.634725479133, 25894.223173304832, 26016.739832601812, 26158.73841261601, 26198.0, 25582.744172558036, 25703.48593028129, 25718.228453146436, 26329.0, 26505.602415963775, 11259.94370028161, 12676.556320528738, 12817.935910320388, 12829.101962862696, 12919.418626161845, 10132.797344053226, 10238.720159980003, 10319.94840025825, 10426.113780328453, 10655.520501577292, 21770.782292176875, 21838.23566175176, 22199.445013874138, 22431.663525047465, 22759.203427879944, 22288.331350059525, 22914.770852291265, 23126.768732312463, 23189.0, 23229.3031209064, 13861.376238069513, 13952.232627205602, 14026.649333766738, 14138.717225655635, 14167.291635418394, 15733.370665173265, 15823.762643560125, 15906.7613985788, 15907.363705451653, 15925.840741592436, 13112.606621801362, 13162.210267383987, 13304.866951330363, 13329.266890321125, 13369.866301337252, 11397.886021139682, 11562.190646654653, 11671.12466564994, 11820.349880756641, 12034.338111403957, 10290.228232882415, 10515.0, 10546.894531054591, 10570.8414373786, 10592.046715795615, 8333.458325208841, 8374.246317831425, 8447.408681392244, 8474.74575762728, 8558.52928088961, 8778.253848422955, 8998.955005224932, 9001.729948101567, 9093.40892841963, 9124.5437728112], "value": 7758.611301373273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.2531344088436, 581.4999100773337, 594.1978329255504, 618.0636335951034, 622.2501885228301, 6099.695015249242, 6402.2957474677805, 6402.615843049421, 6427.196600424947, 6482.870342593157, 6267.341929097447, 6378.3621637836195, 6397.61614303141, 6397.616143031421, 6430.710618022188, 5194.168932970716, 5285.0, 5296.708681022542, 5331.733413329318, 5353.678779273256, 5080.669756465836, 5125.410577783547, 5154.74226288686, 5171.637985341028, 5326.973365133169, 5115.335006449156, 5136.409312929005, 5142.897142057157, 5171.327727395452, 5175.353080864892, 5053.69677819332, 5104.923426148593, 5120.846374608749, 5137.7944882204665, 5151.330327057496, 4657.278121891112, 4684.156851766681, 4726.976365118152, 4738.3603213566075, 4769.284607308897, 6347.682615869188, 6373.681315934185, 6392.456641185505, 6396.26442959061, 6401.455876250524, 5977.801875996364, 6001.279846418414, 6034.6982650867285, 6038.154658347835, 6092.08618707193, 6614.908540090879, 6699.162604674416, 6733.595984240912, 6836.213835408892, 6849.965750171267, 5050.898982020376, 5200.141976573861, 5217.8173763918085, 5264.2893209416625, 5268.60485463588, 6845.247022827485, 6875.106236189314, 6981.232064472904, 7032.15614126303, 7082.477267387537, 5349.117395629755, 5356.4107948125675, 5356.625036247426, 5399.649022813504, 5430.755615997289, 5426.538744206787, 5449.929026969806, 5507.614466987273, 5509.3664228614225, 5523.226748255248, 6049.455549000523, 6050.818475445743, 6059.21230240066, 6060.818175454743, 6093.817185484442, 6753.932460675429, 6792.777300085933, 6806.625635589991, 6842.015815413474, 6861.794146175623, 1858.5818190907207, 1859.6094820087662, 1866.0, 1877.27724825943, 1896.1183049881872, 1278.0, 1291.14139097501, 1344.1330341929402, 1345.2332170662824, 1378.9862101378858, 6271.216097987752, 6427.111597483548, 6429.646369449725, 6447.3552644735155, 6522.608643481406, 6864.519483636197, 6883.380495755406, 6910.825159722859, 6915.0, 6933.237343892168, 6435.485161187094, 6493.545451818327, 6498.122753428227, 6501.284858665543, 6504.252011018793, 3639.727020473475, 3667.1748856507074, 3669.229461812996, 3691.557013158438, 3704.518412606344, 7179.3949566398, 7227.457940654472, 7230.9638451807405, 7264.636768161677, 7285.162206346338, 6946.8610627788175, 6950.200726916368, 6982.79051628452, 6987.720491180397, 7089.610071446017, 7099.183593886666, 7123.608201548757, 7133.5719856808755, 7134.607596582237, 7214.74748383804, 6789.456843452611, 6894.0, 6895.931040689529, 6898.310168983062, 6901.3429829515, 6866.450683945172, 6890.552114112566, 6954.408875245458, 6955.23492415844, 6970.546914450544, 7225.710971561289, 7273.599952002691, 7313.963430182815, 7334.926650733424, 7368.300011498899, 5360.624756267024, 5366.168243922199, 5410.296661433988, 5426.67439953604, 5438.483344082306, 6768.7292508299115, 6907.585544867324, 6910.20532638753, 6952.617606031717, 6977.2673869243, 6482.675866206765, 6643.50173736962, 6699.961505966583, 6792.898106528307, 6831.419329357061, 6595.373439523238, 6648.767293144717, 6681.732730690913, 6687.1975362956755, 6726.899096513458, 6450.516211284079, 6533.346665333429, 6635.369639884203, 6658.300878407697, 6764.966175169093, 6633.900491492728, 6732.697028633625, 6778.2543920167755, 6871.793846184622, 6882.552634078769, 6658.533902626963, 6690.19717633887, 6699.832504187434, 6701.497387696039, 6712.865742685217], "value": 5338.27951182646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1006.7181189267003, 1018.7249442650483, 1039.2361614213557, 1053.0838170791412, 1054.3357684658663, 19264.51838704033, 21366.359009229727, 21925.0, 22019.559608807813, 22044.33866983991, 18777.0, 18847.15187816548, 18870.24519019241, 18906.338278160267, 18974.146163422643, 1086.2124959404427, 1105.7567335186286, 1105.8838821923703, 1107.7119948813286, 1108.905743011845, 1094.0, 1098.7363032872092, 1099.005400112899, 1101.3226865477754, 1104.2270410712492, 1086.934783912964, 1112.010310823368, 1127.2560110327186, 1127.7237076916167, 1171.4318555500618, 1116.2019156303281, 1116.5198964445326, 1117.1956191542158, 1117.7485065860158, 1118.3234143343282, 795.9403044771665, 804.778685861387, 805.7139715401007, 807.6648191000728, 808.8503626829056, 21740.782592174193, 22418.77581224183, 22710.205142819923, 22729.659055114185, 22921.77078229213, 21309.36071917845, 23163.0, 23454.882725586434, 23596.528069438686, 23971.52056958851, 19597.118129684197, 19643.80356196434, 19901.9004904976, 19977.500562485908, 19981.10085046162, 4083.3874918762126, 4129.091599848029, 4130.834766609332, 4133.483314585676, 4139.77231252281, 127975.36012319879, 143509.0, 159439.20280398524, 161102.0, 163508.0, 19168.808311916982, 19275.0, 19490.415287541397, 19917.701234481494, 19933.401997940084, 32363.352732945208, 32827.835860820545, 35593.466098008554, 35651.0, 35701.46447803285, 9883.50582470888, 9891.752706182404, 9903.207743380512, 10019.699409017741, 10054.899451005396, 4923.138450771101, 4938.802447902043, 4954.578860796801, 4963.925541116886, 4994.625403094782, 6529.967350163314, 6677.098591690156, 6677.632730199788, 6682.498812589075, 6682.599044057372, 1283.5250957145915, 1292.9288889111, 1315.9934200328937, 1318.637374721959, 1324.1194605587368, 777.4907435629672, 782.4014628808966, 795.3716563914559, 798.660569258063, 804.8631732605471, 11823.881761182278, 12445.75108497825, 13219.405126769318, 13558.661033474242, 13647.522336718366, 784.2432053068702, 784.4744021505605, 787.5550314072646, 796.0566728426833, 801.0, 5732.140178973187, 5800.941990580124, 5836.970815145897, 5884.499817515559, 5896.262967129109, 138374.3081284587, 138548.0, 139609.0, 142299.0, 145582.0, 122572.38713806374, 123270.38364808119, 127999.0, 129640.0, 132638.33680831533, 114941.0, 118406.0, 119203.0, 121027.0, 122984.77015229913, 13600.795988060385, 13682.31588420595, 14093.0, 14172.078814877, 14309.64225894361, 52034.47965520448, 55541.0, 55785.442145578025, 57150.7142464285, 57477.71261143835, 71393.64303178659, 72994.63502682453, 73106.26893730994, 73376.63311683407, 73384.26615733774, 20091.698624520937, 20858.791412085684, 20925.26761563338, 20990.790092099494, 20996.0, 23647.408814779767, 23756.406089847893, 23939.76060239375, 24021.0, 24151.792410379763, 17747.73378399351, 17789.733154002442, 17833.286668533114, 17871.195796189462, 18021.639567208844, 16591.17044147812, 16776.748348774534, 16788.58028549296, 16843.663126737643, 16888.81778275509, 18113.275468981094, 18124.546886327946, 18127.90936045311, 18224.271029159216, 18271.451856444328, 15491.0, 15495.922520387327, 15498.0, 15548.378064877279, 15773.132477713378, 14415.0, 14483.348249328596, 14522.648083623693, 14574.271286435423, 14600.26998650042], "value": 10339.361279345698, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1367.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 104.0, 105.0, 104.0, 105.0, 109.0, 105.0, 106.0, 105.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 119.0, 112.0, 139.0, 110.0, 119.0, 112.0, 112.0, 112.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 164.0, 161.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 74.0, 74.0, 76.0, 74.0, 73.0, 74.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 84.0, 78.0, 78.0, 78.0, 78.0, 77.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 111.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 150.0, 149.0, 149.0, 147.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 97.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 48.0, 42.0, 43.0, 43.0, 43.0, 49.0, 51.0, 48.0, 44.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 38.0, 37.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 71.0, 69.0, 73.0, 75.0, 75.0, 71.0, 72.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 108.0, 111.0, 104.0, 106.0, 105.0, 111.0, 111.0, 102.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 155.0, 151.0, 158.0, 147.0, 151.0, 154.0, 147.0, 150.0, 150.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 57.0, 59.0, 59.0, 58.0, 61.0, 58.0, 63.0, 58.0], "value": 59.2, "unit": "score"}]}]} 09:16:09 INFO - Return code: 0 09:16:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:10 INFO - # TBPL SUCCESS # 09:16:10 INFO - Running post-action listener: _package_coverage_data 09:16:10 INFO - Running post-action listener: _resource_record_post_action 09:16:10 INFO - [mozharness: 2017-09-26 16:16:10.030683Z] Finished run-tests step (success) 09:16:10 INFO - Running post-run listener: _resource_record_post_run 09:16:10 INFO - Total resource usage - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289071104; Read time: 12; Write time: 257524 09:16:10 INFO - TinderboxPrint: CPU usage
13.1% 09:16:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:16:10 INFO - TinderboxPrint: I/O write bytes / time
289,071,104 / 257,524 09:16:10 INFO - TinderboxPrint: CPU idle
8,192.3 (86.9%) 09:16:10 INFO - TinderboxPrint: CPU user
1,180.7 (12.5%) 09:16:10 INFO - TinderboxPrint: Swap in / out
0 / 0 09:16:10 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 10547200; Read time: 0; Write time: 1008 09:16:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:16:10 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278523904; Read time: 12; Write time: 256516 09:16:10 INFO - Running post-run listener: _upload_blobber_files 09:16:10 INFO - Blob upload gear active. 09:16:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:10 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 09:16:10 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16:10 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:12 INFO - (blobuploader) - INFO - Done attempting. 09:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:19 INFO - (blobuploader) - INFO - Done attempting. 09:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:20 INFO - (blobuploader) - INFO - Done attempting. 09:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:21 INFO - (blobuploader) - INFO - Done attempting. 09:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:21 INFO - Return code: 0 09:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:21 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2562868afa6cad75d8cbe37460e7253c64d7a567a611b75a3db23b26b7dbbcf9f9c5558e99a46c89ecadb318b6a1f79f214b1ff0cbbdf8e4801c5566ca2d97a9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88c33b3f8d4d63956a10a9837120825baa2c8f1c9508536f80387a129ed5ea4c8e2248fe5a4ccaa7c1b1e9893a37e0658c6aef2c6454349d7558463749a97828", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa51588765bcdb4488f31ed75939d06d325698942052fa53699debd27da3747f4a16932f03be35cbaf04500342c8a283149608a8acba4bb85d15d451c8084081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6f101f00ec34dfbfd1253fbf90c09f7bbf114dfde777f95372fa3c4b8b1db1f4f3dc0e893eb1881ecb88e4d46ebec97870700ee4fe2b2aa93280c993d22ebb97"} 09:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:21 INFO - Contents: 09:16:21 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2562868afa6cad75d8cbe37460e7253c64d7a567a611b75a3db23b26b7dbbcf9f9c5558e99a46c89ecadb318b6a1f79f214b1ff0cbbdf8e4801c5566ca2d97a9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88c33b3f8d4d63956a10a9837120825baa2c8f1c9508536f80387a129ed5ea4c8e2248fe5a4ccaa7c1b1e9893a37e0658c6aef2c6454349d7558463749a97828", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa51588765bcdb4488f31ed75939d06d325698942052fa53699debd27da3747f4a16932f03be35cbaf04500342c8a283149608a8acba4bb85d15d451c8084081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6f101f00ec34dfbfd1253fbf90c09f7bbf114dfde777f95372fa3c4b8b1db1f4f3dc0e893eb1881ecb88e4d46ebec97870700ee4fe2b2aa93280c993d22ebb97"} 09:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:21 INFO - Copying logs to upload dir... 09:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.156392 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-26 09:16:21.295686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 09:16:21.303448) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2562868afa6cad75d8cbe37460e7253c64d7a567a611b75a3db23b26b7dbbcf9f9c5558e99a46c89ecadb318b6a1f79f214b1ff0cbbdf8e4801c5566ca2d97a9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88c33b3f8d4d63956a10a9837120825baa2c8f1c9508536f80387a129ed5ea4c8e2248fe5a4ccaa7c1b1e9893a37e0658c6aef2c6454349d7558463749a97828", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa51588765bcdb4488f31ed75939d06d325698942052fa53699debd27da3747f4a16932f03be35cbaf04500342c8a283149608a8acba4bb85d15d451c8084081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6f101f00ec34dfbfd1253fbf90c09f7bbf114dfde777f95372fa3c4b8b1db1f4f3dc0e893eb1881ecb88e4d46ebec97870700ee4fe2b2aa93280c993d22ebb97"} build_url:https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/ER9NEPuWR2OZYMpC2mabvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2562868afa6cad75d8cbe37460e7253c64d7a567a611b75a3db23b26b7dbbcf9f9c5558e99a46c89ecadb318b6a1f79f214b1ff0cbbdf8e4801c5566ca2d97a9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/88c33b3f8d4d63956a10a9837120825baa2c8f1c9508536f80387a129ed5ea4c8e2248fe5a4ccaa7c1b1e9893a37e0658c6aef2c6454349d7558463749a97828", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aa51588765bcdb4488f31ed75939d06d325698942052fa53699debd27da3747f4a16932f03be35cbaf04500342c8a283149608a8acba4bb85d15d451c8084081", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6f101f00ec34dfbfd1253fbf90c09f7bbf114dfde777f95372fa3c4b8b1db1f4f3dc0e893eb1881ecb88e4d46ebec97870700ee4fe2b2aa93280c993d22ebb97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 09:16:21.336623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 09:16:21.336959) ========= 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=5bd038846534b2fdfa68eeae000001e2-1506441341.308699-672053470 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 09:16:21.420145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 09:16:21.420482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 09:16:21.420962) ========= ========= Total master_lag: 0.22 =========