builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-009 starttime: 1505502330.4 results: success (0) revision: 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.399959) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.400392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.400677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.454877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.455262) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 12:05:30-- 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% 41.6M=0s 2017-09-15 12:05:30 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.855562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.855905) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019897 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.919351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:30.919686) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 --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 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 --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=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 12:05:30,973 truncating revision to first 12 chars 2017-09-15 12:05:30,973 Setting DEBUG logging. 2017-09-15 12:05:30,973 attempt 1/10 2017-09-15 12:05:30,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31992a5c3d64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 12:05:31,343 unpacking tar archive at: mozilla-central-31992a5c3d64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:31.615208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:31.615532) ========= script_repo_revision: 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:31.615920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:31.616191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 12:05:31.629910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-15 12:05:31.630296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:31 INFO - MultiFileLogger online at 20170915 12:05:31 in /builds/slave/test 12:05:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:05:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:05:31 INFO - {'append_to_log': False, 12:05:31 INFO - 'base_work_dir': '/builds/slave/test', 12:05:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:05:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:05:31 INFO - 'branch': 'Firefox-Non-PGO', 12:05:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:31 INFO - 'code_coverage': False, 12:05:31 INFO - 'config_files': ('talos/linux_config.py',), 12:05:31 INFO - 'default_actions': ('clobber', 12:05:31 INFO - 'read-buildbot-config', 12:05:31 INFO - 'download-and-extract', 12:05:31 INFO - 'populate-webroot', 12:05:31 INFO - 'create-virtualenv', 12:05:31 INFO - 'install', 12:05:31 INFO - 'setup-mitmproxy', 12:05:31 INFO - 'run-tests'), 12:05:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:31 INFO - 'disable_ccov_upload': False, 12:05:31 INFO - 'disable_stylo': False, 12:05:31 INFO - 'download_minidump_stackwalk': True, 12:05:31 INFO - 'download_symbols': 'ondemand', 12:05:31 INFO - 'enable_stylo': False, 12:05:31 INFO - 'enable_webrender': False, 12:05:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:05:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:31 INFO - 'gecko_profile': False, 12:05:31 INFO - 'gecko_profile_interval': 0, 12:05:31 INFO - 'installer_path': 'installer.exe', 12:05:31 INFO - 'log_level': 'info', 12:05:31 INFO - 'log_name': 'talos', 12:05:31 INFO - 'log_to_console': True, 12:05:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:31 INFO - 'opt_config_files': (), 12:05:31 INFO - 'pip_index': False, 12:05:31 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:05:31 INFO - 'system_bits': '32', 12:05:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:31 INFO - 'title': 'talos-linux64-ix-009', 12:05:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:31 INFO - 'use_talos_json': True, 12:05:31 INFO - 'verify': 'False', 12:05:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:05:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:31 INFO - 'work_dir': 'build'} 12:05:31 INFO - [mozharness: 2017-09-15 19:05:31.818019Z] Running clobber step. 12:05:31 INFO - Running pre-action listener: _resource_record_pre_action 12:05:31 INFO - Running main action method: clobber 12:05:31 INFO - rmtree: /builds/slave/test/build 12:05:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:05:32 INFO - Running post-action listener: _resource_record_post_action 12:05:32 INFO - [mozharness: 2017-09-15 19:05:32.813923Z] Finished clobber step (success) 12:05:32 INFO - [mozharness: 2017-09-15 19:05:32.814032Z] Running read-buildbot-config step. 12:05:32 INFO - Running pre-action listener: _resource_record_pre_action 12:05:32 INFO - Running main action method: read_buildbot_config 12:05:32 INFO - Using buildbot properties: 12:05:32 INFO - { 12:05:32 INFO - "project": "", 12:05:32 INFO - "product": "firefox", 12:05:32 INFO - "who": "ryanvm@gmail.com", 12:05:32 INFO - "installer_path": "public/build/target.tar.bz2", 12:05:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:05:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:05:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 12:05:32 INFO - "stage_platform": "linux64", 12:05:32 INFO - "basedir": "/builds/slave/test", 12:05:32 INFO - "buildnumber": 23, 12:05:32 INFO - "platform": "ubuntu64_hw", 12:05:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:05:32 INFO - "slavebuilddir": "test", 12:05:32 INFO - "taskId": "f7_RWoskSVOW7nskQEZ4Cg", 12:05:32 INFO - "branch": "mozilla-central", 12:05:32 INFO - "script_repo_revision": "production", 12:05:32 INFO - "revision": "31992a5c3d64ade078accdaab8ac4ffb5e43a9d7", 12:05:32 INFO - "slavename": "talos-linux64-ix-009", 12:05:32 INFO - "repo_path": "mozilla-central" 12:05:32 INFO - } 12:05:32 INFO - Finding installer, test and symbols from parent task. 12:05:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7_RWoskSVOW7nskQEZ4Cg'}, attempt #1 12:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7_RWoskSVOW7nskQEZ4Cg'}, attempt #1 12:05:33 INFO - Task dependencies: fA4-U6SkTAuYHvLWxXHwTQ 12:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ'}, attempt #1 12:05:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 12:05:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.test_packages.json 12:05:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.crashreporter-symbols.zip 12:05:34 INFO - Running post-action listener: _resource_record_post_action 12:05:34 INFO - [mozharness: 2017-09-15 19:05:34.298505Z] Finished read-buildbot-config step (success) 12:05:34 INFO - [mozharness: 2017-09-15 19:05:34.298721Z] Running download-and-extract step. 12:05:34 INFO - Running pre-action listener: _resource_record_pre_action 12:05:34 INFO - Running main action method: download_and_extract 12:05:34 INFO - mkdir: /builds/slave/test/build/tests 12:05:34 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')]} 12:05:34 INFO - trying https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.test_packages.json 12:05:34 INFO - Downloading https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:05:35 INFO - Downloaded 989 bytes. 12:05:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:05:35 INFO - Using the following test package requirements: 12:05:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:05:35 INFO - u'common': [u'target.common.tests.zip'], 12:05:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:05:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:05:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:05:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:05:35 INFO - u'mozbase': [u'target.common.tests.zip'], 12:05:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:05:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:05:35 INFO - u'web-platform': [u'target.common.tests.zip', 12:05:35 INFO - u'target.web-platform.tests.tar.gz'], 12:05:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:05:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:05:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.common.tests.zip 12:05:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:05:35 INFO - Fetch https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.common.tests.zip into memory 12:05:36 INFO - Content-Length response header: 54734997 12:05:36 INFO - Bytes received: 54734997 12:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.talos.tests.zip 12:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.talos.tests.zip into memory 12:05:48 INFO - Content-Length response header: 14508749 12:05:48 INFO - Bytes received: 14508749 12:05:48 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')]} 12:05:48 INFO - trying https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 12:05:48 INFO - Downloading https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:05:49 INFO - Downloaded 61472732 bytes. 12:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 12:05:49 INFO - mkdir: /builds/slave/test/properties 12:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 12:05:49 INFO - Contents: 12:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 12:05:49 INFO - Running post-action listener: _resource_record_post_action 12:05:49 INFO - Running post-action listener: find_tests_for_verification 12:05:49 INFO - Running post-action listener: set_extra_try_arguments 12:05:49 INFO - [mozharness: 2017-09-15 19:05:49.608997Z] Finished download-and-extract step (success) 12:05:49 INFO - [mozharness: 2017-09-15 19:05:49.609092Z] Running populate-webroot step. 12:05:49 INFO - Running pre-action listener: _resource_record_pre_action 12:05:49 INFO - Running main action method: populate_webroot 12:05:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:05:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['tresize', 12:05:49 INFO - 'tcanvasmark']}, 12:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:05:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['dromaeo_css', 12:05:49 INFO - 'kraken']}, 12:05:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'tests': ['damp', 'tps']}, 12:05:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['damp', 'tps']}, 12:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['dromaeo_dom']}, 12:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:05:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['basic_compositor_video', 12:05:49 INFO - 'glvideo']}, 12:05:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:05:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['ts_paint_webext', 12:05:49 INFO - 'tp5o_webext']}, 12:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 12:05:49 INFO - 'ts_paint', 12:05:49 INFO - 'tpaint', 12:05:49 INFO - 'sessionrestore', 12:05:49 INFO - 'sessionrestore_many_windows', 12:05:49 INFO - 'sessionrestore_no_auto_restore', 12:05:49 INFO - 'tabpaint']}, 12:05:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['a11yr', 12:05:49 INFO - 'ts_paint', 12:05:49 INFO - 'tpaint', 12:05:49 INFO - 'sessionrestore', 12:05:49 INFO - 'sessionrestore_many_windows', 12:05:49 INFO - 'sessionrestore_no_auto_restore', 12:05:49 INFO - 'tabpaint']}, 12:05:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:05:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:05:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['perf_reftest_singletons']}, 12:05:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['bloom_basic']}, 12:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:05:49 INFO - 'tsvgr_opacity', 12:05:49 INFO - 'tart', 12:05:49 INFO - 'tscrollx', 12:05:49 INFO - 'tsvg_static']}, 12:05:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['tsvgx', 12:05:49 INFO - 'tsvgr_opacity', 12:05:49 INFO - 'tart', 12:05:49 INFO - 'tscrollx', 12:05:49 INFO - 'tsvg_static']}, 12:05:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:05:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo'], 12:05:49 INFO - 'tests': ['tp5o']}, 12:05:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:49 INFO - 'talos_options': ['--mitmproxy', 12:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:49 INFO - '--firstNonBlankPaint'], 12:05:49 INFO - 'tests': ['tp6_google', 12:05:49 INFO - 'tp6_youtube', 12:05:49 INFO - 'tp6_amazon', 12:05:49 INFO - 'tp6_facebook']}, 12:05:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo', 12:05:49 INFO - '--mitmproxy', 12:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:49 INFO - '--firstNonBlankPaint'], 12:05:49 INFO - 'tests': ['tp6_google', 12:05:49 INFO - 'tp6_youtube', 12:05:49 INFO - 'tp6_amazon', 12:05:49 INFO - 'tp6_facebook']}, 12:05:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:05:49 INFO - 'talos_options': ['--stylo-threads=1', 12:05:49 INFO - '--mitmproxy', 12:05:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:05:49 INFO - '--firstNonBlankPaint'], 12:05:49 INFO - 'tests': ['tp6_google', 12:05:49 INFO - 'tp6_youtube', 12:05:49 INFO - 'tp6_amazon', 12:05:49 INFO - 'tp6_facebook']}, 12:05:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--xperf_path', 12:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:49 INFO - 'tests': ['tp5n']}, 12:05:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:05:49 INFO - 'talos_options': ['--disable-stylo', 12:05:49 INFO - '--xperf_path', 12:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:49 INFO - 'tests': ['tp5n']}}} 12:05:49 INFO - Running post-action listener: _resource_record_post_action 12:05:49 INFO - [mozharness: 2017-09-15 19:05:49.624034Z] Finished populate-webroot step (success) 12:05:49 INFO - [mozharness: 2017-09-15 19:05:49.624123Z] Running create-virtualenv step. 12:05:49 INFO - Running pre-action listener: _resource_record_pre_action 12:05:49 INFO - Running main action method: create_virtualenv 12:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:05:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:05:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:05:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 12:05:51 INFO - Installing pip...............done. 12:05:51 INFO - Return code: 0 12:05:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:05:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:05:51 INFO - Reading from file tmpfile_stdout 12:05:51 INFO - Output received: 12:05:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:05:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:51 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:05:51 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 12:05:51 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 12:05:51 INFO - Using env: {'DISPLAY': ':0', 12:05:51 INFO - 'HOME': '/home/cltbld', 12:05:51 INFO - 'LANG': 'en_US.UTF-8', 12:05:51 INFO - 'LANGUAGE': 'en_US:en', 12:05:51 INFO - 'LOGNAME': 'cltbld', 12:05:51 INFO - 'MAIL': '/var/mail/cltbld', 12:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:51 INFO - 'MOZ_NO_REMOTE': '1', 12:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:51 INFO - 'NO_EM_RESTART': '1', 12:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:51 INFO - 'PWD': '/builds/slave/test', 12:05:51 INFO - 'SHELL': '/bin/bash', 12:05:51 INFO - 'SHLVL': '1', 12:05:51 INFO - 'TERM': 'linux', 12:05:51 INFO - 'TMOUT': '86400', 12:05:51 INFO - 'USER': 'cltbld', 12:05:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:51 INFO - '_': '/tools/buildbot/bin/python'} 12:05:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:05:52 INFO - Downloading/unpacking pip>=1.5 12:05:52 INFO - Running setup.py egg_info for package pip 12:05:52 INFO - warning: no files found matching 'pip/cacert.pem' 12:05:52 INFO - warning: no files found matching '*.html' under directory 'docs' 12:05:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:05:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:05:52 INFO - Installing collected packages: pip 12:05:52 INFO - Found existing installation: pip 1.1 12:05:52 INFO - Uninstalling pip: 12:05:52 INFO - Successfully uninstalled pip 12:05:52 INFO - Running setup.py install for pip 12:05:52 INFO - warning: no files found matching 'pip/cacert.pem' 12:05:52 INFO - warning: no files found matching '*.html' under directory 'docs' 12:05:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:05:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:05:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:05:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:05:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:05:52 INFO - Successfully installed pip 12:05:52 INFO - Cleaning up... 12:05:52 INFO - Return code: 0 12:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:05: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')]} 12:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05: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')]} 12:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:53 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:05:53 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 12:05:53 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 12:05:53 INFO - Using env: {'DISPLAY': ':0', 12:05:53 INFO - 'HOME': '/home/cltbld', 12:05:53 INFO - 'LANG': 'en_US.UTF-8', 12:05:53 INFO - 'LANGUAGE': 'en_US:en', 12:05:53 INFO - 'LOGNAME': 'cltbld', 12:05:53 INFO - 'MAIL': '/var/mail/cltbld', 12:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:53 INFO - 'MOZ_NO_REMOTE': '1', 12:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:53 INFO - 'NO_EM_RESTART': '1', 12:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:53 INFO - 'PWD': '/builds/slave/test', 12:05:53 INFO - 'SHELL': '/bin/bash', 12:05:53 INFO - 'SHLVL': '1', 12:05:53 INFO - 'TERM': 'linux', 12:05:53 INFO - 'TMOUT': '86400', 12:05:53 INFO - 'USER': 'cltbld', 12:05:53 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:53 INFO - '_': '/tools/buildbot/bin/python'} 12:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:53 INFO - Downloading/unpacking psutil>=3.1.1 12:05: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 12:05: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 12:05: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 12:05: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 12:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:54 INFO - Installing collected packages: psutil 12:05:54 INFO - Running setup.py install for psutil 12:05:54 INFO - building 'psutil._psutil_linux' extension 12:05:54 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 12:05:54 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 12:05:54 INFO - building 'psutil._psutil_posix' extension 12:05:54 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 12:05:54 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 12:05:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:05:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:05:54 INFO - Successfully installed psutil 12:05:54 INFO - Cleaning up... 12:05:54 INFO - Return code: 0 12:05:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:05:54 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')]} 12:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:54 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')]} 12:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:54 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:05:54 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 12:05:54 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 12:05:54 INFO - Using env: {'DISPLAY': ':0', 12:05:54 INFO - 'HOME': '/home/cltbld', 12:05:54 INFO - 'LANG': 'en_US.UTF-8', 12:05:54 INFO - 'LANGUAGE': 'en_US:en', 12:05:54 INFO - 'LOGNAME': 'cltbld', 12:05:54 INFO - 'MAIL': '/var/mail/cltbld', 12:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:54 INFO - 'MOZ_NO_REMOTE': '1', 12:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:54 INFO - 'NO_EM_RESTART': '1', 12:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:54 INFO - 'PWD': '/builds/slave/test', 12:05:54 INFO - 'SHELL': '/bin/bash', 12:05:54 INFO - 'SHLVL': '1', 12:05:54 INFO - 'TERM': 'linux', 12:05:54 INFO - 'TMOUT': '86400', 12:05:54 INFO - 'USER': 'cltbld', 12:05:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:54 INFO - '_': '/tools/buildbot/bin/python'} 12:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:05:55 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 12:05:55 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 12:05:55 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 12:05:55 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 12:05:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:05:56 INFO - Installing collected packages: mozsystemmonitor 12:05:56 INFO - Running setup.py install for mozsystemmonitor 12:05:56 INFO - Successfully installed mozsystemmonitor 12:05:56 INFO - Cleaning up... 12:05:57 INFO - Return code: 0 12:05:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:05:57 INFO - Using env: {'DISPLAY': ':0', 12:05:57 INFO - 'HOME': '/home/cltbld', 12:05:57 INFO - 'LANG': 'en_US.UTF-8', 12:05:57 INFO - 'LANGUAGE': 'en_US:en', 12:05:57 INFO - 'LOGNAME': 'cltbld', 12:05:57 INFO - 'MAIL': '/var/mail/cltbld', 12:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:05:57 INFO - 'MOZ_NO_REMOTE': '1', 12:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:05:57 INFO - 'NO_EM_RESTART': '1', 12:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:05:57 INFO - 'PWD': '/builds/slave/test', 12:05:57 INFO - 'SHELL': '/bin/bash', 12:05:57 INFO - 'SHLVL': '1', 12:05:57 INFO - 'TERM': 'linux', 12:05:57 INFO - 'TMOUT': '86400', 12:05:57 INFO - 'USER': 'cltbld', 12:05:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:05:57 INFO - '_': '/tools/buildbot/bin/python'} 12:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:05:58 INFO - Downloading/unpacking jsonschema==2.5.1 12:05:58 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 12:05:58 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 12:05:58 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 12:05:58 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 12:05:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:05:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:05:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 12:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:05:59 INFO - warning: no files found matching '*.txt' 12:05:59 INFO - no previously-included directories found matching 'build' 12:05:59 INFO - no previously-included directories found matching 'dist' 12:05:59 INFO - no previously-included directories found matching '.git*' 12:05:59 INFO - Installing collected packages: jsonschema, functools32 12:05:59 INFO - Running setup.py install for functools32 12:06:00 INFO - warning: no files found matching '*.txt' 12:06:00 INFO - no previously-included directories found matching 'build' 12:06:00 INFO - no previously-included directories found matching 'dist' 12:06:00 INFO - no previously-included directories found matching '.git*' 12:06:00 INFO - Successfully installed jsonschema functools32 12:06:00 INFO - Cleaning up... 12:06:00 INFO - Return code: 0 12:06:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:00 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:00 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 12:06:00 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 12:06:00 INFO - Using env: {'DISPLAY': ':0', 12:06:00 INFO - 'HOME': '/home/cltbld', 12:06:00 INFO - 'LANG': 'en_US.UTF-8', 12:06:00 INFO - 'LANGUAGE': 'en_US:en', 12:06:00 INFO - 'LOGNAME': 'cltbld', 12:06:00 INFO - 'MAIL': '/var/mail/cltbld', 12:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:00 INFO - 'MOZ_NO_REMOTE': '1', 12:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:00 INFO - 'NO_EM_RESTART': '1', 12:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:00 INFO - 'PWD': '/builds/slave/test', 12:06:00 INFO - 'SHELL': '/bin/bash', 12:06:00 INFO - 'SHLVL': '1', 12:06:00 INFO - 'TERM': 'linux', 12:06:00 INFO - 'TMOUT': '86400', 12:06:00 INFO - 'USER': 'cltbld', 12:06:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:00 INFO - '_': '/tools/buildbot/bin/python'} 12:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:06:00 INFO - Cleaning up... 12:06:00 INFO - Return code: 0 12:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:00 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:00 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 12:06:00 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 12:06:00 INFO - Using env: {'DISPLAY': ':0', 12:06:00 INFO - 'HOME': '/home/cltbld', 12:06:00 INFO - 'LANG': 'en_US.UTF-8', 12:06:00 INFO - 'LANGUAGE': 'en_US:en', 12:06:00 INFO - 'LOGNAME': 'cltbld', 12:06:00 INFO - 'MAIL': '/var/mail/cltbld', 12:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:00 INFO - 'MOZ_NO_REMOTE': '1', 12:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:00 INFO - 'NO_EM_RESTART': '1', 12:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:00 INFO - 'PWD': '/builds/slave/test', 12:06:00 INFO - 'SHELL': '/bin/bash', 12:06:00 INFO - 'SHLVL': '1', 12:06:00 INFO - 'TERM': 'linux', 12:06:00 INFO - 'TMOUT': '86400', 12:06:00 INFO - 'USER': 'cltbld', 12:06:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:00 INFO - '_': '/tools/buildbot/bin/python'} 12:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:06: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 12:06: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 12:06: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 12:06: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 12:06:01 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06: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 12:06: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 12:06: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 12:06: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 12:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:02 INFO - Downloading docopt-0.6.1.tar.gz 12:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:02 INFO - Running setup.py install for blobuploader 12:06:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:02 INFO - Running setup.py install for requests 12:06:02 INFO - Running setup.py install for docopt 12:06:02 INFO - Successfully installed blobuploader requests docopt 12:06:02 INFO - Cleaning up... 12:06:02 INFO - Return code: 0 12:06:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:02 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:02 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 12:06:02 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 12:06:02 INFO - Using env: {'DISPLAY': ':0', 12:06:02 INFO - 'HOME': '/home/cltbld', 12:06:02 INFO - 'LANG': 'en_US.UTF-8', 12:06:02 INFO - 'LANGUAGE': 'en_US:en', 12:06:02 INFO - 'LOGNAME': 'cltbld', 12:06:02 INFO - 'MAIL': '/var/mail/cltbld', 12:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:02 INFO - 'MOZ_NO_REMOTE': '1', 12:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:02 INFO - 'NO_EM_RESTART': '1', 12:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:02 INFO - 'PWD': '/builds/slave/test', 12:06:02 INFO - 'SHELL': '/bin/bash', 12:06:02 INFO - 'SHLVL': '1', 12:06:02 INFO - 'TERM': 'linux', 12:06:02 INFO - 'TMOUT': '86400', 12:06:02 INFO - 'USER': 'cltbld', 12:06:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:02 INFO - '_': '/tools/buildbot/bin/python'} 12:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:03 INFO - Running setup.py (path:/tmp/pip-m6g0OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:03 INFO - Running setup.py (path:/tmp/pip-RFdC1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:03 INFO - Running setup.py (path:/tmp/pip-hxVnai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:03 INFO - Running setup.py (path:/tmp/pip-SnBYGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:03 INFO - Running setup.py (path:/tmp/pip-1kuWxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:03 INFO - Running setup.py (path:/tmp/pip-msrAV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:03 INFO - Running setup.py (path:/tmp/pip-w1Fqvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:03 INFO - Running setup.py (path:/tmp/pip-OANDBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:03 INFO - Running setup.py (path:/tmp/pip-xk5MiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:03 INFO - Running setup.py (path:/tmp/pip-QptI91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:03 INFO - Running setup.py (path:/tmp/pip-yfX5jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:03 INFO - Running setup.py (path:/tmp/pip-KUh8g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:03 INFO - Running setup.py (path:/tmp/pip-2trxKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:04 INFO - Running setup.py (path:/tmp/pip-UJVmba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:04 INFO - Running setup.py (path:/tmp/pip-1tij1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:04 INFO - Running setup.py (path:/tmp/pip-_PLvpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:04 INFO - Running setup.py (path:/tmp/pip-_TVbxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:04 INFO - Running setup.py install for manifestparser 12:06:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:04 INFO - Running setup.py install for mozcrash 12:06:04 INFO - Running setup.py install for mozdebug 12:06:04 INFO - Running setup.py install for mozdevice 12:06:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:04 INFO - Running setup.py install for mozfile 12:06:04 INFO - Running setup.py install for mozhttpd 12:06:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:04 INFO - Running setup.py install for mozinfo 12:06:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:04 INFO - Running setup.py install for mozInstall 12:06:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Running setup.py install for mozleak 12:06:05 INFO - Running setup.py install for mozlog 12:06:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Running setup.py install for moznetwork 12:06:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Running setup.py install for mozprocess 12:06:05 INFO - Running setup.py install for mozprofile 12:06:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Running setup.py install for mozrunner 12:06:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:05 INFO - Running setup.py install for mozscreenshot 12:06:05 INFO - Running setup.py install for moztest 12:06:05 INFO - Running setup.py install for mozversion 12:06:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:06 INFO - Cleaning up... 12:06:06 INFO - Return code: 0 12:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:06 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')]} 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:06 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')]} 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:06 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:06 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 12:06:06 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 12:06:06 INFO - Using env: {'DISPLAY': ':0', 12:06:06 INFO - 'HOME': '/home/cltbld', 12:06:06 INFO - 'LANG': 'en_US.UTF-8', 12:06:06 INFO - 'LANGUAGE': 'en_US:en', 12:06:06 INFO - 'LOGNAME': 'cltbld', 12:06:06 INFO - 'MAIL': '/var/mail/cltbld', 12:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:06 INFO - 'MOZ_NO_REMOTE': '1', 12:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:06 INFO - 'NO_EM_RESTART': '1', 12:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:06 INFO - 'PWD': '/builds/slave/test', 12:06:06 INFO - 'SHELL': '/bin/bash', 12:06:06 INFO - 'SHLVL': '1', 12:06:06 INFO - 'TERM': 'linux', 12:06:06 INFO - 'TMOUT': '86400', 12:06:06 INFO - 'USER': 'cltbld', 12:06:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:06 INFO - '_': '/tools/buildbot/bin/python'} 12:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:06 INFO - Running setup.py (path:/tmp/pip-TTs1Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:06 INFO - Running setup.py (path:/tmp/pip-26l9Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:06 INFO - Running setup.py (path:/tmp/pip-5AAFKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:06 INFO - Running setup.py (path:/tmp/pip-6yzYbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:06 INFO - Running setup.py (path:/tmp/pip-mb_H_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:06 INFO - Running setup.py (path:/tmp/pip-9L4SxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:06 INFO - Running setup.py (path:/tmp/pip-xRsCik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:06 INFO - Running setup.py (path:/tmp/pip-msMvDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:06 INFO - Running setup.py (path:/tmp/pip-PHQZVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:06 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)) 12:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:06 INFO - Running setup.py (path:/tmp/pip-cuZ6CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:07 INFO - Running setup.py (path:/tmp/pip-Js0bjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:07 INFO - Running setup.py (path:/tmp/pip-0U_NSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:07 INFO - Running setup.py (path:/tmp/pip-GFKzeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:07 INFO - Running setup.py (path:/tmp/pip-h3Y3p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:07 INFO - Running setup.py (path:/tmp/pip-LONgyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:07 INFO - Running setup.py (path:/tmp/pip-WC2z7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:07 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)) 12:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:07 INFO - Running setup.py (path:/tmp/pip-TLU6sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 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)) 12:06:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:07 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 12:06:07 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 12:06:07 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 12:06:07 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 12:06:08 INFO - Downloading blessings-1.6.tar.gz 12:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:08 INFO - Installing collected packages: blessings 12:06:08 INFO - Running setup.py install for blessings 12:06:08 INFO - Successfully installed blessings 12:06:08 INFO - Cleaning up... 12:06:08 INFO - Return code: 0 12:06:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:09 INFO - Reading from file tmpfile_stdout 12:06:09 INFO - Current package versions: 12:06:09 INFO - argparse == 1.2.1 12:06:09 INFO - blessings == 1.6 12:06:09 INFO - blobuploader == 1.2.4 12:06:09 INFO - docopt == 0.6.1 12:06:09 INFO - functools32 == 3.2.3-2 12:06:09 INFO - jsonschema == 2.5.1 12:06:09 INFO - manifestparser == 1.1 12:06:09 INFO - mozInstall == 1.13 12:06:09 INFO - mozcrash == 1.0 12:06:09 INFO - mozdebug == 0.1 12:06:09 INFO - mozdevice == 0.51 12:06:09 INFO - mozfile == 1.2 12:06:09 INFO - mozhttpd == 0.7 12:06:09 INFO - mozinfo == 0.10 12:06:09 INFO - mozleak == 0.1 12:06:09 INFO - mozlog == 3.5 12:06:09 INFO - moznetwork == 0.27 12:06:09 INFO - mozprocess == 0.25 12:06:09 INFO - mozprofile == 0.28 12:06:09 INFO - mozrunner == 6.13 12:06:09 INFO - mozscreenshot == 0.1 12:06:09 INFO - mozsystemmonitor == 0.3 12:06:09 INFO - moztest == 0.8 12:06:09 INFO - mozversion == 1.4 12:06:09 INFO - psutil == 3.1.1 12:06:09 INFO - requests == 1.2.3 12:06:09 INFO - wsgiref == 0.1.2 12:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:09 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')]} 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:09 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')]} 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:09 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 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:09 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 12:06:09 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 12:06:09 INFO - Using env: {'DISPLAY': ':0', 12:06:09 INFO - 'HOME': '/home/cltbld', 12:06:09 INFO - 'LANG': 'en_US.UTF-8', 12:06:09 INFO - 'LANGUAGE': 'en_US:en', 12:06:09 INFO - 'LOGNAME': 'cltbld', 12:06:09 INFO - 'MAIL': '/var/mail/cltbld', 12:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:09 INFO - 'MOZ_NO_REMOTE': '1', 12:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:09 INFO - 'NO_EM_RESTART': '1', 12:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:09 INFO - 'PWD': '/builds/slave/test', 12:06:09 INFO - 'SHELL': '/bin/bash', 12:06:09 INFO - 'SHLVL': '1', 12:06:09 INFO - 'TERM': 'linux', 12:06:09 INFO - 'TMOUT': '86400', 12:06:09 INFO - 'USER': 'cltbld', 12:06:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:09 INFO - '_': '/tools/buildbot/bin/python'} 12:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 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)) 12:06:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:06:10 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)) 12:06:10 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)) 12:06:10 INFO - Installing collected packages: simplejson 12:06:10 INFO - Running setup.py install for simplejson 12:06:10 INFO - building 'simplejson._speedups' extension 12:06:10 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 12:06:11 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 12:06:11 INFO - Successfully installed simplejson 12:06:11 INFO - Cleaning up... 12:06:11 INFO - Return code: 0 12:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, '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': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', '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 12:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:06:11 INFO - Using env: {'DISPLAY': ':0', 12:06:11 INFO - 'HOME': '/home/cltbld', 12:06:11 INFO - 'LANG': 'en_US.UTF-8', 12:06:11 INFO - 'LANGUAGE': 'en_US:en', 12:06:11 INFO - 'LOGNAME': 'cltbld', 12:06:11 INFO - 'MAIL': '/var/mail/cltbld', 12:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:11 INFO - 'MOZ_NO_REMOTE': '1', 12:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:11 INFO - 'NO_EM_RESTART': '1', 12:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:11 INFO - 'PWD': '/builds/slave/test', 12:06:11 INFO - 'SHELL': '/bin/bash', 12:06:11 INFO - 'SHLVL': '1', 12:06:11 INFO - 'TERM': 'linux', 12:06:11 INFO - 'TMOUT': '86400', 12:06:11 INFO - 'USER': 'cltbld', 12:06:11 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:11 INFO - '_': '/tools/buildbot/bin/python'} 12:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:06:11 INFO - Cleaning up... 12:06:11 INFO - Return code: 0 12:06:11 INFO - Running post-action listener: _resource_record_post_action 12:06:11 INFO - Running post-action listener: _start_resource_monitoring 12:06:11 INFO - Starting resource monitoring. 12:06:11 INFO - [mozharness: 2017-09-15 19:06:11.807739Z] Finished create-virtualenv step (success) 12:06:11 INFO - [mozharness: 2017-09-15 19:06:11.808206Z] Running install step. 12:06:11 INFO - Running pre-action listener: _resource_record_pre_action 12:06:11 INFO - Running main action method: install 12:06:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:12 INFO - Reading from file tmpfile_stdout 12:06:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:12 INFO - Reading from file tmpfile_stdout 12:06:12 INFO - Output received: 12:06:12 INFO - Usage: mozinstall [options] installer 12:06:12 INFO - Options: 12:06:12 INFO - -h, --help show this help message and exit 12:06:12 INFO - -d DEST, --destination=DEST 12:06:12 INFO - Directory to install application into. [default: 12:06:12 INFO - "/builds/slave/test"] 12:06:12 INFO - --app=APP Application being installed. [default: firefox] 12:06:12 INFO - mkdir: /builds/slave/test/build/application 12:06:12 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'] 12:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:06:29 INFO - Reading from file tmpfile_stdout 12:06:29 INFO - Output received: 12:06:29 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:29 INFO - Running post-action listener: _resource_record_post_action 12:06:29 INFO - [mozharness: 2017-09-15 19:06:29.914209Z] Finished install step (success) 12:06:29 INFO - [mozharness: 2017-09-15 19:06:29.914462Z] Running setup-mitmproxy step. 12:06:29 INFO - Running pre-action listener: _resource_record_pre_action 12:06:29 INFO - Running main action method: setup_mitmproxy 12:06:29 INFO - Skipping: mitmproxy is not required 12:06:29 INFO - Running post-action listener: _resource_record_post_action 12:06:29 INFO - [mozharness: 2017-09-15 19:06:29.915585Z] Finished setup-mitmproxy step (success) 12:06:29 INFO - [mozharness: 2017-09-15 19:06:29.915804Z] Running run-tests step. 12:06:29 INFO - Running pre-action listener: _resource_record_pre_action 12:06:29 INFO - Running pre-action listener: _set_gcov_prefix 12:06:29 INFO - Running main action method: run_tests 12:06:29 WARNING - Try message not found. 12:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:29 INFO - Python 2.7.3 12:06:29 INFO - Return code: 0 12:06:29 INFO - grabbing minidump binary from tooltool 12:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:06:29 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 0x2452090>, '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 0x2452d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:29 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 12:06:29 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 12:06:29 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 12:06:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:30 INFO - Return code: 0 12:06:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:30 INFO - ENV: RUST_BACKTRACE is now full 12:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:06:30 INFO - Using env: {'DISPLAY': ':0', 12:06:30 INFO - 'HOME': '/home/cltbld', 12:06:30 INFO - 'LANG': 'en_US.UTF-8', 12:06:30 INFO - 'LANGUAGE': 'en_US:en', 12:06:30 INFO - 'LOGNAME': 'cltbld', 12:06:30 INFO - 'MAIL': '/var/mail/cltbld', 12:06:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:30 INFO - 'MOZ_NO_REMOTE': '1', 12:06:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:30 INFO - 'NO_EM_RESTART': '1', 12:06:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:30 INFO - 'PWD': '/builds/slave/test', 12:06:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:30 INFO - 'RUST_BACKTRACE': 'full', 12:06:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:06:30 INFO - 'SHELL': '/bin/bash', 12:06:30 INFO - 'SHLVL': '1', 12:06:30 INFO - 'TERM': 'linux', 12:06:30 INFO - 'TMOUT': '86400', 12:06:30 INFO - 'USER': 'cltbld', 12:06:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:30 INFO - '_': '/tools/buildbot/bin/python'} 12:06:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:06:30 INFO - mozversion application_buildid: 20170915181541 12:06:30 INFO - mozversion application_changeset: 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 12:06:30 INFO - mozversion application_display_name: Nightly 12:06:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:30 INFO - mozversion application_name: Firefox 12:06:30 INFO - mozversion application_remotingname: firefox 12:06:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:06:30 INFO - mozversion application_vendor: Mozilla 12:06:30 INFO - mozversion application_version: 57.0a1 12:06:30 INFO - mozversion platform_buildid: 20170915181541 12:06:30 INFO - mozversion platform_changeset: 31992a5c3d64ade078accdaab8ac4ffb5e43a9d7 12:06:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:06:30 INFO - mozversion platform_version: 57.0a1 12:06:30 INFO - using testdate: 1505502390 12:06:30 INFO - actual date: 1505502390 12:06:30 INFO - starting webserver on 'localhost:34626' 12:06:30 INFO - SUITE-START | Running 2 tests 12:06:30 INFO - TEST-START | dromaeo_css 12:06:30 INFO - Initialising browser for dromaeo_css test... 12:06:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34626/getInfo.html -profile /tmp/tmpocPOiq/profile 12:06:30 INFO - TEST-INFO | started process 14320 (/builds/slave/test/build/application/firefox/firefox http://localhost:34626/getInfo.html) 12:06:36 INFO - TEST-INFO | 14320: exit 0 12:06:37 INFO - Browser initialized. 12:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:06:37 INFO - Using env: {'DISPLAY': ':0', 12:06:37 INFO - 'HOME': '/home/cltbld', 12:06:37 INFO - 'JSGC_DISABLE_POISONING': '1', 12:06:37 INFO - 'LANG': 'en_US.UTF-8', 12:06:37 INFO - 'LANGUAGE': 'en_US:en', 12:06:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:06:37 INFO - 'LOGNAME': 'cltbld', 12:06:37 INFO - 'MAIL': '/var/mail/cltbld', 12:06:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:37 INFO - 'MOZ_CRASHREPORTER': '1', 12:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:06:37 INFO - 'MOZ_NO_REMOTE': '1', 12:06:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:37 INFO - 'NO_EM_RESTART': '1', 12:06:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:37 INFO - 'PWD': '/builds/slave/test', 12:06:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:37 INFO - 'RUST_BACKTRACE': 'full', 12:06:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:06:37 INFO - 'SHELL': '/bin/bash', 12:06:37 INFO - 'SHLVL': '1', 12:06:37 INFO - 'STYLO_FORCE_DISABLED': '1', 12:06:37 INFO - 'TERM': 'linux', 12:06:37 INFO - 'TMOUT': '86400', 12:06:37 INFO - 'USER': 'cltbld', 12:06:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:37 INFO - '_': '/tools/buildbot/bin/python'} 12:06:37 INFO - TEST-INFO | started process 14557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocPOiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:37 INFO - PID 14557 | 12:06:37 INFO - PID 14557 | (/builds/slave/test/build/application/firefox/firefox:14606): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:06:37 INFO - PID 14557 | 12:06:48 INFO - PID 14557 | RSS: Main: 171786240 12:06:48 INFO - PID 14557 | 12:09:46 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34626/tests/dromaeo/cssquery-ext.html) 12:09:47 INFO - PID 14557 | RSS: Main: 175771648 12:09:47 INFO - PID 14557 | 12:12:48 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-ext.html (next: http://localhost:34626/tests/dromaeo/cssquery-jquery.html) 12:12:49 INFO - PID 14557 | RSS: Main: 171253760 12:12:49 INFO - PID 14557 | 12:15:51 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34626/tests/dromaeo/cssquery-mootools.html) 12:15:51 INFO - PID 14557 | RSS: Main: 174125056 12:15:51 INFO - PID 14557 | 12:18:53 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34626/tests/dromaeo/cssquery-prototype.html) 12:18:54 INFO - PID 14557 | RSS: Main: 171974656 12:18:54 INFO - PID 14557 | 12:21:57 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34626/tests/dromaeo/cssquery-yui.html) 12:21:58 INFO - PID 14557 | RSS: Main: 173723648 12:21:58 INFO - PID 14557 | 12:24:59 INFO - PID 14557 | Cycle 1(1): loaded http://localhost:34626/tests/dromaeo/cssquery-yui.html (next: http://localhost:34626/tests/dromaeo/cssquery-dojo.html) 12:25:00 INFO - PID 14557 | RSS: Main: 176377856 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | __start_tp_report 12:25:00 INFO - PID 14557 | _x_x_mozilla_page_load 12:25:00 INFO - PID 14557 | _x_x_mozilla_page_load_details 12:25:00 INFO - PID 14557 | |i|pagename|runs| 12:25:00 INFO - PID 14557 | |0;dojo.html;3128.3430479599283;3141.5915930928977;3158.82626455545;3173.3177366866134;3182.299894023317;6318.178636777213;6380.776672816458;6395.1366565513645;6408.8077357679285;6484.546081774278;6192.81421557354;6284.811455656326;6295.685215739218;6315.305316415191;6324.620522768637;5814.592978491507;5896.88206235875;5910.704464776765;5911.9113213301835;5926.377730338317;5736.569757268201;5885.8822823543505;5890.440408161239;5913.2608423947;5987.580869339148;5407.459254074601;5773.162891380747;5781.913271300934;5925.4963328117165;5927.703614819242;5783.21926539916;5808;5860.736266868002;5872.618279811842;5899.882002359929;5646;5675.233843431167;5772.538196944234;5821.53427725781;5843.649381037151;6345.111684364193;6362.045693146065;6407.295197528269;6421.93578064218;6434.131392262031;6721;6760;6780.118584584022;6855.348741869514;6862.656867156672;6637.402633762985;6773.8983915241315;6780;6827.761028364033;6908.205556361033;6220.1913751212505;6226.315105338409;6229.501639868799;6285.748570057238;6320.273168585672;6983.580985140908;6996.300369962963;7030.859382812315;7087.7164913402885;7096.680649370791;6661;6724.831879203059;6730.226024007204;6754.18949726036;6802.489813264025;6649.4347980421235;6678;6750.291219421988;6802.659867006729;6804.285550017276;6807.693653785592;6808.046873437723;6812.795616131524;6814.659267036727;6861.862762744717;6775.695093720696;6778.593284402951;6861.245263021064;6874.072000279898;6874.793756187322;5311.867203319871;5331.893362132736;5387.649802762886;5390.299261096033;5410.053240682865;4541.704789188692;4601.102784956901;4617.492075871652;4694.976525117352;4700.036492519025;5840.766369345179;5854.18041474194;5893.2044174035955;5893.793717219963;5913.645181289136;6747.359000894907;6821.556598821061;6836;6925.965370173117;6929.029935808991;5691.943080569225;5811.622244554091;5839.240898683144;5908.113782932594;5910.054391297458;5762.481376676119;5767.423257674199;5779.393163717749;5782.392848750905;5863.648181109147;6548.541602087808;6582.539222254492;6610.0745895574655;6641.236257830411;6641.634710090992;6702.195736511552;6815.522913396213;6866.862662746817;6886.8622627547165;6898.689558969758;6385.265694445198;6496.090547323284;6538.1827271591055;6613.735450582115;6626.83432914181;6613.14029176204;6618;6644.933550664625;6667.599944003376;6682.198136223684;6690.230623478362;6740.460763138839;6762.188537375349;6787.321267873173;6796.76211332601;6497.610143391412;6540.738370465128;6578.769743059162;6650.401463868275;6674.566153200027;6578.309277525791;6579.769708060195;6658.201015878126;6669.799906002828;6674.632895190811;6509.837254068686;6511.186101737283;6591.110200123114;6603.669816509251;6618.437432818265;6491.448226900767;6606.405423511907;6608;6707.564008339442;6744.325567443217;6283.120363149254;6392.137061496825;6431.421172094534;6520;6520.315366886598 12:25:00 INFO - PID 14557 | |1;ext.html;833.7540425574455;862.0216054777829;863.145485968891;865.0700496965763;865.8571335729603;40349.99999999996;41148.58851411485;41201;41277.17445651089;41350.37974430382;37329.62670373295;37435.251294974085;37442.81278593603;37496.25007499848;37519.624803751954;6887.552309099918;7013.719451221945;7014.859702805941;7027.683754231072;7032.718691252344;6913.7925862223965;6999.650017499104;7002.124734408199;7032.964835175817;7033.577985320871;7652.655630496613;7840.68637254512;7858.68565257389;7859.724909628164;7916.960415197916;7821.608919554028;7878.369730421553;7888.605569721491;7894.3289820365335;7898.565578893187;7510.098788145458;7636.885446718304;7701.3838892889;7702.807429814244;7706.229377062249;37608.623913760784;38331.80834095839;38337.80831095854;38345.80827095875;38393.42409863854;3504.9649503505148;3539.5398598182073;3543.4861945018088;3546.521219635342;3568.2506673598577;31304.21739456532;31307.843460782777;31347.529787053212;31415.84292078548;31448.37103257945;5088.465711100355;5113.846584602468;5139.357580302462;5151.304573882516;5213.635045546814;181697;182171;183258;183570;184603.99999999866;41734;42688.35967460491;46103.30845037327;47606.5239347609;48314.75842620764;49900.50099498958;49915.25127123096;49936.500634993914;50129.49870501321;50199.74900125476;16132.032078075354;16242.106684132486;16250.106244156448;16253.268602912898;16271.430499932681;13326.466941322238;13370.264635445144;13379;13386.866131338562;13468.730625387438;13619.523316683868;13661.658458538615;13736.10715303502;13745.312734363242;13887.722245555033;5560.220729366645;5739.139129130664;5760.251167348218;5767.913481297784;5855.912161317584;966.8259713251682;1003.6336737091056;1011.110223003752;1017.8473229015559;1028.218553899042;21644.56710865774;21672.024758885887;21898.452538686342;22141.446463838212;22161.113555457923;1114.453917580396;1121.9439028048564;1122.9775404491863;1125.9774804503863;1131.422974283105;11669.591564295379;11804.822927656092;11822.11334149925;11881.821772673416;11883.049356051668;214711;215656;216457;217063;217342;50490.74754626277;51257.743711281204;51277;51430.22854657183;51759.48240517547;1435.6769726811592;1463.6853076588584;1470.4285953952922;1480.3930388540646;1488.3897601983135;20821.167153313698;21542.784572154076;21662.783372166075;21726.130954761633;21893.343199704035;37103;37113.814430927676;37114.44328335023;37116.628833711315;37158.44262336013;178150;178715;179496;180056;180486;32453.35093298168;34441.48337774986;35500.64499354974;35511.644883550834;35529.467057993636;44563.10873782571;44601.33098003597;44668;44745;44816.10367792561;32674.183145420604;32972.17569560684;33172.50241246432;33490.33019339648;33523.4971475433;32599.348013040082;32731.509027365086;32942;32947.67052329446;33543.99368018963;35747.46378804268;36808;36850.63149368579;37005.444918326786;37417.81291093636;32247.35505289928;32390.35219295648;32569;32627.184320391232;32851;23734.881325593262;24015.03939842387;24038;24068.15761448341;24380.390490237176 12:25:00 INFO - PID 14557 | |2;jquery.html;567.8665513604302;576.443731798814;585.0872638683654;588.6703446070198;595.9731812068457;21896.68619882808;22687.319380418612;22688.77311226887;22693.999999999978;22699.432514187134;23457.765422345772;24298.392540186505;24633.26100216992;24749.38126546837;25076.122335718253;6450.451711604507;6670.066190733277;6672;6674.632895190763;6675.933240667579;6521.119648847392;6654.667266636673;6655.800325990228;6657.300983396746;6827.214870289906;7060.54106483077;7099.787006389791;7101.218865924744;7101.538400004009;7101.822454438655;7096.219415864251;7102.85794284114;7107.218205997362;7126.465515086389;7129.251428599974;6746.426553742937;7072.328128827753;7085.185203701537;7087.0432491614;7091.858162836715;29165.85417072901;29701.554476682868;29730.108096757132;29730.554041689174;29732.70267297321;2120.257909731597;2139.368886178581;2141.1435425829636;2148.1622167354744;2158.4927542027613;19841.206351745914;20323.491912702153;20655.5868882623;20711.378658640115;20868.06093725786;2507.2102287779476;2534.569123249052;2568.0626571301527;2588.9352766180996;2594.286571192918;119210;123329;123520;124112;132007;18224.908875455538;20292.391228263175;20474.97625118738;21353.679694804592;22030.339089827332;39803.20393592112;39810.800945995084;40311.39532907009;40424.79787601043;40604.79697601493;11345.94327028376;11413.086953043736;11535.365554894393;11571.42142892852;11886.28682279066;9593.376430531993;9634.614615415305;9655.468949207721;9770.853437198448;9786.217102631772;10872.130229581615;10941.398223097805;10978.780424391627;11252.549898004152;11351.772964540829;3776.508279229689;3881.5924327945722;4244.405783190356;4297.892552686145;4346.195953748566;959.1990687775785;962.9903700963041;973.7808992976524;1001.0740065439439;1006.7885743993697;18102.818971810113;18227.63544729098;18654.720179197324;18701.438956831316;18932.526686832938;1021.341234903483;1021.897810218987;1031.4120951057826;1037.4916291017498;1041.7187359413067;10199.490025498695;10201.795964080826;10223.488825558692;10344.741381465374;10682.305650132717;467390;468927;469912;473442;480581;109414.45292773645;110675.44662276798;112355;112791.4360428209;113129;1148.3683973814536;1156.8322593223936;1173.6068417080203;1185.3302883870758;1188.144535934126;16439.342426303294;16516.339346426008;16553.586160346087;16649.001059936443;16775.74836377431;53850.461495384545;54093;54264.72867635637;54765.72617137048;55184.72407637936;66403;67363.66318168574;67606.32393676;67763.66118169378;67956.66021670058;18724.063796810377;19013.524661883563;19058.618827623646;19138.904305478383;19415.70876436883;21111.472213194178;21362.252321168686;21474.463138421663;21629.459263518536;21666;17230.655386892442;17267.136643168044;17507.737383938995;17543.385981490588;17627.29490820404;15605.765913511079;15623.296951636976;15803.209839508208;16042;16151.015741623914;17569.736453953457;17637.29450821953;17706.734398984285;17820.198091085673;17850.732239016685;18282.817171828112;18586.2565497384;18651.533711657317;18656.34702785396;18661.346852860086;17193.14034298255;17200.397986070428;17213.483595492155;17309.30762769475;17412.39056633012 12:25:00 INFO - PID 14557 | |3;mootools.html;1358.8233529641147;1394.8256467941508;1434.6556826361677;1435.2680133132103;1436.2459708652955;14957.850421495781;15046.849531504682;15674.764878526832;15691.293891774869;15717.13555754433;15620.531384058468;15933.920330398332;15996.76004859928;16048.27782749776;16122.274497647604;2809.8033137680372;2853.9857300713466;2856.5715142728654;2857.771378289742;2857.785441187487;2569.627404026415;2726.332048648084;2789;2790.902318418856;2792.0507027610606;2780.694123646397;2811.05829547102;2818.8167769095044;2819.746222839944;2822.9011984580543;2587.2496975876975;2634.4204275059456;2643.3259518822674;2689.9193024209303;2766.363736340653;2652.124798816386;2664.120840122755;2698.271466703979;2727.7954153438573;2736.7263273672675;15083.321250543751;15115.622109447242;15207.163606001666;15213.923930380277;15278.31247593861;8136.918630813675;8449.450785698971;8464.746057618282;8489.363297752694;8489.745307640718;4979.278004689336;5203;5229.215617657382;5244.187150991603;5294.788208471657;1917.501449623094;1932.7873933867263;1942.9125689344014;1959.4219705187004;2001.1495114576392;26390.86804565984;26525.602115968275;26650.73349266502;26695.466090678077;26765.732342676518;6601.966990165019;6796.932030679729;6830.521863469608;6904.551204171813;6969.686364113627;16857.157142142845;17044.57388565271;17074.82925170757;17081.658366832595;17087.231074601674;7353.411727061823;7571.167171611119;7578.052743407075;7614.619269036637;7618.276263754934;6912.032315475837;7018;7093.077899872984;7115.750948716874;7167.641617919187;5103.336566246364;5252.422233554306;5255.894882102413;5279.9208011879855;5304.310439642899;1316.2628927800463;1368.3431952662777;1499.6101013736507;1502.9173395463135;1514.9469768558047;919.9494027828533;937.7186843946789;939.4175611121149;939.7697564096703;947.5735918836551;8758.86861697075;8805.383623146317;8831.381803273709;8843.07147749477;8942.642294308285;1014.4217795856439;1039.740064983754;1040.1990467340106;1051.1958351860833;1057.3444464431948;4689.3903792507435;4761.119192949315;4773.188557945157;4802.063597598435;4858.6356023297685;20676.379708608765;21997.890010549843;22130.44673883166;22210;22210.44473888166;20976.895115524323;21645.783542164692;21795.34613961584;21881.234156804752;22057.77942220557;11154.051905587954;11177.217594768288;11239.887601123884;11244.550217991353;11273.830892536618;8438.831223375375;8508.276796472122;8607.741767746978;8710.738677839421;8714.956425217833;17073.74389384185;18612.44162675122;18751.812481875553;18773.6245275091;18879.90560047191;18772.436826894667;19486;19510.31713890007;19569.70645440348;19769.40691779249;10368.481575921325;10474.790504189721;10475.319104258198;10635.255532112678;10663.786724265627;12984.740305193654;13212.273324967218;13222.867771322164;13227.074104812955;13244.53644122451;11002;11042.944785276344;11177.832332515181;11276.94361528187;11443;11462.770744584896;11526.193166478266;11619.302841829518;11650.067994560246;11783.057355411374;10076.748081298027;10333.431661258403;10348.430836304076;10357.844632330673;10360.222983276133;7330.376917962033;7416.306103323846;7443.925560744323;7513.774586762406;7532.472726909064;7550.5469671819865;7756.806079848049;7844.254795794391;7845.882311765442;7966.960165199137 12:25:00 INFO - PID 14557 | |4;prototype.html;496.37376751552387;526.1266297945411;528.1628618639457;530.5278302310943;536.6190005096381;6395.808125756229;6414.4662858171;6443.226812782461;6459.41865232129;6460.870782584346;6303.968480157593;6331.968340158304;6365.4907607391415;6395.328490508499;6432.163818703562;5243.370795504536;5248.343957005374;5272.894542109156;5284.233786101013;5286.392064912546;4913.140200464904;5230.816921407752;5231.319928409302;5287.32072116178;5295.338082739658;4949.579285760697;5005.674631148963;5010.123228435027;5030.698158110525;5038.773255203525;4939.333190019337;4978.551930326288;5018.824341148079;5037.798488060474;5056.14045612245;4394.340848872695;4492.842750503717;4508.346289787995;4521.570450807168;4524.276115821485;6037.818865434044;6102.72537735803;6186.690665466709;6196.504279657616;6255.028057183676;5665.5467562594895;5687.630304030225;5707.258056452676;5735.684537350444;5782.537397008229;6633.369829866155;6677.664467106598;6689.397954184098;6690.397864192246;6701.09535212745;4945.010997800418;4945.258211268302;4947.802087916479;4954.331165292675;4961.734757636816;6723.495737819683;6834.2482326944;6891.414229790424;6913;7008.719651213945;5009.624278179078;5033.6476446648385;5046.268291097844;5049.57078648319;5054.82308119214;5113.718745469035;5117.590592752571;5130.846074617767;5135.38375394955;5161.174212126042;5741.971290143606;5753.971230143822;5761.978732224835;5770.221020162308;5797.652140871477;6718.160229971254;6757.358050985148;6758.222804377559;6767.35710107539;6769.729210831511;1777.5733823882176;1787.928482860697;1793.9103044847704;1795.985268323393;1797.1463554811621;1163.761428907072;1215.295128825279;1238.9566365177175;1238.993805030987;1240.2248594628356;5736.5123964462655;5746.482816546447;5748;5751.338596061423;5784.913226301609;6658.4340331071435;6774.882144446111;6789.490788190807;6791.2869148739655;6796.640671865646;5651.491365777018;5754.625949313281;5759.897637362416;5801.9129713054335;5808.5933984621515;3575.5530558680166;3581.606023337431;3607.74745767799;3621.8008009559726;3634.4184930411006;6388.648624325614;6399.504502929531;6409.423151916257;6411.615303081737;6413.29453760086;6432.421082102634;6796.66016699173;6900.654967251618;6909.792706218822;6934.895976560356;6390.616563006234;6442.6778661066755;6478.805635830932;6499.967500162469;6565.638889861008;6583.518708290788;6634.800955971328;6725.621247644123;6745.662716864235;6820.795376138723;6594.835129121619;6655.467562595078;6663.966680166568;6667.766628167991;6780.220274668476;6487.643179625166;6494.805155845333;6498.155239818793;6527.314631963765;6530.640814755234;5029.295898574275;5063.8480845574695;5077;5087.694738315713;5100.770465328995;6509.283978762427;6719.630420326929;6738.2587915328295;6747.243193548438;6763;6409.4872410206135;6527.2167339919515;6534.575252608755;6555.639439830855;6603.570767900071;6514.967425162844;6609.570377925419;6649.833754156185;6649.966750166218;6679.499037572299;6412.61524308543;6518.380753828379;6552.27924928267;6555.344465553407;6577;6657.434118099822;6668.5329227569855;6712.2952090031795;6730.226024007106;6756.459483241427;6485.8702825944165;6490.51321150925;6516.543841931019;6519.674016299261;6531.738730450728 12:25:00 INFO - PID 14557 | |5;yui.html;909.5361365703492;913.5021413329735;923.2567782934735;932.9720108396746;934.7849994501264;15745.606359840995;16148.838511614895;16156.676866462663;16193.757093643604;16196.190190490457;15535.223238838069;16628.418005369815;16678.249478773454;16692.248848801803;16924.069176195306;946.347020555816;962.7111866440075;962.990370096297;964.0937518732369;965.9855102173473;957.5690939077408;977.081543349253;986.8914419413859;991.1426615977164;991.7223177510309;1044.310754901765;1053.6680945502142;1054.562356622001;1056.1128651932374;1056.7463808685936;997.6059456514636;1033.8862725100232;1039.4646756920154;1041.7551875309296;1042.572545256445;748.2367984655675;750.1186106325101;753.2580408297822;755.4938191411767;757.2162811490082;17395.56511087233;17776.822231777645;17793.555161120945;17803;17821.821781782277;21016.579668406546;21476.892615536977;21828.23601173967;21839.344819655435;21887.67168492474;17218.655626887394;17398.39105631297;17845.553861153447;17882.55293617657;18007.639847203114;3726.0312318797037;3751.9812400938094;3755.324041672498;3764.2283331917165;3766.0961369271454;126727;132447;133862.3306883469;134363;135165.3241733795;16876.903001304876;17252.13739313029;17580.296788128588;17684.91157544204;17752.28990840352;31455.213619659233;31581.684183158333;31613.36773264568;31747.52378714321;31838.840805796284;8617.61220745068;8620.655173793104;8629.266512346396;8647.913520864837;8702.782430439289;3981.9402708959387;4238.406623072772;4337.4795024596615;4364.345348197796;4372.956270437255;5228.4510126436935;5300.787968481218;5309.230161626542;5313.44208858072;5363.03465376236;983.2085171437062;984.0454758883872;989.5794287427958;1004.2719028704131;1007.9496025198711;687.9174499060144;705.255095443188;713.12642013533;722.2560762414616;741.3253938915668;11534.59628912984;11766.52933882635;11774.823377649342;11893.643190704293;12088.697782555331;720.8306048078697;720.9675564599605;722.7470385365081;731.8353370491703;740.6407892172292;5525.696086715189;5613.522850557748;5645.830625081254;5697.145428185722;5742.655440673573;125618;125715.37142314413;127354.36322818512;128415.35792320978;129311.35344323218;89465.55267223752;97639;99110.5044474773;111975;113699;94498;96926.06147877003;98184.50907745416;99094.50452747835;102659;12500.437480313225;12903.161294515827;13035.869641303845;13169.275689837152;13434.865651343753;41635.583644164384;42556.36165457583;43346;43581.128377432906;43988.560114398446;56159.719201405365;58545.41454585399;67179.32820671731;83561;83728;18381.264749409875;18476.260949561867;18564.721529176804;18584.349547765763;18649.627007460047;19684.212631494578;20264.797352026882;20340.389788306373;20379;20473.795262047784;18918.905405472884;19133.904330478257;19216.519587009876;19349.4195174145;19433.31983380575;18768.906155469136;18843;18857.90571047136;18915.527111822314;18957.90521047386;18775.90612046931;18831.90584047071;18858.71711924295;18897.71653425227;19137.712934305717;12888.806667899802;12891.355432228538;12996.350182491027;13212.471501140231;13242.073054886065;14315.427382904983;14329.498467553585;14511.274436278354;14647.047941883744;14651.780223296446 12:25:00 INFO - PID 14557 | __end_tp_report 12:25:00 INFO - PID 14557 | __start_cc_report 12:25:00 INFO - PID 14557 | _x_x_mozilla_cycle_collect,374 12:25:00 INFO - PID 14557 | __end_cc_report 12:25:00 INFO - PID 14557 | __startTimestamp1505503500158__endTimestamp 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | ------- Summary: start ------- 12:25:00 INFO - PID 14557 | Number of tests: 6 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#0] dojo.html Cycles:165 Average:6240.59 Median:6509.84 stddev:756.88 (11.6%) stddev-sans-first:718.74 12:25:00 INFO - PID 14557 | Values: 3128.3 3141.6 3158.8 3173.3 3182.3 6318.2 6380.8 6395.1 6408.8 6484.5 6192.8 6284.8 6295.7 6315.3 6324.6 5814.6 5896.9 5910.7 5911.9 5926.4 5736.6 5885.9 5890.4 5913.3 5987.6 5407.5 5773.2 5781.9 5925.5 5927.7 5783.2 5808.0 5860.7 5872.6 5899.9 5646.0 5675.2 5772.5 5821.5 5843.6 6345.1 6362.0 6407.3 6421.9 6434.1 6721.0 6760.0 6780.1 6855.3 6862.7 6637.4 6773.9 6780.0 6827.8 6908.2 6220.2 6226.3 6229.5 6285.7 6320.3 6983.6 6996.3 7030.9 7087.7 7096.7 6661.0 6724.8 6730.2 6754.2 6802.5 6649.4 6678.0 6750.3 6802.7 6804.3 6807.7 6808.0 6812.8 6814.7 6861.9 6775.7 6778.6 6861.2 6874.1 6874.8 5311.9 5331.9 5387.6 5390.3 5410.1 4541.7 4601.1 4617.5 4695.0 4700.0 5840.8 5854.2 5893.2 5893.8 5913.6 6747.4 6821.6 6836.0 6926.0 6929.0 5691.9 5811.6 5839.2 5908.1 5910.1 5762.5 5767.4 5779.4 5782.4 5863.6 6548.5 6582.5 6610.1 6641.2 6641.6 6702.2 6815.5 6866.9 6886.9 6898.7 6385.3 6496.1 6538.2 6613.7 6626.8 6613.1 6618.0 6644.9 6667.6 6682.2 6690.2 6740.5 6762.2 6787.3 6796.8 6497.6 6540.7 6578.8 6650.4 6674.6 6578.3 6579.8 6658.2 6669.8 6674.6 6509.8 6511.2 6591.1 6603.7 6618.4 6491.4 6606.4 6608.0 6707.6 6744.3 6283.1 6392.1 6431.4 6520.0 6520.3 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#1] ext.html Cycles:180 Average:36224.44 Median:35506.14 stddev:50071.55 (141.0%) stddev-sans-first:50141.49 12:25:00 INFO - PID 14557 | Values: 833.8 862.0 863.1 865.1 865.9 40350.0 41148.6 41201.0 41277.2 41350.4 37329.6 37435.3 37442.8 37496.3 37519.6 6887.6 7013.7 7014.9 7027.7 7032.7 6913.8 6999.7 7002.1 7033.0 7033.6 7652.7 7840.7 7858.7 7859.7 7917.0 7821.6 7878.4 7888.6 7894.3 7898.6 7510.1 7636.9 7701.4 7702.8 7706.2 37608.6 38331.8 38337.8 38345.8 38393.4 3505.0 3539.5 3543.5 3546.5 3568.3 31304.2 31307.8 31347.5 31415.8 31448.4 5088.5 5113.8 5139.4 5151.3 5213.6 181697.0 182171.0 183258.0 183570.0 184604.0 41734.0 42688.4 46103.3 47606.5 48314.8 49900.5 49915.3 49936.5 50129.5 50199.7 16132.0 16242.1 16250.1 16253.3 16271.4 13326.5 13370.3 13379.0 13386.9 13468.7 13619.5 13661.7 13736.1 13745.3 13887.7 5560.2 5739.1 5760.3 5767.9 5855.9 966.8 1003.6 1011.1 1017.8 1028.2 21644.6 21672.0 21898.5 22141.4 22161.1 1114.5 1121.9 1123.0 1126.0 1131.4 11669.6 11804.8 11822.1 11881.8 11883.0 214711.0 215656.0 216457.0 217063.0 217342.0 50490.7 51257.7 51277.0 51430.2 51759.5 1435.7 1463.7 1470.4 1480.4 1488.4 20821.2 21542.8 21662.8 21726.1 21893.3 37103.0 37113.8 37114.4 37116.6 37158.4 178150.0 178715.0 179496.0 180056.0 180486.0 32453.4 34441.5 35500.6 35511.6 35529.5 44563.1 44601.3 44668.0 44745.0 44816.1 32674.2 32972.2 33172.5 33490.3 33523.5 32599.3 32731.5 32942.0 32947.7 33544.0 35747.5 36808.0 36850.6 37005.4 37417.8 32247.4 32390.4 32569.0 32627.2 32851.0 23734.9 24015.0 24038.0 24068.2 24380.4 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#2] jquery.html Cycles:180 Average:34442.79 Median:11807.80 stddev:79056.84 (669.5%) stddev-sans-first:79237.71 12:25:00 INFO - PID 14557 | Values: 567.9 576.4 585.1 588.7 596.0 21896.7 22687.3 22688.8 22694.0 22699.4 23457.8 24298.4 24633.3 24749.4 25076.1 6450.5 6670.1 6672.0 6674.6 6675.9 6521.1 6654.7 6655.8 6657.3 6827.2 7060.5 7099.8 7101.2 7101.5 7101.8 7096.2 7102.9 7107.2 7126.5 7129.3 6746.4 7072.3 7085.2 7087.0 7091.9 29165.9 29701.6 29730.1 29730.6 29732.7 2120.3 2139.4 2141.1 2148.2 2158.5 19841.2 20323.5 20655.6 20711.4 20868.1 2507.2 2534.6 2568.1 2588.9 2594.3 119210.0 123329.0 123520.0 124112.0 132007.0 18224.9 20292.4 20475.0 21353.7 22030.3 39803.2 39810.8 40311.4 40424.8 40604.8 11345.9 11413.1 11535.4 11571.4 11886.3 9593.4 9634.6 9655.5 9770.9 9786.2 10872.1 10941.4 10978.8 11252.5 11351.8 3776.5 3881.6 4244.4 4297.9 4346.2 959.2 963.0 973.8 1001.1 1006.8 18102.8 18227.6 18654.7 18701.4 18932.5 1021.3 1021.9 1031.4 1037.5 1041.7 10199.5 10201.8 10223.5 10344.7 10682.3 467390.0 468927.0 469912.0 473442.0 480581.0 109414.5 110675.4 112355.0 112791.4 113129.0 1148.4 1156.8 1173.6 1185.3 1188.1 16439.3 16516.3 16553.6 16649.0 16775.7 53850.5 54093.0 54264.7 54765.7 55184.7 66403.0 67363.7 67606.3 67763.7 67956.7 18724.1 19013.5 19058.6 19138.9 19415.7 21111.5 21362.3 21474.5 21629.5 21666.0 17230.7 17267.1 17507.7 17543.4 17627.3 15605.8 15623.3 15803.2 16042.0 16151.0 17569.7 17637.3 17706.7 17820.2 17850.7 18282.8 18586.3 18651.5 18656.3 18661.3 17193.1 17200.4 17213.5 17309.3 17412.4 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#3] mootools.html Cycles:180 Average:9383.07 Median:2578.44 stddev:6703.31 (260.0%) stddev-sans-first:6695.00 12:25:00 INFO - PID 14557 | Values: 1358.8 1394.8 1434.7 1435.3 1436.2 14957.9 15046.8 15674.8 15691.3 15717.1 15620.5 15933.9 15996.8 16048.3 16122.3 2809.8 2854.0 2856.6 2857.8 2857.8 2569.6 2726.3 2789.0 2790.9 2792.1 2780.7 2811.1 2818.8 2819.7 2822.9 2587.2 2634.4 2643.3 2689.9 2766.4 2652.1 2664.1 2698.3 2727.8 2736.7 15083.3 15115.6 15207.2 15213.9 15278.3 8136.9 8449.5 8464.7 8489.4 8489.7 4979.3 5203.0 5229.2 5244.2 5294.8 1917.5 1932.8 1942.9 1959.4 2001.1 26390.9 26525.6 26650.7 26695.5 26765.7 6602.0 6796.9 6830.5 6904.6 6969.7 16857.2 17044.6 17074.8 17081.7 17087.2 7353.4 7571.2 7578.1 7614.6 7618.3 6912.0 7018.0 7093.1 7115.8 7167.6 5103.3 5252.4 5255.9 5279.9 5304.3 1316.3 1368.3 1499.6 1502.9 1514.9 919.9 937.7 939.4 939.8 947.6 8758.9 8805.4 8831.4 8843.1 8942.6 1014.4 1039.7 1040.2 1051.2 1057.3 4689.4 4761.1 4773.2 4802.1 4858.6 20676.4 21997.9 22130.4 22210.0 22210.4 20976.9 21645.8 21795.3 21881.2 22057.8 11154.1 11177.2 11239.9 11244.6 11273.8 8438.8 8508.3 8607.7 8710.7 8715.0 17073.7 18612.4 18751.8 18773.6 18879.9 18772.4 19486.0 19510.3 19569.7 19769.4 10368.5 10474.8 10475.3 10635.3 10663.8 12984.7 13212.3 13222.9 13227.1 13244.5 11002.0 11042.9 11177.8 11276.9 11443.0 11462.8 11526.2 11619.3 11650.1 11783.1 10076.7 10333.4 10348.4 10357.8 10360.2 7330.4 7416.3 7443.9 7513.8 7532.5 7550.5 7756.8 7844.3 7845.9 7967.0 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#4] prototype.html Cycles:180 Average:5567.84 Median:6317.97 stddev:1551.49 (24.6%) stddev-sans-first:1508.42 12:25:00 INFO - PID 14557 | Values: 496.4 526.1 528.2 530.5 536.6 6395.8 6414.5 6443.2 6459.4 6460.9 6304.0 6332.0 6365.5 6395.3 6432.2 5243.4 5248.3 5272.9 5284.2 5286.4 4913.1 5230.8 5231.3 5287.3 5295.3 4949.6 5005.7 5010.1 5030.7 5038.8 4939.3 4978.6 5018.8 5037.8 5056.1 4394.3 4492.8 4508.3 4521.6 4524.3 6037.8 6102.7 6186.7 6196.5 6255.0 5665.5 5687.6 5707.3 5735.7 5782.5 6633.4 6677.7 6689.4 6690.4 6701.1 4945.0 4945.3 4947.8 4954.3 4961.7 6723.5 6834.2 6891.4 6913.0 7008.7 5009.6 5033.6 5046.3 5049.6 5054.8 5113.7 5117.6 5130.8 5135.4 5161.2 5742.0 5754.0 5762.0 5770.2 5797.7 6718.2 6757.4 6758.2 6767.4 6769.7 1777.6 1787.9 1793.9 1796.0 1797.1 1163.8 1215.3 1239.0 1239.0 1240.2 5736.5 5746.5 5748.0 5751.3 5784.9 6658.4 6774.9 6789.5 6791.3 6796.6 5651.5 5754.6 5759.9 5801.9 5808.6 3575.6 3581.6 3607.7 3621.8 3634.4 6388.6 6399.5 6409.4 6411.6 6413.3 6432.4 6796.7 6900.7 6909.8 6934.9 6390.6 6442.7 6478.8 6500.0 6565.6 6583.5 6634.8 6725.6 6745.7 6820.8 6594.8 6655.5 6664.0 6667.8 6780.2 6487.6 6494.8 6498.2 6527.3 6530.6 5029.3 5063.8 5077.0 5087.7 5100.8 6509.3 6719.6 6738.3 6747.2 6763.0 6409.5 6527.2 6534.6 6555.6 6603.6 6515.0 6609.6 6649.8 6650.0 6679.5 6412.6 6518.4 6552.3 6555.3 6577.0 6657.4 6668.5 6712.3 6730.2 6756.5 6485.9 6490.5 6516.5 6519.7 6531.7 12:25:00 INFO - PID 14557 | 12:25:00 INFO - PID 14557 | [#5] yui.html Cycles:180 Average:24883.16 Median:20302.59 stddev:35141.04 (173.1%) stddev-sans-first:35193.51 12:25:00 INFO - PID 14557 | Values: 909.5 913.5 923.3 933.0 934.8 15745.6 16148.8 16156.7 16193.8 16196.2 15535.2 16628.4 16678.2 16692.2 16924.1 946.3 962.7 963.0 964.1 966.0 957.6 977.1 986.9 991.1 991.7 1044.3 1053.7 1054.6 1056.1 1056.7 997.6 1033.9 1039.5 1041.8 1042.6 748.2 750.1 753.3 755.5 757.2 17395.6 17776.8 17793.6 17803.0 17821.8 21016.6 21476.9 21828.2 21839.3 21887.7 17218.7 17398.4 17845.6 17882.6 18007.6 3726.0 3752.0 3755.3 3764.2 3766.1 126727.0 132447.0 133862.3 134363.0 135165.3 16876.9 17252.1 17580.3 17684.9 17752.3 31455.2 31581.7 31613.4 31747.5 31838.8 8617.6 8620.7 8629.3 8647.9 8702.8 3981.9 4238.4 4337.5 4364.3 4373.0 5228.5 5300.8 5309.2 5313.4 5363.0 983.2 984.0 989.6 1004.3 1007.9 687.9 705.3 713.1 722.3 741.3 11534.6 11766.5 11774.8 11893.6 12088.7 720.8 721.0 722.7 731.8 740.6 5525.7 5613.5 5645.8 5697.1 5742.7 125618.0 125715.4 127354.4 128415.4 129311.4 89465.6 97639.0 99110.5 111975.0 113699.0 94498.0 96926.1 98184.5 99094.5 102659.0 12500.4 12903.2 13035.9 13169.3 13434.9 41635.6 42556.4 43346.0 43581.1 43988.6 56159.7 58545.4 67179.3 83561.0 83728.0 18381.3 18476.3 18564.7 18584.3 18649.6 19684.2 20264.8 20340.4 20379.0 20473.8 18918.9 19133.9 19216.5 19349.4 19433.3 18768.9 18843.0 18857.9 18915.5 18957.9 18775.9 18831.9 18858.7 18897.7 19137.7 12888.8 12891.4 12996.4 13212.5 13242.1 14315.4 14329.5 14511.3 14647.0 14651.8 12:25:00 INFO - PID 14557 | -------- Summary: end -------- 12:25:00 INFO - PID 14557 | 12:25:00 INFO - TEST-INFO | 14557: exit 0 12:25:00 INFO - TEST-OK | dromaeo_css | took 1110641ms 12:25:00 INFO - TEST-START | kraken 12:25:00 INFO - Initialising browser for kraken test... 12:25:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34626/getInfo.html -profile /tmp/tmpqoeO90/profile 12:25:00 INFO - TEST-INFO | started process 14917 (/builds/slave/test/build/application/firefox/firefox http://localhost:34626/getInfo.html) 12:25:06 INFO - TEST-INFO | 14917: exit 0 12:25:06 INFO - Browser initialized. 12:25:06 INFO - Running cycle 1/1 for kraken test... 12:25:06 INFO - Using env: {'DISPLAY': ':0', 12:25:06 INFO - 'HOME': '/home/cltbld', 12:25:06 INFO - 'JSGC_DISABLE_POISONING': '1', 12:25:06 INFO - 'LANG': 'en_US.UTF-8', 12:25:06 INFO - 'LANGUAGE': 'en_US:en', 12:25:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:25:06 INFO - 'LOGNAME': 'cltbld', 12:25:06 INFO - 'MAIL': '/var/mail/cltbld', 12:25:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:06 INFO - 'MOZ_CRASHREPORTER': '1', 12:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:25:06 INFO - 'MOZ_NO_REMOTE': '1', 12:25:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:06 INFO - 'NO_EM_RESTART': '1', 12:25:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:06 INFO - 'PWD': '/builds/slave/test', 12:25:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:06 INFO - 'RUST_BACKTRACE': 'full', 12:25:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:25:06 INFO - 'SHELL': '/bin/bash', 12:25:06 INFO - 'SHLVL': '1', 12:25:06 INFO - 'STYLO_FORCE_DISABLED': '1', 12:25:06 INFO - 'TERM': 'linux', 12:25:06 INFO - 'TMOUT': '86400', 12:25:06 INFO - 'USER': 'cltbld', 12:25:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131', 12:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:06 INFO - '_': '/tools/buildbot/bin/python'} 12:25:06 INFO - TEST-INFO | started process 15148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqoeO90/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:07 INFO - PID 15148 | 12:25:07 INFO - PID 15148 | (/builds/slave/test/build/application/firefox/firefox:15197): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:25:07 INFO - PID 15148 | 12:25:17 INFO - PID 15148 | RSS: Main: 173633536 12:25:17 INFO - PID 15148 | 12:25:20 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34626/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:21 INFO - PID 15148 | RSS: Main: 179290112 12:25:21 INFO - PID 15148 | 12:25:23 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34626/tests/kraken/driver.html?testName=audio-dft) 12:25:24 INFO - PID 15148 | RSS: Main: 179326976 12:25:24 INFO - PID 15148 | 12:25:27 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34626/tests/kraken/driver.html?testName=audio-fft) 12:25:28 INFO - PID 15148 | RSS: Main: 174768128 12:25:28 INFO - PID 15148 | 12:25:30 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34626/tests/kraken/driver.html?testName=audio-oscillator) 12:25:30 INFO - PID 15148 | RSS: Main: 175267840 12:25:30 INFO - PID 15148 | 12:25:32 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:25:33 INFO - PID 15148 | RSS: Main: 175484928 12:25:33 INFO - PID 15148 | 12:25:36 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34626/tests/kraken/driver.html?testName=imaging-darkroom) 12:25:37 INFO - PID 15148 | RSS: Main: 178061312 12:25:37 INFO - PID 15148 | 12:25:41 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34626/tests/kraken/driver.html?testName=imaging-desaturate) 12:25:41 INFO - PID 15148 | RSS: Main: 177754112 12:25:41 INFO - PID 15148 | 12:25:44 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34626/tests/kraken/driver.html?testName=json-parse-financial) 12:25:45 INFO - PID 15148 | RSS: Main: 177790976 12:25:45 INFO - PID 15148 | 12:25:46 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:25:47 INFO - PID 15148 | RSS: Main: 177778688 12:25:47 INFO - PID 15148 | 12:25:49 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:25:49 INFO - PID 15148 | RSS: Main: 177778688 12:25:49 INFO - PID 15148 | 12:25:51 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:25:52 INFO - PID 15148 | RSS: Main: 174964736 12:25:52 INFO - PID 15148 | 12:25:55 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:25:55 INFO - PID 15148 | RSS: Main: 175427584 12:25:55 INFO - PID 15148 | 12:25:58 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:25:59 INFO - PID 15148 | RSS: Main: 175423488 12:25:59 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | Cycle 1(1): loaded http://localhost:34626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34626/tests/kraken/driver.html?testName=ai-astar) 12:26:01 INFO - PID 15148 | RSS: Main: 176836608 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | __start_tp_report 12:26:01 INFO - PID 15148 | _x_x_mozilla_page_load 12:26:01 INFO - PID 15148 | _x_x_mozilla_page_load_details 12:26:01 INFO - PID 15148 | |i|pagename|runs| 12:26:01 INFO - PID 15148 | |0;ai-astar;110;107;110;107;108;101;109;108;107;110 12:26:01 INFO - PID 15148 | |1;audio-beat-detection;117;115;116;116;116;116;120;127;123;116 12:26:01 INFO - PID 15148 | |2;audio-dft;161;161;162;162;161;162;163;167;168;165 12:26:01 INFO - PID 15148 | |3;audio-fft;73;75;73;75;73;75;74;73;74;76 12:26:01 INFO - PID 15148 | |4;audio-oscillator;79;80;81;79;78;78;79;78;79;78 12:26:01 INFO - PID 15148 | |5;imaging-gaussian-blur;114;114;113;113;116;117;112;113;113;114 12:26:01 INFO - PID 15148 | |6;imaging-darkroom;146;148;147;148;147;150;147;149;148;150 12:26:01 INFO - PID 15148 | |7;imaging-desaturate;94;95;94;98;94;95;94;94;96;94 12:26:01 INFO - PID 15148 | |8;json-parse-financial;57;53;53;53;51;52;56;54;51;52 12:26:01 INFO - PID 15148 | |9;json-stringify-tinderbox;37;40;38;38;38;39;38;38;39;38 12:26:01 INFO - PID 15148 | |10;stanford-crypto-aes;75;76;74;78;77;73;83;74;81;76 12:26:01 INFO - PID 15148 | |11;stanford-crypto-ccm;114;109;116;113;120;115;113;119;119;112 12:26:01 INFO - PID 15148 | |12;stanford-crypto-pbkdf2;174;171;169;175;183;166;184;169;168;175 12:26:01 INFO - PID 15148 | |13;stanford-crypto-sha256-iterative;68;68;66;71;66;66;66;72;68;68 12:26:01 INFO - PID 15148 | __end_tp_report 12:26:01 INFO - PID 15148 | __start_cc_report 12:26:01 INFO - PID 15148 | _x_x_mozilla_cycle_collect,944 12:26:01 INFO - PID 15148 | __end_cc_report 12:26:01 INFO - PID 15148 | __startTimestamp1505503561560__endTimestamp 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | ------- Summary: start ------- 12:26:01 INFO - PID 15148 | Number of tests: 14 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.50 stddev:2.67 (2.5%) stddev-sans-first:2.70 12:26:01 INFO - PID 15148 | Values: 110.0 107.0 110.0 107.0 108.0 101.0 109.0 108.0 107.0 110.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:116.50 stddev:3.94 (3.4%) stddev-sans-first:4.15 12:26:01 INFO - PID 15148 | Values: 117.0 115.0 116.0 116.0 116.0 116.0 120.0 127.0 123.0 116.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.57 (1.6%) stddev-sans-first:2.60 12:26:01 INFO - PID 15148 | Values: 161.0 161.0 162.0 162.0 161.0 162.0 163.0 167.0 168.0 165.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.10 (1.5%) stddev-sans-first:1.09 12:26:01 INFO - PID 15148 | Values: 73.0 75.0 73.0 75.0 73.0 75.0 74.0 73.0 74.0 76.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 12:26:01 INFO - PID 15148 | Values: 79.0 80.0 81.0 79.0 78.0 78.0 79.0 78.0 79.0 78.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 12:26:01 INFO - PID 15148 | Values: 114.0 114.0 113.0 113.0 116.0 117.0 112.0 113.0 113.0 114.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.33 (0.9%) stddev-sans-first:1.20 12:26:01 INFO - PID 15148 | Values: 146.0 148.0 147.0 148.0 147.0 150.0 147.0 149.0 148.0 150.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.32 (1.4%) stddev-sans-first:1.36 12:26:01 INFO - PID 15148 | Values: 94.0 95.0 94.0 98.0 94.0 95.0 94.0 94.0 96.0 94.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.99 (3.8%) stddev-sans-first:1.56 12:26:01 INFO - PID 15148 | Values: 57.0 53.0 53.0 53.0 51.0 52.0 56.0 54.0 51.0 52.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.82 (2.2%) stddev-sans-first:0.73 12:26:01 INFO - PID 15148 | Values: 37.0 40.0 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.50 stddev:3.20 (4.2%) stddev-sans-first:3.33 12:26:01 INFO - PID 15148 | Values: 75.0 76.0 74.0 78.0 77.0 73.0 83.0 74.0 81.0 76.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:3.53 (3.1%) stddev-sans-first:3.72 12:26:01 INFO - PID 15148 | Values: 114.0 109.0 116.0 113.0 120.0 115.0 113.0 119.0 119.0 112.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.50 stddev:6.13 (3.5%) stddev-sans-first:6.50 12:26:01 INFO - PID 15148 | Values: 174.0 171.0 169.0 175.0 183.0 166.0 184.0 169.0 168.0 175.0 12:26:01 INFO - PID 15148 | 12:26:01 INFO - PID 15148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.13 (3.1%) stddev-sans-first:2.26 12:26:01 INFO - PID 15148 | Values: 68.0 68.0 66.0 71.0 66.0 66.0 66.0 72.0 68.0 68.0 12:26:01 INFO - PID 15148 | -------- Summary: end -------- 12:26:01 INFO - PID 15148 | 12:26:02 INFO - PID 15148 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:26:02 INFO - TEST-INFO | 15148: exit 0 12:26:02 INFO - TEST-OK | kraken | took 61424ms 12:26:02 INFO - SUITE-END | took 1172s 12:26:02 INFO - Completed test suite (00:19:32) 12:26:02 INFO - javascript benchmark 12:26:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8646.584604498856, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.3430479599283, 3141.5915930928977, 3158.82626455545, 3173.3177366866134, 3182.299894023317, 6318.178636777213, 6380.776672816458, 6395.1366565513645, 6408.8077357679285, 6484.546081774278, 6192.81421557354, 6284.811455656326, 6295.685215739218, 6315.305316415191, 6324.620522768637, 5814.592978491507, 5896.88206235875, 5910.704464776765, 5911.9113213301835, 5926.377730338317, 5736.569757268201, 5885.8822823543505, 5890.440408161239, 5913.2608423947, 5987.580869339148, 5407.459254074601, 5773.162891380747, 5781.913271300934, 5925.4963328117165, 5927.703614819242, 5783.21926539916, 5808.0, 5860.736266868002, 5872.618279811842, 5899.882002359929, 5646.0, 5675.233843431167, 5772.538196944234, 5821.53427725781, 5843.649381037151, 6345.111684364193, 6362.045693146065, 6407.295197528269, 6421.93578064218, 6434.131392262031, 6721.0, 6760.0, 6780.118584584022, 6855.348741869514, 6862.656867156672, 6637.402633762985, 6773.8983915241315, 6780.0, 6827.761028364033, 6908.205556361033, 6220.1913751212505, 6226.315105338409, 6229.501639868799, 6285.748570057238, 6320.273168585672, 6983.580985140908, 6996.300369962963, 7030.859382812315, 7087.7164913402885, 7096.680649370791, 6661.0, 6724.831879203059, 6730.226024007204, 6754.18949726036, 6802.489813264025, 6649.4347980421235, 6678.0, 6750.291219421988, 6802.659867006729, 6804.285550017276, 6807.693653785592, 6808.046873437723, 6812.795616131524, 6814.659267036727, 6861.862762744717, 6775.695093720696, 6778.593284402951, 6861.245263021064, 6874.072000279898, 6874.793756187322, 5311.867203319871, 5331.893362132736, 5387.649802762886, 5390.299261096033, 5410.053240682865, 4541.704789188692, 4601.102784956901, 4617.492075871652, 4694.976525117352, 4700.036492519025, 5840.766369345179, 5854.18041474194, 5893.2044174035955, 5893.793717219963, 5913.645181289136, 6747.359000894907, 6821.556598821061, 6836.0, 6925.965370173117, 6929.029935808991, 5691.943080569225, 5811.622244554091, 5839.240898683144, 5908.113782932594, 5910.054391297458, 5762.481376676119, 5767.423257674199, 5779.393163717749, 5782.392848750905, 5863.648181109147, 6548.541602087808, 6582.539222254492, 6610.0745895574655, 6641.236257830411, 6641.634710090992, 6702.195736511552, 6815.522913396213, 6866.862662746817, 6886.8622627547165, 6898.689558969758, 6385.265694445198, 6496.090547323284, 6538.1827271591055, 6613.735450582115, 6626.83432914181, 6613.14029176204, 6618.0, 6644.933550664625, 6667.599944003376, 6682.198136223684, 6690.230623478362, 6740.460763138839, 6762.188537375349, 6787.321267873173, 6796.76211332601, 6497.610143391412, 6540.738370465128, 6578.769743059162, 6650.401463868275, 6674.566153200027, 6578.309277525791, 6579.769708060195, 6658.201015878126, 6669.799906002828, 6674.632895190811, 6509.837254068686, 6511.186101737283, 6591.110200123114, 6603.669816509251, 6618.437432818265, 6491.448226900767, 6606.405423511907, 6608.0, 6707.564008339442, 6744.325567443217, 6283.120363149254, 6392.137061496825, 6431.421172094534, 6520.0, 6520.315366886598], "value": 6182.142527950047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.7540425574455, 862.0216054777829, 863.145485968891, 865.0700496965763, 865.8571335729603, 40349.99999999996, 41148.58851411485, 41201.0, 41277.17445651089, 41350.37974430382, 37329.62670373295, 37435.251294974085, 37442.81278593603, 37496.25007499848, 37519.624803751954, 6887.552309099918, 7013.719451221945, 7014.859702805941, 7027.683754231072, 7032.718691252344, 6913.7925862223965, 6999.650017499104, 7002.124734408199, 7032.964835175817, 7033.577985320871, 7652.655630496613, 7840.68637254512, 7858.68565257389, 7859.724909628164, 7916.960415197916, 7821.608919554028, 7878.369730421553, 7888.605569721491, 7894.3289820365335, 7898.565578893187, 7510.098788145458, 7636.885446718304, 7701.3838892889, 7702.807429814244, 7706.229377062249, 37608.623913760784, 38331.80834095839, 38337.80831095854, 38345.80827095875, 38393.42409863854, 3504.9649503505148, 3539.5398598182073, 3543.4861945018088, 3546.521219635342, 3568.2506673598577, 31304.21739456532, 31307.843460782777, 31347.529787053212, 31415.84292078548, 31448.37103257945, 5088.465711100355, 5113.846584602468, 5139.357580302462, 5151.304573882516, 5213.635045546814, 181697.0, 182171.0, 183258.0, 183570.0, 184603.99999999866, 41734.0, 42688.35967460491, 46103.30845037327, 47606.5239347609, 48314.75842620764, 49900.50099498958, 49915.25127123096, 49936.500634993914, 50129.49870501321, 50199.74900125476, 16132.032078075354, 16242.106684132486, 16250.106244156448, 16253.268602912898, 16271.430499932681, 13326.466941322238, 13370.264635445144, 13379.0, 13386.866131338562, 13468.730625387438, 13619.523316683868, 13661.658458538615, 13736.10715303502, 13745.312734363242, 13887.722245555033, 5560.220729366645, 5739.139129130664, 5760.251167348218, 5767.913481297784, 5855.912161317584, 966.8259713251682, 1003.6336737091056, 1011.110223003752, 1017.8473229015559, 1028.218553899042, 21644.56710865774, 21672.024758885887, 21898.452538686342, 22141.446463838212, 22161.113555457923, 1114.453917580396, 1121.9439028048564, 1122.9775404491863, 1125.9774804503863, 1131.422974283105, 11669.591564295379, 11804.822927656092, 11822.11334149925, 11881.821772673416, 11883.049356051668, 214711.0, 215656.0, 216457.0, 217063.0, 217342.0, 50490.74754626277, 51257.743711281204, 51277.0, 51430.22854657183, 51759.48240517547, 1435.6769726811592, 1463.6853076588584, 1470.4285953952922, 1480.3930388540646, 1488.3897601983135, 20821.167153313698, 21542.784572154076, 21662.783372166075, 21726.130954761633, 21893.343199704035, 37103.0, 37113.814430927676, 37114.44328335023, 37116.628833711315, 37158.44262336013, 178150.0, 178715.0, 179496.0, 180056.0, 180486.0, 32453.35093298168, 34441.48337774986, 35500.64499354974, 35511.644883550834, 35529.467057993636, 44563.10873782571, 44601.33098003597, 44668.0, 44745.0, 44816.10367792561, 32674.183145420604, 32972.17569560684, 33172.50241246432, 33490.33019339648, 33523.4971475433, 32599.348013040082, 32731.509027365086, 32942.0, 32947.67052329446, 33543.99368018963, 35747.46378804268, 36808.0, 36850.63149368579, 37005.444918326786, 37417.81291093636, 32247.35505289928, 32390.35219295648, 32569.0, 32627.184320391232, 32851.0, 23734.881325593262, 24015.03939842387, 24038.0, 24068.15761448341, 24380.390490237176], "value": 16891.544362518816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8665513604302, 576.443731798814, 585.0872638683654, 588.6703446070198, 595.9731812068457, 21896.68619882808, 22687.319380418612, 22688.77311226887, 22693.999999999978, 22699.432514187134, 23457.765422345772, 24298.392540186505, 24633.26100216992, 24749.38126546837, 25076.122335718253, 6450.451711604507, 6670.066190733277, 6672.0, 6674.632895190763, 6675.933240667579, 6521.119648847392, 6654.667266636673, 6655.800325990228, 6657.300983396746, 6827.214870289906, 7060.54106483077, 7099.787006389791, 7101.218865924744, 7101.538400004009, 7101.822454438655, 7096.219415864251, 7102.85794284114, 7107.218205997362, 7126.465515086389, 7129.251428599974, 6746.426553742937, 7072.328128827753, 7085.185203701537, 7087.0432491614, 7091.858162836715, 29165.85417072901, 29701.554476682868, 29730.108096757132, 29730.554041689174, 29732.70267297321, 2120.257909731597, 2139.368886178581, 2141.1435425829636, 2148.1622167354744, 2158.4927542027613, 19841.206351745914, 20323.491912702153, 20655.5868882623, 20711.378658640115, 20868.06093725786, 2507.2102287779476, 2534.569123249052, 2568.0626571301527, 2588.9352766180996, 2594.286571192918, 119210.0, 123329.0, 123520.0, 124112.0, 132007.0, 18224.908875455538, 20292.391228263175, 20474.97625118738, 21353.679694804592, 22030.339089827332, 39803.20393592112, 39810.800945995084, 40311.39532907009, 40424.79787601043, 40604.79697601493, 11345.94327028376, 11413.086953043736, 11535.365554894393, 11571.42142892852, 11886.28682279066, 9593.376430531993, 9634.614615415305, 9655.468949207721, 9770.853437198448, 9786.217102631772, 10872.130229581615, 10941.398223097805, 10978.780424391627, 11252.549898004152, 11351.772964540829, 3776.508279229689, 3881.5924327945722, 4244.405783190356, 4297.892552686145, 4346.195953748566, 959.1990687775785, 962.9903700963041, 973.7808992976524, 1001.0740065439439, 1006.7885743993697, 18102.818971810113, 18227.63544729098, 18654.720179197324, 18701.438956831316, 18932.526686832938, 1021.341234903483, 1021.897810218987, 1031.4120951057826, 1037.4916291017498, 1041.7187359413067, 10199.490025498695, 10201.795964080826, 10223.488825558692, 10344.741381465374, 10682.305650132717, 467390.0, 468927.0, 469912.0, 473442.0, 480581.0, 109414.45292773645, 110675.44662276798, 112355.0, 112791.4360428209, 113129.0, 1148.3683973814536, 1156.8322593223936, 1173.6068417080203, 1185.3302883870758, 1188.144535934126, 16439.342426303294, 16516.339346426008, 16553.586160346087, 16649.001059936443, 16775.74836377431, 53850.461495384545, 54093.0, 54264.72867635637, 54765.72617137048, 55184.72407637936, 66403.0, 67363.66318168574, 67606.32393676, 67763.66118169378, 67956.66021670058, 18724.063796810377, 19013.524661883563, 19058.618827623646, 19138.904305478383, 19415.70876436883, 21111.472213194178, 21362.252321168686, 21474.463138421663, 21629.459263518536, 21666.0, 17230.655386892442, 17267.136643168044, 17507.737383938995, 17543.385981490588, 17627.29490820404, 15605.765913511079, 15623.296951636976, 15803.209839508208, 16042.0, 16151.015741623914, 17569.736453953457, 17637.29450821953, 17706.734398984285, 17820.198091085673, 17850.732239016685, 18282.817171828112, 18586.2565497384, 18651.533711657317, 18656.34702785396, 18661.346852860086, 17193.14034298255, 17200.397986070428, 17213.483595492155, 17309.30762769475, 17412.39056633012], "value": 12597.496574565113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.8233529641147, 1394.8256467941508, 1434.6556826361677, 1435.2680133132103, 1436.2459708652955, 14957.850421495781, 15046.849531504682, 15674.764878526832, 15691.293891774869, 15717.13555754433, 15620.531384058468, 15933.920330398332, 15996.76004859928, 16048.27782749776, 16122.274497647604, 2809.8033137680372, 2853.9857300713466, 2856.5715142728654, 2857.771378289742, 2857.785441187487, 2569.627404026415, 2726.332048648084, 2789.0, 2790.902318418856, 2792.0507027610606, 2780.694123646397, 2811.05829547102, 2818.8167769095044, 2819.746222839944, 2822.9011984580543, 2587.2496975876975, 2634.4204275059456, 2643.3259518822674, 2689.9193024209303, 2766.363736340653, 2652.124798816386, 2664.120840122755, 2698.271466703979, 2727.7954153438573, 2736.7263273672675, 15083.321250543751, 15115.622109447242, 15207.163606001666, 15213.923930380277, 15278.31247593861, 8136.918630813675, 8449.450785698971, 8464.746057618282, 8489.363297752694, 8489.745307640718, 4979.278004689336, 5203.0, 5229.215617657382, 5244.187150991603, 5294.788208471657, 1917.501449623094, 1932.7873933867263, 1942.9125689344014, 1959.4219705187004, 2001.1495114576392, 26390.86804565984, 26525.602115968275, 26650.73349266502, 26695.466090678077, 26765.732342676518, 6601.966990165019, 6796.932030679729, 6830.521863469608, 6904.551204171813, 6969.686364113627, 16857.157142142845, 17044.57388565271, 17074.82925170757, 17081.658366832595, 17087.231074601674, 7353.411727061823, 7571.167171611119, 7578.052743407075, 7614.619269036637, 7618.276263754934, 6912.032315475837, 7018.0, 7093.077899872984, 7115.750948716874, 7167.641617919187, 5103.336566246364, 5252.422233554306, 5255.894882102413, 5279.9208011879855, 5304.310439642899, 1316.2628927800463, 1368.3431952662777, 1499.6101013736507, 1502.9173395463135, 1514.9469768558047, 919.9494027828533, 937.7186843946789, 939.4175611121149, 939.7697564096703, 947.5735918836551, 8758.86861697075, 8805.383623146317, 8831.381803273709, 8843.07147749477, 8942.642294308285, 1014.4217795856439, 1039.740064983754, 1040.1990467340106, 1051.1958351860833, 1057.3444464431948, 4689.3903792507435, 4761.119192949315, 4773.188557945157, 4802.063597598435, 4858.6356023297685, 20676.379708608765, 21997.890010549843, 22130.44673883166, 22210.0, 22210.44473888166, 20976.895115524323, 21645.783542164692, 21795.34613961584, 21881.234156804752, 22057.77942220557, 11154.051905587954, 11177.217594768288, 11239.887601123884, 11244.550217991353, 11273.830892536618, 8438.831223375375, 8508.276796472122, 8607.741767746978, 8710.738677839421, 8714.956425217833, 17073.74389384185, 18612.44162675122, 18751.812481875553, 18773.6245275091, 18879.90560047191, 18772.436826894667, 19486.0, 19510.31713890007, 19569.70645440348, 19769.40691779249, 10368.481575921325, 10474.790504189721, 10475.319104258198, 10635.255532112678, 10663.786724265627, 12984.740305193654, 13212.273324967218, 13222.867771322164, 13227.074104812955, 13244.53644122451, 11002.0, 11042.944785276344, 11177.832332515181, 11276.94361528187, 11443.0, 11462.770744584896, 11526.193166478266, 11619.302841829518, 11650.067994560246, 11783.057355411374, 10076.748081298027, 10333.431661258403, 10348.430836304076, 10357.844632330673, 10360.222983276133, 7330.376917962033, 7416.306103323846, 7443.925560744323, 7513.774586762406, 7532.472726909064, 7550.5469671819865, 7756.806079848049, 7844.254795794391, 7845.882311765442, 7966.960165199137], "value": 6727.573146343023, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.37376751552387, 526.1266297945411, 528.1628618639457, 530.5278302310943, 536.6190005096381, 6395.808125756229, 6414.4662858171, 6443.226812782461, 6459.41865232129, 6460.870782584346, 6303.968480157593, 6331.968340158304, 6365.4907607391415, 6395.328490508499, 6432.163818703562, 5243.370795504536, 5248.343957005374, 5272.894542109156, 5284.233786101013, 5286.392064912546, 4913.140200464904, 5230.816921407752, 5231.319928409302, 5287.32072116178, 5295.338082739658, 4949.579285760697, 5005.674631148963, 5010.123228435027, 5030.698158110525, 5038.773255203525, 4939.333190019337, 4978.551930326288, 5018.824341148079, 5037.798488060474, 5056.14045612245, 4394.340848872695, 4492.842750503717, 4508.346289787995, 4521.570450807168, 4524.276115821485, 6037.818865434044, 6102.72537735803, 6186.690665466709, 6196.504279657616, 6255.028057183676, 5665.5467562594895, 5687.630304030225, 5707.258056452676, 5735.684537350444, 5782.537397008229, 6633.369829866155, 6677.664467106598, 6689.397954184098, 6690.397864192246, 6701.09535212745, 4945.010997800418, 4945.258211268302, 4947.802087916479, 4954.331165292675, 4961.734757636816, 6723.495737819683, 6834.2482326944, 6891.414229790424, 6913.0, 7008.719651213945, 5009.624278179078, 5033.6476446648385, 5046.268291097844, 5049.57078648319, 5054.82308119214, 5113.718745469035, 5117.590592752571, 5130.846074617767, 5135.38375394955, 5161.174212126042, 5741.971290143606, 5753.971230143822, 5761.978732224835, 5770.221020162308, 5797.652140871477, 6718.160229971254, 6757.358050985148, 6758.222804377559, 6767.35710107539, 6769.729210831511, 1777.5733823882176, 1787.928482860697, 1793.9103044847704, 1795.985268323393, 1797.1463554811621, 1163.761428907072, 1215.295128825279, 1238.9566365177175, 1238.993805030987, 1240.2248594628356, 5736.5123964462655, 5746.482816546447, 5748.0, 5751.338596061423, 5784.913226301609, 6658.4340331071435, 6774.882144446111, 6789.490788190807, 6791.2869148739655, 6796.640671865646, 5651.491365777018, 5754.625949313281, 5759.897637362416, 5801.9129713054335, 5808.5933984621515, 3575.5530558680166, 3581.606023337431, 3607.74745767799, 3621.8008009559726, 3634.4184930411006, 6388.648624325614, 6399.504502929531, 6409.423151916257, 6411.615303081737, 6413.29453760086, 6432.421082102634, 6796.66016699173, 6900.654967251618, 6909.792706218822, 6934.895976560356, 6390.616563006234, 6442.6778661066755, 6478.805635830932, 6499.967500162469, 6565.638889861008, 6583.518708290788, 6634.800955971328, 6725.621247644123, 6745.662716864235, 6820.795376138723, 6594.835129121619, 6655.467562595078, 6663.966680166568, 6667.766628167991, 6780.220274668476, 6487.643179625166, 6494.805155845333, 6498.155239818793, 6527.314631963765, 6530.640814755234, 5029.295898574275, 5063.8480845574695, 5077.0, 5087.694738315713, 5100.770465328995, 6509.283978762427, 6719.630420326929, 6738.2587915328295, 6747.243193548438, 6763.0, 6409.4872410206135, 6527.2167339919515, 6534.575252608755, 6555.639439830855, 6603.570767900071, 6514.967425162844, 6609.570377925419, 6649.833754156185, 6649.966750166218, 6679.499037572299, 6412.61524308543, 6518.380753828379, 6552.27924928267, 6555.344465553407, 6577.0, 6657.434118099822, 6668.5329227569855, 6712.2952090031795, 6730.226024007106, 6756.459483241427, 6485.8702825944165, 6490.51321150925, 6516.543841931019, 6519.674016299261, 6531.738730450728], "value": 5111.210403487983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.5361365703492, 913.5021413329735, 923.2567782934735, 932.9720108396746, 934.7849994501264, 15745.606359840995, 16148.838511614895, 16156.676866462663, 16193.757093643604, 16196.190190490457, 15535.223238838069, 16628.418005369815, 16678.249478773454, 16692.248848801803, 16924.069176195306, 946.347020555816, 962.7111866440075, 962.990370096297, 964.0937518732369, 965.9855102173473, 957.5690939077408, 977.081543349253, 986.8914419413859, 991.1426615977164, 991.7223177510309, 1044.310754901765, 1053.6680945502142, 1054.562356622001, 1056.1128651932374, 1056.7463808685936, 997.6059456514636, 1033.8862725100232, 1039.4646756920154, 1041.7551875309296, 1042.572545256445, 748.2367984655675, 750.1186106325101, 753.2580408297822, 755.4938191411767, 757.2162811490082, 17395.56511087233, 17776.822231777645, 17793.555161120945, 17803.0, 17821.821781782277, 21016.579668406546, 21476.892615536977, 21828.23601173967, 21839.344819655435, 21887.67168492474, 17218.655626887394, 17398.39105631297, 17845.553861153447, 17882.55293617657, 18007.639847203114, 3726.0312318797037, 3751.9812400938094, 3755.324041672498, 3764.2283331917165, 3766.0961369271454, 126727.0, 132447.0, 133862.3306883469, 134363.0, 135165.3241733795, 16876.903001304876, 17252.13739313029, 17580.296788128588, 17684.91157544204, 17752.28990840352, 31455.213619659233, 31581.684183158333, 31613.36773264568, 31747.52378714321, 31838.840805796284, 8617.61220745068, 8620.655173793104, 8629.266512346396, 8647.913520864837, 8702.782430439289, 3981.9402708959387, 4238.406623072772, 4337.4795024596615, 4364.345348197796, 4372.956270437255, 5228.4510126436935, 5300.787968481218, 5309.230161626542, 5313.44208858072, 5363.03465376236, 983.2085171437062, 984.0454758883872, 989.5794287427958, 1004.2719028704131, 1007.9496025198711, 687.9174499060144, 705.255095443188, 713.12642013533, 722.2560762414616, 741.3253938915668, 11534.59628912984, 11766.52933882635, 11774.823377649342, 11893.643190704293, 12088.697782555331, 720.8306048078697, 720.9675564599605, 722.7470385365081, 731.8353370491703, 740.6407892172292, 5525.696086715189, 5613.522850557748, 5645.830625081254, 5697.145428185722, 5742.655440673573, 125618.0, 125715.37142314413, 127354.36322818512, 128415.35792320978, 129311.35344323218, 89465.55267223752, 97639.0, 99110.5044474773, 111975.0, 113699.0, 94498.0, 96926.06147877003, 98184.50907745416, 99094.50452747835, 102659.0, 12500.437480313225, 12903.161294515827, 13035.869641303845, 13169.275689837152, 13434.865651343753, 41635.583644164384, 42556.36165457583, 43346.0, 43581.128377432906, 43988.560114398446, 56159.719201405365, 58545.41454585399, 67179.32820671731, 83561.0, 83728.0, 18381.264749409875, 18476.260949561867, 18564.721529176804, 18584.349547765763, 18649.627007460047, 19684.212631494578, 20264.797352026882, 20340.389788306373, 20379.0, 20473.795262047784, 18918.905405472884, 19133.904330478257, 19216.519587009876, 19349.4195174145, 19433.31983380575, 18768.906155469136, 18843.0, 18857.90571047136, 18915.527111822314, 18957.90521047386, 18775.90612046931, 18831.90584047071, 18858.71711924295, 18897.71653425227, 19137.712934305717, 12888.806667899802, 12891.355432228538, 12996.350182491027, 13212.471501140231, 13242.073054886065, 14315.427382904983, 14329.498467553585, 14511.274436278354, 14647.047941883744, 14651.780223296446], "value": 9237.77035893728, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 107.0, 108.0, 101.0, 109.0, 108.0, 107.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 116.0, 116.0, 116.0, 120.0, 127.0, 123.0, 116.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 163.0, 167.0, 168.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 75.0, 73.0, 75.0, 74.0, 73.0, 74.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 79.0, 78.0, 78.0, 79.0, 78.0, 79.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 116.0, 117.0, 112.0, 113.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 147.0, 150.0, 147.0, 149.0, 148.0, 150.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 98.0, 94.0, 95.0, 94.0, 94.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 51.0, 52.0, 56.0, 54.0, 51.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 40.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 78.0, 77.0, 73.0, 83.0, 74.0, 81.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 113.0, 120.0, 115.0, 113.0, 119.0, 119.0, 112.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 169.0, 175.0, 183.0, 166.0, 184.0, 169.0, 168.0, 175.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 71.0, 66.0, 66.0, 66.0, 72.0, 68.0, 68.0], "value": 67.9, "unit": "score"}]}]} 12:26:02 INFO - Return code: 0 12:26:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:26:02 INFO - # TBPL SUCCESS # 12:26:02 INFO - Running post-action listener: _package_coverage_data 12:26:02 INFO - Running post-action listener: _resource_record_post_action 12:26:02 INFO - [mozharness: 2017-09-15 19:26:02.862507Z] Finished run-tests step (success) 12:26:02 INFO - Running post-run listener: _resource_record_post_run 12:26:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 40960; Write bytes: 336138240; Read time: 292; Write time: 381700 12:26:02 INFO - TinderboxPrint: CPU usage
13.1% 12:26:02 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 292 12:26:02 INFO - TinderboxPrint: I/O write bytes / time
336,138,240 / 381,700 12:26:02 INFO - TinderboxPrint: CPU idle
8,247.4 (86.9%) 12:26:02 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 12:26:02 INFO - TinderboxPrint: Swap in / out
0 / 0 12:26:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9936896; Read time: 0; Write time: 700 12:26:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:26:02 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 36864; Write bytes: 326201344; Read time: 276; Write time: 381000 12:26:03 INFO - Running post-run listener: _upload_blobber_files 12:26:03 INFO - Blob upload gear active. 12:26:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:03 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 12:26:03 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:26:03 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:26:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:26:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:04 INFO - (blobuploader) - INFO - Done attempting. 12:26:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:26:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:11 INFO - (blobuploader) - INFO - Done attempting. 12:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:26:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:12 INFO - (blobuploader) - INFO - Done attempting. 12:26:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:26:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:13 INFO - (blobuploader) - INFO - Done attempting. 12:26:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:26:13 INFO - Return code: 0 12:26:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:26:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:26:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8cc677388bb06ec6f50fed9c43bfb08645d9cb32b41e792ed664e31e2e8e066c2144e3fa9bdfcac45103369165fe7cb7aaba579b7f5c2a7429d8a3b346d6887", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79cf99ba709695c739acc26c12786db57dd7d3c9efa4d66cb1a0c8b1a4ce3374bc44f776cfdc8d4d464e995f0228fb77720756ddf24c9848a294853369d87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac7ca526ad315ad7a5e2229faf085a0c34c66d50925ddef4a19b489b99d3c9328fcf4f0502996506405c05bc1d5feabec67cd7598926f4d44c8cc84cc41215d3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7abd0fef2c5cdc4f5984893fc29443298696340d9ff86b6f1212381813b32156d93b343d8914ed3d27fce25515a768e8167f368a3176ce51bc84ed0cc26bde55"} 12:26:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:26:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:26:13 INFO - Contents: 12:26:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8cc677388bb06ec6f50fed9c43bfb08645d9cb32b41e792ed664e31e2e8e066c2144e3fa9bdfcac45103369165fe7cb7aaba579b7f5c2a7429d8a3b346d6887", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79cf99ba709695c739acc26c12786db57dd7d3c9efa4d66cb1a0c8b1a4ce3374bc44f776cfdc8d4d464e995f0228fb77720756ddf24c9848a294853369d87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac7ca526ad315ad7a5e2229faf085a0c34c66d50925ddef4a19b489b99d3c9328fcf4f0502996506405c05bc1d5feabec67cd7598926f4d44c8cc84cc41215d3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7abd0fef2c5cdc4f5984893fc29443298696340d9ff86b6f1212381813b32156d93b343d8914ed3d27fce25515a768e8167f368a3176ce51bc84ed0cc26bde55"} 12:26:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:26:13 INFO - Copying logs to upload dir... 12:26:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:26:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.014135 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-15 12:26:13.676847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 12:26:13.680103) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 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-Non-PGO/sha512/c8cc677388bb06ec6f50fed9c43bfb08645d9cb32b41e792ed664e31e2e8e066c2144e3fa9bdfcac45103369165fe7cb7aaba579b7f5c2a7429d8a3b346d6887", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79cf99ba709695c739acc26c12786db57dd7d3c9efa4d66cb1a0c8b1a4ce3374bc44f776cfdc8d4d464e995f0228fb77720756ddf24c9848a294853369d87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac7ca526ad315ad7a5e2229faf085a0c34c66d50925ddef4a19b489b99d3c9328fcf4f0502996506405c05bc1d5feabec67cd7598926f4d44c8cc84cc41215d3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7abd0fef2c5cdc4f5984893fc29443298696340d9ff86b6f1212381813b32156d93b343d8914ed3d27fce25515a768e8167f368a3176ce51bc84ed0cc26bde55"} build_url:https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/fA4-U6SkTAuYHvLWxXHwTQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c8cc677388bb06ec6f50fed9c43bfb08645d9cb32b41e792ed664e31e2e8e066c2144e3fa9bdfcac45103369165fe7cb7aaba579b7f5c2a7429d8a3b346d6887", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc79cf99ba709695c739acc26c12786db57dd7d3c9efa4d66cb1a0c8b1a4ce3374bc44f776cfdc8d4d464e995f0228fb77720756ddf24c9848a294853369d87b", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac7ca526ad315ad7a5e2229faf085a0c34c66d50925ddef4a19b489b99d3c9328fcf4f0502996506405c05bc1d5feabec67cd7598926f4d44c8cc84cc41215d3", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7abd0fef2c5cdc4f5984893fc29443298696340d9ff86b6f1212381813b32156d93b343d8914ed3d27fce25515a768e8167f368a3176ce51bc84ed0cc26bde55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 12:26:13.708859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:26:13.709243) ========= 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=17051fcd5208b27b50bedfeb000001dd-1505497105.885603-1867410131 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 12:26:13.792078) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 12:26:13.792421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 12:26:13.792772) ========= ========= Total master_lag: 0.22 =========