builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-053 starttime: 1505587226.05 results: success (0) revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.046572) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.047001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.047272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.128087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.128452) ========= 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=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 11:40:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.2M=0s 2017-09-16 11:40:26 (45.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182637 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.347898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.348179) ========= 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=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.061777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.439325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:26.439643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 34e2566a71f160eb3c5c3d92626453852e818f18 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 11:40:26,441 truncating revision to first 12 chars 2017-09-16 11:40:26,441 Setting DEBUG logging. 2017-09-16 11:40:26,441 attempt 1/10 2017-09-16 11:40:26,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e2566a71f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 11:40:26,845 unpacking tar archive at: mozilla-central-34e2566a71f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.753481 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.212797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.213105) ========= script_repo_revision: 34e2566a71f160eb3c5c3d92626453852e818f18 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.216537) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.216800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 11:40:27.237984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 11:40:27.238255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:40:27 INFO - MultiFileLogger online at 20170916 11:40:27 in /builds/slave/test 11:40:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:40:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:27 INFO - {'append_to_log': False, 11:40:27 INFO - 'base_work_dir': '/builds/slave/test', 11:40:27 INFO - 'blob_upload_branch': 'Firefox', 11:40:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:27 INFO - 'branch': 'Firefox', 11:40:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:27 INFO - 'code_coverage': False, 11:40:27 INFO - 'config_files': ('talos/linux_config.py',), 11:40:27 INFO - 'default_actions': ('clobber', 11:40:27 INFO - 'read-buildbot-config', 11:40:27 INFO - 'download-and-extract', 11:40:27 INFO - 'populate-webroot', 11:40:27 INFO - 'create-virtualenv', 11:40:27 INFO - 'install', 11:40:27 INFO - 'setup-mitmproxy', 11:40:27 INFO - 'run-tests'), 11:40:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:27 INFO - 'disable_ccov_upload': False, 11:40:27 INFO - 'disable_stylo': False, 11:40:27 INFO - 'download_minidump_stackwalk': True, 11:40:27 INFO - 'download_symbols': 'ondemand', 11:40:27 INFO - 'enable_stylo': False, 11:40:27 INFO - 'enable_webrender': False, 11:40:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:40:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:27 INFO - 'gecko_profile': False, 11:40:27 INFO - 'gecko_profile_interval': 0, 11:40:27 INFO - 'installer_path': 'installer.exe', 11:40:27 INFO - 'log_level': 'info', 11:40:27 INFO - 'log_name': 'talos', 11:40:27 INFO - 'log_to_console': True, 11:40:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:40:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:40:27 INFO - 'opt_config_files': (), 11:40:27 INFO - 'pip_index': False, 11:40:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:40:27 INFO - 'system_bits': '32', 11:40:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:27 INFO - 'title': 'talos-linux64-ix-053', 11:40:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:27 INFO - 'use_talos_json': True, 11:40:27 INFO - 'verify': 'False', 11:40:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:27 INFO - 'work_dir': 'build'} 11:40:27 INFO - [mozharness: 2017-09-16 18:40:27.465227Z] Running clobber step. 11:40:27 INFO - Running pre-action listener: _resource_record_pre_action 11:40:27 INFO - Running main action method: clobber 11:40:27 INFO - rmtree: /builds/slave/test/build 11:40:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:29 INFO - Running post-action listener: _resource_record_post_action 11:40:29 INFO - [mozharness: 2017-09-16 18:40:29.252798Z] Finished clobber step (success) 11:40:29 INFO - [mozharness: 2017-09-16 18:40:29.252894Z] Running read-buildbot-config step. 11:40:29 INFO - Running pre-action listener: _resource_record_pre_action 11:40:29 INFO - Running main action method: read_buildbot_config 11:40:29 INFO - Using buildbot properties: 11:40:29 INFO - { 11:40:29 INFO - "project": "", 11:40:29 INFO - "product": "firefox", 11:40:29 INFO - "who": "ffxbld@noreply.mozilla.org", 11:40:29 INFO - "installer_path": "public/build/target.tar.bz2", 11:40:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:40:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:40:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 11:40:29 INFO - "stage_platform": "linux64-pgo", 11:40:29 INFO - "basedir": "/builds/slave/test", 11:40:29 INFO - "buildnumber": 23, 11:40:29 INFO - "platform": "ubuntu64_hw", 11:40:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:40:29 INFO - "slavebuilddir": "test", 11:40:29 INFO - "taskId": "Ggs_7BiWTX6oZRPRDJknWQ", 11:40:29 INFO - "branch": "mozilla-central", 11:40:29 INFO - "script_repo_revision": "production", 11:40:29 INFO - "revision": "34e2566a71f160eb3c5c3d92626453852e818f18", 11:40:29 INFO - "slavename": "talos-linux64-ix-053", 11:40:29 INFO - "repo_path": "mozilla-central" 11:40:29 INFO - } 11:40:29 INFO - Finding installer, test and symbols from parent task. 11:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ggs_7BiWTX6oZRPRDJknWQ'}, attempt #1 11:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ggs_7BiWTX6oZRPRDJknWQ'}, attempt #1 11:40:30 INFO - Task dependencies: BvB_Y1Q7TT2lE8hTX3In_Q 11:40:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q'}, attempt #1 11:40:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json 11:40:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip 11:40:30 INFO - Running post-action listener: _resource_record_post_action 11:40:30 INFO - [mozharness: 2017-09-16 18:40:30.589834Z] Finished read-buildbot-config step (success) 11:40:30 INFO - [mozharness: 2017-09-16 18:40:30.590048Z] Running download-and-extract step. 11:40:30 INFO - Running pre-action listener: _resource_record_pre_action 11:40:30 INFO - Running main action method: download_and_extract 11:40:30 INFO - mkdir: /builds/slave/test/build/tests 11:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:30 INFO - trying https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json 11:40:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:40:31 INFO - Downloaded 989 bytes. 11:40:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:40:31 INFO - Using the following test package requirements: 11:40:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:40:31 INFO - u'common': [u'target.common.tests.zip'], 11:40:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:40:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:40:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:40:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:40:31 INFO - u'mozbase': [u'target.common.tests.zip'], 11:40:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:40:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:40:31 INFO - u'web-platform': [u'target.common.tests.zip', 11:40:31 INFO - u'target.web-platform.tests.tar.gz'], 11:40:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:40:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:40:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip 11:40:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:40:31 INFO - Fetch https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.common.tests.zip into memory 11:40:33 INFO - Content-Length response header: 55324282 11:40:33 INFO - Bytes received: 55324282 11:40:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip 11:40:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:40:44 INFO - Fetch https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.talos.tests.zip into memory 11:40:45 INFO - Content-Length response header: 14508748 11:40:45 INFO - Bytes received: 14508748 11:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:45 INFO - trying https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:40:48 INFO - Downloaded 62158329 bytes. 11:40:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:48 INFO - mkdir: /builds/slave/test/properties 11:40:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:40:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:40:48 INFO - Contents: 11:40:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 11:40:48 INFO - Running post-action listener: _resource_record_post_action 11:40:48 INFO - Running post-action listener: find_tests_for_verification 11:40:48 INFO - Running post-action listener: set_extra_try_arguments 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.809296Z] Finished download-and-extract step (success) 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.809393Z] Running populate-webroot step. 11:40:48 INFO - Running pre-action listener: _resource_record_pre_action 11:40:48 INFO - Running main action method: populate_webroot 11:40:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:40:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tresize', 11:40:48 INFO - 'tcanvasmark']}, 11:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:40:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['dromaeo_css', 11:40:48 INFO - 'kraken']}, 11:40:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:40:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['damp', 'tps']}, 11:40:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['damp', 'tps']}, 11:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:40:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['dromaeo_dom']}, 11:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:40:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['basic_compositor_video', 11:40:48 INFO - 'glvideo']}, 11:40:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:40:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['ts_paint_webext', 11:40:48 INFO - 'tp5o_webext']}, 11:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:40:48 INFO - 'ts_paint', 11:40:48 INFO - 'tpaint', 11:40:48 INFO - 'sessionrestore', 11:40:48 INFO - 'sessionrestore_many_windows', 11:40:48 INFO - 'sessionrestore_no_auto_restore', 11:40:48 INFO - 'tabpaint']}, 11:40:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['a11yr', 11:40:48 INFO - 'ts_paint', 11:40:48 INFO - 'tpaint', 11:40:48 INFO - 'sessionrestore', 11:40:48 INFO - 'sessionrestore_many_windows', 11:40:48 INFO - 'sessionrestore_no_auto_restore', 11:40:48 INFO - 'tabpaint']}, 11:40:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:40:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:40:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:40:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['bloom_basic']}, 11:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:40:48 INFO - 'tsvgr_opacity', 11:40:48 INFO - 'tart', 11:40:48 INFO - 'tscrollx', 11:40:48 INFO - 'tsvg_static']}, 11:40:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tsvgx', 11:40:48 INFO - 'tsvgr_opacity', 11:40:48 INFO - 'tart', 11:40:48 INFO - 'tscrollx', 11:40:48 INFO - 'tsvg_static']}, 11:40:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:40:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo'], 11:40:48 INFO - 'tests': ['tp5o']}, 11:40:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo', 11:40:48 INFO - '--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:40:48 INFO - 'talos_options': ['--stylo-threads=1', 11:40:48 INFO - '--mitmproxy', 11:40:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:40:48 INFO - '--firstNonBlankPaint'], 11:40:48 INFO - 'tests': ['tp6_google', 11:40:48 INFO - 'tp6_youtube', 11:40:48 INFO - 'tp6_amazon', 11:40:48 INFO - 'tp6_facebook']}, 11:40:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--xperf_path', 11:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:48 INFO - 'tests': ['tp5n']}, 11:40:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:40:48 INFO - 'talos_options': ['--disable-stylo', 11:40:48 INFO - '--xperf_path', 11:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:40:48 INFO - 'tests': ['tp5n']}}} 11:40:48 INFO - Running post-action listener: _resource_record_post_action 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.824292Z] Finished populate-webroot step (success) 11:40:48 INFO - [mozharness: 2017-09-16 18:40:48.824381Z] Running create-virtualenv step. 11:40:48 INFO - Running pre-action listener: _resource_record_pre_action 11:40:48 INFO - Running main action method: create_virtualenv 11:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:40:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:40:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:40:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:40:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:40:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:49 INFO - Installing pip...............done. 11:40:49 INFO - Return code: 0 11:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:40:50 INFO - Reading from file tmpfile_stdout 11:40:50 INFO - Output received: 11:40:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:40:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:40:50 INFO - Using env: {'DISPLAY': ':0', 11:40:50 INFO - 'HOME': '/home/cltbld', 11:40:50 INFO - 'LANG': 'en_US.UTF-8', 11:40:50 INFO - 'LANGUAGE': 'en_US:en', 11:40:50 INFO - 'LOGNAME': 'cltbld', 11:40:50 INFO - 'MAIL': '/var/mail/cltbld', 11:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:50 INFO - 'MOZ_NO_REMOTE': '1', 11:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:50 INFO - 'NO_EM_RESTART': '1', 11:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:50 INFO - 'PWD': '/builds/slave/test', 11:40:50 INFO - 'SHELL': '/bin/bash', 11:40:50 INFO - 'SHLVL': '1', 11:40:50 INFO - 'TERM': 'linux', 11:40:50 INFO - 'TMOUT': '86400', 11:40:50 INFO - 'USER': 'cltbld', 11:40:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:50 INFO - '_': '/tools/buildbot/bin/python'} 11:40:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:40:51 INFO - Downloading/unpacking pip>=1.5 11:40:51 INFO - Running setup.py egg_info for package pip 11:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:40:51 INFO - Installing collected packages: pip 11:40:51 INFO - Found existing installation: pip 1.1 11:40:51 INFO - Uninstalling pip: 11:40:51 INFO - Successfully uninstalled pip 11:40:51 INFO - Running setup.py install for pip 11:40:51 INFO - warning: no files found matching 'pip/cacert.pem' 11:40:51 INFO - warning: no files found matching '*.html' under directory 'docs' 11:40:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:40:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:40:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:40:51 INFO - Successfully installed pip 11:40:51 INFO - Cleaning up... 11:40:51 INFO - Return code: 0 11:40:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40: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')]} 11:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40: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', '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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:40: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 psutil>=3.1.1 11:40:51 INFO - Using env: {'DISPLAY': ':0', 11:40:51 INFO - 'HOME': '/home/cltbld', 11:40:51 INFO - 'LANG': 'en_US.UTF-8', 11:40:51 INFO - 'LANGUAGE': 'en_US:en', 11:40:51 INFO - 'LOGNAME': 'cltbld', 11:40:51 INFO - 'MAIL': '/var/mail/cltbld', 11:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:51 INFO - 'MOZ_NO_REMOTE': '1', 11:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:51 INFO - 'NO_EM_RESTART': '1', 11:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:51 INFO - 'PWD': '/builds/slave/test', 11:40:51 INFO - 'SHELL': '/bin/bash', 11:40:51 INFO - 'SHLVL': '1', 11:40:51 INFO - 'TERM': 'linux', 11:40:51 INFO - 'TMOUT': '86400', 11:40:51 INFO - 'USER': 'cltbld', 11:40:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:51 INFO - '_': '/tools/buildbot/bin/python'} 11:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:51 INFO - Downloading/unpacking psutil>=3.1.1 11:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:53 INFO - Installing collected packages: psutil 11:40:53 INFO - Running setup.py install for psutil 11:40:53 INFO - building 'psutil._psutil_linux' extension 11:40:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:40:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:40:55 INFO - building 'psutil._psutil_posix' extension 11:40:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:40:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:40:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:55 INFO - Successfully installed psutil 11:40:55 INFO - Cleaning up... 11:40:55 INFO - Return code: 0 11:40:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:55 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:40:55 INFO - Using env: {'DISPLAY': ':0', 11:40:55 INFO - 'HOME': '/home/cltbld', 11:40:55 INFO - 'LANG': 'en_US.UTF-8', 11:40:55 INFO - 'LANGUAGE': 'en_US:en', 11:40:55 INFO - 'LOGNAME': 'cltbld', 11:40:55 INFO - 'MAIL': '/var/mail/cltbld', 11:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:55 INFO - 'MOZ_NO_REMOTE': '1', 11:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:55 INFO - 'NO_EM_RESTART': '1', 11:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:55 INFO - 'PWD': '/builds/slave/test', 11:40:55 INFO - 'SHELL': '/bin/bash', 11:40:55 INFO - 'SHLVL': '1', 11:40:55 INFO - 'TERM': 'linux', 11:40:55 INFO - 'TMOUT': '86400', 11:40:55 INFO - 'USER': 'cltbld', 11:40:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:55 INFO - '_': '/tools/buildbot/bin/python'} 11:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40: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 11:40: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 11:40: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 11:40: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 11:40:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:56 INFO - Installing collected packages: mozsystemmonitor 11:40:56 INFO - Running setup.py install for mozsystemmonitor 11:40:57 INFO - Successfully installed mozsystemmonitor 11:40:57 INFO - Cleaning up... 11:40:57 INFO - Return code: 0 11:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40: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')]} 11:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40: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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40: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 11:40: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 11:40:57 INFO - Using env: {'DISPLAY': ':0', 11:40:57 INFO - 'HOME': '/home/cltbld', 11:40:57 INFO - 'LANG': 'en_US.UTF-8', 11:40:57 INFO - 'LANGUAGE': 'en_US:en', 11:40:57 INFO - 'LOGNAME': 'cltbld', 11:40:57 INFO - 'MAIL': '/var/mail/cltbld', 11:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:57 INFO - 'MOZ_NO_REMOTE': '1', 11:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:57 INFO - 'NO_EM_RESTART': '1', 11:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:57 INFO - 'PWD': '/builds/slave/test', 11:40:57 INFO - 'SHELL': '/bin/bash', 11:40:57 INFO - 'SHLVL': '1', 11:40:57 INFO - 'TERM': 'linux', 11:40:57 INFO - 'TMOUT': '86400', 11:40:57 INFO - 'USER': 'cltbld', 11:40:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:57 INFO - '_': '/tools/buildbot/bin/python'} 11:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40: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 11:40: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 11:40: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 11:40: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 11:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:58 INFO - warning: no files found matching '*.txt' 11:40:58 INFO - no previously-included directories found matching 'build' 11:40:58 INFO - no previously-included directories found matching 'dist' 11:40:58 INFO - no previously-included directories found matching '.git*' 11:40:58 INFO - Installing collected packages: jsonschema, functools32 11:40:58 INFO - Running setup.py install for functools32 11:40:58 INFO - warning: no files found matching '*.txt' 11:40:58 INFO - no previously-included directories found matching 'build' 11:40:58 INFO - no previously-included directories found matching 'dist' 11:40:58 INFO - no previously-included directories found matching '.git*' 11:40:58 INFO - Successfully installed jsonschema functools32 11:40:58 INFO - Cleaning up... 11:40:58 INFO - Return code: 0 11:40:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:58 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:40:58 INFO - Using env: {'DISPLAY': ':0', 11:40:58 INFO - 'HOME': '/home/cltbld', 11:40:58 INFO - 'LANG': 'en_US.UTF-8', 11:40:58 INFO - 'LANGUAGE': 'en_US:en', 11:40:58 INFO - 'LOGNAME': 'cltbld', 11:40:58 INFO - 'MAIL': '/var/mail/cltbld', 11:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:58 INFO - 'MOZ_NO_REMOTE': '1', 11:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:58 INFO - 'NO_EM_RESTART': '1', 11:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:58 INFO - 'PWD': '/builds/slave/test', 11:40:58 INFO - 'SHELL': '/bin/bash', 11:40:58 INFO - 'SHLVL': '1', 11:40:58 INFO - 'TERM': 'linux', 11:40:58 INFO - 'TMOUT': '86400', 11:40:58 INFO - 'USER': 'cltbld', 11:40:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:58 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:40:59 INFO - Cleaning up... 11:40:59 INFO - Return code: 0 11:40:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:59 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:40:59 INFO - Using env: {'DISPLAY': ':0', 11:40:59 INFO - 'HOME': '/home/cltbld', 11:40:59 INFO - 'LANG': 'en_US.UTF-8', 11:40:59 INFO - 'LANGUAGE': 'en_US:en', 11:40:59 INFO - 'LOGNAME': 'cltbld', 11:40:59 INFO - 'MAIL': '/var/mail/cltbld', 11:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:59 INFO - 'MOZ_NO_REMOTE': '1', 11:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:59 INFO - 'NO_EM_RESTART': '1', 11:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:59 INFO - 'PWD': '/builds/slave/test', 11:40:59 INFO - 'SHELL': '/bin/bash', 11:40:59 INFO - 'SHLVL': '1', 11:40:59 INFO - 'TERM': 'linux', 11:40:59 INFO - 'TMOUT': '86400', 11:40:59 INFO - 'USER': 'cltbld', 11:40:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:59 INFO - '_': '/tools/buildbot/bin/python'} 11:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:40: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 11:40: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 11:40: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 11:40: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 11:41:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:00 INFO - Downloading docopt-0.6.1.tar.gz 11:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:00 INFO - Running setup.py install for blobuploader 11:41:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:01 INFO - Running setup.py install for requests 11:41:01 INFO - Running setup.py install for docopt 11:41:01 INFO - Successfully installed blobuploader requests docopt 11:41:01 INFO - Cleaning up... 11:41:01 INFO - Return code: 0 11:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:01 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:01 INFO - Using env: {'DISPLAY': ':0', 11:41:01 INFO - 'HOME': '/home/cltbld', 11:41:01 INFO - 'LANG': 'en_US.UTF-8', 11:41:01 INFO - 'LANGUAGE': 'en_US:en', 11:41:01 INFO - 'LOGNAME': 'cltbld', 11:41:01 INFO - 'MAIL': '/var/mail/cltbld', 11:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:01 INFO - 'MOZ_NO_REMOTE': '1', 11:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:01 INFO - 'NO_EM_RESTART': '1', 11:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:01 INFO - 'PWD': '/builds/slave/test', 11:41:01 INFO - 'SHELL': '/bin/bash', 11:41:01 INFO - 'SHLVL': '1', 11:41:01 INFO - 'TERM': 'linux', 11:41:01 INFO - 'TMOUT': '86400', 11:41:01 INFO - 'USER': 'cltbld', 11:41:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:01 INFO - '_': '/tools/buildbot/bin/python'} 11:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:01 INFO - Running setup.py (path:/tmp/pip-zF25UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:01 INFO - Running setup.py (path:/tmp/pip-wOu09O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:01 INFO - Running setup.py (path:/tmp/pip-PLGMmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:01 INFO - Running setup.py (path:/tmp/pip-3PpKMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:02 INFO - Running setup.py (path:/tmp/pip-mTB9QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 INFO - Running setup.py (path:/tmp/pip-RsDosy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 INFO - Running setup.py (path:/tmp/pip-rOc43Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:02 INFO - Running setup.py (path:/tmp/pip-pXy41d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:02 INFO - Running setup.py (path:/tmp/pip-ZzWFyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:02 INFO - Running setup.py (path:/tmp/pip-1XIoWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:02 INFO - Running setup.py (path:/tmp/pip-glxpZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:02 INFO - Running setup.py (path:/tmp/pip-Kb__Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 INFO - Running setup.py (path:/tmp/pip-D69kMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:02 INFO - Running setup.py (path:/tmp/pip-xAdTzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:02 INFO - Running setup.py (path:/tmp/pip-6nYr1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:02 INFO - Running setup.py (path:/tmp/pip-fWGEUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:02 INFO - Running setup.py (path:/tmp/pip-vfx8D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:02 INFO - Running setup.py install for manifestparser 11:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozcrash 11:41:03 INFO - Running setup.py install for mozdebug 11:41:03 INFO - Running setup.py install for mozdevice 11:41:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozfile 11:41:03 INFO - Running setup.py install for mozhttpd 11:41:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozinfo 11:41:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozInstall 11:41:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for mozleak 11:41:03 INFO - Running setup.py install for mozlog 11:41:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:03 INFO - Running setup.py install for moznetwork 11:41:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozprocess 11:41:04 INFO - Running setup.py install for mozprofile 11:41:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozrunner 11:41:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Running setup.py install for mozscreenshot 11:41:04 INFO - Running setup.py install for moztest 11:41:04 INFO - Running setup.py install for mozversion 11:41:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:04 INFO - Cleaning up... 11:41:04 INFO - Return code: 0 11:41:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:04 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:04 INFO - Using env: {'DISPLAY': ':0', 11:41:04 INFO - 'HOME': '/home/cltbld', 11:41:04 INFO - 'LANG': 'en_US.UTF-8', 11:41:04 INFO - 'LANGUAGE': 'en_US:en', 11:41:04 INFO - 'LOGNAME': 'cltbld', 11:41:04 INFO - 'MAIL': '/var/mail/cltbld', 11:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:04 INFO - 'MOZ_NO_REMOTE': '1', 11:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:04 INFO - 'NO_EM_RESTART': '1', 11:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:04 INFO - 'PWD': '/builds/slave/test', 11:41:04 INFO - 'SHELL': '/bin/bash', 11:41:04 INFO - 'SHLVL': '1', 11:41:04 INFO - 'TERM': 'linux', 11:41:04 INFO - 'TMOUT': '86400', 11:41:04 INFO - 'USER': 'cltbld', 11:41:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:04 INFO - '_': '/tools/buildbot/bin/python'} 11:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:04 INFO - Running setup.py (path:/tmp/pip-YdR8cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:05 INFO - Running setup.py (path:/tmp/pip-0gwX1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:05 INFO - Running setup.py (path:/tmp/pip-pdxP93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:05 INFO - Running setup.py (path:/tmp/pip-BSd5MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:05 INFO - Running setup.py (path:/tmp/pip-_Aihrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:05 INFO - Running setup.py (path:/tmp/pip-fIGaPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:05 INFO - Running setup.py (path:/tmp/pip-dlhFxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:05 INFO - Running setup.py (path:/tmp/pip-T1R4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:05 INFO - Running setup.py (path:/tmp/pip-tXJcWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:05 INFO - Running setup.py (path:/tmp/pip-OSlp4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:05 INFO - Running setup.py (path:/tmp/pip-aVdsYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:05 INFO - Running setup.py (path:/tmp/pip-ZFmOFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:05 INFO - Running setup.py (path:/tmp/pip-2FEWN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:05 INFO - Running setup.py (path:/tmp/pip-7lHnRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:05 INFO - Running setup.py (path:/tmp/pip-A09Rsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:06 INFO - Running setup.py (path:/tmp/pip-Z47IsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:06 INFO - Running setup.py (path:/tmp/pip-LTAN47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:41:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:07 INFO - Downloading blessings-1.6.tar.gz 11:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:07 INFO - Installing collected packages: blessings 11:41:07 INFO - Running setup.py install for blessings 11:41:07 INFO - Successfully installed blessings 11:41:07 INFO - Cleaning up... 11:41:07 INFO - Return code: 0 11:41:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:07 INFO - Reading from file tmpfile_stdout 11:41:07 INFO - Current package versions: 11:41:07 INFO - argparse == 1.2.1 11:41:07 INFO - blessings == 1.6 11:41:07 INFO - blobuploader == 1.2.4 11:41:07 INFO - docopt == 0.6.1 11:41:07 INFO - functools32 == 3.2.3-2 11:41:07 INFO - jsonschema == 2.5.1 11:41:07 INFO - manifestparser == 1.1 11:41:07 INFO - mozInstall == 1.13 11:41:07 INFO - mozcrash == 1.0 11:41:07 INFO - mozdebug == 0.1 11:41:07 INFO - mozdevice == 0.51 11:41:07 INFO - mozfile == 1.2 11:41:07 INFO - mozhttpd == 0.7 11:41:07 INFO - mozinfo == 0.10 11:41:07 INFO - mozleak == 0.1 11:41:07 INFO - mozlog == 3.5 11:41:07 INFO - moznetwork == 0.27 11:41:07 INFO - mozprocess == 0.25 11:41:07 INFO - mozprofile == 0.28 11:41:07 INFO - mozrunner == 6.13 11:41:07 INFO - mozscreenshot == 0.1 11:41:07 INFO - mozsystemmonitor == 0.3 11:41:07 INFO - moztest == 0.8 11:41:07 INFO - mozversion == 1.4 11:41:07 INFO - psutil == 3.1.1 11:41:07 INFO - requests == 1.2.3 11:41:07 INFO - wsgiref == 0.1.2 11:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:07 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:41:07 INFO - Using env: {'DISPLAY': ':0', 11:41:07 INFO - 'HOME': '/home/cltbld', 11:41:07 INFO - 'LANG': 'en_US.UTF-8', 11:41:07 INFO - 'LANGUAGE': 'en_US:en', 11:41:07 INFO - 'LOGNAME': 'cltbld', 11:41:07 INFO - 'MAIL': '/var/mail/cltbld', 11:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:07 INFO - 'MOZ_NO_REMOTE': '1', 11:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:07 INFO - 'NO_EM_RESTART': '1', 11:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:07 INFO - 'PWD': '/builds/slave/test', 11:41:07 INFO - 'SHELL': '/bin/bash', 11:41:07 INFO - 'SHLVL': '1', 11:41:07 INFO - 'TERM': 'linux', 11:41:07 INFO - 'TMOUT': '86400', 11:41:07 INFO - 'USER': 'cltbld', 11:41:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:07 INFO - '_': '/tools/buildbot/bin/python'} 11:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:41:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:41: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 11:41: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 11:41: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 11:41: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 11:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:41:09 INFO - Installing collected packages: simplejson 11:41:09 INFO - Running setup.py install for simplejson 11:41:09 INFO - building 'simplejson._speedups' extension 11:41:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:41:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:41:10 INFO - Successfully installed simplejson 11:41:10 INFO - Cleaning up... 11:41:10 INFO - Return code: 0 11:41:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:10 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 0xdbe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf87a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, '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': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:41:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:41:10 INFO - Using env: {'DISPLAY': ':0', 11:41:10 INFO - 'HOME': '/home/cltbld', 11:41:10 INFO - 'LANG': 'en_US.UTF-8', 11:41:10 INFO - 'LANGUAGE': 'en_US:en', 11:41:10 INFO - 'LOGNAME': 'cltbld', 11:41:10 INFO - 'MAIL': '/var/mail/cltbld', 11:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:10 INFO - 'MOZ_NO_REMOTE': '1', 11:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:10 INFO - 'NO_EM_RESTART': '1', 11:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:10 INFO - 'PWD': '/builds/slave/test', 11:41:10 INFO - 'SHELL': '/bin/bash', 11:41:10 INFO - 'SHLVL': '1', 11:41:10 INFO - 'TERM': 'linux', 11:41:10 INFO - 'TMOUT': '86400', 11:41:10 INFO - 'USER': 'cltbld', 11:41:10 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:10 INFO - '_': '/tools/buildbot/bin/python'} 11:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:10 INFO - Cleaning up... 11:41:10 INFO - Return code: 0 11:41:10 INFO - Running post-action listener: _resource_record_post_action 11:41:10 INFO - Running post-action listener: _start_resource_monitoring 11:41:10 INFO - Starting resource monitoring. 11:41:10 INFO - [mozharness: 2017-09-16 18:41:10.474233Z] Finished create-virtualenv step (success) 11:41:10 INFO - [mozharness: 2017-09-16 18:41:10.475229Z] Running install step. 11:41:10 INFO - Running pre-action listener: _resource_record_pre_action 11:41:10 INFO - Running main action method: install 11:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:10 INFO - Reading from file tmpfile_stdout 11:41:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:10 INFO - Reading from file tmpfile_stdout 11:41:10 INFO - Output received: 11:41:10 INFO - Usage: mozinstall [options] installer 11:41:10 INFO - Options: 11:41:10 INFO - -h, --help show this help message and exit 11:41:10 INFO - -d DEST, --destination=DEST 11:41:10 INFO - Directory to install application into. [default: 11:41:10 INFO - "/builds/slave/test"] 11:41:10 INFO - --app=APP Application being installed. [default: firefox] 11:41:10 INFO - mkdir: /builds/slave/test/build/application 11:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:41:28 INFO - Reading from file tmpfile_stdout 11:41:28 INFO - Output received: 11:41:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:41:28 INFO - Running post-action listener: _resource_record_post_action 11:41:28 INFO - [mozharness: 2017-09-16 18:41:28.372351Z] Finished install step (success) 11:41:28 INFO - [mozharness: 2017-09-16 18:41:28.372459Z] Running setup-mitmproxy step. 11:41:28 INFO - Running pre-action listener: _resource_record_pre_action 11:41:28 INFO - Running main action method: setup_mitmproxy 11:41:28 INFO - Skipping: mitmproxy is not required 11:41:28 INFO - Running post-action listener: _resource_record_post_action 11:41:28 INFO - [mozharness: 2017-09-16 18:41:28.372926Z] Finished setup-mitmproxy step (success) 11:41:28 INFO - [mozharness: 2017-09-16 18:41:28.373017Z] Running run-tests step. 11:41:28 INFO - Running pre-action listener: _resource_record_pre_action 11:41:28 INFO - Running pre-action listener: _set_gcov_prefix 11:41:28 INFO - Running main action method: run_tests 11:41:28 WARNING - Try message not found. 11:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:28 INFO - Python 2.7.3 11:41:28 INFO - Return code: 0 11:41:28 INFO - grabbing minidump binary from tooltool 11:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:28 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 0x112e090>, '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 0x112ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1128f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:41:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:41:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:41:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:28 INFO - Return code: 0 11:41:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:41:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:28 INFO - ENV: RUST_BACKTRACE is now full 11:41:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:41:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:41:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 11:41:28 INFO - Using env: {'DISPLAY': ':0', 11:41:28 INFO - 'HOME': '/home/cltbld', 11:41:28 INFO - 'LANG': 'en_US.UTF-8', 11:41:28 INFO - 'LANGUAGE': 'en_US:en', 11:41:28 INFO - 'LOGNAME': 'cltbld', 11:41:28 INFO - 'MAIL': '/var/mail/cltbld', 11:41:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:28 INFO - 'MOZ_NO_REMOTE': '1', 11:41:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:28 INFO - 'NO_EM_RESTART': '1', 11:41:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:28 INFO - 'PWD': '/builds/slave/test', 11:41:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:28 INFO - 'RUST_BACKTRACE': 'full', 11:41:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:41:28 INFO - 'SHELL': '/bin/bash', 11:41:28 INFO - 'SHLVL': '1', 11:41:28 INFO - 'TERM': 'linux', 11:41:28 INFO - 'TMOUT': '86400', 11:41:28 INFO - 'USER': 'cltbld', 11:41:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:28 INFO - '_': '/tools/buildbot/bin/python'} 11:41:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:41:29 INFO - mozversion application_buildid: 20170916172404 11:41:29 INFO - mozversion application_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:41:29 INFO - mozversion application_display_name: Nightly 11:41:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:29 INFO - mozversion application_name: Firefox 11:41:29 INFO - mozversion application_remotingname: firefox 11:41:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:41:29 INFO - mozversion application_vendor: Mozilla 11:41:29 INFO - mozversion application_version: 57.0a1 11:41:29 INFO - mozversion platform_buildid: 20170916172404 11:41:29 INFO - mozversion platform_changeset: 34e2566a71f160eb3c5c3d92626453852e818f18 11:41:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:41:29 INFO - mozversion platform_version: 57.0a1 11:41:29 INFO - using testdate: 1505587289 11:41:29 INFO - actual date: 1505587289 11:41:29 INFO - starting webserver on 'localhost:56381' 11:41:29 INFO - SUITE-START | Running 2 tests 11:41:29 INFO - TEST-START | dromaeo_css 11:41:29 INFO - Initialising browser for dromaeo_css test... 11:41:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56381/getInfo.html -profile /tmp/tmpbJP0Fj/profile 11:41:29 INFO - TEST-INFO | started process 3583 (/builds/slave/test/build/application/firefox/firefox http://localhost:56381/getInfo.html) 11:41:37 INFO - TEST-INFO | 3583: exit 0 11:41:37 INFO - Browser initialized. 11:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:37 INFO - Using env: {'DISPLAY': ':0', 11:41:37 INFO - 'HOME': '/home/cltbld', 11:41:37 INFO - 'JSGC_DISABLE_POISONING': '1', 11:41:37 INFO - 'LANG': 'en_US.UTF-8', 11:41:37 INFO - 'LANGUAGE': 'en_US:en', 11:41:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:41:37 INFO - 'LOGNAME': 'cltbld', 11:41:37 INFO - 'MAIL': '/var/mail/cltbld', 11:41:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:41:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:41:37 INFO - 'MOZ_NO_REMOTE': '1', 11:41:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:41:37 INFO - 'NO_EM_RESTART': '1', 11:41:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:37 INFO - 'PWD': '/builds/slave/test', 11:41:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:37 INFO - 'RUST_BACKTRACE': 'full', 11:41:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:41:37 INFO - 'SHELL': '/bin/bash', 11:41:37 INFO - 'SHLVL': '1', 11:41:37 INFO - 'STYLO_FORCE_DISABLED': '1', 11:41:37 INFO - 'TERM': 'linux', 11:41:37 INFO - 'TMOUT': '86400', 11:41:37 INFO - 'USER': 'cltbld', 11:41:37 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 11:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:37 INFO - '_': '/tools/buildbot/bin/python'} 11:41:37 INFO - TEST-INFO | started process 3823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJP0Fj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:38 INFO - PID 3823 | 11:41:38 INFO - PID 3823 | (/builds/slave/test/build/application/firefox/firefox:3872): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:41:38 INFO - PID 3823 | 11:41:48 INFO - PID 3823 | RSS: Main: 144297984 11:41:48 INFO - PID 3823 | 11:44:44 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56381/tests/dromaeo/cssquery-ext.html) 11:44:46 INFO - PID 3823 | RSS: Main: 148021248 11:44:46 INFO - PID 3823 | 11:47:47 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-ext.html (next: http://localhost:56381/tests/dromaeo/cssquery-jquery.html) 11:47:48 INFO - PID 3823 | RSS: Main: 148152320 11:47:48 INFO - PID 3823 | 11:50:50 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56381/tests/dromaeo/cssquery-mootools.html) 11:50:50 INFO - PID 3823 | RSS: Main: 150507520 11:50:50 INFO - PID 3823 | 11:53:52 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56381/tests/dromaeo/cssquery-prototype.html) 11:53:52 INFO - PID 3823 | RSS: Main: 149118976 11:53:52 INFO - PID 3823 | 11:56:55 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56381/tests/dromaeo/cssquery-yui.html) 11:56:56 INFO - PID 3823 | RSS: Main: 150556672 11:56:56 INFO - PID 3823 | 11:59:57 INFO - PID 3823 | Cycle 1(1): loaded http://localhost:56381/tests/dromaeo/cssquery-yui.html (next: http://localhost:56381/tests/dromaeo/cssquery-dojo.html) 11:59:58 INFO - PID 3823 | RSS: Main: 152637440 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | __start_tp_report 11:59:58 INFO - PID 3823 | _x_x_mozilla_page_load 11:59:58 INFO - PID 3823 | _x_x_mozilla_page_load_details 11:59:58 INFO - PID 3823 | |i|pagename|runs| 11:59:58 INFO - PID 3823 | |0;dojo.html;3887.9028024299387;3889.6499315061646;3905.3165696003193;3923.6861051115907;3954.960450395495;6285.968570157154;6346.841328966778;6352.301246862848;6422.357764223575;6477.287498375181;6379.712912918918;6390.520710946675;6409.967950160242;6412.422881940636;6433.678316084189;5684.630499017561;5726.942730572703;5747.2528571285675;5757.078867381219;5768.048272035109;5774.249347584829;5812.738426770806;5828.737706803183;5837.562182836305;5855.560832937525;66.0965736310988;5722.427757224286;5730.512906402961;5742.799002034909;5860.413958604148;5729.369769325371;5805.448482394166;5810.157527158581;5818.1563673267565;5821.796237131723;5695.515881150107;5723.7996670116345;5755.453231942959;5782.392848750905;5790.536757059425;6119.26568811741;6290.716917738667;6339.8415039623915;6376.744930202833;6454.967725161344;6832.248452670202;6865.313468653145;6923.6884340204815;6988.021676965229;6988.091548098715;6919.204291506491;6938.271481494471;6945.72217111315;6996;6997.160340759091;6373.521985851034;6464.25661048976;6495.31799161086;6500.284968653492;6504;7083.89374159388;7105.538140020882;7203.099612548432;7205.2434494378385;7214.242504536948;6830.385265326145;6835.897461538081;6900.827479313058;6907.447404207652;6912.135983002125;6737.797866064026;6817.216020157745;6879.346462086194;6950.443964482931;6955.93044069563;6871.793846184622;6935.653217339112;6949.617771022642;6988.19635741886;6997.720091196397;6855.348741869514;6863.10779598659;6943.89584156238;6959.130108736408;6960.060391847137;4924.3105965164905;4926.8768280793265;4935.851924442272;4999;5002.374703162105;4506.188886000486;4545.477270113913;4562.178807814559;4572.88567785808;4586.312053191981;6348.111264422984;6408.391202835816;6420.839479013062;6437.388448097423;6448.871022579616;6765.323467653196;6833.965830170917;6922.134733158356;6924.272951340137;6969.756058537927;6351.396617321347;6356.332585078592;6441.967790161019;6449.193850768654;6453.032045193258;5461.863453413696;5511.063119269734;5519.69641669712;5528.612997090246;5534.1975413565615;7088.716451341992;7106.467014973898;7120.216776154619;7127;7131.108611423572;6828.692708828214;6908.689108990107;6925.930740692629;6935.202451718016;6943.583384996917;7152.749653762094;7154.570725756471;7184.892226616709;7264.818379540342;7273.927260727325;6712.463002959849;6809.353111454404;6822.317768223138;6828.146481689789;6941.791746247621;6832.248452670103;6835.93164068353;6870.690818913061;6870.793876183722;6933.2720064392515;6645.700943457459;6679.332066793282;6690.498212633975;6712.83217919556;6717.596944183365;6600.07598936159;6611.900821487586;6616.4045235929;6700.262971073275;6712.798616041527;6482.157319548429;6555.508336874849;6563.7702680405955;6644.202695676549;6649.434798042027;6611.570247933869;6686.83282917931;6727.865442691216;6787.049813026081;6800.115984921928;6435.356464353527;6548.410643042149;6580.1116849224745;6601.438877695449;6617.702203400762 11:59:58 INFO - PID 3823 | |1;ext.html;915.4370062411615;937.2923442800685;969.3505351414553;972.0959507657875;973.3673112476889;42604.786976065116;43558.564414355846;43675.78162109185;43742.56257437425;43881.78059109704;41337.58662413375;43237.56762432375;43761.343579846245;43862;44202.33696494547;8141.796455088641;8255.339572834158;8260.83478330433;8290.626921788504;8296.83406331873;7847.843043139133;7924;7937.365010799151;7938.2855543001115;7945.562994035326;7889.921100788976;7926.28663420292;7949;7958.52248865067;7961.402894782886;7893.13175550689;7921.36629069673;7922.920770792276;7963.163867793885;7965.362770978308;8031.678732850679;8094.271515563569;8098.51408915467;8102.878456823152;8108.391870609669;39875.4018689717;39978.40032399487;40021.19957600861;40161.79919100415;40211.39682904759;3637.781733096023;3651.123730304734;3661.066428060854;3666.926661466756;3668.211334563055;31818.363632727214;32000.359992800248;32041.198970025936;32064.519032214535;32085.35829283401;5426.782928682848;5446.945530544684;5452.863678408032;5455.809046683386;5600.52395546379;217143;217312;218238;224192;225021.87489062615;52347.214791778155;52743.47256527462;52761.2085818713;52858;52900.206496902574;55416.445835541934;55528.72235638796;55690.72154639282;55721.16418253729;55905;15448.613784655474;15553.144577048144;15572.766408503881;15788.68422631564;15860.841391586167;12594.24434533931;12600.495980160691;12603.621891343275;12611.558595449298;12790.29653369055;13920;14064.789028164585;14108.647283817781;14153.433862645585;14284.357203925849;5395.4604539545735;5454.645448045864;5465.289512363447;5467.890642187134;5508.989218935059;1112.5605385872534;1115.1469126118525;1119.367557330106;1130.6777568392968;1132.184826924613;25545.489090218092;25572.744272557036;25621.3594660135;25710.48579028409;26031;1204.2533629149807;1219.408586835384;1224.13086708438;1238.7027113492877;1241.1126044877956;13732.794008089886;13733;13825.930870345584;13860.722785544232;14022.22877741734;297494;298425;300628;300928;302065;56613.71693141508;57012;57150.42849571534;57216;57236.42763572394;1493.46235355272;1520.8935374523899;1546.791183190255;1552.0532475190125;1556.533040087969;24927.252182434557;24931.0027598894;25183.37041573975;25253.621195681713;25574.23277301684;41208.38187427251;41229.793851030554;41330.586694132675;41404;41404.79297603493;241647;242566;245483;245773;246265;35816.82091589525;37544;38450.807745961094;38482;38505.807470963584;48164.759176203894;48764.51235487741;49076.50923490719;49207.26189107095;49312.260316096006;36669.816650916575;36759.08102297464;37018;37044.6295537052;37306;35799;36182.81908590545;36293;36782.816085919396;36825.63174368222;41438.171236575705;42326.576734232265;42702;42725.35911961261;42856.57143428526;34653.48019779655;35350.82324588463;35419.11452213612;35628.82185589056;35693.64306357007;26501.734982649927;26848.731512685405;27190.320241994108;27204.45591088207;27696.58455123215 11:59:58 INFO - PID 3823 | |2;jquery.html;575.7869588252345;580.889630970116;584.1150656755015;607.9240094988126;611.8715069835334;23261.185858494955;23937.922793474292;23939.401514962112;23964.5207095858;24014.15950441735;25110.744462776835;25698.74301256987;26756.598651020202;26801.32996675084;26981.86509067452;6563.6061836289855;6689.6989635466525;6709.261981182066;6720;6729.05793188954;6413.230412350525;6520.054592084169;6599.571027883172;6640.0703901453835;6668.299828518008;6613.3386661333725;6617;6617.867642647144;6618.569792963466;6619.702113404908;6632.966835165842;6636.170478690164;6641.833954151137;6680.131582894192;6898.379145876896;6418.743250269984;6421.229452465734;6422.325655806119;6424.5502814802985;6428.067930150102;30856.69143308583;31248.687513124805;31358.21604459884;31378.843105784552;31388.686113139032;2308.595995700746;2328.0222306631254;2333.4166458385403;2333.614953532665;2339.87130707811;19788.901055494774;21085.156593736232;21417;21640.783592164033;21657.133714651394;2500.1374525788574;2502.186789293487;2550.9872450637813;2579.9742002579924;2581.5998520229396;135629;145871;154170;156307;163441;15757.133357665209;15864.603384915239;15904.409559044003;15981.28084236212;16557.337706491846;26087.608685869727;26137;26158.215253542425;26178.214653560422;26225.475490490084;10693.518791654395;10773.83839242412;10821.891781082246;10824.13406927444;10853.34879907208;9680.467574283482;9743.805123897482;9826.705198844045;9931.702048938543;9967.10296073357;9673.854892176623;10005.899941000642;10024.19806415485;10065.899341006643;10164.745881353025;2776.7084456131815;2794.874230659625;2845.8434786086964;2960.2747326905046;2988.0886329669224;1038.5638032026568;1051.295631926611;1073.2487258918632;1083.182197440927;1095.5782023920847;21364.359069227947;21387.89306053491;21456;21559.137634494757;21746.13015479363;1115.2360632966445;1128.4414214963645;1134.262729225993;1139.920205585601;1144.101880024177;11620.593279235187;11739.647810565697;11774.3524106175;12021.218620789621;12053.939730301292;604995;611627;622865;624527;647638;132416.3379183117;132929;134530;134823;135420;1140.2702270546856;1229.3484453239798;1233.7779199743952;1256.6230130960676;1285.6657269110099;22185.556288874453;22320.21879234219;22444.214452494085;22503.549929001656;22615.88692056529;62795.6860215696;63844;64777.35222647713;65563.67218163879;66666.33333666601;83310.16689833024;83663;83676;83893.58053209695;84591.57704211686;15179.544613661608;15236.162011089053;15302.387904483696;15370.538883833502;15454.459093931659;23677.881610591838;23728.40678983039;24131.75868241295;24240;24396.878015610517;19714.901425493354;19998.30005949843;20002.69995950033;20114.59770804605;20295.188192472135;17284.79006469535;17613.82386176122;17641.558961026076;18021.72967405516;18336.90831545834;20175;20545.178192872118;20550.38348849537;20602.072906718935;20624.27815026467;15167.544973650367;15279.159646219565;15321;15335.386584536494;15344.156071415733;19549.51126221856;19732.30936917201;19802.603947920674;19874.403767886986;19919.10364033651 11:59:58 INFO - PID 3823 | |3;mootools.html;1426.6290764401256;1474.432343547734;1484.5175318021645;1490.4559835659982;1511.2066165263236;16548.17259137043;17240.482785516455;17309.04800235985;17318.480445586654;17331.913340433297;16794;16900.323987040505;16994.32022719093;17002.234899429524;17004.06477643729;2854.5575435807377;2905.142982820073;2906.433245517125;2913.28624487001;2914.2859999300094;2789.2190186747744;2844.6586409630872;2845.9573106403423;2848.5157523221;2854.5290027145497;2816;2832.107886015898;2878.3379822640804;2885.1344596621034;2887.7256660617313;2878.568214767781;2885.5527393253974;2895;2901.245676124202;2915.28575499002;2658.880350384218;2661.5741481363084;2688.838669679806;2772.306923269183;2869.4548035873117;16844.74732879008;16975.3209871605;17004.574885627957;17017.65964680712;17019.65960680792;8338.166183381674;8629.827403451958;8631.913680863174;8633.784155396103;8642.13578642137;5600.943990560124;5669.858253543694;5751.884962300773;5819.185314056035;5899.646021238739;2126.3515359693934;2140.2188201306567;2149.795769401904;2182.2907555044676;2196.978030219709;30631.081067568008;30796;30848.228794280098;30848.691513084807;30971.535426968614;6989.615571143636;7079.734484964865;7134.500584959107;7235.240299768554;7240;19887.303944361876;19927;19933.800661993486;19944.3019494317;19947.700784488243;8217.671293148207;8318.459300145592;8362.958185209034;8399.748007559783;8402.537860417613;7496.362809161283;7543.245675432413;7742.729004484816;7744.303012728881;7746.806329841686;5323.254744335796;5482.23248745176;5486.835394938158;5543.057680194376;5659.320881494247;1558.1897413344998;1566.9608259793367;1575.58247064528;1576.5270418874293;1591.4111778641977;924.4961495984704;938.9953050234706;949.658123075706;950.8336041192764;958.678842587727;8060.758177254692;8103.432759706764;8182.22268884455;8199.385046121564;8200.712975045964;771.6643260181839;776.2547953964257;778.4706399648294;787.5432249295395;793.1156760212322;5147.716875571879;5495.203195536705;5570.972145139248;5683.516901063374;5707.143928410688;23276.66151468302;24803.751962480143;24951.500969980498;25311.62032569513;25594;24145.879270603535;24968.375790605016;25098.372540686265;25138;25585.87207063953;11481.311121332747;11751.294922304689;11784.58753943625;11791.823122653168;11812.763744725058;8674.132586741276;8764.737057888273;8806.339524535813;8854.867176992479;8919.73240802777;20811.8959405202;21059;21127.683084753433;21464.24875129363;21829.454263643536;22299.888500557394;22320.665190022486;22361.44096397603;22500.437489062904;22662.546749064597;12348.753024939271;12662.620121396372;12728.109032367645;12736;12737.29944853042;15421.228938553251;15425.382984680487;15444.613884652974;15623.296951636976;15650.373985040926;12333.50665973351;12517.374131293216;12859;12911.35443227816;13134.540291089766;12384.62846114618;12426;12544.121911466109;12591.24452532851;12876.549320774102;10929.18031147683;11033.724156896142;11055.668329949793;11200;11214.383208923588;7329.52358096722;7347.8530429392185;7404.222556631476;7408.222136675571;7422.96288518554;7701.268379503938;7724.304812566896;7812.804679883048;7814.413918955987;7987.960060199662 11:59:58 INFO - PID 3823 | |4;prototype.html;527.4172039895917;544.1429748146668;546.7621584610694;559.8020236693479;564.6640249051812;6197.566170368076;6201.627902325864;6294;6300.369963003697;6303.495720342373;6180.75276988921;6190.3190649028575;6222.906656400158;6263.655498947556;6293.937060629392;4089.386592011207;4987.600991920655;5119.692818430897;5152.407473140599;5164.509371609691;4942.233953737176;4959.776810043539;4980.800767969277;5011.674241174312;5100.234964755279;5012.52381023804;5059.62052846038;5066.240063990413;5066.620003499734;5083.61872859537;5041.890784027508;5057.317262169597;5072.315237442972;5086.77109530072;5097.974510127463;4750.073735621555;4757.738324392157;4766.952330476685;4783.521647835189;4801.303810947428;6026.54800889935;6100.908486372664;6116.847078823021;6170.84572885677;6230.781922632731;5947.613405128696;5969.671668058255;5971.61184523009;6006.159137720722;6041.456268935773;6630.204375474926;6648.401643852077;6659.866802663968;6673.132492775957;6729.899051514231;5035.949640503584;5206.5314121729225;5221.094300580261;5254.106801843695;5303.310569625924;6796.728130874759;6855.760048398332;6860.245373008965;6907.551009184437;7005.684744186524;5483.369412517612;5491.697956612345;5505.284313039279;5584.888302233932;5602.4033150551895;5601.439856014447;5609.971950140223;5622.128570071645;5623.240862483594;5659.405762394971;6047.853012180701;6068.696565171724;6068.787592434332;6083.361247069082;6089.695515224221;6717.16035495563;6723.495737819683;6758.78341898463;6793.626350550767;6793.762218322335;1951.024487756122;1954.833839123662;1957.9902100489405;1966.7049942508738;1968.1536939116318;1362.4550179928108;1446.6094154578416;1455.3669153918079;1455.8398576156615;1469.2662658063587;5987.670678112659;5995.760169593167;6023.789167379121;6037.607555508878;6082.1789058477425;6526.608403495806;6540.967295163494;6548.574342667712;6605.07528945948;6621.801345959629;6050.6369617823075;6082;6139.785107521216;6166.907496387557;6190.659513726789;3511.841967111486;3533.6289689582736;3549.148204430918;3562.964370356315;3570.5001299818045;6924.792256232321;6965.233824279325;6979.546329488567;6991.23096459389;7017.438604911595;6562.50781191403;6725.2602213756445;6750.3924646782025;6791.456683465311;6861.897071543931;6948.6178260195165;6968.233494315621;7001.584453363582;7009.754658586925;7026.437884969292;6578.671066446755;6662.400383965466;6662.800115996528;6712.328767123248;6725.226598941184;6567.146270984741;6571.474282057328;6594.901076483952;6653.201615806134;6666.799996000128;6813.965930170318;6877.89683154743;6931.1682598088555;6969.721211151497;6975.965120174366;5510.9448905510435;5511.255980442589;5531.225628412106;5550.195221692751;5561.3295225151205;6421.678916054085;6691.130153080263;6774.119364482585;6805.217399999064;6878.3465570770695;6096.695165241631;6389.105525226379;6496.480281577368;6548.738050477928;6636.5686230396805;6362.854686156351;6382.776602818879;6402.967985160044;6409.071608761969;6561.770338038336;6298.464630506458;6338.8732225354315;6405.807825765234;6435.92048746394;6492.253390860112;6446.419822216023;6479.935200647933;6541.672916354068;6569.770058047945;6585.176852893388;6368.28056424772;6415.807525774234;6432.292447830829;6445.614192948538;6460.580062295936 11:59:58 INFO - PID 3823 | |5;yui.html;911.5806728904704;943.5376665433939;944.145548278808;981.317984001119;1001.8747656542935;20110.296139635117;20781.792182078174;20821;20836.479088022807;20885.477863053413;19515.41453756386;19745.605087898235;19879.304224352152;20046;20158.19367225309;1058.185197398003;1072.4208927179313;1072.4691277817453;1073.5115522437272;1074.3339129739572;1076.935383876966;1089.7384627689337;1091.5961094395084;1092.1044743310488;1095.8411030400587;1091.1707102602;1140.2075557487508;1142.662914440242;1143.1026644084395;1143.8798926112763;1125.6229163230328;1130.2088538023334;1131.1346819682908;1131.4795194210674;1131.9434028298592;797.752696664036;815.6207363575907;824.6948629007305;825.4634487583119;826.2439867521271;20359.185632574678;20392.796072039237;20444.182232710824;20525.897370513052;20589.691154632543;23276;23510.882445587835;23933.88033059841;24026.159084432136;24089.51820963571;18389.540261493436;18612;18958.43124706261;19013;19026.42920712381;3944.6844252460023;3947.624975627311;3957.940630890539;3962.86129985452;3973.9006524836823;167114;167414;168739;169166;170519;17380.565485862702;17496.212670429606;17505.912470437564;17802.643947120985;17804;31878;32796.3440731184;33211.83394083014;33917.15207119842;34381.82809085939;9535.284853636005;9614.807703846023;9668.613255469843;9674.08096230857;9713.688652032026;4260.659147268273;4270.658347332268;4392.2752745797225;4411.801468933906;4414.3157810539415;6009.969950150309;6135.386461353829;6135.601185922901;6164.260288765377;6166.229221347332;1106.4910141334915;1121.9439028048564;1138.8974992250737;1140.0480598700012;1146.908247340211;724.3010494872474;738.1879932074675;738.8891666250106;739.8557281330196;751.5565816168487;12429.316497392114;13088.60734177957;13285.402156902963;13563;13705.314734263446;718.586812582767;726.2410780734145;726.8364617960916;731.9011933388924;746.2537462537463;5720.942790572124;5857.297124345021;5935.109733539917;5954.910676339859;6018.458338749533;150208;150578.24710876375;151820;151892.2026949335;154596;105083;107357.46321268343;123541;136651;143225;110396.89603104026;111585;111851.44074279576;113180;119435.40282298706;13832.308384580932;14479.348429320917;14657.193854337687;14670;14689.41242350294;54556.454435456726;54589.72705136449;54601.72699136479;54764;56224.71887640536;69381.30618693748;69451.55128646357;69541;69743;70084.64957675179;19773;19958.101885415483;19971;20126.39620811378;20172.596548068665;23439.296821095395;23593.29220123399;23631;23723.881380592986;23843.642345364486;20035.499112522302;20161.39515814528;20181.798182018578;20267.59464810666;20446.897765511076;19679.901600491907;19769.209231630575;19898.70151947751;19966.600667986848;20113.19547218095;19405.32081377145;19592.510187245432;19603.215871364984;19838.20647174097;19841;15313.310901009258;15655.37378504847;15921;16036.35854565851;16070.67858642844;15091.698166036836;15136.697266054396;15143.848561514244;15271;15389.230538473255 11:59:58 INFO - PID 3823 | __end_tp_report 11:59:58 INFO - PID 3823 | __start_cc_report 11:59:58 INFO - PID 3823 | _x_x_mozilla_cycle_collect,270 11:59:58 INFO - PID 3823 | __end_cc_report 11:59:58 INFO - PID 3823 | __startTimestamp1505588398086__endTimestamp 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | ------- Summary: start ------- 11:59:58 INFO - PID 3823 | Number of tests: 6 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#0] dojo.html Cycles:165 Average:6324.41 Median:6601.44 stddev:904.22 (13.7%) stddev-sans-first:886.56 11:59:58 INFO - PID 3823 | Values: 3887.9 3889.6 3905.3 3923.7 3955.0 6286.0 6346.8 6352.3 6422.4 6477.3 6379.7 6390.5 6410.0 6412.4 6433.7 5684.6 5726.9 5747.3 5757.1 5768.0 5774.2 5812.7 5828.7 5837.6 5855.6 66.1 5722.4 5730.5 5742.8 5860.4 5729.4 5805.4 5810.2 5818.2 5821.8 5695.5 5723.8 5755.5 5782.4 5790.5 6119.3 6290.7 6339.8 6376.7 6455.0 6832.2 6865.3 6923.7 6988.0 6988.1 6919.2 6938.3 6945.7 6996.0 6997.2 6373.5 6464.3 6495.3 6500.3 6504.0 7083.9 7105.5 7203.1 7205.2 7214.2 6830.4 6835.9 6900.8 6907.4 6912.1 6737.8 6817.2 6879.3 6950.4 6955.9 6871.8 6935.7 6949.6 6988.2 6997.7 6855.3 6863.1 6943.9 6959.1 6960.1 4924.3 4926.9 4935.9 4999.0 5002.4 4506.2 4545.5 4562.2 4572.9 4586.3 6348.1 6408.4 6420.8 6437.4 6448.9 6765.3 6834.0 6922.1 6924.3 6969.8 6351.4 6356.3 6442.0 6449.2 6453.0 5461.9 5511.1 5519.7 5528.6 5534.2 7088.7 7106.5 7120.2 7127.0 7131.1 6828.7 6908.7 6925.9 6935.2 6943.6 7152.7 7154.6 7184.9 7264.8 7273.9 6712.5 6809.4 6822.3 6828.1 6941.8 6832.2 6835.9 6870.7 6870.8 6933.3 6645.7 6679.3 6690.5 6712.8 6717.6 6600.1 6611.9 6616.4 6700.3 6712.8 6482.2 6555.5 6563.8 6644.2 6649.4 6611.6 6686.8 6727.9 6787.0 6800.1 6435.4 6548.4 6580.1 6601.4 6617.7 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#1] ext.html Cycles:180 Average:43380.36 Median:37425.00 stddev:66957.66 (178.9%) stddev-sans-first:67069.57 11:59:58 INFO - PID 3823 | Values: 915.4 937.3 969.4 972.1 973.4 42604.8 43558.6 43675.8 43742.6 43881.8 41337.6 43237.6 43761.3 43862.0 44202.3 8141.8 8255.3 8260.8 8290.6 8296.8 7847.8 7924.0 7937.4 7938.3 7945.6 7889.9 7926.3 7949.0 7958.5 7961.4 7893.1 7921.4 7922.9 7963.2 7965.4 8031.7 8094.3 8098.5 8102.9 8108.4 39875.4 39978.4 40021.2 40161.8 40211.4 3637.8 3651.1 3661.1 3666.9 3668.2 31818.4 32000.4 32041.2 32064.5 32085.4 5426.8 5446.9 5452.9 5455.8 5600.5 217143.0 217312.0 218238.0 224192.0 225021.9 52347.2 52743.5 52761.2 52858.0 52900.2 55416.4 55528.7 55690.7 55721.2 55905.0 15448.6 15553.1 15572.8 15788.7 15860.8 12594.2 12600.5 12603.6 12611.6 12790.3 13920.0 14064.8 14108.6 14153.4 14284.4 5395.5 5454.6 5465.3 5467.9 5509.0 1112.6 1115.1 1119.4 1130.7 1132.2 25545.5 25572.7 25621.4 25710.5 26031.0 1204.3 1219.4 1224.1 1238.7 1241.1 13732.8 13733.0 13825.9 13860.7 14022.2 297494.0 298425.0 300628.0 300928.0 302065.0 56613.7 57012.0 57150.4 57216.0 57236.4 1493.5 1520.9 1546.8 1552.1 1556.5 24927.3 24931.0 25183.4 25253.6 25574.2 41208.4 41229.8 41330.6 41404.0 41404.8 241647.0 242566.0 245483.0 245773.0 246265.0 35816.8 37544.0 38450.8 38482.0 38505.8 48164.8 48764.5 49076.5 49207.3 49312.3 36669.8 36759.1 37018.0 37044.6 37306.0 35799.0 36182.8 36293.0 36782.8 36825.6 41438.2 42326.6 42702.0 42725.4 42856.6 34653.5 35350.8 35419.1 35628.8 35693.6 26501.7 26848.7 27190.3 27204.5 27696.6 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#2] jquery.html Cycles:180 Average:40679.41 Median:12794.60 stddev:104090.93 (813.6%) stddev-sans-first:104339.38 11:59:58 INFO - PID 3823 | Values: 575.8 580.9 584.1 607.9 611.9 23261.2 23937.9 23939.4 23964.5 24014.2 25110.7 25698.7 26756.6 26801.3 26981.9 6563.6 6689.7 6709.3 6720.0 6729.1 6413.2 6520.1 6599.6 6640.1 6668.3 6613.3 6617.0 6617.9 6618.6 6619.7 6633.0 6636.2 6641.8 6680.1 6898.4 6418.7 6421.2 6422.3 6424.6 6428.1 30856.7 31248.7 31358.2 31378.8 31388.7 2308.6 2328.0 2333.4 2333.6 2339.9 19788.9 21085.2 21417.0 21640.8 21657.1 2500.1 2502.2 2551.0 2580.0 2581.6 135629.0 145871.0 154170.0 156307.0 163441.0 15757.1 15864.6 15904.4 15981.3 16557.3 26087.6 26137.0 26158.2 26178.2 26225.5 10693.5 10773.8 10821.9 10824.1 10853.3 9680.5 9743.8 9826.7 9931.7 9967.1 9673.9 10005.9 10024.2 10065.9 10164.7 2776.7 2794.9 2845.8 2960.3 2988.1 1038.6 1051.3 1073.2 1083.2 1095.6 21364.4 21387.9 21456.0 21559.1 21746.1 1115.2 1128.4 1134.3 1139.9 1144.1 11620.6 11739.6 11774.4 12021.2 12053.9 604995.0 611627.0 622865.0 624527.0 647638.0 132416.3 132929.0 134530.0 134823.0 135420.0 1140.3 1229.3 1233.8 1256.6 1285.7 22185.6 22320.2 22444.2 22503.5 22615.9 62795.7 63844.0 64777.4 65563.7 66666.3 83310.2 83663.0 83676.0 83893.6 84591.6 15179.5 15236.2 15302.4 15370.5 15454.5 23677.9 23728.4 24131.8 24240.0 24396.9 19714.9 19998.3 20002.7 20114.6 20295.2 17284.8 17613.8 17641.6 18021.7 18336.9 20175.0 20545.2 20550.4 20602.1 20624.3 15167.5 15279.2 15321.0 15335.4 15344.2 19549.5 19732.3 19802.6 19874.4 19919.1 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#3] mootools.html Cycles:180 Average:10370.21 Median:2824.05 stddev:7800.10 (276.2%) stddev-sans-first:7793.05 11:59:58 INFO - PID 3823 | Values: 1426.6 1474.4 1484.5 1490.5 1511.2 16548.2 17240.5 17309.0 17318.5 17331.9 16794.0 16900.3 16994.3 17002.2 17004.1 2854.6 2905.1 2906.4 2913.3 2914.3 2789.2 2844.7 2846.0 2848.5 2854.5 2816.0 2832.1 2878.3 2885.1 2887.7 2878.6 2885.6 2895.0 2901.2 2915.3 2658.9 2661.6 2688.8 2772.3 2869.5 16844.7 16975.3 17004.6 17017.7 17019.7 8338.2 8629.8 8631.9 8633.8 8642.1 5600.9 5669.9 5751.9 5819.2 5899.6 2126.4 2140.2 2149.8 2182.3 2197.0 30631.1 30796.0 30848.2 30848.7 30971.5 6989.6 7079.7 7134.5 7235.2 7240.0 19887.3 19927.0 19933.8 19944.3 19947.7 8217.7 8318.5 8363.0 8399.7 8402.5 7496.4 7543.2 7742.7 7744.3 7746.8 5323.3 5482.2 5486.8 5543.1 5659.3 1558.2 1567.0 1575.6 1576.5 1591.4 924.5 939.0 949.7 950.8 958.7 8060.8 8103.4 8182.2 8199.4 8200.7 771.7 776.3 778.5 787.5 793.1 5147.7 5495.2 5571.0 5683.5 5707.1 23276.7 24803.8 24951.5 25311.6 25594.0 24145.9 24968.4 25098.4 25138.0 25585.9 11481.3 11751.3 11784.6 11791.8 11812.8 8674.1 8764.7 8806.3 8854.9 8919.7 20811.9 21059.0 21127.7 21464.2 21829.5 22299.9 22320.7 22361.4 22500.4 22662.5 12348.8 12662.6 12728.1 12736.0 12737.3 15421.2 15425.4 15444.6 15623.3 15650.4 12333.5 12517.4 12859.0 12911.4 13134.5 12384.6 12426.0 12544.1 12591.2 12876.5 10929.2 11033.7 11055.7 11200.0 11214.4 7329.5 7347.9 7404.2 7408.2 7423.0 7701.3 7724.3 7812.8 7814.4 7988.0 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#4] prototype.html Cycles:180 Average:5658.60 Median:6190.49 stddev:1527.85 (24.7%) stddev-sans-first:1482.80 11:59:58 INFO - PID 3823 | Values: 527.4 544.1 546.8 559.8 564.7 6197.6 6201.6 6294.0 6300.4 6303.5 6180.8 6190.3 6222.9 6263.7 6293.9 4089.4 4987.6 5119.7 5152.4 5164.5 4942.2 4959.8 4980.8 5011.7 5100.2 5012.5 5059.6 5066.2 5066.6 5083.6 5041.9 5057.3 5072.3 5086.8 5098.0 4750.1 4757.7 4767.0 4783.5 4801.3 6026.5 6100.9 6116.8 6170.8 6230.8 5947.6 5969.7 5971.6 6006.2 6041.5 6630.2 6648.4 6659.9 6673.1 6729.9 5035.9 5206.5 5221.1 5254.1 5303.3 6796.7 6855.8 6860.2 6907.6 7005.7 5483.4 5491.7 5505.3 5584.9 5602.4 5601.4 5610.0 5622.1 5623.2 5659.4 6047.9 6068.7 6068.8 6083.4 6089.7 6717.2 6723.5 6758.8 6793.6 6793.8 1951.0 1954.8 1958.0 1966.7 1968.2 1362.5 1446.6 1455.4 1455.8 1469.3 5987.7 5995.8 6023.8 6037.6 6082.2 6526.6 6541.0 6548.6 6605.1 6621.8 6050.6 6082.0 6139.8 6166.9 6190.7 3511.8 3533.6 3549.1 3563.0 3570.5 6924.8 6965.2 6979.5 6991.2 7017.4 6562.5 6725.3 6750.4 6791.5 6861.9 6948.6 6968.2 7001.6 7009.8 7026.4 6578.7 6662.4 6662.8 6712.3 6725.2 6567.1 6571.5 6594.9 6653.2 6666.8 6814.0 6877.9 6931.2 6969.7 6976.0 5510.9 5511.3 5531.2 5550.2 5561.3 6421.7 6691.1 6774.1 6805.2 6878.3 6096.7 6389.1 6496.5 6548.7 6636.6 6362.9 6382.8 6403.0 6409.1 6561.8 6298.5 6338.9 6405.8 6435.9 6492.3 6446.4 6479.9 6541.7 6569.8 6585.2 6368.3 6415.8 6432.3 6445.6 6460.6 11:59:58 INFO - PID 3823 | 11:59:58 INFO - PID 3823 | [#5] yui.html Cycles:180 Average:28798.19 Median:20003.25 stddev:42458.03 (212.3%) stddev-sans-first:42525.50 11:59:58 INFO - PID 3823 | Values: 911.6 943.5 944.1 981.3 1001.9 20110.3 20781.8 20821.0 20836.5 20885.5 19515.4 19745.6 19879.3 20046.0 20158.2 1058.2 1072.4 1072.5 1073.5 1074.3 1076.9 1089.7 1091.6 1092.1 1095.8 1091.2 1140.2 1142.7 1143.1 1143.9 1125.6 1130.2 1131.1 1131.5 1131.9 797.8 815.6 824.7 825.5 826.2 20359.2 20392.8 20444.2 20525.9 20589.7 23276.0 23510.9 23933.9 24026.2 24089.5 18389.5 18612.0 18958.4 19013.0 19026.4 3944.7 3947.6 3957.9 3962.9 3973.9 167114.0 167414.0 168739.0 169166.0 170519.0 17380.6 17496.2 17505.9 17802.6 17804.0 31878.0 32796.3 33211.8 33917.2 34381.8 9535.3 9614.8 9668.6 9674.1 9713.7 4260.7 4270.7 4392.3 4411.8 4414.3 6010.0 6135.4 6135.6 6164.3 6166.2 1106.5 1121.9 1138.9 1140.0 1146.9 724.3 738.2 738.9 739.9 751.6 12429.3 13088.6 13285.4 13563.0 13705.3 718.6 726.2 726.8 731.9 746.3 5720.9 5857.3 5935.1 5954.9 6018.5 150208.0 150578.2 151820.0 151892.2 154596.0 105083.0 107357.5 123541.0 136651.0 143225.0 110396.9 111585.0 111851.4 113180.0 119435.4 13832.3 14479.3 14657.2 14670.0 14689.4 54556.5 54589.7 54601.7 54764.0 56224.7 69381.3 69451.6 69541.0 69743.0 70084.6 19773.0 19958.1 19971.0 20126.4 20172.6 23439.3 23593.3 23631.0 23723.9 23843.6 20035.5 20161.4 20181.8 20267.6 20446.9 19679.9 19769.2 19898.7 19966.6 20113.2 19405.3 19592.5 19603.2 19838.2 19841.0 15313.3 15655.4 15921.0 16036.4 16070.7 15091.7 15136.7 15143.8 15271.0 15389.2 11:59:58 INFO - PID 3823 | -------- Summary: end -------- 11:59:58 INFO - PID 3823 | 11:59:58 INFO - TEST-INFO | 3823: exit 0 11:59:58 INFO - TEST-OK | dromaeo_css | took 1109700ms 11:59:58 INFO - TEST-START | kraken 11:59:58 INFO - Initialising browser for kraken test... 11:59:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56381/getInfo.html -profile /tmp/tmpN91_8x/profile 11:59:58 INFO - TEST-INFO | started process 4187 (/builds/slave/test/build/application/firefox/firefox http://localhost:56381/getInfo.html) 12:00:04 INFO - TEST-INFO | 4187: exit 0 12:00:04 INFO - Browser initialized. 12:00:04 INFO - Running cycle 1/1 for kraken test... 12:00:04 INFO - Using env: {'DISPLAY': ':0', 12:00:04 INFO - 'HOME': '/home/cltbld', 12:00:04 INFO - 'JSGC_DISABLE_POISONING': '1', 12:00:04 INFO - 'LANG': 'en_US.UTF-8', 12:00:04 INFO - 'LANGUAGE': 'en_US:en', 12:00:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:00:04 INFO - 'LOGNAME': 'cltbld', 12:00:04 INFO - 'MAIL': '/var/mail/cltbld', 12:00:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:00:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:00:04 INFO - 'MOZ_CRASHREPORTER': '1', 12:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:00:04 INFO - 'MOZ_NO_REMOTE': '1', 12:00:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:04 INFO - 'NO_EM_RESTART': '1', 12:00:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:04 INFO - 'PWD': '/builds/slave/test', 12:00:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:00:04 INFO - 'RUST_BACKTRACE': 'full', 12:00:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:00:04 INFO - 'SHELL': '/bin/bash', 12:00:04 INFO - 'SHLVL': '1', 12:00:04 INFO - 'STYLO_FORCE_DISABLED': '1', 12:00:04 INFO - 'TERM': 'linux', 12:00:04 INFO - 'TMOUT': '86400', 12:00:04 INFO - 'USER': 'cltbld', 12:00:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057', 12:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:04 INFO - '_': '/tools/buildbot/bin/python'} 12:00:04 INFO - TEST-INFO | started process 4421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN91_8x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:00:04 INFO - PID 4421 | 12:00:04 INFO - PID 4421 | (/builds/slave/test/build/application/firefox/firefox:4471): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:00:04 INFO - PID 4421 | 12:00:15 INFO - PID 4421 | RSS: Main: 147357696 12:00:15 INFO - PID 4421 | 12:00:17 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56381/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:18 INFO - PID 4421 | RSS: Main: 153006080 12:00:18 INFO - PID 4421 | 12:00:21 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56381/tests/kraken/driver.html?testName=audio-dft) 12:00:21 INFO - PID 4421 | RSS: Main: 153427968 12:00:21 INFO - PID 4421 | 12:00:24 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56381/tests/kraken/driver.html?testName=audio-fft) 12:00:25 INFO - PID 4421 | RSS: Main: 149499904 12:00:25 INFO - PID 4421 | 12:00:27 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56381/tests/kraken/driver.html?testName=audio-oscillator) 12:00:28 INFO - PID 4421 | RSS: Main: 150929408 12:00:28 INFO - PID 4421 | 12:00:30 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:30 INFO - PID 4421 | RSS: Main: 150970368 12:00:30 INFO - PID 4421 | 12:00:33 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56381/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:34 INFO - PID 4421 | RSS: Main: 151089152 12:00:34 INFO - PID 4421 | 12:00:37 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56381/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:38 INFO - PID 4421 | RSS: Main: 152051712 12:00:38 INFO - PID 4421 | 12:00:41 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56381/tests/kraken/driver.html?testName=json-parse-financial) 12:00:41 INFO - PID 4421 | RSS: Main: 153595904 12:00:41 INFO - PID 4421 | 12:00:43 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:44 INFO - PID 4421 | RSS: Main: 153706496 12:00:44 INFO - PID 4421 | 12:00:45 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:46 INFO - PID 4421 | RSS: Main: 153591808 12:00:46 INFO - PID 4421 | 12:00:48 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:48 INFO - PID 4421 | RSS: Main: 150536192 12:00:48 INFO - PID 4421 | 12:00:51 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:51 INFO - PID 4421 | RSS: Main: 150577152 12:00:51 INFO - PID 4421 | 12:00:54 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:55 INFO - PID 4421 | RSS: Main: 151244800 12:00:55 INFO - PID 4421 | 12:00:56 INFO - PID 4421 | Cycle 1(1): loaded http://localhost:56381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56381/tests/kraken/driver.html?testName=ai-astar) 12:00:57 INFO - PID 4421 | RSS: Main: 152834048 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | __start_tp_report 12:00:57 INFO - PID 4421 | _x_x_mozilla_page_load 12:00:57 INFO - PID 4421 | _x_x_mozilla_page_load_details 12:00:57 INFO - PID 4421 | |i|pagename|runs| 12:00:57 INFO - PID 4421 | |0;ai-astar;104;106;105;106;107;111;107;106;104;104 12:00:57 INFO - PID 4421 | |1;audio-beat-detection;112;121;111;111;113;112;113;111;140;116 12:00:57 INFO - PID 4421 | |2;audio-dft;163;162;162;162;163;163;162;162;161;167 12:00:57 INFO - PID 4421 | |3;audio-fft;79;78;74;83;73;74;75;74;75;74 12:00:57 INFO - PID 4421 | |4;audio-oscillator;79;78;78;79;81;78;79;79;77;78 12:00:57 INFO - PID 4421 | |5;imaging-gaussian-blur;110;113;110;113;117;114;114;113;111;114 12:00:57 INFO - PID 4421 | |6;imaging-darkroom;150;151;151;150;149;149;150;149;150;149 12:00:57 INFO - PID 4421 | |7;imaging-desaturate;94;94;93;94;94;94;94;93;94;93 12:00:57 INFO - PID 4421 | |8;json-parse-financial;44;45;46;49;43;44;44;45;44;44 12:00:57 INFO - PID 4421 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;38;38;39 12:00:57 INFO - PID 4421 | |10;stanford-crypto-aes;70;71;71;70;70;74;72;71;69;72 12:00:57 INFO - PID 4421 | |11;stanford-crypto-ccm;104;114;108;107;105;107;104;120;114;112 12:00:57 INFO - PID 4421 | |12;stanford-crypto-pbkdf2;147;154;152;152;156;150;156;152;153;156 12:00:57 INFO - PID 4421 | |13;stanford-crypto-sha256-iterative;58;59;59;60;62;59;59;58;58;64 12:00:57 INFO - PID 4421 | __end_tp_report 12:00:57 INFO - PID 4421 | __start_cc_report 12:00:57 INFO - PID 4421 | _x_x_mozilla_cycle_collect,706 12:00:57 INFO - PID 4421 | __end_cc_report 12:00:57 INFO - PID 4421 | __startTimestamp1505588457197__endTimestamp 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | ------- Summary: start ------- 12:00:57 INFO - PID 4421 | Number of tests: 14 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:2.11 (2.0%) stddev-sans-first:2.11 12:00:57 INFO - PID 4421 | Values: 104.0 106.0 105.0 106.0 107.0 111.0 107.0 106.0 104.0 104.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:113.00 stddev:8.98 (7.9%) stddev-sans-first:9.41 12:00:57 INFO - PID 4421 | Values: 112.0 121.0 111.0 111.0 113.0 112.0 113.0 111.0 140.0 116.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.64 (1.0%) stddev-sans-first:1.73 12:00:57 INFO - PID 4421 | Values: 163.0 162.0 162.0 162.0 163.0 163.0 162.0 162.0 161.0 167.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#3] audio-fft Cycles:10 Average:75.90 Median:75.00 stddev:3.14 (4.2%) stddev-sans-first:3.13 12:00:57 INFO - PID 4421 | Values: 79.0 78.0 74.0 83.0 73.0 74.0 75.0 74.0 75.0 74.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:79.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 12:00:57 INFO - PID 4421 | Values: 79.0 78.0 78.0 79.0 81.0 78.0 79.0 79.0 77.0 78.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:113.50 stddev:2.13 (1.9%) stddev-sans-first:1.99 12:00:57 INFO - PID 4421 | Values: 110.0 113.0 110.0 113.0 117.0 114.0 114.0 113.0 111.0 114.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 12:00:57 INFO - PID 4421 | Values: 150.0 151.0 151.0 150.0 149.0 149.0 150.0 149.0 150.0 149.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:00:57 INFO - PID 4421 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#8] json-parse-financial Cycles:10 Average:44.80 Median:44.50 stddev:1.69 (3.8%) stddev-sans-first:1.76 12:00:57 INFO - PID 4421 | Values: 44.0 45.0 46.0 49.0 43.0 44.0 44.0 45.0 44.0 44.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 12:00:57 INFO - PID 4421 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 39.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#10] stanford-crypto-aes Cycles:10 Average:71.00 Median:71.00 stddev:1.41 (2.0%) stddev-sans-first:1.45 12:00:57 INFO - PID 4421 | Values: 70.0 71.0 71.0 70.0 70.0 74.0 72.0 71.0 69.0 72.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#11] stanford-crypto-ccm Cycles:10 Average:109.50 Median:110.00 stddev:5.30 (4.8%) stddev-sans-first:5.23 12:00:57 INFO - PID 4421 | Values: 104.0 114.0 108.0 107.0 105.0 107.0 104.0 120.0 114.0 112.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.50 stddev:2.90 (1.9%) stddev-sans-first:2.19 12:00:57 INFO - PID 4421 | Values: 147.0 154.0 152.0 152.0 156.0 150.0 156.0 152.0 153.0 156.0 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.00 stddev:1.96 (3.3%) stddev-sans-first:1.99 12:00:57 INFO - PID 4421 | Values: 58.0 59.0 59.0 60.0 62.0 59.0 59.0 58.0 58.0 64.0 12:00:57 INFO - PID 4421 | -------- Summary: end -------- 12:00:57 INFO - PID 4421 | 12:00:57 INFO - PID 4421 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:00:57 INFO - TEST-INFO | 4421: exit 0 12:00:57 INFO - TEST-OK | kraken | took 59142ms 12:00:57 INFO - SUITE-END | took 1168s 12:00:58 INFO - Completed test suite (00:19:29) 12:00:58 INFO - javascript benchmark 12:00:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9131.615392098722, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3887.9028024299387, 3889.6499315061646, 3905.3165696003193, 3923.6861051115907, 3954.960450395495, 6285.968570157154, 6346.841328966778, 6352.301246862848, 6422.357764223575, 6477.287498375181, 6379.712912918918, 6390.520710946675, 6409.967950160242, 6412.422881940636, 6433.678316084189, 5684.630499017561, 5726.942730572703, 5747.2528571285675, 5757.078867381219, 5768.048272035109, 5774.249347584829, 5812.738426770806, 5828.737706803183, 5837.562182836305, 5855.560832937525, 66.0965736310988, 5722.427757224286, 5730.512906402961, 5742.799002034909, 5860.413958604148, 5729.369769325371, 5805.448482394166, 5810.157527158581, 5818.1563673267565, 5821.796237131723, 5695.515881150107, 5723.7996670116345, 5755.453231942959, 5782.392848750905, 5790.536757059425, 6119.26568811741, 6290.716917738667, 6339.8415039623915, 6376.744930202833, 6454.967725161344, 6832.248452670202, 6865.313468653145, 6923.6884340204815, 6988.021676965229, 6988.091548098715, 6919.204291506491, 6938.271481494471, 6945.72217111315, 6996.0, 6997.160340759091, 6373.521985851034, 6464.25661048976, 6495.31799161086, 6500.284968653492, 6504.0, 7083.89374159388, 7105.538140020882, 7203.099612548432, 7205.2434494378385, 7214.242504536948, 6830.385265326145, 6835.897461538081, 6900.827479313058, 6907.447404207652, 6912.135983002125, 6737.797866064026, 6817.216020157745, 6879.346462086194, 6950.443964482931, 6955.93044069563, 6871.793846184622, 6935.653217339112, 6949.617771022642, 6988.19635741886, 6997.720091196397, 6855.348741869514, 6863.10779598659, 6943.89584156238, 6959.130108736408, 6960.060391847137, 4924.3105965164905, 4926.8768280793265, 4935.851924442272, 4999.0, 5002.374703162105, 4506.188886000486, 4545.477270113913, 4562.178807814559, 4572.88567785808, 4586.312053191981, 6348.111264422984, 6408.391202835816, 6420.839479013062, 6437.388448097423, 6448.871022579616, 6765.323467653196, 6833.965830170917, 6922.134733158356, 6924.272951340137, 6969.756058537927, 6351.396617321347, 6356.332585078592, 6441.967790161019, 6449.193850768654, 6453.032045193258, 5461.863453413696, 5511.063119269734, 5519.69641669712, 5528.612997090246, 5534.1975413565615, 7088.716451341992, 7106.467014973898, 7120.216776154619, 7127.0, 7131.108611423572, 6828.692708828214, 6908.689108990107, 6925.930740692629, 6935.202451718016, 6943.583384996917, 7152.749653762094, 7154.570725756471, 7184.892226616709, 7264.818379540342, 7273.927260727325, 6712.463002959849, 6809.353111454404, 6822.317768223138, 6828.146481689789, 6941.791746247621, 6832.248452670103, 6835.93164068353, 6870.690818913061, 6870.793876183722, 6933.2720064392515, 6645.700943457459, 6679.332066793282, 6690.498212633975, 6712.83217919556, 6717.596944183365, 6600.07598936159, 6611.900821487586, 6616.4045235929, 6700.262971073275, 6712.798616041527, 6482.157319548429, 6555.508336874849, 6563.7702680405955, 6644.202695676549, 6649.434798042027, 6611.570247933869, 6686.83282917931, 6727.865442691216, 6787.049813026081, 6800.115984921928, 6435.356464353527, 6548.410643042149, 6580.1116849224745, 6601.438877695449, 6617.702203400762], "value": 6264.550837202893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.4370062411615, 937.2923442800685, 969.3505351414553, 972.0959507657875, 973.3673112476889, 42604.786976065116, 43558.564414355846, 43675.78162109185, 43742.56257437425, 43881.78059109704, 41337.58662413375, 43237.56762432375, 43761.343579846245, 43862.0, 44202.33696494547, 8141.796455088641, 8255.339572834158, 8260.83478330433, 8290.626921788504, 8296.83406331873, 7847.843043139133, 7924.0, 7937.365010799151, 7938.2855543001115, 7945.562994035326, 7889.921100788976, 7926.28663420292, 7949.0, 7958.52248865067, 7961.402894782886, 7893.13175550689, 7921.36629069673, 7922.920770792276, 7963.163867793885, 7965.362770978308, 8031.678732850679, 8094.271515563569, 8098.51408915467, 8102.878456823152, 8108.391870609669, 39875.4018689717, 39978.40032399487, 40021.19957600861, 40161.79919100415, 40211.39682904759, 3637.781733096023, 3651.123730304734, 3661.066428060854, 3666.926661466756, 3668.211334563055, 31818.363632727214, 32000.359992800248, 32041.198970025936, 32064.519032214535, 32085.35829283401, 5426.782928682848, 5446.945530544684, 5452.863678408032, 5455.809046683386, 5600.52395546379, 217143.0, 217312.0, 218238.0, 224192.0, 225021.87489062615, 52347.214791778155, 52743.47256527462, 52761.2085818713, 52858.0, 52900.206496902574, 55416.445835541934, 55528.72235638796, 55690.72154639282, 55721.16418253729, 55905.0, 15448.613784655474, 15553.144577048144, 15572.766408503881, 15788.68422631564, 15860.841391586167, 12594.24434533931, 12600.495980160691, 12603.621891343275, 12611.558595449298, 12790.29653369055, 13920.0, 14064.789028164585, 14108.647283817781, 14153.433862645585, 14284.357203925849, 5395.4604539545735, 5454.645448045864, 5465.289512363447, 5467.890642187134, 5508.989218935059, 1112.5605385872534, 1115.1469126118525, 1119.367557330106, 1130.6777568392968, 1132.184826924613, 25545.489090218092, 25572.744272557036, 25621.3594660135, 25710.48579028409, 26031.0, 1204.2533629149807, 1219.408586835384, 1224.13086708438, 1238.7027113492877, 1241.1126044877956, 13732.794008089886, 13733.0, 13825.930870345584, 13860.722785544232, 14022.22877741734, 297494.0, 298425.0, 300628.0, 300928.0, 302065.0, 56613.71693141508, 57012.0, 57150.42849571534, 57216.0, 57236.42763572394, 1493.46235355272, 1520.8935374523899, 1546.791183190255, 1552.0532475190125, 1556.533040087969, 24927.252182434557, 24931.0027598894, 25183.37041573975, 25253.621195681713, 25574.23277301684, 41208.38187427251, 41229.793851030554, 41330.586694132675, 41404.0, 41404.79297603493, 241647.0, 242566.0, 245483.0, 245773.0, 246265.0, 35816.82091589525, 37544.0, 38450.807745961094, 38482.0, 38505.807470963584, 48164.759176203894, 48764.51235487741, 49076.50923490719, 49207.26189107095, 49312.260316096006, 36669.816650916575, 36759.08102297464, 37018.0, 37044.6295537052, 37306.0, 35799.0, 36182.81908590545, 36293.0, 36782.816085919396, 36825.63174368222, 41438.171236575705, 42326.576734232265, 42702.0, 42725.35911961261, 42856.57143428526, 34653.48019779655, 35350.82324588463, 35419.11452213612, 35628.82185589056, 35693.64306357007, 26501.734982649927, 26848.731512685405, 27190.320241994108, 27204.45591088207, 27696.58455123215], "value": 18593.4613602184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7869588252345, 580.889630970116, 584.1150656755015, 607.9240094988126, 611.8715069835334, 23261.185858494955, 23937.922793474292, 23939.401514962112, 23964.5207095858, 24014.15950441735, 25110.744462776835, 25698.74301256987, 26756.598651020202, 26801.32996675084, 26981.86509067452, 6563.6061836289855, 6689.6989635466525, 6709.261981182066, 6720.0, 6729.05793188954, 6413.230412350525, 6520.054592084169, 6599.571027883172, 6640.0703901453835, 6668.299828518008, 6613.3386661333725, 6617.0, 6617.867642647144, 6618.569792963466, 6619.702113404908, 6632.966835165842, 6636.170478690164, 6641.833954151137, 6680.131582894192, 6898.379145876896, 6418.743250269984, 6421.229452465734, 6422.325655806119, 6424.5502814802985, 6428.067930150102, 30856.69143308583, 31248.687513124805, 31358.21604459884, 31378.843105784552, 31388.686113139032, 2308.595995700746, 2328.0222306631254, 2333.4166458385403, 2333.614953532665, 2339.87130707811, 19788.901055494774, 21085.156593736232, 21417.0, 21640.783592164033, 21657.133714651394, 2500.1374525788574, 2502.186789293487, 2550.9872450637813, 2579.9742002579924, 2581.5998520229396, 135629.0, 145871.0, 154170.0, 156307.0, 163441.0, 15757.133357665209, 15864.603384915239, 15904.409559044003, 15981.28084236212, 16557.337706491846, 26087.608685869727, 26137.0, 26158.215253542425, 26178.214653560422, 26225.475490490084, 10693.518791654395, 10773.83839242412, 10821.891781082246, 10824.13406927444, 10853.34879907208, 9680.467574283482, 9743.805123897482, 9826.705198844045, 9931.702048938543, 9967.10296073357, 9673.854892176623, 10005.899941000642, 10024.19806415485, 10065.899341006643, 10164.745881353025, 2776.7084456131815, 2794.874230659625, 2845.8434786086964, 2960.2747326905046, 2988.0886329669224, 1038.5638032026568, 1051.295631926611, 1073.2487258918632, 1083.182197440927, 1095.5782023920847, 21364.359069227947, 21387.89306053491, 21456.0, 21559.137634494757, 21746.13015479363, 1115.2360632966445, 1128.4414214963645, 1134.262729225993, 1139.920205585601, 1144.101880024177, 11620.593279235187, 11739.647810565697, 11774.3524106175, 12021.218620789621, 12053.939730301292, 604995.0, 611627.0, 622865.0, 624527.0, 647638.0, 132416.3379183117, 132929.0, 134530.0, 134823.0, 135420.0, 1140.2702270546856, 1229.3484453239798, 1233.7779199743952, 1256.6230130960676, 1285.6657269110099, 22185.556288874453, 22320.21879234219, 22444.214452494085, 22503.549929001656, 22615.88692056529, 62795.6860215696, 63844.0, 64777.35222647713, 65563.67218163879, 66666.33333666601, 83310.16689833024, 83663.0, 83676.0, 83893.58053209695, 84591.57704211686, 15179.544613661608, 15236.162011089053, 15302.387904483696, 15370.538883833502, 15454.459093931659, 23677.881610591838, 23728.40678983039, 24131.75868241295, 24240.0, 24396.878015610517, 19714.901425493354, 19998.30005949843, 20002.69995950033, 20114.59770804605, 20295.188192472135, 17284.79006469535, 17613.82386176122, 17641.558961026076, 18021.72967405516, 18336.90831545834, 20175.0, 20545.178192872118, 20550.38348849537, 20602.072906718935, 20624.27815026467, 15167.544973650367, 15279.159646219565, 15321.0, 15335.386584536494, 15344.156071415733, 19549.51126221856, 19732.30936917201, 19802.603947920674, 19874.403767886986, 19919.10364033651], "value": 12947.154804071506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6290764401256, 1474.432343547734, 1484.5175318021645, 1490.4559835659982, 1511.2066165263236, 16548.17259137043, 17240.482785516455, 17309.04800235985, 17318.480445586654, 17331.913340433297, 16794.0, 16900.323987040505, 16994.32022719093, 17002.234899429524, 17004.06477643729, 2854.5575435807377, 2905.142982820073, 2906.433245517125, 2913.28624487001, 2914.2859999300094, 2789.2190186747744, 2844.6586409630872, 2845.9573106403423, 2848.5157523221, 2854.5290027145497, 2816.0, 2832.107886015898, 2878.3379822640804, 2885.1344596621034, 2887.7256660617313, 2878.568214767781, 2885.5527393253974, 2895.0, 2901.245676124202, 2915.28575499002, 2658.880350384218, 2661.5741481363084, 2688.838669679806, 2772.306923269183, 2869.4548035873117, 16844.74732879008, 16975.3209871605, 17004.574885627957, 17017.65964680712, 17019.65960680792, 8338.166183381674, 8629.827403451958, 8631.913680863174, 8633.784155396103, 8642.13578642137, 5600.943990560124, 5669.858253543694, 5751.884962300773, 5819.185314056035, 5899.646021238739, 2126.3515359693934, 2140.2188201306567, 2149.795769401904, 2182.2907555044676, 2196.978030219709, 30631.081067568008, 30796.0, 30848.228794280098, 30848.691513084807, 30971.535426968614, 6989.615571143636, 7079.734484964865, 7134.500584959107, 7235.240299768554, 7240.0, 19887.303944361876, 19927.0, 19933.800661993486, 19944.3019494317, 19947.700784488243, 8217.671293148207, 8318.459300145592, 8362.958185209034, 8399.748007559783, 8402.537860417613, 7496.362809161283, 7543.245675432413, 7742.729004484816, 7744.303012728881, 7746.806329841686, 5323.254744335796, 5482.23248745176, 5486.835394938158, 5543.057680194376, 5659.320881494247, 1558.1897413344998, 1566.9608259793367, 1575.58247064528, 1576.5270418874293, 1591.4111778641977, 924.4961495984704, 938.9953050234706, 949.658123075706, 950.8336041192764, 958.678842587727, 8060.758177254692, 8103.432759706764, 8182.22268884455, 8199.385046121564, 8200.712975045964, 771.6643260181839, 776.2547953964257, 778.4706399648294, 787.5432249295395, 793.1156760212322, 5147.716875571879, 5495.203195536705, 5570.972145139248, 5683.516901063374, 5707.143928410688, 23276.66151468302, 24803.751962480143, 24951.500969980498, 25311.62032569513, 25594.0, 24145.879270603535, 24968.375790605016, 25098.372540686265, 25138.0, 25585.87207063953, 11481.311121332747, 11751.294922304689, 11784.58753943625, 11791.823122653168, 11812.763744725058, 8674.132586741276, 8764.737057888273, 8806.339524535813, 8854.867176992479, 8919.73240802777, 20811.8959405202, 21059.0, 21127.683084753433, 21464.24875129363, 21829.454263643536, 22299.888500557394, 22320.665190022486, 22361.44096397603, 22500.437489062904, 22662.546749064597, 12348.753024939271, 12662.620121396372, 12728.109032367645, 12736.0, 12737.29944853042, 15421.228938553251, 15425.382984680487, 15444.613884652974, 15623.296951636976, 15650.373985040926, 12333.50665973351, 12517.374131293216, 12859.0, 12911.35443227816, 13134.540291089766, 12384.62846114618, 12426.0, 12544.121911466109, 12591.24452532851, 12876.549320774102, 10929.18031147683, 11033.724156896142, 11055.668329949793, 11200.0, 11214.383208923588, 7329.52358096722, 7347.8530429392185, 7404.222556631476, 7408.222136675571, 7422.96288518554, 7701.268379503938, 7724.304812566896, 7812.804679883048, 7814.413918955987, 7987.960060199662], "value": 7194.59309730974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.4172039895917, 544.1429748146668, 546.7621584610694, 559.8020236693479, 564.6640249051812, 6197.566170368076, 6201.627902325864, 6294.0, 6300.369963003697, 6303.495720342373, 6180.75276988921, 6190.3190649028575, 6222.906656400158, 6263.655498947556, 6293.937060629392, 4089.386592011207, 4987.600991920655, 5119.692818430897, 5152.407473140599, 5164.509371609691, 4942.233953737176, 4959.776810043539, 4980.800767969277, 5011.674241174312, 5100.234964755279, 5012.52381023804, 5059.62052846038, 5066.240063990413, 5066.620003499734, 5083.61872859537, 5041.890784027508, 5057.317262169597, 5072.315237442972, 5086.77109530072, 5097.974510127463, 4750.073735621555, 4757.738324392157, 4766.952330476685, 4783.521647835189, 4801.303810947428, 6026.54800889935, 6100.908486372664, 6116.847078823021, 6170.84572885677, 6230.781922632731, 5947.613405128696, 5969.671668058255, 5971.61184523009, 6006.159137720722, 6041.456268935773, 6630.204375474926, 6648.401643852077, 6659.866802663968, 6673.132492775957, 6729.899051514231, 5035.949640503584, 5206.5314121729225, 5221.094300580261, 5254.106801843695, 5303.310569625924, 6796.728130874759, 6855.760048398332, 6860.245373008965, 6907.551009184437, 7005.684744186524, 5483.369412517612, 5491.697956612345, 5505.284313039279, 5584.888302233932, 5602.4033150551895, 5601.439856014447, 5609.971950140223, 5622.128570071645, 5623.240862483594, 5659.405762394971, 6047.853012180701, 6068.696565171724, 6068.787592434332, 6083.361247069082, 6089.695515224221, 6717.16035495563, 6723.495737819683, 6758.78341898463, 6793.626350550767, 6793.762218322335, 1951.024487756122, 1954.833839123662, 1957.9902100489405, 1966.7049942508738, 1968.1536939116318, 1362.4550179928108, 1446.6094154578416, 1455.3669153918079, 1455.8398576156615, 1469.2662658063587, 5987.670678112659, 5995.760169593167, 6023.789167379121, 6037.607555508878, 6082.1789058477425, 6526.608403495806, 6540.967295163494, 6548.574342667712, 6605.07528945948, 6621.801345959629, 6050.6369617823075, 6082.0, 6139.785107521216, 6166.907496387557, 6190.659513726789, 3511.841967111486, 3533.6289689582736, 3549.148204430918, 3562.964370356315, 3570.5001299818045, 6924.792256232321, 6965.233824279325, 6979.546329488567, 6991.23096459389, 7017.438604911595, 6562.50781191403, 6725.2602213756445, 6750.3924646782025, 6791.456683465311, 6861.897071543931, 6948.6178260195165, 6968.233494315621, 7001.584453363582, 7009.754658586925, 7026.437884969292, 6578.671066446755, 6662.400383965466, 6662.800115996528, 6712.328767123248, 6725.226598941184, 6567.146270984741, 6571.474282057328, 6594.901076483952, 6653.201615806134, 6666.799996000128, 6813.965930170318, 6877.89683154743, 6931.1682598088555, 6969.721211151497, 6975.965120174366, 5510.9448905510435, 5511.255980442589, 5531.225628412106, 5550.195221692751, 5561.3295225151205, 6421.678916054085, 6691.130153080263, 6774.119364482585, 6805.217399999064, 6878.3465570770695, 6096.695165241631, 6389.105525226379, 6496.480281577368, 6548.738050477928, 6636.5686230396805, 6362.854686156351, 6382.776602818879, 6402.967985160044, 6409.071608761969, 6561.770338038336, 6298.464630506458, 6338.8732225354315, 6405.807825765234, 6435.92048746394, 6492.253390860112, 6446.419822216023, 6479.935200647933, 6541.672916354068, 6569.770058047945, 6585.176852893388, 6368.28056424772, 6415.807525774234, 6432.292447830829, 6445.614192948538, 6460.580062295936], "value": 5226.7562699843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.5806728904704, 943.5376665433939, 944.145548278808, 981.317984001119, 1001.8747656542935, 20110.296139635117, 20781.792182078174, 20821.0, 20836.479088022807, 20885.477863053413, 19515.41453756386, 19745.605087898235, 19879.304224352152, 20046.0, 20158.19367225309, 1058.185197398003, 1072.4208927179313, 1072.4691277817453, 1073.5115522437272, 1074.3339129739572, 1076.935383876966, 1089.7384627689337, 1091.5961094395084, 1092.1044743310488, 1095.8411030400587, 1091.1707102602, 1140.2075557487508, 1142.662914440242, 1143.1026644084395, 1143.8798926112763, 1125.6229163230328, 1130.2088538023334, 1131.1346819682908, 1131.4795194210674, 1131.9434028298592, 797.752696664036, 815.6207363575907, 824.6948629007305, 825.4634487583119, 826.2439867521271, 20359.185632574678, 20392.796072039237, 20444.182232710824, 20525.897370513052, 20589.691154632543, 23276.0, 23510.882445587835, 23933.88033059841, 24026.159084432136, 24089.51820963571, 18389.540261493436, 18612.0, 18958.43124706261, 19013.0, 19026.42920712381, 3944.6844252460023, 3947.624975627311, 3957.940630890539, 3962.86129985452, 3973.9006524836823, 167114.0, 167414.0, 168739.0, 169166.0, 170519.0, 17380.565485862702, 17496.212670429606, 17505.912470437564, 17802.643947120985, 17804.0, 31878.0, 32796.3440731184, 33211.83394083014, 33917.15207119842, 34381.82809085939, 9535.284853636005, 9614.807703846023, 9668.613255469843, 9674.08096230857, 9713.688652032026, 4260.659147268273, 4270.658347332268, 4392.2752745797225, 4411.801468933906, 4414.3157810539415, 6009.969950150309, 6135.386461353829, 6135.601185922901, 6164.260288765377, 6166.229221347332, 1106.4910141334915, 1121.9439028048564, 1138.8974992250737, 1140.0480598700012, 1146.908247340211, 724.3010494872474, 738.1879932074675, 738.8891666250106, 739.8557281330196, 751.5565816168487, 12429.316497392114, 13088.60734177957, 13285.402156902963, 13563.0, 13705.314734263446, 718.586812582767, 726.2410780734145, 726.8364617960916, 731.9011933388924, 746.2537462537463, 5720.942790572124, 5857.297124345021, 5935.109733539917, 5954.910676339859, 6018.458338749533, 150208.0, 150578.24710876375, 151820.0, 151892.2026949335, 154596.0, 105083.0, 107357.46321268343, 123541.0, 136651.0, 143225.0, 110396.89603104026, 111585.0, 111851.44074279576, 113180.0, 119435.40282298706, 13832.308384580932, 14479.348429320917, 14657.193854337687, 14670.0, 14689.41242350294, 54556.454435456726, 54589.72705136449, 54601.72699136479, 54764.0, 56224.71887640536, 69381.30618693748, 69451.55128646357, 69541.0, 69743.0, 70084.64957675179, 19773.0, 19958.101885415483, 19971.0, 20126.39620811378, 20172.596548068665, 23439.296821095395, 23593.29220123399, 23631.0, 23723.881380592986, 23843.642345364486, 20035.499112522302, 20161.39515814528, 20181.798182018578, 20267.59464810666, 20446.897765511076, 19679.901600491907, 19769.209231630575, 19898.70151947751, 19966.600667986848, 20113.19547218095, 19405.32081377145, 19592.510187245432, 19603.215871364984, 19838.20647174097, 19841.0, 15313.310901009258, 15655.37378504847, 15921.0, 16036.35854565851, 16070.67858642844, 15091.698166036836, 15136.697266054396, 15143.848561514244, 15271.0, 15389.230538473255], "value": 10223.411926185374, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1371.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 106.0, 105.0, 106.0, 107.0, 111.0, 107.0, 106.0, 104.0, 104.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 121.0, 111.0, 111.0, 113.0, 112.0, 113.0, 111.0, 140.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 167.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 74.0, 83.0, 73.0, 74.0, 75.0, 74.0, 75.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 81.0, 78.0, 79.0, 79.0, 77.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 110.0, 113.0, 117.0, 114.0, 114.0, 113.0, 111.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 46.0, 49.0, 43.0, 44.0, 44.0, 45.0, 44.0, 44.0], "value": 44.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 70.0, 70.0, 74.0, 72.0, 71.0, 69.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 108.0, 107.0, 105.0, 107.0, 104.0, 120.0, 114.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 154.0, 152.0, 152.0, 156.0, 150.0, 156.0, 152.0, 153.0, 156.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 60.0, 62.0, 59.0, 59.0, 58.0, 58.0, 64.0], "value": 59.6, "unit": "score"}]}]} 12:00:58 INFO - Return code: 0 12:00:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:58 INFO - # TBPL SUCCESS # 12:00:58 INFO - Running post-action listener: _package_coverage_data 12:00:58 INFO - Running post-action listener: _resource_record_post_action 12:00:58 INFO - [mozharness: 2017-09-16 19:00:58.485354Z] Finished run-tests step (success) 12:00:58 INFO - Running post-run listener: _resource_record_post_run 12:00:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 10145792; Write bytes: 461496320; Read time: 3632; Write time: 515176 12:00:58 INFO - TinderboxPrint: CPU usage
13.1% 12:00:58 INFO - TinderboxPrint: I/O read bytes / time
10,145,792 / 3,632 12:00:58 INFO - TinderboxPrint: I/O write bytes / time
461,496,320 / 515,176 12:00:58 INFO - TinderboxPrint: CPU idle
8,225.8 (86.9%) 12:00:58 INFO - TinderboxPrint: CPU user
1,185.9 (12.5%) 12:00:58 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12783616; Read time: 0; Write time: 2688 12:00:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:00:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 10145792; Write bytes: 410353664; Read time: 3632; Write time: 501404 12:00:59 INFO - Running post-run listener: _upload_blobber_files 12:00:59 INFO - Blob upload gear active. 12:00:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:59 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:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:00:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:00:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:00 INFO - (blobuploader) - INFO - Done attempting. 12:01:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:01:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:01:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:01 INFO - (blobuploader) - INFO - Done attempting. 12:01:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:01:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:04 INFO - (blobuploader) - INFO - Done attempting. 12:01:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:01:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:01:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:05 INFO - (blobuploader) - INFO - Done attempting. 12:01:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:01:05 INFO - Return code: 0 12:01:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:01:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:01:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e9de168ad37bd0684dfb120e18dbb60885fc038c6c9c31262b595bd2c628ede3697282c89f3486c4e94730e60b4b728fd3961e8ee96fd88058f9472394f5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571d2830bdf5dafe2bcb4b988dbe7e758496ce420599472d5a785e71baa429c15dd2d45fb072676c70d1e2486fb4cf9a11da94d5760367bb15bb8f9e8e599f84", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/545500fd444144012cae19c5cada403c43680e1af9e5743c04676b55beb2a129209f1f61e4689f88d5626f51250677e29258d06071063b09f1031c9edf642a71", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6475a635caeea3514e99530b39a8a5bbc349886c36ad87bcb0de2e63d1acd69fc1ff1400c1d75c2b03c1a33d09bf8a074d6630912f2e7893702c7843c0abf28f"} 12:01:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:01:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:01:05 INFO - Contents: 12:01:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e9de168ad37bd0684dfb120e18dbb60885fc038c6c9c31262b595bd2c628ede3697282c89f3486c4e94730e60b4b728fd3961e8ee96fd88058f9472394f5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571d2830bdf5dafe2bcb4b988dbe7e758496ce420599472d5a785e71baa429c15dd2d45fb072676c70d1e2486fb4cf9a11da94d5760367bb15bb8f9e8e599f84", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/545500fd444144012cae19c5cada403c43680e1af9e5743c04676b55beb2a129209f1f61e4689f88d5626f51250677e29258d06071063b09f1031c9edf642a71", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6475a635caeea3514e99530b39a8a5bbc349886c36ad87bcb0de2e63d1acd69fc1ff1400c1d75c2b03c1a33d09bf8a074d6630912f2e7893702c7843c0abf28f"} 12:01:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:01:05 INFO - Copying logs to upload dir... 12:01:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:01:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.689728 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 12:01:05.989721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:05.994930) ========= 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=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e9de168ad37bd0684dfb120e18dbb60885fc038c6c9c31262b595bd2c628ede3697282c89f3486c4e94730e60b4b728fd3961e8ee96fd88058f9472394f5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571d2830bdf5dafe2bcb4b988dbe7e758496ce420599472d5a785e71baa429c15dd2d45fb072676c70d1e2486fb4cf9a11da94d5760367bb15bb8f9e8e599f84", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/545500fd444144012cae19c5cada403c43680e1af9e5743c04676b55beb2a129209f1f61e4689f88d5626f51250677e29258d06071063b09f1031c9edf642a71", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6475a635caeea3514e99530b39a8a5bbc349886c36ad87bcb0de2e63d1acd69fc1ff1400c1d75c2b03c1a33d09bf8a074d6630912f2e7893702c7843c0abf28f"} build_url:https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/BvB_Y1Q7TT2lE8hTX3In_Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73e9de168ad37bd0684dfb120e18dbb60885fc038c6c9c31262b595bd2c628ede3697282c89f3486c4e94730e60b4b728fd3961e8ee96fd88058f9472394f5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/571d2830bdf5dafe2bcb4b988dbe7e758496ce420599472d5a785e71baa429c15dd2d45fb072676c70d1e2486fb4cf9a11da94d5760367bb15bb8f9e8e599f84", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/545500fd444144012cae19c5cada403c43680e1af9e5743c04676b55beb2a129209f1f61e4689f88d5626f51250677e29258d06071063b09f1031c9edf642a71", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6475a635caeea3514e99530b39a8a5bbc349886c36ad87bcb0de2e63d1acd69fc1ff1400c1d75c2b03c1a33d09bf8a074d6630912f2e7893702c7843c0abf28f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:06.030690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:06.031080) ========= 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=920470bf432669ad7e3a5387000001ca-1505586206.166762-1041032057 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 12:01:06.115517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 12:01:06.115854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 12:01:06.116204) ========= ========= Total master_lag: 0.25 =========