builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1505585604.79 results: success (0) revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.794888) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.795697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.795974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.841433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.841689) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 11:13:24-- 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% 109M=0s 2017-09-16 11:13:24 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.956788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:24.957115) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:25.008867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 11:13:25.009157) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --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=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 11:13:25,029 truncating revision to first 12 chars 2017-09-16 11:13:25,029 Setting DEBUG logging. 2017-09-16 11:13:25,029 attempt 1/10 2017-09-16 11:13:25,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e2566a71f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 11:13:26,031 unpacking tar archive at: mozilla-central-34e2566a71f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-16 11:13:26.386541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:26.386875) ========= script_repo_revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:26.387270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:26.387568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:13:26.401097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-16 11:13:26.401402) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:26 INFO - MultiFileLogger online at 20170916 11:13:26 in /builds/slave/test 11:13:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:13:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:13:26 INFO - {'append_to_log': False, 11:13:26 INFO - 'base_work_dir': '/builds/slave/test', 11:13:26 INFO - 'blob_upload_branch': 'Firefox', 11:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:13:26 INFO - 'branch': 'Firefox', 11:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:26 INFO - 'code_coverage': False, 11:13:26 INFO - 'config_files': ('talos/linux_config.py',), 11:13:26 INFO - 'default_actions': ('clobber', 11:13:26 INFO - 'read-buildbot-config', 11:13:26 INFO - 'download-and-extract', 11:13:26 INFO - 'populate-webroot', 11:13:26 INFO - 'create-virtualenv', 11:13:26 INFO - 'install', 11:13:26 INFO - 'setup-mitmproxy', 11:13:26 INFO - 'run-tests'), 11:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:26 INFO - 'disable_ccov_upload': False, 11:13:26 INFO - 'disable_stylo': False, 11:13:26 INFO - 'download_minidump_stackwalk': True, 11:13:26 INFO - 'download_symbols': 'ondemand', 11:13:26 INFO - 'enable_stylo': False, 11:13:26 INFO - 'enable_webrender': False, 11:13:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:26 INFO - 'gecko_profile': False, 11:13:26 INFO - 'gecko_profile_interval': 0, 11:13:26 INFO - 'installer_path': 'installer.exe', 11:13:26 INFO - 'log_level': 'info', 11:13:26 INFO - 'log_name': 'talos', 11:13:26 INFO - 'log_to_console': True, 11:13:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:26 INFO - 'opt_config_files': (), 11:13:26 INFO - 'pip_index': False, 11:13:26 INFO - 'suite': 'dromaeojs-e10s', 11:13:26 INFO - 'system_bits': '32', 11:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:26 INFO - 'title': 'talos-linux64-ix-067', 11:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:26 INFO - 'use_talos_json': True, 11:13:26 INFO - 'verify': 'False', 11:13:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:26 INFO - 'work_dir': 'build'} 11:13:26 INFO - [mozharness: 2017-09-16 18:13:26.564401Z] Running clobber step. 11:13:26 INFO - Running pre-action listener: _resource_record_pre_action 11:13:26 INFO - Running main action method: clobber 11:13:26 INFO - rmtree: /builds/slave/test/build 11:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:13:27 INFO - Running post-action listener: _resource_record_post_action 11:13:27 INFO - [mozharness: 2017-09-16 18:13:27.557859Z] Finished clobber step (success) 11:13:27 INFO - [mozharness: 2017-09-16 18:13:27.557956Z] Running read-buildbot-config step. 11:13:27 INFO - Running pre-action listener: _resource_record_pre_action 11:13:27 INFO - Running main action method: read_buildbot_config 11:13:27 INFO - Using buildbot properties: 11:13:27 INFO - { 11:13:27 INFO - "project": "", 11:13:27 INFO - "product": "firefox", 11:13:27 INFO - "who": "ffxbld@noreply.mozilla.org", 11:13:27 INFO - "installer_path": "public/build/target.tar.bz2", 11:13:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:13:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:13:27 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:13:27 INFO - "stage_platform": "linux64-qr", 11:13:27 INFO - "basedir": "/builds/slave/test", 11:13:27 INFO - "buildnumber": 64, 11:13:27 INFO - "platform": "ubuntu64_hw_qr", 11:13:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:13:27 INFO - "slavebuilddir": "test", 11:13:27 INFO - "taskId": "W2Cela7lTeOnJ1ODJKRFTg", 11:13:27 INFO - "branch": "mozilla-central", 11:13:27 INFO - "script_repo_revision": "production", 11:13:27 INFO - "revision": "34e2566a71f160eb3c5c3d92626453852e818f18", 11:13:27 INFO - "slavename": "talos-linux64-ix-067", 11:13:27 INFO - "repo_path": "mozilla-central" 11:13:27 INFO - } 11:13:27 INFO - Finding installer, test and symbols from parent task. 11:13:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2Cela7lTeOnJ1ODJKRFTg'}, attempt #1 11:13:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2Cela7lTeOnJ1ODJKRFTg'}, attempt #1 11:13:28 INFO - Task dependencies: MWFstPgVRxqTsnauXlFVFQ 11:13:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ'}, attempt #1 11:13:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:13:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json 11:13:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip 11:13:28 INFO - Running post-action listener: _resource_record_post_action 11:13:28 INFO - [mozharness: 2017-09-16 18:13:28.897106Z] Finished read-buildbot-config step (success) 11:13:28 INFO - [mozharness: 2017-09-16 18:13:28.897324Z] Running download-and-extract step. 11:13:28 INFO - Running pre-action listener: _resource_record_pre_action 11:13:28 INFO - Running main action method: download_and_extract 11:13:28 INFO - mkdir: /builds/slave/test/build/tests 11:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:28 INFO - trying https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json 11:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:13:29 INFO - Downloaded 989 bytes. 11:13:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:13:29 INFO - Using the following test package requirements: 11:13:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:13:29 INFO - u'common': [u'target.common.tests.zip'], 11:13:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:13:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:13:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:13:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:13:29 INFO - u'mozbase': [u'target.common.tests.zip'], 11:13:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:13:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:13:29 INFO - u'web-platform': [u'target.common.tests.zip', 11:13:29 INFO - u'target.web-platform.tests.tar.gz'], 11:13:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:13:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:13:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip 11:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.common.tests.zip into memory 11:13:30 INFO - Content-Length response header: 54731154 11:13:30 INFO - Bytes received: 54731154 11:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip 11:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.talos.tests.zip into memory 11:13:42 INFO - Content-Length response header: 14508748 11:13:42 INFO - Bytes received: 14508748 11:13:42 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')]} 11:13:42 INFO - trying https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:13:43 INFO - Downloaded 61516366 bytes. 11:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:13:43 INFO - mkdir: /builds/slave/test/properties 11:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:43 INFO - Contents: 11:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 11:13:43 INFO - Running post-action listener: _resource_record_post_action 11:13:43 INFO - Running post-action listener: find_tests_for_verification 11:13:43 INFO - Running post-action listener: set_extra_try_arguments 11:13:43 INFO - [mozharness: 2017-09-16 18:13:43.786104Z] Finished download-and-extract step (success) 11:13:43 INFO - [mozharness: 2017-09-16 18:13:43.786201Z] Running populate-webroot step. 11:13:43 INFO - Running pre-action listener: _resource_record_pre_action 11:13:43 INFO - Running main action method: populate_webroot 11:13:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:43 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['tresize', 11:13:43 INFO - 'tcanvasmark']}, 11:13:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:43 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['dromaeo_css', 11:13:43 INFO - 'kraken']}, 11:13:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:43 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'tests': ['damp', 'tps']}, 11:13:43 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['damp', 'tps']}, 11:13:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:43 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['dromaeo_dom']}, 11:13:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:13:43 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['basic_compositor_video', 11:13:43 INFO - 'glvideo']}, 11:13:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:13:43 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['ts_paint_webext', 11:13:43 INFO - 'tp5o_webext']}, 11:13:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:43 INFO - 'ts_paint', 11:13:43 INFO - 'tpaint', 11:13:43 INFO - 'sessionrestore', 11:13:43 INFO - 'sessionrestore_many_windows', 11:13:43 INFO - 'sessionrestore_no_auto_restore', 11:13:43 INFO - 'tabpaint']}, 11:13:43 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['a11yr', 11:13:43 INFO - 'ts_paint', 11:13:43 INFO - 'tpaint', 11:13:43 INFO - 'sessionrestore', 11:13:43 INFO - 'sessionrestore_many_windows', 11:13:43 INFO - 'sessionrestore_no_auto_restore', 11:13:43 INFO - 'tabpaint']}, 11:13:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:13:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:13:43 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['perf_reftest_singletons']}, 11:13:43 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['bloom_basic']}, 11:13:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:43 INFO - 'tsvgr_opacity', 11:13:43 INFO - 'tart', 11:13:43 INFO - 'tscrollx', 11:13:43 INFO - 'tsvg_static']}, 11:13:43 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['tsvgx', 11:13:43 INFO - 'tsvgr_opacity', 11:13:43 INFO - 'tart', 11:13:43 INFO - 'tscrollx', 11:13:43 INFO - 'tsvg_static']}, 11:13:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:13:43 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo'], 11:13:43 INFO - 'tests': ['tp5o']}, 11:13:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:43 INFO - 'talos_options': ['--mitmproxy', 11:13:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:43 INFO - '--firstNonBlankPaint'], 11:13:43 INFO - 'tests': ['tp6_google', 11:13:43 INFO - 'tp6_youtube', 11:13:43 INFO - 'tp6_amazon', 11:13:43 INFO - 'tp6_facebook']}, 11:13:43 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo', 11:13:43 INFO - '--mitmproxy', 11:13:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:43 INFO - '--firstNonBlankPaint'], 11:13:43 INFO - 'tests': ['tp6_google', 11:13:43 INFO - 'tp6_youtube', 11:13:43 INFO - 'tp6_amazon', 11:13:43 INFO - 'tp6_facebook']}, 11:13:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:43 INFO - 'talos_options': ['--stylo-threads=1', 11:13:43 INFO - '--mitmproxy', 11:13:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:43 INFO - '--firstNonBlankPaint'], 11:13:43 INFO - 'tests': ['tp6_google', 11:13:43 INFO - 'tp6_youtube', 11:13:43 INFO - 'tp6_amazon', 11:13:43 INFO - 'tp6_facebook']}, 11:13:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--xperf_path', 11:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:43 INFO - 'tests': ['tp5n']}, 11:13:43 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:13:43 INFO - 'talos_options': ['--disable-stylo', 11:13:43 INFO - '--xperf_path', 11:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:43 INFO - 'tests': ['tp5n']}}} 11:13:43 INFO - Running post-action listener: _resource_record_post_action 11:13:43 INFO - [mozharness: 2017-09-16 18:13:43.801191Z] Finished populate-webroot step (success) 11:13:43 INFO - [mozharness: 2017-09-16 18:13:43.801281Z] Running create-virtualenv step. 11:13:43 INFO - Running pre-action listener: _resource_record_pre_action 11:13:43 INFO - Running main action method: create_virtualenv 11:13:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:43 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:13:43 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:13:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:13:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:44 INFO - Installing pip...............done. 11:13:44 INFO - Return code: 0 11:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:13:44 INFO - Reading from file tmpfile_stdout 11:13:44 INFO - Output received: 11:13:44 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:13:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:44 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')]} 11:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:44 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')]} 11:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:44 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:44 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 11:13:44 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 11:13:44 INFO - Using env: {'DISPLAY': ':0', 11:13:44 INFO - 'HOME': '/home/cltbld', 11:13:44 INFO - 'LANG': 'en_US.UTF-8', 11:13:44 INFO - 'LANGUAGE': 'en_US:en', 11:13:44 INFO - 'LOGNAME': 'cltbld', 11:13:44 INFO - 'MAIL': '/var/mail/cltbld', 11:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:44 INFO - 'MOZ_NO_REMOTE': '1', 11:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:44 INFO - 'NO_EM_RESTART': '1', 11:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:44 INFO - 'PWD': '/builds/slave/test', 11:13:44 INFO - 'SHELL': '/bin/bash', 11:13:44 INFO - 'SHLVL': '1', 11:13:44 INFO - 'TERM': 'linux', 11:13:44 INFO - 'TMOUT': '86400', 11:13:44 INFO - 'USER': 'cltbld', 11:13:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:44 INFO - '_': '/tools/buildbot/bin/python'} 11:13:45 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:13:45 INFO - Downloading/unpacking pip>=1.5 11:13:45 INFO - Running setup.py egg_info for package pip 11:13:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:45 INFO - Installing collected packages: pip 11:13:45 INFO - Found existing installation: pip 1.1 11:13:45 INFO - Uninstalling pip: 11:13:45 INFO - Successfully uninstalled pip 11:13:45 INFO - Running setup.py install for pip 11:13:45 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:45 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:45 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:45 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:45 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:13:45 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:13:45 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:13:45 INFO - Successfully installed pip 11:13:45 INFO - Cleaning up... 11:13:45 INFO - Return code: 0 11:13:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:45 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')]} 11:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:45 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')]} 11:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:45 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:45 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 11:13:45 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 11:13:45 INFO - Using env: {'DISPLAY': ':0', 11:13:45 INFO - 'HOME': '/home/cltbld', 11:13:45 INFO - 'LANG': 'en_US.UTF-8', 11:13:45 INFO - 'LANGUAGE': 'en_US:en', 11:13:45 INFO - 'LOGNAME': 'cltbld', 11:13:45 INFO - 'MAIL': '/var/mail/cltbld', 11:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:45 INFO - 'MOZ_NO_REMOTE': '1', 11:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:45 INFO - 'NO_EM_RESTART': '1', 11:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:45 INFO - 'PWD': '/builds/slave/test', 11:13:45 INFO - 'SHELL': '/bin/bash', 11:13:45 INFO - 'SHLVL': '1', 11:13:45 INFO - 'TERM': 'linux', 11:13:45 INFO - 'TMOUT': '86400', 11:13:45 INFO - 'USER': 'cltbld', 11:13:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:45 INFO - '_': '/tools/buildbot/bin/python'} 11:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:46 INFO - Downloading/unpacking psutil>=3.1.1 11:13:46 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 11:13:46 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 11:13:46 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 11:13:46 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 11:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:47 INFO - Installing collected packages: psutil 11:13:47 INFO - Running setup.py install for psutil 11:13:47 INFO - building 'psutil._psutil_linux' extension 11:13:47 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 11:13:47 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 11:13:47 INFO - building 'psutil._psutil_posix' extension 11:13:47 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 11:13:47 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 11:13:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:47 INFO - Successfully installed psutil 11:13:47 INFO - Cleaning up... 11:13:47 INFO - Return code: 0 11:13:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13:47 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')]} 11:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:47 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')]} 11:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:47 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:47 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 11:13:47 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 11:13:47 INFO - Using env: {'DISPLAY': ':0', 11:13:47 INFO - 'HOME': '/home/cltbld', 11:13:47 INFO - 'LANG': 'en_US.UTF-8', 11:13:47 INFO - 'LANGUAGE': 'en_US:en', 11:13:47 INFO - 'LOGNAME': 'cltbld', 11:13:47 INFO - 'MAIL': '/var/mail/cltbld', 11:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:47 INFO - 'MOZ_NO_REMOTE': '1', 11:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:47 INFO - 'NO_EM_RESTART': '1', 11:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:47 INFO - 'PWD': '/builds/slave/test', 11:13:47 INFO - 'SHELL': '/bin/bash', 11:13:47 INFO - 'SHLVL': '1', 11:13:47 INFO - 'TERM': 'linux', 11:13:47 INFO - 'TMOUT': '86400', 11:13:47 INFO - 'USER': 'cltbld', 11:13:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:47 INFO - '_': '/tools/buildbot/bin/python'} 11:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:48 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 11:13:48 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 11:13:48 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 11:13:48 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 11:13:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:49 INFO - Installing collected packages: mozsystemmonitor 11:13:49 INFO - Running setup.py install for mozsystemmonitor 11:13:49 INFO - Successfully installed mozsystemmonitor 11:13:49 INFO - Cleaning up... 11:13:50 INFO - Return code: 0 11:13:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:50 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')]} 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:50 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')]} 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:50 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:50 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 11:13:50 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 11:13:50 INFO - Using env: {'DISPLAY': ':0', 11:13:50 INFO - 'HOME': '/home/cltbld', 11:13:50 INFO - 'LANG': 'en_US.UTF-8', 11:13:50 INFO - 'LANGUAGE': 'en_US:en', 11:13:50 INFO - 'LOGNAME': 'cltbld', 11:13:50 INFO - 'MAIL': '/var/mail/cltbld', 11:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:50 INFO - 'MOZ_NO_REMOTE': '1', 11:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:50 INFO - 'NO_EM_RESTART': '1', 11:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:50 INFO - 'PWD': '/builds/slave/test', 11:13:50 INFO - 'SHELL': '/bin/bash', 11:13:50 INFO - 'SHLVL': '1', 11:13:50 INFO - 'TERM': 'linux', 11:13:50 INFO - 'TMOUT': '86400', 11:13:50 INFO - 'USER': 'cltbld', 11:13:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:50 INFO - '_': '/tools/buildbot/bin/python'} 11:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:50 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 11:13:50 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 11:13:50 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 11:13:50 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 11:13:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:51 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 11:13:51 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 11:13:51 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 11:13:51 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 11:13:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:51 INFO - warning: no files found matching '*.txt' 11:13:51 INFO - no previously-included directories found matching 'build' 11:13:51 INFO - no previously-included directories found matching 'dist' 11:13:51 INFO - no previously-included directories found matching '.git*' 11:13:51 INFO - Installing collected packages: jsonschema, functools32 11:13:52 INFO - Running setup.py install for functools32 11:13:52 INFO - warning: no files found matching '*.txt' 11:13:52 INFO - no previously-included directories found matching 'build' 11:13:52 INFO - no previously-included directories found matching 'dist' 11:13:52 INFO - no previously-included directories found matching '.git*' 11:13:52 INFO - Successfully installed jsonschema functools32 11:13:52 INFO - Cleaning up... 11:13:52 INFO - Return code: 0 11:13:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13:52 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')]} 11:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:52 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')]} 11:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:52 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:52 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 11:13:52 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 11:13:52 INFO - Using env: {'DISPLAY': ':0', 11:13:52 INFO - 'HOME': '/home/cltbld', 11:13:52 INFO - 'LANG': 'en_US.UTF-8', 11:13:52 INFO - 'LANGUAGE': 'en_US:en', 11:13:52 INFO - 'LOGNAME': 'cltbld', 11:13:52 INFO - 'MAIL': '/var/mail/cltbld', 11:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:52 INFO - 'MOZ_NO_REMOTE': '1', 11:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:52 INFO - 'NO_EM_RESTART': '1', 11:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:52 INFO - 'PWD': '/builds/slave/test', 11:13:52 INFO - 'SHELL': '/bin/bash', 11:13:52 INFO - 'SHLVL': '1', 11:13:52 INFO - 'TERM': 'linux', 11:13:52 INFO - 'TMOUT': '86400', 11:13:52 INFO - 'USER': 'cltbld', 11:13:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:52 INFO - '_': '/tools/buildbot/bin/python'} 11:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:52 INFO - Cleaning up... 11:13:52 INFO - Return code: 0 11:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:52 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')]} 11:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:52 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')]} 11:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:52 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:52 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 11:13:52 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 11:13:52 INFO - Using env: {'DISPLAY': ':0', 11:13:52 INFO - 'HOME': '/home/cltbld', 11:13:52 INFO - 'LANG': 'en_US.UTF-8', 11:13:52 INFO - 'LANGUAGE': 'en_US:en', 11:13:52 INFO - 'LOGNAME': 'cltbld', 11:13:52 INFO - 'MAIL': '/var/mail/cltbld', 11:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:52 INFO - 'MOZ_NO_REMOTE': '1', 11:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:52 INFO - 'NO_EM_RESTART': '1', 11:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:52 INFO - 'PWD': '/builds/slave/test', 11:13:52 INFO - 'SHELL': '/bin/bash', 11:13:52 INFO - 'SHLVL': '1', 11:13:52 INFO - 'TERM': 'linux', 11:13:52 INFO - 'TMOUT': '86400', 11:13:52 INFO - 'USER': 'cltbld', 11:13:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:52 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:53 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 11:13:53 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 11:13:53 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 11:13:53 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 11:13:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:54 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 11:13:54 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 11:13:54 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 11:13:54 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 11:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:54 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 11:13:54 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 11:13:54 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 11:13:54 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 11:13:54 INFO - Downloading docopt-0.6.1.tar.gz 11:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:54 INFO - Running setup.py install for blobuploader 11:13:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:54 INFO - Running setup.py install for requests 11:13:55 INFO - Running setup.py install for docopt 11:13:55 INFO - Successfully installed blobuploader requests docopt 11:13:55 INFO - Cleaning up... 11:13:55 INFO - Return code: 0 11:13:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:55 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:55 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 11:13:55 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 11:13:55 INFO - Using env: {'DISPLAY': ':0', 11:13:55 INFO - 'HOME': '/home/cltbld', 11:13:55 INFO - 'LANG': 'en_US.UTF-8', 11:13:55 INFO - 'LANGUAGE': 'en_US:en', 11:13:55 INFO - 'LOGNAME': 'cltbld', 11:13:55 INFO - 'MAIL': '/var/mail/cltbld', 11:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:55 INFO - 'MOZ_NO_REMOTE': '1', 11:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:55 INFO - 'NO_EM_RESTART': '1', 11:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:55 INFO - 'PWD': '/builds/slave/test', 11:13:55 INFO - 'SHELL': '/bin/bash', 11:13:55 INFO - 'SHLVL': '1', 11:13:55 INFO - 'TERM': 'linux', 11:13:55 INFO - 'TMOUT': '86400', 11:13:55 INFO - 'USER': 'cltbld', 11:13:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:55 INFO - '_': '/tools/buildbot/bin/python'} 11:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:55 INFO - Running setup.py (path:/tmp/pip-0SxCpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:55 INFO - Running setup.py (path:/tmp/pip-hPNtFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:55 INFO - Running setup.py (path:/tmp/pip-9JJH30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:55 INFO - Running setup.py (path:/tmp/pip-XFKV1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:55 INFO - Running setup.py (path:/tmp/pip-zxNXPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:55 INFO - Running setup.py (path:/tmp/pip-4xaXVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:56 INFO - Running setup.py (path:/tmp/pip-GBKgpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:56 INFO - Running setup.py (path:/tmp/pip-APUOx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:56 INFO - Running setup.py (path:/tmp/pip-euvLXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:56 INFO - Running setup.py (path:/tmp/pip-LUA2GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:56 INFO - Running setup.py (path:/tmp/pip-HFH8sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:56 INFO - Running setup.py (path:/tmp/pip-eka10N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:56 INFO - Running setup.py (path:/tmp/pip-2rt90W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:56 INFO - Running setup.py (path:/tmp/pip-tLCMOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:56 INFO - Running setup.py (path:/tmp/pip-e6e5nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:56 INFO - Running setup.py (path:/tmp/pip-wTKjNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:56 INFO - Running setup.py (path:/tmp/pip-gMEov4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:56 INFO - Running setup.py install for manifestparser 11:13:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:56 INFO - Running setup.py install for mozcrash 11:13:57 INFO - Running setup.py install for mozdebug 11:13:57 INFO - Running setup.py install for mozdevice 11:13:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for mozfile 11:13:57 INFO - Running setup.py install for mozhttpd 11:13:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for mozinfo 11:13:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for mozInstall 11:13:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for mozleak 11:13:57 INFO - Running setup.py install for mozlog 11:13:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for moznetwork 11:13:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:57 INFO - Running setup.py install for mozprocess 11:13:58 INFO - Running setup.py install for mozprofile 11:13:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:58 INFO - Running setup.py install for mozrunner 11:13:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:58 INFO - Running setup.py install for mozscreenshot 11:13:58 INFO - Running setup.py install for moztest 11:13:58 INFO - Running setup.py install for mozversion 11:13:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:58 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')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 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')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:13:58 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 11:13:58 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 11:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:58 INFO - Running setup.py (path:/tmp/pip-hRpQYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:58 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)) 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:58 INFO - Running setup.py (path:/tmp/pip-as7dMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:58 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)) 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:58 INFO - Running setup.py (path:/tmp/pip-QTQeoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:59 INFO - Running setup.py (path:/tmp/pip-HPs6r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:59 INFO - Running setup.py (path:/tmp/pip-ErJx5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:59 INFO - Running setup.py (path:/tmp/pip-M24FEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:59 INFO - Running setup.py (path:/tmp/pip-jBhDZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:59 INFO - Running setup.py (path:/tmp/pip-lXvKw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:59 INFO - Running setup.py (path:/tmp/pip-3OI1G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:59 INFO - Running setup.py (path:/tmp/pip-OuYn2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:59 INFO - Running setup.py (path:/tmp/pip-kEbpoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:59 INFO - Running setup.py (path:/tmp/pip-OoWF5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:59 INFO - Running setup.py (path:/tmp/pip-uSLzgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:59 INFO - Running setup.py (path:/tmp/pip-cvSC0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:59 INFO - Running setup.py (path:/tmp/pip-5qziOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:59 INFO - Running setup.py (path:/tmp/pip-HQGQur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:59 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)) 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:59 INFO - Running setup.py (path:/tmp/pip-befyuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:00 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)) 11:14:00 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)) 11:14:00 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)) 11:14:00 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)) 11:14:00 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)) 11:14:00 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)) 11:14:00 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)) 11:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:01 INFO - Downloading blessings-1.6.tar.gz 11:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:01 INFO - Installing collected packages: blessings 11:14:01 INFO - Running setup.py install for blessings 11:14:01 INFO - Successfully installed blessings 11:14:01 INFO - Cleaning up... 11:14:01 INFO - Return code: 0 11:14:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:01 INFO - Reading from file tmpfile_stdout 11:14:01 INFO - Current package versions: 11:14:01 INFO - argparse == 1.2.1 11:14:01 INFO - blessings == 1.6 11:14:01 INFO - blobuploader == 1.2.4 11:14:01 INFO - docopt == 0.6.1 11:14:01 INFO - functools32 == 3.2.3-2 11:14:01 INFO - jsonschema == 2.5.1 11:14:01 INFO - manifestparser == 1.1 11:14:01 INFO - mozInstall == 1.13 11:14:01 INFO - mozcrash == 1.0 11:14:01 INFO - mozdebug == 0.1 11:14:01 INFO - mozdevice == 0.51 11:14:01 INFO - mozfile == 1.2 11:14:01 INFO - mozhttpd == 0.7 11:14:01 INFO - mozinfo == 0.10 11:14:01 INFO - mozleak == 0.1 11:14:01 INFO - mozlog == 3.5 11:14:01 INFO - moznetwork == 0.27 11:14:01 INFO - mozprocess == 0.25 11:14:01 INFO - mozprofile == 0.28 11:14:01 INFO - mozrunner == 6.13 11:14:01 INFO - mozscreenshot == 0.1 11:14:01 INFO - mozsystemmonitor == 0.3 11:14:01 INFO - moztest == 0.8 11:14:01 INFO - mozversion == 1.4 11:14:01 INFO - psutil == 3.1.1 11:14:01 INFO - requests == 1.2.3 11:14:01 INFO - wsgiref == 0.1.2 11:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:01 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:14:01 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 11:14:01 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 11:14:01 INFO - Using env: {'DISPLAY': ':0', 11:14:01 INFO - 'HOME': '/home/cltbld', 11:14:01 INFO - 'LANG': 'en_US.UTF-8', 11:14:01 INFO - 'LANGUAGE': 'en_US:en', 11:14:01 INFO - 'LOGNAME': 'cltbld', 11:14:01 INFO - 'MAIL': '/var/mail/cltbld', 11:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:01 INFO - 'MOZ_NO_REMOTE': '1', 11:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:01 INFO - 'NO_EM_RESTART': '1', 11:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:01 INFO - 'PWD': '/builds/slave/test', 11:14:01 INFO - 'SHELL': '/bin/bash', 11:14:01 INFO - 'SHLVL': '1', 11:14:01 INFO - 'TERM': 'linux', 11:14:01 INFO - 'TMOUT': '86400', 11:14:01 INFO - 'USER': 'cltbld', 11:14:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:01 INFO - '_': '/tools/buildbot/bin/python'} 11:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 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)) 11:14:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:14:03 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)) 11:14:03 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)) 11:14:03 INFO - Installing collected packages: simplejson 11:14:03 INFO - Running setup.py install for simplejson 11:14:03 INFO - building 'simplejson._speedups' extension 11:14:03 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 11:14:03 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 11:14:04 INFO - Successfully installed simplejson 11:14:04 INFO - Cleaning up... 11:14:04 INFO - Return code: 0 11:14:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:04 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')]} 11:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:04 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')]} 11:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:04 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 0x23561f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c2a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', '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 11:14:04 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 11:14:04 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 11:14:04 INFO - Using env: {'DISPLAY': ':0', 11:14:04 INFO - 'HOME': '/home/cltbld', 11:14:04 INFO - 'LANG': 'en_US.UTF-8', 11:14:04 INFO - 'LANGUAGE': 'en_US:en', 11:14:04 INFO - 'LOGNAME': 'cltbld', 11:14:04 INFO - 'MAIL': '/var/mail/cltbld', 11:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:04 INFO - 'MOZ_NO_REMOTE': '1', 11:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:04 INFO - 'NO_EM_RESTART': '1', 11:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:04 INFO - 'PWD': '/builds/slave/test', 11:14:04 INFO - 'SHELL': '/bin/bash', 11:14:04 INFO - 'SHLVL': '1', 11:14:04 INFO - 'TERM': 'linux', 11:14:04 INFO - 'TMOUT': '86400', 11:14:04 INFO - 'USER': 'cltbld', 11:14:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:04 INFO - '_': '/tools/buildbot/bin/python'} 11:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:04 INFO - Cleaning up... 11:14:04 INFO - Return code: 0 11:14:04 INFO - Running post-action listener: _resource_record_post_action 11:14:04 INFO - Running post-action listener: _start_resource_monitoring 11:14:04 INFO - Starting resource monitoring. 11:14:04 INFO - [mozharness: 2017-09-16 18:14:04.294504Z] Finished create-virtualenv step (success) 11:14:04 INFO - [mozharness: 2017-09-16 18:14:04.295012Z] Running install step. 11:14:04 INFO - Running pre-action listener: _resource_record_pre_action 11:14:04 INFO - Running main action method: install 11:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:04 INFO - Reading from file tmpfile_stdout 11:14:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:04 INFO - Reading from file tmpfile_stdout 11:14:04 INFO - Output received: 11:14:04 INFO - Usage: mozinstall [options] installer 11:14:04 INFO - Options: 11:14:04 INFO - -h, --help show this help message and exit 11:14:04 INFO - -d DEST, --destination=DEST 11:14:04 INFO - Directory to install application into. [default: 11:14:04 INFO - "/builds/slave/test"] 11:14:04 INFO - --app=APP Application being installed. [default: firefox] 11:14:04 INFO - mkdir: /builds/slave/test/build/application 11:14:04 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'] 11:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:14:22 INFO - Reading from file tmpfile_stdout 11:14:22 INFO - Output received: 11:14:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:14:22 INFO - Running post-action listener: _resource_record_post_action 11:14:22 INFO - [mozharness: 2017-09-16 18:14:22.489946Z] Finished install step (success) 11:14:22 INFO - [mozharness: 2017-09-16 18:14:22.490266Z] Running setup-mitmproxy step. 11:14:22 INFO - Running pre-action listener: _resource_record_pre_action 11:14:22 INFO - Running main action method: setup_mitmproxy 11:14:22 INFO - Skipping: mitmproxy is not required 11:14:22 INFO - Running post-action listener: _resource_record_post_action 11:14:22 INFO - [mozharness: 2017-09-16 18:14:22.491392Z] Finished setup-mitmproxy step (success) 11:14:22 INFO - [mozharness: 2017-09-16 18:14:22.491613Z] Running run-tests step. 11:14:22 INFO - Running pre-action listener: _resource_record_pre_action 11:14:22 INFO - Running pre-action listener: _set_gcov_prefix 11:14:22 INFO - Running main action method: run_tests 11:14:22 WARNING - Try message not found. 11:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:22 INFO - Python 2.7.3 11:14:22 INFO - Return code: 0 11:14:22 INFO - grabbing minidump binary from tooltool 11:14:22 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')]} 11:14:22 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 0x26c6090>, '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 0x26c6d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c0f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:22 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 11:14:22 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 11:14:22 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 11:14:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:22 INFO - Return code: 0 11:14:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:14:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:22 INFO - ENV: RUST_BACKTRACE is now full 11:14:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:14:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 11:14:22 INFO - Using env: {'DISPLAY': ':0', 11:14:22 INFO - 'HOME': '/home/cltbld', 11:14:22 INFO - 'LANG': 'en_US.UTF-8', 11:14:22 INFO - 'LANGUAGE': 'en_US:en', 11:14:22 INFO - 'LOGNAME': 'cltbld', 11:14:22 INFO - 'MAIL': '/var/mail/cltbld', 11:14:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:22 INFO - 'MOZ_ACCELERATED': '1', 11:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:22 INFO - 'MOZ_NO_REMOTE': '1', 11:14:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:22 INFO - 'MOZ_WEBRENDER': '1', 11:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:22 INFO - 'NO_EM_RESTART': '1', 11:14:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:22 INFO - 'PWD': '/builds/slave/test', 11:14:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:22 INFO - 'RUST_BACKTRACE': 'full', 11:14:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:14:22 INFO - 'SHELL': '/bin/bash', 11:14:22 INFO - 'SHLVL': '1', 11:14:22 INFO - 'TERM': 'linux', 11:14:22 INFO - 'TMOUT': '86400', 11:14:22 INFO - 'USER': 'cltbld', 11:14:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:22 INFO - '_': '/tools/buildbot/bin/python'} 11:14:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:14:22 INFO - mozversion application_buildid: 20170916172404 11:14:22 INFO - mozversion application_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:14:22 INFO - mozversion application_display_name: Nightly 11:14:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:22 INFO - mozversion application_name: Firefox 11:14:22 INFO - mozversion application_remotingname: firefox 11:14:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:14:22 INFO - mozversion application_vendor: Mozilla 11:14:22 INFO - mozversion application_version: 57.0a1 11:14:22 INFO - mozversion platform_buildid: 20170916172404 11:14:22 INFO - mozversion platform_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:14:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:14:22 INFO - mozversion platform_version: 57.0a1 11:14:22 INFO - using testdate: 1505585662 11:14:22 INFO - actual date: 1505585662 11:14:22 INFO - starting webserver on 'localhost:45348' 11:14:22 INFO - SUITE-START | Running 2 tests 11:14:22 INFO - TEST-START | dromaeo_css 11:14:22 INFO - Initialising browser for dromaeo_css test... 11:14:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45348/getInfo.html -profile /tmp/tmpjOJ7FC/profile 11:14:22 INFO - TEST-INFO | started process 18916 (/builds/slave/test/build/application/firefox/firefox http://localhost:45348/getInfo.html) 11:14:28 INFO - TEST-INFO | 18916: exit 0 11:14:28 INFO - Browser initialized. 11:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:28 INFO - Using env: {'DISPLAY': ':0', 11:14:28 INFO - 'HOME': '/home/cltbld', 11:14:28 INFO - 'JSGC_DISABLE_POISONING': '1', 11:14:28 INFO - 'LANG': 'en_US.UTF-8', 11:14:28 INFO - 'LANGUAGE': 'en_US:en', 11:14:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:14:28 INFO - 'LOGNAME': 'cltbld', 11:14:28 INFO - 'MAIL': '/var/mail/cltbld', 11:14:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:28 INFO - 'MOZ_ACCELERATED': '1', 11:14:28 INFO - 'MOZ_CRASHREPORTER': '1', 11:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:14:28 INFO - 'MOZ_NO_REMOTE': '1', 11:14:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:28 INFO - 'MOZ_WEBRENDER': '1', 11:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:28 INFO - 'NO_EM_RESTART': '1', 11:14:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:28 INFO - 'PWD': '/builds/slave/test', 11:14:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:28 INFO - 'RUST_BACKTRACE': 'full', 11:14:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:14:28 INFO - 'SHELL': '/bin/bash', 11:14:28 INFO - 'SHLVL': '1', 11:14:28 INFO - 'TERM': 'linux', 11:14:28 INFO - 'TMOUT': '86400', 11:14:28 INFO - 'USER': 'cltbld', 11:14:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:28 INFO - '_': '/tools/buildbot/bin/python'} 11:14:28 INFO - TEST-INFO | started process 19165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjOJ7FC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:29 INFO - PID 19165 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:14:29 INFO - PID 19165 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:14:29 INFO - PID 19165 | 11:14:29 INFO - PID 19165 | (/builds/slave/test/build/application/firefox/firefox:19225): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:14:29 INFO - PID 19165 | 11:14:40 INFO - PID 19165 | RSS: Main: 208805888 11:14:40 INFO - PID 19165 | 11:17:36 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45348/tests/dromaeo/cssquery-ext.html) 11:17:38 INFO - PID 19165 | RSS: Main: 210456576 11:17:38 INFO - PID 19165 | 11:20:40 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-ext.html (next: http://localhost:45348/tests/dromaeo/cssquery-jquery.html) 11:20:41 INFO - PID 19165 | RSS: Main: 210927616 11:20:41 INFO - PID 19165 | 11:23:43 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45348/tests/dromaeo/cssquery-mootools.html) 11:23:43 INFO - PID 19165 | RSS: Main: 215900160 11:23:43 INFO - PID 19165 | 11:26:45 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45348/tests/dromaeo/cssquery-prototype.html) 11:26:46 INFO - PID 19165 | RSS: Main: 211566592 11:26:46 INFO - PID 19165 | 11:29:50 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45348/tests/dromaeo/cssquery-yui.html) 11:29:50 INFO - PID 19165 | RSS: Main: 209780736 11:29:50 INFO - PID 19165 | 11:32:52 INFO - PID 19165 | Cycle 1(1): loaded http://localhost:45348/tests/dromaeo/cssquery-yui.html (next: http://localhost:45348/tests/dromaeo/cssquery-dojo.html) 11:32:53 INFO - PID 19165 | RSS: Main: 217362432 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | __start_tp_report 11:32:53 INFO - PID 19165 | _x_x_mozilla_page_load 11:32:53 INFO - PID 19165 | _x_x_mozilla_page_load_details 11:32:53 INFO - PID 19165 | |i|pagename|runs| 11:32:53 INFO - PID 19165 | |0;dojo.html;3063.662997070322;3081.368319494504;3117.968820311796;3120.0951724000042;3143.214196450888;5979.342272350049;6111.144439778429;6166.53750968678;6211.782587609435;6245.750169993206;6108.480779133779;6137.6624285664275;6207.751689932397;6233.563650544464;6279.120923070774;5628.98678237917;5664.858378540528;5731.312242530902;5760.913586296209;5774.682392468412;5680.9715951420185;5728.68492232927;5738.684372359518;5784.421557844203;5803.680797556132;338.0656189164808;5576.693281869496;5649.576281778842;5728.25532680753;5851.385604511529;5673.574481913873;5683.119116536944;5696.3733989261145;5723.914141287884;5768.278965129359;5611.943880561183;5628.802991895264;5694.572907031989;5733.111367738007;5742.0238559445;6074.878502429927;6158.6612736299485;6180.412860778219;6253.968095264276;6271.247450305947;6535.248446428626;6578;6614.173228346457;6666.500012499034;6716.261211266757;6702.6648667566915;6709.49678774089;6773.966130169367;6790.864182716318;6798.04827324175;6057.42454466825;6089.786857459968;6153.261608606951;6260.217472815898;6274.090256912722;6833.043373927704;6876.140482439695;6878.071460352889;6886.827829304208;6907.861842763116;6517.641529715816;6549.279579246279;6612.404883560503;6618.205815302098;6631.3700198481065;6499.09012738217;6615.768448104293;6640.601563906181;6681.064650948871;6743;6356.618602883842;6502.187226596676;6516.739330426824;6518.022296655445;6519.511036672268;6535.901961470582;6567.310432404529;6598.901016484757;6622.37087476689;6638.236602790645;5214.061468935628;5234.712090834964;5286.8942621148135;5288.9735551322;5315.415304316522;4558.9772051139535;4585.72485650862;4610.631149508032;4639;4651.697639653412;5608.130739735348;5656.179853921159;5739.311282646109;5826.82519524415;5832.504237139806;6666.766663166766;6710.597364158166;6710.966445167743;6763;6766.15423072116;5732.226149469769;5750.712464376765;5789.305283366023;5817.825465235965;5821.563382746311;5708.257926469532;5729.713514324267;5752.137179423036;5785.1611516329895;5797.101449275369;6270.7805226816845;6319.399657032574;6387.936120638734;6426.389492998158;6462.903056454157;6669.266380698119;6701.430378417792;6706.631135287606;6724.7646332378135;6742.561733487308;6378.075179099097;6406.23125224976;6428.774992875227;6436.8390790230615;6485.481161506974;6497.9025314619375;6565.113709649137;6605.768798092236;6606.8017959461295;6662.200535935719;6596.109525214227;6623.271440141677;6658.334166583303;6750.426213771884;6801.1158549388265;6449;6465.676716164267;6478.611283323015;6498.317676643885;6523.7716679915975;6490.253620833664;6514.120593719977;6564.737410503717;6575.50683698715;6592.17597800275;6407.327230640715;6419.422251997343;6500.70746816385;6509.511786616117;6510.414062734377;6357.364263573606;6413.262474815269;6460.644664543495;6546.476281897341;6593.340665933561;6389.87220255583;6391.872162556816;6396.6481843497195;6400.263969643551;6403.3276505966205 11:32:53 INFO - PID 19165 | |1;ext.html;855.9101294364091;887.7159309021112;888.4891187567142;893.3032234856812;893.705077324483;38018.23963520728;41228.79385603068;41508.58491415085;41760.58239417605;41985.160296794085;38046.66836660718;38111.04722381942;38375.42436863449;38564;38644;6917.273686262933;7072.752453664123;7098.822529436754;7100.786976390691;7119.038929744496;7010.263922288163;7074.22183559808;7094.2551032141655;7116.7509137180205;7135.785926422215;7091.787246382617;7108.253633368499;7124.465665075114;7160.785176444715;7164.85670286594;7025.402840758542;7057.788266352043;7578.810529736801;7791.805204869867;7812.453128281023;7652.617369131521;7726.613669316512;7768.145503994556;7770.922290777076;7771.261730135628;38346.42480362797;38747.61252387468;38863.61136388628;39124.41313380301;39132;3519.5952465466544;3541.29174165168;3547.7161827053774;3571.535700358963;3574.9821250893838;31684.207894802585;31872.681273187434;32303.51544726831;32331.19172020695;32392.190195245308;5159.74201289934;5165.483451654804;5171.948280517185;5182.404023537266;5249.317588713481;181668;183482;184510;185212.0739396308;185660.99999999866;41152.58847411547;41765;47275.76362118167;47435.28847067297;48595.75702121537;51126.744366278675;51480.22779658308;51514.74242628838;51575.74212128916;51715.482845171064;14442.205678687773;14572.854271457361;14581.927090364481;14592.343344549521;14605.78091328631;11469.426528673534;11588.88411115878;11597.710057248636;11681.591144309908;11700.941495292469;14094.577162685136;14179.929100354433;14201.78697319541;14262.215578143301;14282.21447820359;5660.235868157828;5683.943160568424;5772.538196944234;5785.739641716133;5957.165996760457;1009.4952523738131;1009.5961615353917;1011.4841430870309;1022.6983040003217;1027.9074883260541;23089.76910230876;23106.191283305005;23122.421939451648;23320.53358932812;23453.296401107993;1091.399730148431;1122.1415617052799;1127;1127.6504283672089;1134.0587312530579;12141.75716485683;12337.568185113478;12344.506219751289;12364.56724014655;12369.690757731129;228295;228797;228882;230080;230547;52558;52695.73652131715;52731.20903186455;52797.472025280025;52882.471175287756;1414.8160739104057;1459.6861674739769;1465.3479201755117;1475.1223022301713;1484.139199264424;22224.666630000887;22533.549329013655;22545.887270563544;22649;23210.767892320862;36336.45495317625;36487;36744.81627591952;36754.8162259187;36885.81557092197;197892;198200;198287;198535;198925;29334.706652933197;30133.246668832577;32189.034328970167;33390;33895;42192;42494.575054249064;42510.5748942519;42634.57365426306;43278.350824738285;31528.842355788074;31701.524477133324;32043.519347209345;32302.676973229965;32313.676863231067;30969.225769355948;31359.37281254408;31455.21361965969;31684.683153169095;31898.043058708277;35740.82129589335;35786.64213357833;35797.64202357943;35906.46140307845;36410.63589364178;29910.700892991663;30211.69788302089;30506.694933051273;30728.846355768077;31792.364152716353;22983;23194.956226970164;23522.529549408573;23592.646110308702;23631.64552531679 11:32:53 INFO - PID 19165 | |2;jquery.html;541.7914103070317;549.157043937556;562.1736048009427;563.7259792868118;567.29088639201;22036.88981555094;22901.656475152886;22960.65559016614;22985.655215171744;23196.188133415333;24064.157754478554;24343.878280608616;24461.633075503883;24496.877515612443;24597.1391001315;6646.800595982116;6667.333266673342;6690.096836927001;6700.430463410616;6702.262751097375;6551;6723.663816809164;6726.865462690744;6726.966365168192;6727.932720672804;6634.0712300278;6654.26803051664;6713.731450741989;6724.193096828388;6725.932740672604;6710.731570737189;6724.293949135319;6727.629980351078;6730.697118629649;6734.124563806723;5915.260592425947;5997.250343707036;6089.512838972872;6099.298580663236;6144.446999769997;28280.717192828015;28303.575446368322;28535.714642853512;28627.570586441012;28674.283142921384;2064.4013236161495;2081.895905204749;2088.968665470019;2091.048572899327;2092.455961450034;19160.329388471335;19874.205031798712;20187.788732676087;20223.089960951645;20833.79166208334;2197.2199869046576;2442.5969714997004;2449.8285120041605;2493.551160791057;2531.8227724059325;119777;124125.37937310255;138282;144306;145634.99999999895;14445.274707987548;15154.393824246907;15223.619409514851;15304.158271294962;15426.46007389736;23084.192053278053;23150.884245578665;23198.884005579865;23307.76692233056;23399.41501462477;9951.15415189717;10022.344078819118;10046.497675116361;10060.094591486655;10078.748031299276;9201.76995575116;9270.582823772946;9270.768230794283;9305.069493050776;9429.15137637616;8937.910620893708;8979.326550508738;9127.726168214964;9364.438133712;9461.290403219786;2512.1033619617438;2516.5721827289403;2525.92063816938;2577.987110064475;2639.643648107481;973.0561355485167;982.7936133411921;990.8910019897805;998.0618218874235;998.3111652959435;19605.31381401644;19759.703604445946;19788.604227915363;19822.008899554963;19879.900600497192;1040.3237895368072;1048.0881632979356;1049.6431213387484;1064.9361038337724;1066.4401189375485;11008;11078.667639970814;11098.944505277583;11138.498767555317;11228.606998755004;440636;446426;447163;447433;454065;113273;113948;114611;114900;117167;1009.7879445316565;1134.869490008643;1168.1355796710543;1179.8289248058984;1211.594115971142;20862.26982055621;20991.685124722837;21099;21216;21262.681059783805;57056.714716427814;60726;60788.39211607827;61815.6909215451;62631;70528;72841.6357918207;73101.6344918272;73827.26172738204;74513;14623.122612643276;14629;14710.117392956457;14797.778033329723;14916.85083149198;23381.298561043197;23996.64005039961;24047.51904961856;24271.635925461487;24535.63196552089;18807.623847523246;18868.15093320831;19077.809221907602;19204.519887002938;19473.221071156993;15716.92141539285;15860.682786343978;16234;16314.102724350274;16356.918215408847;19053.523661908563;19702.802971970672;19772;19788.307409241184;19813.10841012129;14681.119132852064;14684.853151468777;14699.55901322962;14712.852871471148;14732;17859.642807144046;18646.34737784171;18676.34632787846;18933.90533047326;19090.140943657847 11:32:53 INFO - PID 19165 | |3;mootools.html;1340.644729146776;1366.8516053776784;1375.3054707372776;1375.8761711445968;1397.1477398786742;12532.185407948476;13210.07529472936;15324.38702451902;15830.84169158308;15879.92060039701;15233.466828661;15593.142377169252;15609.375624975015;15616;15643.217839108027;2710.593410988348;2734.945301093977;2759.9448011039767;2764.4885696146175;2768.418632087264;2672.0647773279393;2724.809263351556;2731.153342463833;2749.670039595251;2754.752072313491;2594.1439325022698;2657.9601305980427;2666.8666566671686;2760.558310670293;2768.9446211075765;2688.623592697024;2754.911809835124;2758.9862050689817;2761.7514423701964;2762.5441802102628;2572.897084116633;2665.8533780642056;2689.3142248726645;2716.755492005709;2720.687120981073;15126.319315630713;15276.236188190545;15394;15441.613959650986;15453.845461545465;8128.146544612849;8248.340132789423;8322.417430779848;8389.916100838975;8440.662373505053;5225.529702326771;5408.945910540883;5554.888902221933;5562.3881373048935;5604.467575580314;1775.5383600264024;1811.2121227266182;1818.354484158118;1849.833514983658;1853.3605905962422;26118.34704132393;26326.736732632813;26394.340141496425;26424.603630945552;26424.86787566069;6836.5214434989075;7431.554106753504;7667.961660191663;7701.114371847198;7762.611869406507;17384.65230695404;17386.826131738522;17462.825371746374;17501.299948002194;17588.2085306159;7912.28789408956;8185.427020108655;8199.877001844978;8201.343892488587;8204.261616454547;7389.261073892568;7475.887861682079;7482.877568364789;7519.398448124137;7548.811279717941;5273.683578985273;5367.838964831061;5421.891562168814;5436.483534064258;5460.399356070829;1520.2626726037863;1541.4604888289234;1544.1815837606086;1555.5566663500847;1569.7096037233148;881.7751473374249;881.8809460722721;898.6091050392969;917.4632839788799;918.4672889723944;7600.125985511626;7601.961990190013;7634.351080158249;7681.539107653447;7698.884516732253;696.9965150174216;705.9505834591529;706.4630880530833;716.4197000429668;722.4148439763808;5279.815206467755;5410.540104091197;5423.403425623178;5461.208124821878;5630.071038278638;21686.674699879513;22360.552788944457;22598.774012259666;22672.886635566716;22828.88585557095;21006.894965525076;21737.13051477923;21831.890840545697;21834;22115.115395384004;11312.6040588579;11378.374189419661;11440.599579014695;11539.653810385702;11562.94218528902;8479.915200847912;8581.141885811368;8622.870656940277;8623.310135189044;8636.697715580176;19123.617527649647;19246.326378577243;19249.807501924803;19347.322843700967;19583.412497625093;19300.903495482995;19391;19511.70732439043;19562;19725.80274197297;10312.123469504875;10385;10407.375557466576;10424.426656533964;10432.165426765992;13891;13961.4415423386;14203.928980355033;14206.360713768112;14275;10281.588736450458;10409.63566275207;10686.145108391465;10693.679189624323;10724.73188170302;11076.667699969013;11193.72015699614;11406.942965285121;11518.193726439069;11750.471228794895;9389.10803473669;9395.201407880406;9396.76508087276;9426.245900328095;9460.479673617741;7190.856182876418;7279.490435669664;7298.124225093023;7331.156916954618;7341.816454588678;7064.752733654297;7082.575045497287;7110.644467776487;7145.46409019336;7234.927650723425 11:32:53 INFO - PID 19165 | |4;prototype.html;495.02297276886424;497.75112443778113;521.278029928549;522.4775224775225;533.1765362460385;6151.723172457239;6167.599106058109;6195.132681424604;6230.345813689565;6284.748610055598;6076.179715738374;6082.270127584685;6086.995645718451;6133.969330153354;6143.201383820108;5060.69635821851;5111.105556527611;5150.459201783815;5153.706600562751;5156.793728250866;5100.668456550331;5113.386393632769;5114.795408183687;5125.744192672801;5145.81989630363;4765.30903019062;4877.219644856824;4880.219164933611;4896.436909755388;4905.386826646669;4868.758466591032;4924.113659541281;4926.236433352836;4952.430470495903;4980.352554167935;4369.191699535596;4391.187630288407;4432.20220360335;4440;4464;5769.1346298055205;5902.2622172228475;5965.254343207099;5992.370801065869;6060.33336333003;5615;5645.350784659776;5648.717564121818;5658.292713410824;5680.11958146488;6455.4835613150835;6464.4828413727255;6513.674316284167;6530.93469065308;6543.901841472381;4577.313402989545;4792.825757689388;4829.5653391194965;4847;4848.248521479177;6576.177977752781;6620.503462240303;6629.436497897685;6712.731490740413;6722.243880009173;4914.8771280718265;4923.87690307738;4940.752962351868;4952.8761780955765;4960.363080183531;4955.182394904872;4977.178765503724;4980.825671101494;4985.775640096204;4992.400911890524;5527.55779537636;5563.582731295088;5608.214849921014;5612.540739407784;5640.210370548127;6460.547761656733;6490.448311893448;6495.752123938031;6576.671166441659;6583.80248592543;1719.819418960991;1735.5661084728818;1738.2004278031993;1738.3307426640833;1755.262789628359;1124.6176300058019;1189.1556994533978;1191.7556900835482;1204.145057009533;1205.7950148474781;5448.56411487088;5457.263269458652;5526.309211348582;5551.167324901297;5581.441855814467;6505.349465053551;6508.674566271668;6543.574667646588;6590.736370545221;6594.901076483857;5465.098258787256;5503.862403439946;5538.972305138448;5545.833624991256;5595.804146854841;3410.641882602291;3443.2080621456703;3452.3095380923914;3482.3905816482015;3491.965080349164;6105.618808664624;6108.450239478469;6264.404881536247;6297.4017468340435;6305.085762564402;6529.444997175198;6558.508111891531;6613.603183808987;6643.302453242437;6716.697748601325;6066.545009124334;6255.593386429868;6260.5617606768;6268.056902360283;6341.968290158612;6318.368163183645;6415.935840641534;6425.293217745951;6519.380658837403;6592.340765923369;5893.852653683693;6349.777398030258;6376.617402955838;6423.775167869102;6483.092367068709;6083.870645274119;6166.075088736546;6237.75048998035;6250.874982500233;6252.155958945484;4728.763561821964;4781.713097214179;4794.256890182028;4835.58897493717;4891.584215341736;6189.195404597373;6318.767840271103;6322.652254125883;6574.1453611032175;6601.702923368556;6236.844078897882;6283.340249273943;6302.684865756602;6304.3380445054445;6340.1440805490665;6190.81427557174;6348.175062097507;6357.841053973688;6384.936150638434;6390.5526613136635;6307.180066591497;6318.526110541636;6345.4923606112325;6366.745330186741;6413.775517856852;6439.549231553746;6453.870922581616;6464;6487.708053137526;6501.284858665637;6217.595856269328;6259.906101408392;6264.467520260829;6285.717142728497;6289.490522274713 11:32:53 INFO - PID 19165 | |5;yui.html;883.7172104926418;906.6917248135635;919.10387372312;919.1865199298622;930.8882934047915;19037;19668.70496942547;19937.3021944232;19987.200511979503;20072.197112115497;17857.374991875287;17863.732044019318;18095.366662166827;18721;18884.05579721012;954.5465903695741;964.1997142371814;970.3644113105892;972.6595691507987;974.1816873825985;973.2360097323602;973.7760315127525;975.5902520941222;976.1848856205078;976.5605477535103;1009.0827427887036;1026.6252817721552;1029.6190409548478;1032.5198782566106;1043.1498328861992;1028.4960369418968;1030.8093002794508;1031.8968103189695;1037.341288281939;1040.8802987656402;726.1540305544034;741.985160296791;746.1941103608144;751.4326683354033;757.2994979643862;20422.489437764027;20496.897515512326;20516.38450846477;20536.486587835276;20541.281055163;18645.160967756347;18675.066246687613;18907.621847562972;19280.61438771217;19559.413217603495;17302.56743581408;17409.390671326444;17537;17544.91227543867;17703.38038168658;3733.383991641376;3763.2849758546063;3771.057235691077;3773.4339849022867;3775.263823554408;138612;140218;140752;141860;143007;16441.09573973443;16469.34122635081;16526.338946442007;16676.082815445025;16695.66608667844;31468.685313147034;32174;32195.195120121716;32979.3404131916;33249.168770780925;8522.360822938304;8562.100979397199;8693;8710.12898710124;8713.477191368538;3892.9416058759143;3959.2675355059405;3959.7228194026143;3966.147278335114;4005.7796821175116;5502.944970550243;5543.473370029841;5562.666240025531;5598.972005139948;5606.383297837235;1010.6715317521835;1026.5431882812227;1036.7356324137297;1037.1184493180735;1049.5539395756925;690.2890023276034;708.1679027143086;715.6922523315025;716.9175544812309;721.0783262605204;11072.889271107348;11686.88313116875;11824.408779560987;12726.363681815872;12888.613341599766;667.5660820466735;670.7618795327686;672.9461643068543;690.8065741592362;698.5145323999772;5615.578831587647;5645.717714114277;5731.369549349568;5776.42235776419;5838.095095260242;121417;122433.38783306026;124612;124612.37693811655;125873;108242.45878770556;109003;109022.45488772505;109643;111703;95352.52323738337;96459.51770241105;96494.51752741191;96944.0305596949;97668;10215.846762298423;10283.1490331741;10310.381377117097;10366.792664146826;10618.36289822613;43164.568354316056;44879.551204487536;45065.77467112643;45168.77415612901;45687.771561141984;58449.12326315194;60190.39809601848;60588;60781.69609151926;61278.693606531684;15377.769333459783;15525.922370388076;15560.688786224438;15625.76561351558;15814.130222837854;16891.493255202364;17025.14874256307;17210.569735756708;17356.739648905022;17576.296948121933;15094.094354338775;15134.545963621109;15235.3905843765;15300.387984480496;15316.770248446059;14769.483068092564;14870.405183792527;14890.32993515316;14943.850561494246;14987.700245995236;14751.262436878327;15003.624909377353;15069.47256846005;15137.318820652878;15169.165695886832;11801.881981180079;11872.76254474923;12097.153199275966;12148.696282593006;12257.14200005991;11609.30344179352;11615.535378584762;11819.11356648272;11942.761144777229;12109.515619375126 11:32:53 INFO - PID 19165 | __end_tp_report 11:32:53 INFO - PID 19165 | __start_cc_report 11:32:53 INFO - PID 19165 | _x_x_mozilla_cycle_collect,281 11:32:53 INFO - PID 19165 | __end_cc_report 11:32:53 INFO - PID 19165 | __startTimestamp1505586773006__endTimestamp 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | ------- Summary: start ------- 11:32:53 INFO - PID 19165 | Number of tests: 6 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#0] dojo.html Cycles:165 Average:6086.35 Median:6391.87 stddev:858.60 (13.4%) stddev-sans-first:827.84 11:32:53 INFO - PID 19165 | Values: 3063.7 3081.4 3118.0 3120.1 3143.2 5979.3 6111.1 6166.5 6211.8 6245.8 6108.5 6137.7 6207.8 6233.6 6279.1 5629.0 5664.9 5731.3 5760.9 5774.7 5681.0 5728.7 5738.7 5784.4 5803.7 338.1 5576.7 5649.6 5728.3 5851.4 5673.6 5683.1 5696.4 5723.9 5768.3 5611.9 5628.8 5694.6 5733.1 5742.0 6074.9 6158.7 6180.4 6254.0 6271.2 6535.2 6578.0 6614.2 6666.5 6716.3 6702.7 6709.5 6774.0 6790.9 6798.0 6057.4 6089.8 6153.3 6260.2 6274.1 6833.0 6876.1 6878.1 6886.8 6907.9 6517.6 6549.3 6612.4 6618.2 6631.4 6499.1 6615.8 6640.6 6681.1 6743.0 6356.6 6502.2 6516.7 6518.0 6519.5 6535.9 6567.3 6598.9 6622.4 6638.2 5214.1 5234.7 5286.9 5289.0 5315.4 4559.0 4585.7 4610.6 4639.0 4651.7 5608.1 5656.2 5739.3 5826.8 5832.5 6666.8 6710.6 6711.0 6763.0 6766.2 5732.2 5750.7 5789.3 5817.8 5821.6 5708.3 5729.7 5752.1 5785.2 5797.1 6270.8 6319.4 6387.9 6426.4 6462.9 6669.3 6701.4 6706.6 6724.8 6742.6 6378.1 6406.2 6428.8 6436.8 6485.5 6497.9 6565.1 6605.8 6606.8 6662.2 6596.1 6623.3 6658.3 6750.4 6801.1 6449.0 6465.7 6478.6 6498.3 6523.8 6490.3 6514.1 6564.7 6575.5 6592.2 6407.3 6419.4 6500.7 6509.5 6510.4 6357.4 6413.3 6460.6 6546.5 6593.3 6389.9 6391.9 6396.6 6400.3 6403.3 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#1] ext.html Cycles:180 Average:36941.72 Median:3530.44 stddev:53099.45 (1504.0%) stddev-sans-first:53179.27 11:32:53 INFO - PID 19165 | Values: 855.9 887.7 888.5 893.3 893.7 38018.2 41228.8 41508.6 41760.6 41985.2 38046.7 38111.0 38375.4 38564.0 38644.0 6917.3 7072.8 7098.8 7100.8 7119.0 7010.3 7074.2 7094.3 7116.8 7135.8 7091.8 7108.3 7124.5 7160.8 7164.9 7025.4 7057.8 7578.8 7791.8 7812.5 7652.6 7726.6 7768.1 7770.9 7771.3 38346.4 38747.6 38863.6 39124.4 39132.0 3519.6 3541.3 3547.7 3571.5 3575.0 31684.2 31872.7 32303.5 32331.2 32392.2 5159.7 5165.5 5171.9 5182.4 5249.3 181668.0 183482.0 184510.0 185212.1 185661.0 41152.6 41765.0 47275.8 47435.3 48595.8 51126.7 51480.2 51514.7 51575.7 51715.5 14442.2 14572.9 14581.9 14592.3 14605.8 11469.4 11588.9 11597.7 11681.6 11700.9 14094.6 14179.9 14201.8 14262.2 14282.2 5660.2 5683.9 5772.5 5785.7 5957.2 1009.5 1009.6 1011.5 1022.7 1027.9 23089.8 23106.2 23122.4 23320.5 23453.3 1091.4 1122.1 1127.0 1127.7 1134.1 12141.8 12337.6 12344.5 12364.6 12369.7 228295.0 228797.0 228882.0 230080.0 230547.0 52558.0 52695.7 52731.2 52797.5 52882.5 1414.8 1459.7 1465.3 1475.1 1484.1 22224.7 22533.5 22545.9 22649.0 23210.8 36336.5 36487.0 36744.8 36754.8 36885.8 197892.0 198200.0 198287.0 198535.0 198925.0 29334.7 30133.2 32189.0 33390.0 33895.0 42192.0 42494.6 42510.6 42634.6 43278.4 31528.8 31701.5 32043.5 32302.7 32313.7 30969.2 31359.4 31455.2 31684.7 31898.0 35740.8 35786.6 35797.6 35906.5 36410.6 29910.7 30211.7 30506.7 30728.8 31792.4 22983.0 23195.0 23522.5 23592.6 23631.6 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#2] jquery.html Cycles:180 Average:33751.28 Median:23173.54 stddev:75900.45 (327.5%) stddev-sans-first:76072.42 11:32:53 INFO - PID 19165 | Values: 541.8 549.2 562.2 563.7 567.3 22036.9 22901.7 22960.7 22985.7 23196.2 24064.2 24343.9 24461.6 24496.9 24597.1 6646.8 6667.3 6690.1 6700.4 6702.3 6551.0 6723.7 6726.9 6727.0 6727.9 6634.1 6654.3 6713.7 6724.2 6725.9 6710.7 6724.3 6727.6 6730.7 6734.1 5915.3 5997.3 6089.5 6099.3 6144.4 28280.7 28303.6 28535.7 28627.6 28674.3 2064.4 2081.9 2089.0 2091.0 2092.5 19160.3 19874.2 20187.8 20223.1 20833.8 2197.2 2442.6 2449.8 2493.6 2531.8 119777.0 124125.4 138282.0 144306.0 145635.0 14445.3 15154.4 15223.6 15304.2 15426.5 23084.2 23150.9 23198.9 23307.8 23399.4 9951.2 10022.3 10046.5 10060.1 10078.7 9201.8 9270.6 9270.8 9305.1 9429.2 8937.9 8979.3 9127.7 9364.4 9461.3 2512.1 2516.6 2525.9 2578.0 2639.6 973.1 982.8 990.9 998.1 998.3 19605.3 19759.7 19788.6 19822.0 19879.9 1040.3 1048.1 1049.6 1064.9 1066.4 11008.0 11078.7 11098.9 11138.5 11228.6 440636.0 446426.0 447163.0 447433.0 454065.0 113273.0 113948.0 114611.0 114900.0 117167.0 1009.8 1134.9 1168.1 1179.8 1211.6 20862.3 20991.7 21099.0 21216.0 21262.7 57056.7 60726.0 60788.4 61815.7 62631.0 70528.0 72841.6 73101.6 73827.3 74513.0 14623.1 14629.0 14710.1 14797.8 14916.9 23381.3 23996.6 24047.5 24271.6 24535.6 18807.6 18868.2 19077.8 19204.5 19473.2 15716.9 15860.7 16234.0 16314.1 16356.9 19053.5 19702.8 19772.0 19788.3 19813.1 14681.1 14684.9 14699.6 14712.9 14732.0 17859.6 18646.3 18676.3 18933.9 19090.1 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#3] mootools.html Cycles:180 Average:9382.77 Median:2680.34 stddev:6754.98 (252.0%) stddev-sans-first:6746.90 11:32:53 INFO - PID 19165 | Values: 1340.6 1366.9 1375.3 1375.9 1397.1 12532.2 13210.1 15324.4 15830.8 15879.9 15233.5 15593.1 15609.4 15616.0 15643.2 2710.6 2734.9 2759.9 2764.5 2768.4 2672.1 2724.8 2731.2 2749.7 2754.8 2594.1 2658.0 2666.9 2760.6 2768.9 2688.6 2754.9 2759.0 2761.8 2762.5 2572.9 2665.9 2689.3 2716.8 2720.7 15126.3 15276.2 15394.0 15441.6 15453.8 8128.1 8248.3 8322.4 8389.9 8440.7 5225.5 5408.9 5554.9 5562.4 5604.5 1775.5 1811.2 1818.4 1849.8 1853.4 26118.3 26326.7 26394.3 26424.6 26424.9 6836.5 7431.6 7668.0 7701.1 7762.6 17384.7 17386.8 17462.8 17501.3 17588.2 7912.3 8185.4 8199.9 8201.3 8204.3 7389.3 7475.9 7482.9 7519.4 7548.8 5273.7 5367.8 5421.9 5436.5 5460.4 1520.3 1541.5 1544.2 1555.6 1569.7 881.8 881.9 898.6 917.5 918.5 7600.1 7602.0 7634.4 7681.5 7698.9 697.0 706.0 706.5 716.4 722.4 5279.8 5410.5 5423.4 5461.2 5630.1 21686.7 22360.6 22598.8 22672.9 22828.9 21006.9 21737.1 21831.9 21834.0 22115.1 11312.6 11378.4 11440.6 11539.7 11562.9 8479.9 8581.1 8622.9 8623.3 8636.7 19123.6 19246.3 19249.8 19347.3 19583.4 19300.9 19391.0 19511.7 19562.0 19725.8 10312.1 10385.0 10407.4 10424.4 10432.2 13891.0 13961.4 14203.9 14206.4 14275.0 10281.6 10409.6 10686.1 10693.7 10724.7 11076.7 11193.7 11406.9 11518.2 11750.5 9389.1 9395.2 9396.8 9426.2 9460.5 7190.9 7279.5 7298.1 7331.2 7341.8 7064.8 7082.6 7110.6 7145.5 7234.9 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#4] prototype.html Cycles:180 Average:5381.84 Median:6063.44 stddev:1490.63 (24.6%) stddev-sans-first:1448.98 11:32:53 INFO - PID 19165 | Values: 495.0 497.8 521.3 522.5 533.2 6151.7 6167.6 6195.1 6230.3 6284.7 6076.2 6082.3 6087.0 6134.0 6143.2 5060.7 5111.1 5150.5 5153.7 5156.8 5100.7 5113.4 5114.8 5125.7 5145.8 4765.3 4877.2 4880.2 4896.4 4905.4 4868.8 4924.1 4926.2 4952.4 4980.4 4369.2 4391.2 4432.2 4440.0 4464.0 5769.1 5902.3 5965.3 5992.4 6060.3 5615.0 5645.4 5648.7 5658.3 5680.1 6455.5 6464.5 6513.7 6530.9 6543.9 4577.3 4792.8 4829.6 4847.0 4848.2 6576.2 6620.5 6629.4 6712.7 6722.2 4914.9 4923.9 4940.8 4952.9 4960.4 4955.2 4977.2 4980.8 4985.8 4992.4 5527.6 5563.6 5608.2 5612.5 5640.2 6460.5 6490.4 6495.8 6576.7 6583.8 1719.8 1735.6 1738.2 1738.3 1755.3 1124.6 1189.2 1191.8 1204.1 1205.8 5448.6 5457.3 5526.3 5551.2 5581.4 6505.3 6508.7 6543.6 6590.7 6594.9 5465.1 5503.9 5539.0 5545.8 5595.8 3410.6 3443.2 3452.3 3482.4 3492.0 6105.6 6108.5 6264.4 6297.4 6305.1 6529.4 6558.5 6613.6 6643.3 6716.7 6066.5 6255.6 6260.6 6268.1 6342.0 6318.4 6415.9 6425.3 6519.4 6592.3 5893.9 6349.8 6376.6 6423.8 6483.1 6083.9 6166.1 6237.8 6250.9 6252.2 4728.8 4781.7 4794.3 4835.6 4891.6 6189.2 6318.8 6322.7 6574.1 6601.7 6236.8 6283.3 6302.7 6304.3 6340.1 6190.8 6348.2 6357.8 6384.9 6390.6 6307.2 6318.5 6345.5 6366.7 6413.8 6439.5 6453.9 6464.0 6487.7 6501.3 6217.6 6259.9 6264.5 6285.7 6289.5 11:32:53 INFO - PID 19165 | 11:32:53 INFO - PID 19165 | [#5] yui.html Cycles:180 Average:24437.82 Median:18802.53 stddev:35733.72 (190.0%) stddev-sans-first:35790.20 11:32:53 INFO - PID 19165 | Values: 883.7 906.7 919.1 919.2 930.9 19037.0 19668.7 19937.3 19987.2 20072.2 17857.4 17863.7 18095.4 18721.0 18884.1 954.5 964.2 970.4 972.7 974.2 973.2 973.8 975.6 976.2 976.6 1009.1 1026.6 1029.6 1032.5 1043.1 1028.5 1030.8 1031.9 1037.3 1040.9 726.2 742.0 746.2 751.4 757.3 20422.5 20496.9 20516.4 20536.5 20541.3 18645.2 18675.1 18907.6 19280.6 19559.4 17302.6 17409.4 17537.0 17544.9 17703.4 3733.4 3763.3 3771.1 3773.4 3775.3 138612.0 140218.0 140752.0 141860.0 143007.0 16441.1 16469.3 16526.3 16676.1 16695.7 31468.7 32174.0 32195.2 32979.3 33249.2 8522.4 8562.1 8693.0 8710.1 8713.5 3892.9 3959.3 3959.7 3966.1 4005.8 5502.9 5543.5 5562.7 5599.0 5606.4 1010.7 1026.5 1036.7 1037.1 1049.6 690.3 708.2 715.7 716.9 721.1 11072.9 11686.9 11824.4 12726.4 12888.6 667.6 670.8 672.9 690.8 698.5 5615.6 5645.7 5731.4 5776.4 5838.1 121417.0 122433.4 124612.0 124612.4 125873.0 108242.5 109003.0 109022.5 109643.0 111703.0 95352.5 96459.5 96494.5 96944.0 97668.0 10215.8 10283.1 10310.4 10366.8 10618.4 43164.6 44879.6 45065.8 45168.8 45687.8 58449.1 60190.4 60588.0 60781.7 61278.7 15377.8 15525.9 15560.7 15625.8 15814.1 16891.5 17025.1 17210.6 17356.7 17576.3 15094.1 15134.5 15235.4 15300.4 15316.8 14769.5 14870.4 14890.3 14943.9 14987.7 14751.3 15003.6 15069.5 15137.3 15169.2 11801.9 11872.8 12097.2 12148.7 12257.1 11609.3 11615.5 11819.1 11942.8 12109.5 11:32:53 INFO - PID 19165 | -------- Summary: end -------- 11:32:53 INFO - PID 19165 | 11:32:53 INFO - TEST-INFO | 19165: exit 0 11:32:53 INFO - TEST-OK | dromaeo_css | took 1110975ms 11:32:53 INFO - TEST-START | kraken 11:32:53 INFO - Initialising browser for kraken test... 11:32:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45348/getInfo.html -profile /tmp/tmpFWWZ81/profile 11:32:53 INFO - TEST-INFO | started process 19553 (/builds/slave/test/build/application/firefox/firefox http://localhost:45348/getInfo.html) 11:32:59 INFO - TEST-INFO | 19553: exit 0 11:32:59 INFO - Browser initialized. 11:32:59 INFO - Running cycle 1/1 for kraken test... 11:32:59 INFO - Using env: {'DISPLAY': ':0', 11:32:59 INFO - 'HOME': '/home/cltbld', 11:32:59 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:59 INFO - 'LANG': 'en_US.UTF-8', 11:32:59 INFO - 'LANGUAGE': 'en_US:en', 11:32:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:59 INFO - 'LOGNAME': 'cltbld', 11:32:59 INFO - 'MAIL': '/var/mail/cltbld', 11:32:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:59 INFO - 'MOZ_ACCELERATED': '1', 11:32:59 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:59 INFO - 'MOZ_NO_REMOTE': '1', 11:32:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:59 INFO - 'MOZ_WEBRENDER': '1', 11:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:59 INFO - 'NO_EM_RESTART': '1', 11:32:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:59 INFO - 'PWD': '/builds/slave/test', 11:32:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:59 INFO - 'RUST_BACKTRACE': 'full', 11:32:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:59 INFO - 'SHELL': '/bin/bash', 11:32:59 INFO - 'SHLVL': '1', 11:32:59 INFO - 'TERM': 'linux', 11:32:59 INFO - 'TMOUT': '86400', 11:32:59 INFO - 'USER': 'cltbld', 11:32:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224', 11:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:59 INFO - '_': '/tools/buildbot/bin/python'} 11:32:59 INFO - TEST-INFO | started process 19802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWWZ81/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:00 INFO - PID 19802 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:33:00 INFO - PID 19802 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:33:00 INFO - PID 19802 | 11:33:00 INFO - PID 19802 | (/builds/slave/test/build/application/firefox/firefox:19862): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:33:00 INFO - PID 19802 | 11:33:10 INFO - PID 19802 | RSS: Main: 205385728 11:33:10 INFO - PID 19802 | 11:33:13 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45348/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:14 INFO - PID 19802 | RSS: Main: 207880192 11:33:14 INFO - PID 19802 | 11:33:17 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45348/tests/kraken/driver.html?testName=audio-dft) 11:33:17 INFO - PID 19802 | RSS: Main: 207515648 11:33:17 INFO - PID 19802 | 11:33:20 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45348/tests/kraken/driver.html?testName=audio-fft) 11:33:21 INFO - PID 19802 | RSS: Main: 203227136 11:33:21 INFO - PID 19802 | 11:33:23 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45348/tests/kraken/driver.html?testName=audio-oscillator) 11:33:24 INFO - PID 19802 | RSS: Main: 204898304 11:33:24 INFO - PID 19802 | 11:33:26 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:26 INFO - PID 19802 | RSS: Main: 203317248 11:33:26 INFO - PID 19802 | 11:33:30 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45348/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:30 INFO - PID 19802 | RSS: Main: 207183872 11:33:30 INFO - PID 19802 | 11:33:34 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45348/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:35 INFO - PID 19802 | RSS: Main: 207183872 11:33:35 INFO - PID 19802 | 11:33:38 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45348/tests/kraken/driver.html?testName=json-parse-financial) 11:33:38 INFO - PID 19802 | RSS: Main: 207314944 11:33:38 INFO - PID 19802 | 11:33:40 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:41 INFO - PID 19802 | RSS: Main: 207208448 11:33:41 INFO - PID 19802 | 11:33:42 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:43 INFO - PID 19802 | RSS: Main: 206934016 11:33:43 INFO - PID 19802 | 11:33:45 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:46 INFO - PID 19802 | RSS: Main: 207400960 11:33:46 INFO - PID 19802 | 11:33:48 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:49 INFO - PID 19802 | RSS: Main: 208211968 11:33:49 INFO - PID 19802 | 11:33:52 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:53 INFO - PID 19802 | RSS: Main: 206807040 11:33:53 INFO - PID 19802 | 11:33:54 INFO - PID 19802 | Cycle 1(1): loaded http://localhost:45348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45348/tests/kraken/driver.html?testName=ai-astar) 11:33:55 INFO - PID 19802 | RSS: Main: 210116608 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | __start_tp_report 11:33:55 INFO - PID 19802 | _x_x_mozilla_page_load 11:33:55 INFO - PID 19802 | _x_x_mozilla_page_load_details 11:33:55 INFO - PID 19802 | |i|pagename|runs| 11:33:55 INFO - PID 19802 | |0;ai-astar;112;108;109;116;115;108;106;106;107;120 11:33:55 INFO - PID 19802 | |1;audio-beat-detection;122;117;118;116;118;115;127;152;125;120 11:33:55 INFO - PID 19802 | |2;audio-dft;164;165;163;163;171;168;174;164;163;164 11:33:55 INFO - PID 19802 | |3;audio-fft;78;81;83;75;79;80;74;75;75;83 11:33:55 INFO - PID 19802 | |4;audio-oscillator;89;89;79;84;79;87;80;85;80;79 11:33:55 INFO - PID 19802 | |5;imaging-gaussian-blur;113;114;117;113;114;115;114;111;117;114 11:33:55 INFO - PID 19802 | |6;imaging-darkroom;149;149;149;153;148;149;148;150;153;148 11:33:55 INFO - PID 19802 | |7;imaging-desaturate;94;104;95;94;102;98;96;94;95;95 11:33:55 INFO - PID 19802 | |8;json-parse-financial;53;55;55;55;57;60;56;56;55;54 11:33:55 INFO - PID 19802 | |9;json-stringify-tinderbox;47;47;43;38;47;46;47;39;43;42 11:33:55 INFO - PID 19802 | |10;stanford-crypto-aes;82;75;75;84;91;82;75;82;78;81 11:33:55 INFO - PID 19802 | |11;stanford-crypto-ccm;120;113;118;117;114;120;117;111;110;115 11:33:55 INFO - PID 19802 | |12;stanford-crypto-pbkdf2;172;169;172;177;177;171;167;172;185;189 11:33:55 INFO - PID 19802 | |13;stanford-crypto-sha256-iterative;70;67;70;63;70;65;66;69;63;65 11:33:55 INFO - PID 19802 | __end_tp_report 11:33:55 INFO - PID 19802 | __start_cc_report 11:33:55 INFO - PID 19802 | _x_x_mozilla_cycle_collect,758 11:33:55 INFO - PID 19802 | __end_cc_report 11:33:55 INFO - PID 19802 | __startTimestamp1505586835165__endTimestamp 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | ------- Summary: start ------- 11:33:55 INFO - PID 19802 | Number of tests: 14 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:4.83 (4.4%) stddev-sans-first:5.10 11:33:55 INFO - PID 19802 | Values: 112.0 108.0 109.0 116.0 115.0 108.0 106.0 106.0 107.0 120.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:121.00 stddev:10.90 (9.0%) stddev-sans-first:11.56 11:33:55 INFO - PID 19802 | Values: 122.0 117.0 118.0 116.0 118.0 115.0 127.0 152.0 125.0 120.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#2] audio-dft Cycles:10 Average:165.90 Median:164.50 stddev:3.84 (2.3%) stddev-sans-first:4.01 11:33:55 INFO - PID 19802 | Values: 164.0 165.0 163.0 163.0 171.0 168.0 174.0 164.0 163.0 164.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#3] audio-fft Cycles:10 Average:78.30 Median:79.50 stddev:3.43 (4.3%) stddev-sans-first:3.64 11:33:55 INFO - PID 19802 | Values: 78.0 81.0 83.0 75.0 79.0 80.0 74.0 75.0 75.0 83.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:84.50 stddev:4.20 (5.0%) stddev-sans-first:3.88 11:33:55 INFO - PID 19802 | Values: 89.0 89.0 79.0 84.0 79.0 87.0 80.0 85.0 80.0 79.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 11:33:55 INFO - PID 19802 | Values: 113.0 114.0 117.0 113.0 114.0 115.0 114.0 111.0 117.0 114.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.00 stddev:1.90 (1.3%) stddev-sans-first:2.00 11:33:55 INFO - PID 19802 | Values: 149.0 149.0 149.0 153.0 148.0 149.0 148.0 150.0 153.0 148.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:95.00 stddev:3.56 (3.7%) stddev-sans-first:3.64 11:33:55 INFO - PID 19802 | Values: 94.0 104.0 95.0 94.0 102.0 98.0 96.0 94.0 95.0 95.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:1.90 (3.4%) stddev-sans-first:1.76 11:33:55 INFO - PID 19802 | Values: 53.0 55.0 55.0 55.0 57.0 60.0 56.0 56.0 55.0 54.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#9] json-stringify-tinderbox Cycles:10 Average:43.90 Median:46.50 stddev:3.45 (7.4%) stddev-sans-first:3.47 11:33:55 INFO - PID 19802 | Values: 47.0 47.0 43.0 38.0 47.0 46.0 47.0 39.0 43.0 42.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:82.00 stddev:5.02 (6.1%) stddev-sans-first:5.29 11:33:55 INFO - PID 19802 | Values: 82.0 75.0 75.0 84.0 91.0 82.0 75.0 82.0 78.0 81.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:117.00 stddev:3.50 (3.0%) stddev-sans-first:3.32 11:33:55 INFO - PID 19802 | Values: 120.0 113.0 118.0 117.0 114.0 120.0 117.0 111.0 110.0 115.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:174.50 stddev:7.05 (4.0%) stddev-sans-first:7.38 11:33:55 INFO - PID 19802 | Values: 172.0 169.0 172.0 177.0 177.0 171.0 167.0 172.0 185.0 189.0 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:68.00 stddev:2.82 (4.1%) stddev-sans-first:2.74 11:33:55 INFO - PID 19802 | Values: 70.0 67.0 70.0 63.0 70.0 65.0 66.0 69.0 63.0 65.0 11:33:55 INFO - PID 19802 | -------- Summary: end -------- 11:33:55 INFO - PID 19802 | 11:33:55 INFO - PID 19802 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:33:55 INFO - TEST-INFO | 19802: exit 0 11:33:56 INFO - TEST-OK | kraken | took 62207ms 11:33:56 INFO - SUITE-END | took 1173s 11:33:56 INFO - Completed test suite (00:19:33) 11:33:56 INFO - javascript benchmark 11:33:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8422.642389221806, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.662997070322, 3081.368319494504, 3117.968820311796, 3120.0951724000042, 3143.214196450888, 5979.342272350049, 6111.144439778429, 6166.53750968678, 6211.782587609435, 6245.750169993206, 6108.480779133779, 6137.6624285664275, 6207.751689932397, 6233.563650544464, 6279.120923070774, 5628.98678237917, 5664.858378540528, 5731.312242530902, 5760.913586296209, 5774.682392468412, 5680.9715951420185, 5728.68492232927, 5738.684372359518, 5784.421557844203, 5803.680797556132, 338.0656189164808, 5576.693281869496, 5649.576281778842, 5728.25532680753, 5851.385604511529, 5673.574481913873, 5683.119116536944, 5696.3733989261145, 5723.914141287884, 5768.278965129359, 5611.943880561183, 5628.802991895264, 5694.572907031989, 5733.111367738007, 5742.0238559445, 6074.878502429927, 6158.6612736299485, 6180.412860778219, 6253.968095264276, 6271.247450305947, 6535.248446428626, 6578.0, 6614.173228346457, 6666.500012499034, 6716.261211266757, 6702.6648667566915, 6709.49678774089, 6773.966130169367, 6790.864182716318, 6798.04827324175, 6057.42454466825, 6089.786857459968, 6153.261608606951, 6260.217472815898, 6274.090256912722, 6833.043373927704, 6876.140482439695, 6878.071460352889, 6886.827829304208, 6907.861842763116, 6517.641529715816, 6549.279579246279, 6612.404883560503, 6618.205815302098, 6631.3700198481065, 6499.09012738217, 6615.768448104293, 6640.601563906181, 6681.064650948871, 6743.0, 6356.618602883842, 6502.187226596676, 6516.739330426824, 6518.022296655445, 6519.511036672268, 6535.901961470582, 6567.310432404529, 6598.901016484757, 6622.37087476689, 6638.236602790645, 5214.061468935628, 5234.712090834964, 5286.8942621148135, 5288.9735551322, 5315.415304316522, 4558.9772051139535, 4585.72485650862, 4610.631149508032, 4639.0, 4651.697639653412, 5608.130739735348, 5656.179853921159, 5739.311282646109, 5826.82519524415, 5832.504237139806, 6666.766663166766, 6710.597364158166, 6710.966445167743, 6763.0, 6766.15423072116, 5732.226149469769, 5750.712464376765, 5789.305283366023, 5817.825465235965, 5821.563382746311, 5708.257926469532, 5729.713514324267, 5752.137179423036, 5785.1611516329895, 5797.101449275369, 6270.7805226816845, 6319.399657032574, 6387.936120638734, 6426.389492998158, 6462.903056454157, 6669.266380698119, 6701.430378417792, 6706.631135287606, 6724.7646332378135, 6742.561733487308, 6378.075179099097, 6406.23125224976, 6428.774992875227, 6436.8390790230615, 6485.481161506974, 6497.9025314619375, 6565.113709649137, 6605.768798092236, 6606.8017959461295, 6662.200535935719, 6596.109525214227, 6623.271440141677, 6658.334166583303, 6750.426213771884, 6801.1158549388265, 6449.0, 6465.676716164267, 6478.611283323015, 6498.317676643885, 6523.7716679915975, 6490.253620833664, 6514.120593719977, 6564.737410503717, 6575.50683698715, 6592.17597800275, 6407.327230640715, 6419.422251997343, 6500.70746816385, 6509.511786616117, 6510.414062734377, 6357.364263573606, 6413.262474815269, 6460.644664543495, 6546.476281897341, 6593.340665933561, 6389.87220255583, 6391.872162556816, 6396.6481843497195, 6400.263969643551, 6403.3276505966205], "value": 6024.8474930481525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.9101294364091, 887.7159309021112, 888.4891187567142, 893.3032234856812, 893.705077324483, 38018.23963520728, 41228.79385603068, 41508.58491415085, 41760.58239417605, 41985.160296794085, 38046.66836660718, 38111.04722381942, 38375.42436863449, 38564.0, 38644.0, 6917.273686262933, 7072.752453664123, 7098.822529436754, 7100.786976390691, 7119.038929744496, 7010.263922288163, 7074.22183559808, 7094.2551032141655, 7116.7509137180205, 7135.785926422215, 7091.787246382617, 7108.253633368499, 7124.465665075114, 7160.785176444715, 7164.85670286594, 7025.402840758542, 7057.788266352043, 7578.810529736801, 7791.805204869867, 7812.453128281023, 7652.617369131521, 7726.613669316512, 7768.145503994556, 7770.922290777076, 7771.261730135628, 38346.42480362797, 38747.61252387468, 38863.61136388628, 39124.41313380301, 39132.0, 3519.5952465466544, 3541.29174165168, 3547.7161827053774, 3571.535700358963, 3574.9821250893838, 31684.207894802585, 31872.681273187434, 32303.51544726831, 32331.19172020695, 32392.190195245308, 5159.74201289934, 5165.483451654804, 5171.948280517185, 5182.404023537266, 5249.317588713481, 181668.0, 183482.0, 184510.0, 185212.0739396308, 185660.99999999866, 41152.58847411547, 41765.0, 47275.76362118167, 47435.28847067297, 48595.75702121537, 51126.744366278675, 51480.22779658308, 51514.74242628838, 51575.74212128916, 51715.482845171064, 14442.205678687773, 14572.854271457361, 14581.927090364481, 14592.343344549521, 14605.78091328631, 11469.426528673534, 11588.88411115878, 11597.710057248636, 11681.591144309908, 11700.941495292469, 14094.577162685136, 14179.929100354433, 14201.78697319541, 14262.215578143301, 14282.21447820359, 5660.235868157828, 5683.943160568424, 5772.538196944234, 5785.739641716133, 5957.165996760457, 1009.4952523738131, 1009.5961615353917, 1011.4841430870309, 1022.6983040003217, 1027.9074883260541, 23089.76910230876, 23106.191283305005, 23122.421939451648, 23320.53358932812, 23453.296401107993, 1091.399730148431, 1122.1415617052799, 1127.0, 1127.6504283672089, 1134.0587312530579, 12141.75716485683, 12337.568185113478, 12344.506219751289, 12364.56724014655, 12369.690757731129, 228295.0, 228797.0, 228882.0, 230080.0, 230547.0, 52558.0, 52695.73652131715, 52731.20903186455, 52797.472025280025, 52882.471175287756, 1414.8160739104057, 1459.6861674739769, 1465.3479201755117, 1475.1223022301713, 1484.139199264424, 22224.666630000887, 22533.549329013655, 22545.887270563544, 22649.0, 23210.767892320862, 36336.45495317625, 36487.0, 36744.81627591952, 36754.8162259187, 36885.81557092197, 197892.0, 198200.0, 198287.0, 198535.0, 198925.0, 29334.706652933197, 30133.246668832577, 32189.034328970167, 33390.0, 33895.0, 42192.0, 42494.575054249064, 42510.5748942519, 42634.57365426306, 43278.350824738285, 31528.842355788074, 31701.524477133324, 32043.519347209345, 32302.676973229965, 32313.676863231067, 30969.225769355948, 31359.37281254408, 31455.21361965969, 31684.683153169095, 31898.043058708277, 35740.82129589335, 35786.64213357833, 35797.64202357943, 35906.46140307845, 36410.63589364178, 29910.700892991663, 30211.69788302089, 30506.694933051273, 30728.846355768077, 31792.364152716353, 22983.0, 23194.956226970164, 23522.529549408573, 23592.646110308702, 23631.64552531679], "value": 16801.710555299134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.7914103070317, 549.157043937556, 562.1736048009427, 563.7259792868118, 567.29088639201, 22036.88981555094, 22901.656475152886, 22960.65559016614, 22985.655215171744, 23196.188133415333, 24064.157754478554, 24343.878280608616, 24461.633075503883, 24496.877515612443, 24597.1391001315, 6646.800595982116, 6667.333266673342, 6690.096836927001, 6700.430463410616, 6702.262751097375, 6551.0, 6723.663816809164, 6726.865462690744, 6726.966365168192, 6727.932720672804, 6634.0712300278, 6654.26803051664, 6713.731450741989, 6724.193096828388, 6725.932740672604, 6710.731570737189, 6724.293949135319, 6727.629980351078, 6730.697118629649, 6734.124563806723, 5915.260592425947, 5997.250343707036, 6089.512838972872, 6099.298580663236, 6144.446999769997, 28280.717192828015, 28303.575446368322, 28535.714642853512, 28627.570586441012, 28674.283142921384, 2064.4013236161495, 2081.895905204749, 2088.968665470019, 2091.048572899327, 2092.455961450034, 19160.329388471335, 19874.205031798712, 20187.788732676087, 20223.089960951645, 20833.79166208334, 2197.2199869046576, 2442.5969714997004, 2449.8285120041605, 2493.551160791057, 2531.8227724059325, 119777.0, 124125.37937310255, 138282.0, 144306.0, 145634.99999999895, 14445.274707987548, 15154.393824246907, 15223.619409514851, 15304.158271294962, 15426.46007389736, 23084.192053278053, 23150.884245578665, 23198.884005579865, 23307.76692233056, 23399.41501462477, 9951.15415189717, 10022.344078819118, 10046.497675116361, 10060.094591486655, 10078.748031299276, 9201.76995575116, 9270.582823772946, 9270.768230794283, 9305.069493050776, 9429.15137637616, 8937.910620893708, 8979.326550508738, 9127.726168214964, 9364.438133712, 9461.290403219786, 2512.1033619617438, 2516.5721827289403, 2525.92063816938, 2577.987110064475, 2639.643648107481, 973.0561355485167, 982.7936133411921, 990.8910019897805, 998.0618218874235, 998.3111652959435, 19605.31381401644, 19759.703604445946, 19788.604227915363, 19822.008899554963, 19879.900600497192, 1040.3237895368072, 1048.0881632979356, 1049.6431213387484, 1064.9361038337724, 1066.4401189375485, 11008.0, 11078.667639970814, 11098.944505277583, 11138.498767555317, 11228.606998755004, 440636.0, 446426.0, 447163.0, 447433.0, 454065.0, 113273.0, 113948.0, 114611.0, 114900.0, 117167.0, 1009.7879445316565, 1134.869490008643, 1168.1355796710543, 1179.8289248058984, 1211.594115971142, 20862.26982055621, 20991.685124722837, 21099.0, 21216.0, 21262.681059783805, 57056.714716427814, 60726.0, 60788.39211607827, 61815.6909215451, 62631.0, 70528.0, 72841.6357918207, 73101.6344918272, 73827.26172738204, 74513.0, 14623.122612643276, 14629.0, 14710.117392956457, 14797.778033329723, 14916.85083149198, 23381.298561043197, 23996.64005039961, 24047.51904961856, 24271.635925461487, 24535.63196552089, 18807.623847523246, 18868.15093320831, 19077.809221907602, 19204.519887002938, 19473.221071156993, 15716.92141539285, 15860.682786343978, 16234.0, 16314.102724350274, 16356.918215408847, 19053.523661908563, 19702.802971970672, 19772.0, 19788.307409241184, 19813.10841012129, 14681.119132852064, 14684.853151468777, 14699.55901322962, 14712.852871471148, 14732.0, 17859.642807144046, 18646.34737784171, 18676.34632787846, 18933.90533047326, 19090.140943657847], "value": 12050.538007816176, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.644729146776, 1366.8516053776784, 1375.3054707372776, 1375.8761711445968, 1397.1477398786742, 12532.185407948476, 13210.07529472936, 15324.38702451902, 15830.84169158308, 15879.92060039701, 15233.466828661, 15593.142377169252, 15609.375624975015, 15616.0, 15643.217839108027, 2710.593410988348, 2734.945301093977, 2759.9448011039767, 2764.4885696146175, 2768.418632087264, 2672.0647773279393, 2724.809263351556, 2731.153342463833, 2749.670039595251, 2754.752072313491, 2594.1439325022698, 2657.9601305980427, 2666.8666566671686, 2760.558310670293, 2768.9446211075765, 2688.623592697024, 2754.911809835124, 2758.9862050689817, 2761.7514423701964, 2762.5441802102628, 2572.897084116633, 2665.8533780642056, 2689.3142248726645, 2716.755492005709, 2720.687120981073, 15126.319315630713, 15276.236188190545, 15394.0, 15441.613959650986, 15453.845461545465, 8128.146544612849, 8248.340132789423, 8322.417430779848, 8389.916100838975, 8440.662373505053, 5225.529702326771, 5408.945910540883, 5554.888902221933, 5562.3881373048935, 5604.467575580314, 1775.5383600264024, 1811.2121227266182, 1818.354484158118, 1849.833514983658, 1853.3605905962422, 26118.34704132393, 26326.736732632813, 26394.340141496425, 26424.603630945552, 26424.86787566069, 6836.5214434989075, 7431.554106753504, 7667.961660191663, 7701.114371847198, 7762.611869406507, 17384.65230695404, 17386.826131738522, 17462.825371746374, 17501.299948002194, 17588.2085306159, 7912.28789408956, 8185.427020108655, 8199.877001844978, 8201.343892488587, 8204.261616454547, 7389.261073892568, 7475.887861682079, 7482.877568364789, 7519.398448124137, 7548.811279717941, 5273.683578985273, 5367.838964831061, 5421.891562168814, 5436.483534064258, 5460.399356070829, 1520.2626726037863, 1541.4604888289234, 1544.1815837606086, 1555.5566663500847, 1569.7096037233148, 881.7751473374249, 881.8809460722721, 898.6091050392969, 917.4632839788799, 918.4672889723944, 7600.125985511626, 7601.961990190013, 7634.351080158249, 7681.539107653447, 7698.884516732253, 696.9965150174216, 705.9505834591529, 706.4630880530833, 716.4197000429668, 722.4148439763808, 5279.815206467755, 5410.540104091197, 5423.403425623178, 5461.208124821878, 5630.071038278638, 21686.674699879513, 22360.552788944457, 22598.774012259666, 22672.886635566716, 22828.88585557095, 21006.894965525076, 21737.13051477923, 21831.890840545697, 21834.0, 22115.115395384004, 11312.6040588579, 11378.374189419661, 11440.599579014695, 11539.653810385702, 11562.94218528902, 8479.915200847912, 8581.141885811368, 8622.870656940277, 8623.310135189044, 8636.697715580176, 19123.617527649647, 19246.326378577243, 19249.807501924803, 19347.322843700967, 19583.412497625093, 19300.903495482995, 19391.0, 19511.70732439043, 19562.0, 19725.80274197297, 10312.123469504875, 10385.0, 10407.375557466576, 10424.426656533964, 10432.165426765992, 13891.0, 13961.4415423386, 14203.928980355033, 14206.360713768112, 14275.0, 10281.588736450458, 10409.63566275207, 10686.145108391465, 10693.679189624323, 10724.73188170302, 11076.667699969013, 11193.72015699614, 11406.942965285121, 11518.193726439069, 11750.471228794895, 9389.10803473669, 9395.201407880406, 9396.76508087276, 9426.245900328095, 9460.479673617741, 7190.856182876418, 7279.490435669664, 7298.124225093023, 7331.156916954618, 7341.816454588678, 7064.752733654297, 7082.575045497287, 7110.644467776487, 7145.46409019336, 7234.927650723425], "value": 6651.26268396932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.02297276886424, 497.75112443778113, 521.278029928549, 522.4775224775225, 533.1765362460385, 6151.723172457239, 6167.599106058109, 6195.132681424604, 6230.345813689565, 6284.748610055598, 6076.179715738374, 6082.270127584685, 6086.995645718451, 6133.969330153354, 6143.201383820108, 5060.69635821851, 5111.105556527611, 5150.459201783815, 5153.706600562751, 5156.793728250866, 5100.668456550331, 5113.386393632769, 5114.795408183687, 5125.744192672801, 5145.81989630363, 4765.30903019062, 4877.219644856824, 4880.219164933611, 4896.436909755388, 4905.386826646669, 4868.758466591032, 4924.113659541281, 4926.236433352836, 4952.430470495903, 4980.352554167935, 4369.191699535596, 4391.187630288407, 4432.20220360335, 4440.0, 4464.0, 5769.1346298055205, 5902.2622172228475, 5965.254343207099, 5992.370801065869, 6060.33336333003, 5615.0, 5645.350784659776, 5648.717564121818, 5658.292713410824, 5680.11958146488, 6455.4835613150835, 6464.4828413727255, 6513.674316284167, 6530.93469065308, 6543.901841472381, 4577.313402989545, 4792.825757689388, 4829.5653391194965, 4847.0, 4848.248521479177, 6576.177977752781, 6620.503462240303, 6629.436497897685, 6712.731490740413, 6722.243880009173, 4914.8771280718265, 4923.87690307738, 4940.752962351868, 4952.8761780955765, 4960.363080183531, 4955.182394904872, 4977.178765503724, 4980.825671101494, 4985.775640096204, 4992.400911890524, 5527.55779537636, 5563.582731295088, 5608.214849921014, 5612.540739407784, 5640.210370548127, 6460.547761656733, 6490.448311893448, 6495.752123938031, 6576.671166441659, 6583.80248592543, 1719.819418960991, 1735.5661084728818, 1738.2004278031993, 1738.3307426640833, 1755.262789628359, 1124.6176300058019, 1189.1556994533978, 1191.7556900835482, 1204.145057009533, 1205.7950148474781, 5448.56411487088, 5457.263269458652, 5526.309211348582, 5551.167324901297, 5581.441855814467, 6505.349465053551, 6508.674566271668, 6543.574667646588, 6590.736370545221, 6594.901076483857, 5465.098258787256, 5503.862403439946, 5538.972305138448, 5545.833624991256, 5595.804146854841, 3410.641882602291, 3443.2080621456703, 3452.3095380923914, 3482.3905816482015, 3491.965080349164, 6105.618808664624, 6108.450239478469, 6264.404881536247, 6297.4017468340435, 6305.085762564402, 6529.444997175198, 6558.508111891531, 6613.603183808987, 6643.302453242437, 6716.697748601325, 6066.545009124334, 6255.593386429868, 6260.5617606768, 6268.056902360283, 6341.968290158612, 6318.368163183645, 6415.935840641534, 6425.293217745951, 6519.380658837403, 6592.340765923369, 5893.852653683693, 6349.777398030258, 6376.617402955838, 6423.775167869102, 6483.092367068709, 6083.870645274119, 6166.075088736546, 6237.75048998035, 6250.874982500233, 6252.155958945484, 4728.763561821964, 4781.713097214179, 4794.256890182028, 4835.58897493717, 4891.584215341736, 6189.195404597373, 6318.767840271103, 6322.652254125883, 6574.1453611032175, 6601.702923368556, 6236.844078897882, 6283.340249273943, 6302.684865756602, 6304.3380445054445, 6340.1440805490665, 6190.81427557174, 6348.175062097507, 6357.841053973688, 6384.936150638434, 6390.5526613136635, 6307.180066591497, 6318.526110541636, 6345.4923606112325, 6366.745330186741, 6413.775517856852, 6439.549231553746, 6453.870922581616, 6464.0, 6487.708053137526, 6501.284858665637, 6217.595856269328, 6259.906101408392, 6264.467520260829, 6285.717142728497, 6289.490522274713], "value": 4944.929417914436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.7172104926418, 906.6917248135635, 919.10387372312, 919.1865199298622, 930.8882934047915, 19037.0, 19668.70496942547, 19937.3021944232, 19987.200511979503, 20072.197112115497, 17857.374991875287, 17863.732044019318, 18095.366662166827, 18721.0, 18884.05579721012, 954.5465903695741, 964.1997142371814, 970.3644113105892, 972.6595691507987, 974.1816873825985, 973.2360097323602, 973.7760315127525, 975.5902520941222, 976.1848856205078, 976.5605477535103, 1009.0827427887036, 1026.6252817721552, 1029.6190409548478, 1032.5198782566106, 1043.1498328861992, 1028.4960369418968, 1030.8093002794508, 1031.8968103189695, 1037.341288281939, 1040.8802987656402, 726.1540305544034, 741.985160296791, 746.1941103608144, 751.4326683354033, 757.2994979643862, 20422.489437764027, 20496.897515512326, 20516.38450846477, 20536.486587835276, 20541.281055163, 18645.160967756347, 18675.066246687613, 18907.621847562972, 19280.61438771217, 19559.413217603495, 17302.56743581408, 17409.390671326444, 17537.0, 17544.91227543867, 17703.38038168658, 3733.383991641376, 3763.2849758546063, 3771.057235691077, 3773.4339849022867, 3775.263823554408, 138612.0, 140218.0, 140752.0, 141860.0, 143007.0, 16441.09573973443, 16469.34122635081, 16526.338946442007, 16676.082815445025, 16695.66608667844, 31468.685313147034, 32174.0, 32195.195120121716, 32979.3404131916, 33249.168770780925, 8522.360822938304, 8562.100979397199, 8693.0, 8710.12898710124, 8713.477191368538, 3892.9416058759143, 3959.2675355059405, 3959.7228194026143, 3966.147278335114, 4005.7796821175116, 5502.944970550243, 5543.473370029841, 5562.666240025531, 5598.972005139948, 5606.383297837235, 1010.6715317521835, 1026.5431882812227, 1036.7356324137297, 1037.1184493180735, 1049.5539395756925, 690.2890023276034, 708.1679027143086, 715.6922523315025, 716.9175544812309, 721.0783262605204, 11072.889271107348, 11686.88313116875, 11824.408779560987, 12726.363681815872, 12888.613341599766, 667.5660820466735, 670.7618795327686, 672.9461643068543, 690.8065741592362, 698.5145323999772, 5615.578831587647, 5645.717714114277, 5731.369549349568, 5776.42235776419, 5838.095095260242, 121417.0, 122433.38783306026, 124612.0, 124612.37693811655, 125873.0, 108242.45878770556, 109003.0, 109022.45488772505, 109643.0, 111703.0, 95352.52323738337, 96459.51770241105, 96494.51752741191, 96944.0305596949, 97668.0, 10215.846762298423, 10283.1490331741, 10310.381377117097, 10366.792664146826, 10618.36289822613, 43164.568354316056, 44879.551204487536, 45065.77467112643, 45168.77415612901, 45687.771561141984, 58449.12326315194, 60190.39809601848, 60588.0, 60781.69609151926, 61278.693606531684, 15377.769333459783, 15525.922370388076, 15560.688786224438, 15625.76561351558, 15814.130222837854, 16891.493255202364, 17025.14874256307, 17210.569735756708, 17356.739648905022, 17576.296948121933, 15094.094354338775, 15134.545963621109, 15235.3905843765, 15300.387984480496, 15316.770248446059, 14769.483068092564, 14870.405183792527, 14890.32993515316, 14943.850561494246, 14987.700245995236, 14751.262436878327, 15003.624909377353, 15069.47256846005, 15137.318820652878, 15169.165695886832, 11801.881981180079, 11872.76254474923, 12097.153199275966, 12148.696282593006, 12257.14200005991, 11609.30344179352, 11615.535378584762, 11819.11356648272, 11942.761144777229, 12109.515619375126], "value": 8898.021715337865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 109.0, 116.0, 115.0, 108.0, 106.0, 106.0, 107.0, 120.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 118.0, 116.0, 118.0, 115.0, 127.0, 152.0, 125.0, 120.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 163.0, 171.0, 168.0, 174.0, 164.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 83.0, 75.0, 79.0, 80.0, 74.0, 75.0, 75.0, 83.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 79.0, 84.0, 79.0, 87.0, 80.0, 85.0, 80.0, 79.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 113.0, 114.0, 115.0, 114.0, 111.0, 117.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 153.0, 148.0, 149.0, 148.0, 150.0, 153.0, 148.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 104.0, 95.0, 94.0, 102.0, 98.0, 96.0, 94.0, 95.0, 95.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 55.0, 57.0, 60.0, 56.0, 56.0, 55.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 43.0, 38.0, 47.0, 46.0, 47.0, 39.0, 43.0, 42.0], "value": 43.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 75.0, 84.0, 91.0, 82.0, 75.0, 82.0, 78.0, 81.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 113.0, 118.0, 117.0, 114.0, 120.0, 117.0, 111.0, 110.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 172.0, 177.0, 177.0, 171.0, 167.0, 172.0, 185.0, 189.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 63.0, 70.0, 65.0, 66.0, 69.0, 63.0, 65.0], "value": 66.8, "unit": "score"}]}]} 11:33:56 INFO - Return code: 0 11:33:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:56 INFO - # TBPL SUCCESS # 11:33:56 INFO - Running post-action listener: _package_coverage_data 11:33:56 INFO - Running post-action listener: _resource_record_post_action 11:33:56 INFO - [mozharness: 2017-09-16 18:33:56.436817Z] Finished run-tests step (success) 11:33:56 INFO - Running post-run listener: _resource_record_post_run 11:33:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 339017728; Read time: 16; Write time: 213256 11:33:56 INFO - TinderboxPrint: CPU usage
13.2% 11:33:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:33:56 INFO - TinderboxPrint: I/O write bytes / time
339,017,728 / 213,256 11:33:56 INFO - TinderboxPrint: CPU idle
8,239.4 (86.7%) 11:33:56 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 11:33:56 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9621504; Read time: 0; Write time: 780 11:33:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:33:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 328273920; Read time: 0; Write time: 212452 11:33:57 INFO - Running post-run listener: _upload_blobber_files 11:33:57 INFO - Blob upload gear active. 11:33:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:57 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 11:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:58 INFO - (blobuploader) - INFO - Done attempting. 11:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:59 INFO - (blobuploader) - INFO - Done attempting. 11:33:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:06 INFO - (blobuploader) - INFO - Done attempting. 11:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:07 INFO - (blobuploader) - INFO - Done attempting. 11:34:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:07 INFO - Return code: 0 11:34:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b11a5c4f7f41e77bea1451569514feb6486fd4dd1de2bf9dcd6a2e5ae30422a5127d50b92c76a4ec2ed880cc8b9dc6c518017942f1992aeaea4bb9f1a7b91b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2aefd1ba2e73708a868335d9ec2117af89375a33a0be541bc3000f446a80c0a0469cc684e4524a6619f3d38f2064366f5dbd359536d9e52c228cc670f4ef65", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d73bc35a7b44945d09851f8b33a5c38e342a60e64935694477488c80557df5cdbac6c7389a1f1569e58cccf7e05ec1efd83eb907163a96a61bd2f6871e9d4db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea198d4114d32ee07820d47efbb61b126d077f0f4864890631b6f14d35be83ef6fe8b0baab6687a4fe3de134582df95c605b4714264efc3bbe7cb14a850df8af"} 11:34:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:07 INFO - Contents: 11:34:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b11a5c4f7f41e77bea1451569514feb6486fd4dd1de2bf9dcd6a2e5ae30422a5127d50b92c76a4ec2ed880cc8b9dc6c518017942f1992aeaea4bb9f1a7b91b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2aefd1ba2e73708a868335d9ec2117af89375a33a0be541bc3000f446a80c0a0469cc684e4524a6619f3d38f2064366f5dbd359536d9e52c228cc670f4ef65", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d73bc35a7b44945d09851f8b33a5c38e342a60e64935694477488c80557df5cdbac6c7389a1f1569e58cccf7e05ec1efd83eb907163a96a61bd2f6871e9d4db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea198d4114d32ee07820d47efbb61b126d077f0f4864890631b6f14d35be83ef6fe8b0baab6687a4fe3de134582df95c605b4714264efc3bbe7cb14a850df8af"} 11:34:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:07 INFO - Copying logs to upload dir... 11:34:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.569943 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-16 11:34:08.050083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 11:34:08.053729) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b11a5c4f7f41e77bea1451569514feb6486fd4dd1de2bf9dcd6a2e5ae30422a5127d50b92c76a4ec2ed880cc8b9dc6c518017942f1992aeaea4bb9f1a7b91b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2aefd1ba2e73708a868335d9ec2117af89375a33a0be541bc3000f446a80c0a0469cc684e4524a6619f3d38f2064366f5dbd359536d9e52c228cc670f4ef65", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d73bc35a7b44945d09851f8b33a5c38e342a60e64935694477488c80557df5cdbac6c7389a1f1569e58cccf7e05ec1efd83eb907163a96a61bd2f6871e9d4db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea198d4114d32ee07820d47efbb61b126d077f0f4864890631b6f14d35be83ef6fe8b0baab6687a4fe3de134582df95c605b4714264efc3bbe7cb14a850df8af"} build_url:https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011695 build_url: 'https://queue.taskcluster.net/v1/task/MWFstPgVRxqTsnauXlFVFQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35b11a5c4f7f41e77bea1451569514feb6486fd4dd1de2bf9dcd6a2e5ae30422a5127d50b92c76a4ec2ed880cc8b9dc6c518017942f1992aeaea4bb9f1a7b91b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2aefd1ba2e73708a868335d9ec2117af89375a33a0be541bc3000f446a80c0a0469cc684e4524a6619f3d38f2064366f5dbd359536d9e52c228cc670f4ef65", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d73bc35a7b44945d09851f8b33a5c38e342a60e64935694477488c80557df5cdbac6c7389a1f1569e58cccf7e05ec1efd83eb907163a96a61bd2f6871e9d4db", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea198d4114d32ee07820d47efbb61b126d077f0f4864890631b6f14d35be83ef6fe8b0baab6687a4fe3de134582df95c605b4714264efc3bbe7cb14a850df8af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 11:34:08.084049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:34:08.084380) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1505583849.337926-233883224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:34:08.138110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 11:34:08.140456) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 11:34:08.140768) ========= ========= Total master_lag: 0.22 =========