builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1506385344.89 results: success (0) revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:24.894068) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:24.894526) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:24.894886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:24.946009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:24.946406) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 17:22:25-- 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% 16.4M=0.001s 2017-09-25 17:22:25 (16.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150152 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.162907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.163273) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019374 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.203907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.204239) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 641bfddb87113b45ee3df9849345dbcf821ef3da --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 641bfddb87113b45ee3df9849345dbcf821ef3da --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=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 17:22:25,405 truncating revision to first 12 chars 2017-09-25 17:22:25,405 Setting DEBUG logging. 2017-09-25 17:22:25,406 attempt 1/10 2017-09-25 17:22:25,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/641bfddb8711?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 17:22:25,792 unpacking tar archive at: mozilla-central-641bfddb8711/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700782 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.952086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.952421) ========= script_repo_revision: 641bfddb87113b45ee3df9849345dbcf821ef3da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.952824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:25.953082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 17:22:26.031049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-25 17:22:26.031575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:26 INFO - MultiFileLogger online at 20170925 17:22:26 in /builds/slave/test 17:22:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:22:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:26 INFO - {'append_to_log': False, 17:22:26 INFO - 'base_work_dir': '/builds/slave/test', 17:22:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:22:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:26 INFO - 'branch': 'Firefox-Non-PGO', 17:22:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:26 INFO - 'code_coverage': False, 17:22:26 INFO - 'config_files': ('talos/linux_config.py',), 17:22:26 INFO - 'default_actions': ('clobber', 17:22:26 INFO - 'read-buildbot-config', 17:22:26 INFO - 'download-and-extract', 17:22:26 INFO - 'populate-webroot', 17:22:26 INFO - 'create-virtualenv', 17:22:26 INFO - 'install', 17:22:26 INFO - 'setup-mitmproxy', 17:22:26 INFO - 'run-tests'), 17:22:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:26 INFO - 'disable_ccov_upload': False, 17:22:26 INFO - 'disable_stylo': False, 17:22:26 INFO - 'download_minidump_stackwalk': True, 17:22:26 INFO - 'download_symbols': 'ondemand', 17:22:26 INFO - 'enable_stylo': False, 17:22:26 INFO - 'enable_webrender': False, 17:22:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:22:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:26 INFO - 'gecko_profile': False, 17:22:26 INFO - 'gecko_profile_interval': 0, 17:22:26 INFO - 'installer_path': 'installer.exe', 17:22:26 INFO - 'log_level': 'info', 17:22:26 INFO - 'log_name': 'talos', 17:22:26 INFO - 'log_to_console': True, 17:22:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:26 INFO - 'opt_config_files': (), 17:22:26 INFO - 'pip_index': False, 17:22:26 INFO - 'suite': 'dromaeojs-e10s', 17:22:26 INFO - 'system_bits': '32', 17:22:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:26 INFO - 'title': 'talos-linux64-ix-069', 17:22:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:26 INFO - 'use_talos_json': True, 17:22:26 INFO - 'verify': 'False', 17:22:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:26 INFO - 'work_dir': 'build'} 17:22:26 INFO - [mozharness: 2017-09-26 00:22:26.382275Z] Running clobber step. 17:22:26 INFO - Running pre-action listener: _resource_record_pre_action 17:22:26 INFO - Running main action method: clobber 17:22:26 INFO - rmtree: /builds/slave/test/build 17:22:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:27 INFO - Running post-action listener: _resource_record_post_action 17:22:27 INFO - [mozharness: 2017-09-26 00:22:27.885390Z] Finished clobber step (success) 17:22:27 INFO - [mozharness: 2017-09-26 00:22:27.885487Z] Running read-buildbot-config step. 17:22:27 INFO - Running pre-action listener: _resource_record_pre_action 17:22:27 INFO - Running main action method: read_buildbot_config 17:22:27 INFO - Using buildbot properties: 17:22:27 INFO - { 17:22:27 INFO - "project": "", 17:22:27 INFO - "product": "firefox", 17:22:27 INFO - "who": "kwierso@gmail.com", 17:22:27 INFO - "installer_path": "public/build/target.tar.bz2", 17:22:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:22:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:22:27 INFO - "stage_platform": "linux64", 17:22:27 INFO - "basedir": "/builds/slave/test", 17:22:27 INFO - "buildnumber": 865, 17:22:27 INFO - "platform": "ubuntu64_hw", 17:22:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:22:27 INFO - "slavebuilddir": "test", 17:22:27 INFO - "taskId": "A-cLmJNFSwOz5dhXpqUQUQ", 17:22:27 INFO - "branch": "mozilla-central", 17:22:27 INFO - "script_repo_revision": "production", 17:22:27 INFO - "revision": "641bfddb87113b45ee3df9849345dbcf821ef3da", 17:22:27 INFO - "slavename": "talos-linux64-ix-069", 17:22:27 INFO - "repo_path": "mozilla-central" 17:22:27 INFO - } 17:22:27 INFO - Finding installer, test and symbols from parent task. 17:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-cLmJNFSwOz5dhXpqUQUQ'}, attempt #1 17:22:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A-cLmJNFSwOz5dhXpqUQUQ'}, attempt #1 17:22:29 INFO - Task dependencies: T6YG80ZaRluUV1sg95wmlQ 17:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ'}, attempt #1 17:22:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip 17:22:29 INFO - Running post-action listener: _resource_record_post_action 17:22:29 INFO - [mozharness: 2017-09-26 00:22:29.819918Z] Finished read-buildbot-config step (success) 17:22:29 INFO - [mozharness: 2017-09-26 00:22:29.820136Z] Running download-and-extract step. 17:22:29 INFO - Running pre-action listener: _resource_record_pre_action 17:22:29 INFO - Running main action method: download_and_extract 17:22:29 INFO - mkdir: /builds/slave/test/build/tests 17:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:29 INFO - trying https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json 17:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:22:30 INFO - Downloaded 989 bytes. 17:22:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:22:30 INFO - Using the following test package requirements: 17:22:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:22:30 INFO - u'common': [u'target.common.tests.zip'], 17:22:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:22:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:22:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:22:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:22:30 INFO - u'mozbase': [u'target.common.tests.zip'], 17:22:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:22:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:22:30 INFO - u'web-platform': [u'target.common.tests.zip', 17:22:30 INFO - u'target.web-platform.tests.tar.gz'], 17:22:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:22:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip 17:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.common.tests.zip into memory 17:22:32 INFO - Content-Length response header: 54943852 17:22:32 INFO - Bytes received: 54943852 17:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip 17:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.talos.tests.zip into memory 17:22:44 INFO - Content-Length response header: 14513823 17:22:44 INFO - Bytes received: 14513823 17:22:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:44 INFO - trying https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:44 INFO - Downloading https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:22:48 INFO - Downloaded 61770111 bytes. 17:22:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:48 INFO - mkdir: /builds/slave/test/properties 17:22:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:48 INFO - Contents: 17:22:48 INFO - build_url:https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - Running post-action listener: find_tests_for_verification 17:22:48 INFO - Running post-action listener: set_extra_try_arguments 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.443665Z] Finished download-and-extract step (success) 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.443765Z] Running populate-webroot step. 17:22:48 INFO - Running pre-action listener: _resource_record_pre_action 17:22:48 INFO - Running main action method: populate_webroot 17:22:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tresize', 17:22:48 INFO - 'tcanvasmark']}, 17:22:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_css', 17:22:48 INFO - 'kraken']}, 17:22:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['damp', 'tps']}, 17:22:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['dromaeo_dom']}, 17:22:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:22:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['basic_compositor_video', 17:22:48 INFO - 'glvideo']}, 17:22:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:22:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['ts_paint_webext', 17:22:48 INFO - 'tp5o_webext']}, 17:22:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['a11yr', 17:22:48 INFO - 'ts_paint', 17:22:48 INFO - 'tpaint', 17:22:48 INFO - 'sessionrestore', 17:22:48 INFO - 'sessionrestore_many_windows', 17:22:48 INFO - 'sessionrestore_no_auto_restore', 17:22:48 INFO - 'tabpaint']}, 17:22:48 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:22:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest_singletons']}, 17:22:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['perf_reftest']}, 17:22:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tsvgx', 17:22:48 INFO - 'tsvgr_opacity', 17:22:48 INFO - 'tart', 17:22:48 INFO - 'tscrollx', 17:22:48 INFO - 'tsvg_static']}, 17:22:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:22:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo'], 17:22:48 INFO - 'tests': ['tp5o']}, 17:22:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:22:48 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:22:48 INFO - 'talos_options': ['--stylo-threads=1', 17:22:48 INFO - '--mitmproxy', 17:22:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:22:48 INFO - '--firstNonBlankPaint'], 17:22:48 INFO - 'tests': ['tp6_google', 17:22:48 INFO - 'tp6_youtube', 17:22:48 INFO - 'tp6_amazon', 17:22:48 INFO - 'tp6_facebook']}, 17:22:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}, 17:22:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:22:48 INFO - 'talos_options': ['--disable-stylo', 17:22:48 INFO - '--xperf_path', 17:22:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:48 INFO - 'tests': ['tp5n']}}} 17:22:48 INFO - Running post-action listener: _resource_record_post_action 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.464784Z] Finished populate-webroot step (success) 17:22:48 INFO - [mozharness: 2017-09-26 00:22:48.464874Z] Running create-virtualenv step. 17:22:48 INFO - Running pre-action listener: _resource_record_pre_action 17:22:48 INFO - Running main action method: create_virtualenv 17:22:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:22:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:22:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:22:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:49 INFO - Installing pip...............done. 17:22:49 INFO - Return code: 0 17:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:22:49 INFO - Reading from file tmpfile_stdout 17:22:49 INFO - Output received: 17:22:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:49 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')]} 17:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:49 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')]} 17:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:49 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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22:49 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 17:22:49 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 17:22:49 INFO - Using env: {'DISPLAY': ':0', 17:22:49 INFO - 'HOME': '/home/cltbld', 17:22:49 INFO - 'LANG': 'en_US.UTF-8', 17:22:49 INFO - 'LANGUAGE': 'en_US:en', 17:22:49 INFO - 'LOGNAME': 'cltbld', 17:22:49 INFO - 'MAIL': '/var/mail/cltbld', 17:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:49 INFO - 'MOZ_NO_REMOTE': '1', 17:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:49 INFO - 'NO_EM_RESTART': '1', 17:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:49 INFO - 'PWD': '/builds/slave/test', 17:22:49 INFO - 'SHELL': '/bin/bash', 17:22:49 INFO - 'SHLVL': '1', 17:22:49 INFO - 'TERM': 'linux', 17:22:49 INFO - 'TMOUT': '86400', 17:22:49 INFO - 'USER': 'cltbld', 17:22:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:49 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking pip>=1.5 17:22:50 INFO - Running setup.py egg_info for package pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing collected packages: pip 17:22:50 INFO - Found existing installation: pip 1.1 17:22:50 INFO - Uninstalling pip: 17:22:50 INFO - Successfully uninstalled pip 17:22:50 INFO - Running setup.py install for pip 17:22:50 INFO - warning: no files found matching 'pip/cacert.pem' 17:22:50 INFO - warning: no files found matching '*.html' under directory 'docs' 17:22:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:22:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:22:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:22:50 INFO - Successfully installed pip 17:22:50 INFO - Cleaning up... 17:22:50 INFO - Return code: 0 17:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', '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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:22: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 psutil>=3.1.1 17:22:50 INFO - Using env: {'DISPLAY': ':0', 17:22:50 INFO - 'HOME': '/home/cltbld', 17:22:50 INFO - 'LANG': 'en_US.UTF-8', 17:22:50 INFO - 'LANGUAGE': 'en_US:en', 17:22:50 INFO - 'LOGNAME': 'cltbld', 17:22:50 INFO - 'MAIL': '/var/mail/cltbld', 17:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:50 INFO - 'MOZ_NO_REMOTE': '1', 17:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:50 INFO - 'NO_EM_RESTART': '1', 17:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:50 INFO - 'PWD': '/builds/slave/test', 17:22:50 INFO - 'SHELL': '/bin/bash', 17:22:50 INFO - 'SHLVL': '1', 17:22:50 INFO - 'TERM': 'linux', 17:22:50 INFO - 'TMOUT': '86400', 17:22:50 INFO - 'USER': 'cltbld', 17:22:50 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:50 INFO - '_': '/tools/buildbot/bin/python'} 17:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:50 INFO - Downloading/unpacking psutil>=3.1.1 17:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Installing collected packages: psutil 17:22:52 INFO - Running setup.py install for psutil 17:22:52 INFO - building 'psutil._psutil_linux' extension 17:22:52 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 17:22:52 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 17:22:52 INFO - building 'psutil._psutil_posix' extension 17:22:52 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 17:22:52 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 17:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:52 INFO - Successfully installed psutil 17:22:52 INFO - Cleaning up... 17:22:52 INFO - Return code: 0 17:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:22:52 INFO - Using env: {'DISPLAY': ':0', 17:22:52 INFO - 'HOME': '/home/cltbld', 17:22:52 INFO - 'LANG': 'en_US.UTF-8', 17:22:52 INFO - 'LANGUAGE': 'en_US:en', 17:22:52 INFO - 'LOGNAME': 'cltbld', 17:22:52 INFO - 'MAIL': '/var/mail/cltbld', 17:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:52 INFO - 'MOZ_NO_REMOTE': '1', 17:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:52 INFO - 'NO_EM_RESTART': '1', 17:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:52 INFO - 'PWD': '/builds/slave/test', 17:22:52 INFO - 'SHELL': '/bin/bash', 17:22:52 INFO - 'SHLVL': '1', 17:22:52 INFO - 'TERM': 'linux', 17:22:52 INFO - 'TMOUT': '86400', 17:22:52 INFO - 'USER': 'cltbld', 17:22:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:52 INFO - '_': '/tools/buildbot/bin/python'} 17:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:52 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 17:22:52 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 17:22:52 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 17:22:52 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 17:22:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:54 INFO - Installing collected packages: mozsystemmonitor 17:22:54 INFO - Running setup.py install for mozsystemmonitor 17:22:54 INFO - Successfully installed mozsystemmonitor 17:22:54 INFO - Cleaning up... 17:22:55 INFO - Return code: 0 17:22:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', '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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:22: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 jsonschema==2.5.1 17:22:55 INFO - Using env: {'DISPLAY': ':0', 17:22:55 INFO - 'HOME': '/home/cltbld', 17:22:55 INFO - 'LANG': 'en_US.UTF-8', 17:22:55 INFO - 'LANGUAGE': 'en_US:en', 17:22:55 INFO - 'LOGNAME': 'cltbld', 17:22:55 INFO - 'MAIL': '/var/mail/cltbld', 17:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:55 INFO - 'MOZ_NO_REMOTE': '1', 17:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:55 INFO - 'NO_EM_RESTART': '1', 17:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:55 INFO - 'PWD': '/builds/slave/test', 17:22:55 INFO - 'SHELL': '/bin/bash', 17:22:55 INFO - 'SHLVL': '1', 17:22:55 INFO - 'TERM': 'linux', 17:22:55 INFO - 'TMOUT': '86400', 17:22:55 INFO - 'USER': 'cltbld', 17:22:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:55 INFO - '_': '/tools/buildbot/bin/python'} 17:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:22: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 17:22: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 17:22: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 17:22: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 17:22:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:22: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 17:22: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 17:22: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 17:22: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 17:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:58 INFO - warning: no files found matching '*.txt' 17:22:58 INFO - no previously-included directories found matching 'build' 17:22:58 INFO - no previously-included directories found matching 'dist' 17:22:58 INFO - no previously-included directories found matching '.git*' 17:22:58 INFO - Installing collected packages: jsonschema, functools32 17:22:58 INFO - Running setup.py install for functools32 17:22:59 INFO - warning: no files found matching '*.txt' 17:22:59 INFO - no previously-included directories found matching 'build' 17:22:59 INFO - no previously-included directories found matching 'dist' 17:22:59 INFO - no previously-included directories found matching '.git*' 17:22:59 INFO - Successfully installed jsonschema functools32 17:22:59 INFO - Cleaning up... 17:22:59 INFO - Return code: 0 17:22:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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', '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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:22: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 functools32==3.2.3-2 17:22:59 INFO - Using env: {'DISPLAY': ':0', 17:22:59 INFO - 'HOME': '/home/cltbld', 17:22:59 INFO - 'LANG': 'en_US.UTF-8', 17:22:59 INFO - 'LANGUAGE': 'en_US:en', 17:22:59 INFO - 'LOGNAME': 'cltbld', 17:22:59 INFO - 'MAIL': '/var/mail/cltbld', 17:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:59 INFO - 'MOZ_NO_REMOTE': '1', 17:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:59 INFO - 'NO_EM_RESTART': '1', 17:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:59 INFO - 'PWD': '/builds/slave/test', 17:22:59 INFO - 'SHELL': '/bin/bash', 17:22:59 INFO - 'SHLVL': '1', 17:22:59 INFO - 'TERM': 'linux', 17:22:59 INFO - 'TMOUT': '86400', 17:22:59 INFO - 'USER': 'cltbld', 17:22:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:59 INFO - '_': '/tools/buildbot/bin/python'} 17:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:22:59 INFO - Cleaning up... 17:22:59 INFO - Return code: 0 17:22:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22: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')]} 17:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22: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')]} 17:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22: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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:22: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 17:22: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 17:22:59 INFO - Using env: {'DISPLAY': ':0', 17:22:59 INFO - 'HOME': '/home/cltbld', 17:22:59 INFO - 'LANG': 'en_US.UTF-8', 17:22:59 INFO - 'LANGUAGE': 'en_US:en', 17:22:59 INFO - 'LOGNAME': 'cltbld', 17:22:59 INFO - 'MAIL': '/var/mail/cltbld', 17:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:59 INFO - 'MOZ_NO_REMOTE': '1', 17:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:59 INFO - 'NO_EM_RESTART': '1', 17:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:59 INFO - 'PWD': '/builds/slave/test', 17:22:59 INFO - 'SHELL': '/bin/bash', 17:22:59 INFO - 'SHLVL': '1', 17:22:59 INFO - 'TERM': 'linux', 17:22:59 INFO - 'TMOUT': '86400', 17:22:59 INFO - 'USER': 'cltbld', 17:22:59 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:59 INFO - '_': '/tools/buildbot/bin/python'} 17:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:22: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 17:22: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 17:22: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 17:22: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 17:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:23: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 17:23: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 17:23: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 17:23: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 17:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:23:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:01 INFO - Downloading docopt-0.6.1.tar.gz 17:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:23:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:23:01 INFO - Running setup.py install for blobuploader 17:23:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:23:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:23:01 INFO - Running setup.py install for requests 17:23:01 INFO - Running setup.py install for docopt 17:23:01 INFO - Successfully installed blobuploader requests docopt 17:23:01 INFO - Cleaning up... 17:23:01 INFO - Return code: 0 17:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23: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')]} 17:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23: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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:23: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 17:23: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 17:23:01 INFO - Using env: {'DISPLAY': ':0', 17:23:01 INFO - 'HOME': '/home/cltbld', 17:23:01 INFO - 'LANG': 'en_US.UTF-8', 17:23:01 INFO - 'LANGUAGE': 'en_US:en', 17:23:01 INFO - 'LOGNAME': 'cltbld', 17:23:01 INFO - 'MAIL': '/var/mail/cltbld', 17:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:01 INFO - 'MOZ_NO_REMOTE': '1', 17:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:01 INFO - 'NO_EM_RESTART': '1', 17:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:01 INFO - 'PWD': '/builds/slave/test', 17:23:01 INFO - 'SHELL': '/bin/bash', 17:23:01 INFO - 'SHLVL': '1', 17:23:01 INFO - 'TERM': 'linux', 17:23:01 INFO - 'TMOUT': '86400', 17:23:01 INFO - 'USER': 'cltbld', 17:23:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:01 INFO - '_': '/tools/buildbot/bin/python'} 17:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:02 INFO - Running setup.py (path:/tmp/pip-kUR1F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:02 INFO - Running setup.py (path:/tmp/pip-WEWHsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:02 INFO - Running setup.py (path:/tmp/pip-tSUV5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:02 INFO - Running setup.py (path:/tmp/pip-Kh7vsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:02 INFO - Running setup.py (path:/tmp/pip-H2YvIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:02 INFO - Running setup.py (path:/tmp/pip-IqelAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:02 INFO - Running setup.py (path:/tmp/pip-aY69ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:02 INFO - Running setup.py (path:/tmp/pip-r2Musk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:02 INFO - Running setup.py (path:/tmp/pip-9z0Lke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:02 INFO - Running setup.py (path:/tmp/pip-omwtif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:02 INFO - Running setup.py (path:/tmp/pip-O7kECm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:02 INFO - Running setup.py (path:/tmp/pip-Tt4Lzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:02 INFO - Running setup.py (path:/tmp/pip-pCX_Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:02 INFO - Running setup.py (path:/tmp/pip-Xy7Tpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:03 INFO - Running setup.py (path:/tmp/pip-qYBCzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:03 INFO - Running setup.py (path:/tmp/pip-PQEvv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:03 INFO - Running setup.py (path:/tmp/pip-QdKLY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:23:03 INFO - Running setup.py install for manifestparser 17:23:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozcrash 17:23:03 INFO - Running setup.py install for mozdebug 17:23:03 INFO - Running setup.py install for mozdevice 17:23:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozfile 17:23:03 INFO - Running setup.py install for mozhttpd 17:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozinfo 17:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:23:03 INFO - Running setup.py install for mozInstall 17:23:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for mozleak 17:23:04 INFO - Running setup.py install for mozlog 17:23:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for moznetwork 17:23:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for mozprocess 17:23:04 INFO - Running setup.py install for mozprofile 17:23:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for mozrunner 17:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:23:04 INFO - Running setup.py install for mozscreenshot 17:23:04 INFO - Running setup.py install for moztest 17:23:04 INFO - Running setup.py install for mozversion 17:23:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:23:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:23:05 INFO - Cleaning up... 17:23:05 INFO - Return code: 0 17:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:05 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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:23:05 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 17:23:05 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 17:23:05 INFO - Using env: {'DISPLAY': ':0', 17:23:05 INFO - 'HOME': '/home/cltbld', 17:23:05 INFO - 'LANG': 'en_US.UTF-8', 17:23:05 INFO - 'LANGUAGE': 'en_US:en', 17:23:05 INFO - 'LOGNAME': 'cltbld', 17:23:05 INFO - 'MAIL': '/var/mail/cltbld', 17:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:05 INFO - 'MOZ_NO_REMOTE': '1', 17:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:05 INFO - 'NO_EM_RESTART': '1', 17:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:05 INFO - 'PWD': '/builds/slave/test', 17:23:05 INFO - 'SHELL': '/bin/bash', 17:23:05 INFO - 'SHLVL': '1', 17:23:05 INFO - 'TERM': 'linux', 17:23:05 INFO - 'TMOUT': '86400', 17:23:05 INFO - 'USER': 'cltbld', 17:23:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:05 INFO - '_': '/tools/buildbot/bin/python'} 17:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:23:05 INFO - Running setup.py (path:/tmp/pip-rBiWxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:23:05 INFO - Running setup.py (path:/tmp/pip-KMVrHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:23:05 INFO - Running setup.py (path:/tmp/pip-zSK0JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:23:05 INFO - Running setup.py (path:/tmp/pip-HdWu7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:23:05 INFO - Running setup.py (path:/tmp/pip-8b2p7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:23:05 INFO - Running setup.py (path:/tmp/pip-FQ2yX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:23:05 INFO - Running setup.py (path:/tmp/pip-guIUgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:23:05 INFO - Running setup.py (path:/tmp/pip-HdaRId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:23:05 INFO - Running setup.py (path:/tmp/pip-FXeFlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:23:05 INFO - Running setup.py (path:/tmp/pip-Jr7eNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:23: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)) 17:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:23:05 INFO - Running setup.py (path:/tmp/pip-7NsmPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:23:06 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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:23:06 INFO - Running setup.py (path:/tmp/pip-7qeGRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:23:06 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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:23:06 INFO - Running setup.py (path:/tmp/pip-2d23WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:23:06 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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:23:06 INFO - Running setup.py (path:/tmp/pip-g8aiXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:23:06 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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:23:06 INFO - Running setup.py (path:/tmp/pip-4_ua5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:23: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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:23:06 INFO - Running setup.py (path:/tmp/pip-cEvXjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:23: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)) 17:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:23:06 INFO - Running setup.py (path:/tmp/pip-O1ek5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23: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)) 17:23:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:23: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 17:23: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 17:23: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 17:23: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 17:23:07 INFO - Downloading blessings-1.6.tar.gz 17:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:23:07 INFO - Installing collected packages: blessings 17:23:07 INFO - Running setup.py install for blessings 17:23:07 INFO - Successfully installed blessings 17:23:07 INFO - Cleaning up... 17:23:07 INFO - Return code: 0 17:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:08 INFO - Reading from file tmpfile_stdout 17:23:08 INFO - Current package versions: 17:23:08 INFO - argparse == 1.2.1 17:23:08 INFO - blessings == 1.6 17:23:08 INFO - blobuploader == 1.2.4 17:23:08 INFO - docopt == 0.6.1 17:23:08 INFO - functools32 == 3.2.3-2 17:23:08 INFO - jsonschema == 2.5.1 17:23:08 INFO - manifestparser == 1.1 17:23:08 INFO - mozInstall == 1.13 17:23:08 INFO - mozcrash == 1.0 17:23:08 INFO - mozdebug == 0.1 17:23:08 INFO - mozdevice == 0.51 17:23:08 INFO - mozfile == 1.2 17:23:08 INFO - mozhttpd == 0.7 17:23:08 INFO - mozinfo == 0.10 17:23:08 INFO - mozleak == 0.1 17:23:08 INFO - mozlog == 3.5 17:23:08 INFO - moznetwork == 0.27 17:23:08 INFO - mozprocess == 0.25 17:23:08 INFO - mozprofile == 0.28 17:23:08 INFO - mozrunner == 6.13 17:23:08 INFO - mozscreenshot == 0.1 17:23:08 INFO - mozsystemmonitor == 0.3 17:23:08 INFO - moztest == 0.8 17:23:08 INFO - mozversion == 1.4 17:23:08 INFO - psutil == 3.1.1 17:23:08 INFO - requests == 1.2.3 17:23:08 INFO - wsgiref == 0.1.2 17:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:23:08 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')]} 17:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23:08 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')]} 17:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23:08 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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:23:08 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 17:23:08 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 17:23:08 INFO - Using env: {'DISPLAY': ':0', 17:23:08 INFO - 'HOME': '/home/cltbld', 17:23:08 INFO - 'LANG': 'en_US.UTF-8', 17:23:08 INFO - 'LANGUAGE': 'en_US:en', 17:23:08 INFO - 'LOGNAME': 'cltbld', 17:23:08 INFO - 'MAIL': '/var/mail/cltbld', 17:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:08 INFO - 'MOZ_NO_REMOTE': '1', 17:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:08 INFO - 'NO_EM_RESTART': '1', 17:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:08 INFO - 'PWD': '/builds/slave/test', 17:23:08 INFO - 'SHELL': '/bin/bash', 17:23:08 INFO - 'SHLVL': '1', 17:23:08 INFO - 'TERM': 'linux', 17:23:08 INFO - 'TMOUT': '86400', 17:23:08 INFO - 'USER': 'cltbld', 17:23:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:08 INFO - '_': '/tools/buildbot/bin/python'} 17:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 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)) 17:23:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:23: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)) 17:23: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)) 17:23:09 INFO - Installing collected packages: simplejson 17:23:09 INFO - Running setup.py install for simplejson 17:23:09 INFO - building 'simplejson._speedups' extension 17:23: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 17:23: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 17:23:10 INFO - Successfully installed simplejson 17:23:10 INFO - Cleaning up... 17:23:10 INFO - Return code: 0 17:23:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:23: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')]} 17:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:23: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')]} 17:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:23: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 0x1c021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f6f9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', '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 17:23: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 17:23: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 17:23:10 INFO - Using env: {'DISPLAY': ':0', 17:23:10 INFO - 'HOME': '/home/cltbld', 17:23:10 INFO - 'LANG': 'en_US.UTF-8', 17:23:10 INFO - 'LANGUAGE': 'en_US:en', 17:23:10 INFO - 'LOGNAME': 'cltbld', 17:23:10 INFO - 'MAIL': '/var/mail/cltbld', 17:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:10 INFO - 'MOZ_NO_REMOTE': '1', 17:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:10 INFO - 'NO_EM_RESTART': '1', 17:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:10 INFO - 'PWD': '/builds/slave/test', 17:23:10 INFO - 'SHELL': '/bin/bash', 17:23:10 INFO - 'SHLVL': '1', 17:23:10 INFO - 'TERM': 'linux', 17:23:10 INFO - 'TMOUT': '86400', 17:23:10 INFO - 'USER': 'cltbld', 17:23:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:10 INFO - '_': '/tools/buildbot/bin/python'} 17:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:23:10 INFO - Cleaning up... 17:23:10 INFO - Return code: 0 17:23:10 INFO - Running post-action listener: _resource_record_post_action 17:23:10 INFO - Running post-action listener: _start_resource_monitoring 17:23:10 INFO - Starting resource monitoring. 17:23:10 INFO - [mozharness: 2017-09-26 00:23:10.734133Z] Finished create-virtualenv step (success) 17:23:10 INFO - [mozharness: 2017-09-26 00:23:10.734615Z] Running install step. 17:23:10 INFO - Running pre-action listener: _resource_record_pre_action 17:23:10 INFO - Running main action method: install 17:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:23:10 INFO - Reading from file tmpfile_stdout 17:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:23:11 INFO - Reading from file tmpfile_stdout 17:23:11 INFO - Output received: 17:23:11 INFO - Usage: mozinstall [options] installer 17:23:11 INFO - Options: 17:23:11 INFO - -h, --help show this help message and exit 17:23:11 INFO - -d DEST, --destination=DEST 17:23:11 INFO - Directory to install application into. [default: 17:23:11 INFO - "/builds/slave/test"] 17:23:11 INFO - --app=APP Application being installed. [default: firefox] 17:23:11 INFO - mkdir: /builds/slave/test/build/application 17:23:11 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'] 17:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:23:28 INFO - Reading from file tmpfile_stdout 17:23:28 INFO - Output received: 17:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:28 INFO - Running post-action listener: _resource_record_post_action 17:23:28 INFO - [mozharness: 2017-09-26 00:23:28.867149Z] Finished install step (success) 17:23:28 INFO - [mozharness: 2017-09-26 00:23:28.867402Z] Running setup-mitmproxy step. 17:23:28 INFO - Running pre-action listener: _resource_record_pre_action 17:23:28 INFO - Running main action method: setup_mitmproxy 17:23:28 INFO - Skipping: mitmproxy is not required 17:23:28 INFO - Running post-action listener: _resource_record_post_action 17:23:28 INFO - [mozharness: 2017-09-26 00:23:28.868525Z] Finished setup-mitmproxy step (success) 17:23:28 INFO - [mozharness: 2017-09-26 00:23:28.868744Z] Running run-tests step. 17:23:28 INFO - Running pre-action listener: _resource_record_pre_action 17:23:28 INFO - Running pre-action listener: _set_gcov_prefix 17:23:28 INFO - Running main action method: run_tests 17:23:28 WARNING - Try message not found. 17:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:28 INFO - Python 2.7.3 17:23:28 INFO - Return code: 0 17:23:28 INFO - grabbing minidump binary from tooltool 17:23: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')]} 17:23: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 0x1f6cd60>, '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 0x1f6da60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f6def0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23: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 17:23: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 17:23: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 17:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:28 INFO - Return code: 0 17:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:29 INFO - ENV: RUST_BACKTRACE is now full 17:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:23:29 INFO - Using env: {'DISPLAY': ':0', 17:23:29 INFO - 'HOME': '/home/cltbld', 17:23:29 INFO - 'LANG': 'en_US.UTF-8', 17:23:29 INFO - 'LANGUAGE': 'en_US:en', 17:23:29 INFO - 'LOGNAME': 'cltbld', 17:23:29 INFO - 'MAIL': '/var/mail/cltbld', 17:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:29 INFO - 'MOZ_NO_REMOTE': '1', 17:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:29 INFO - 'NO_EM_RESTART': '1', 17:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:29 INFO - 'PWD': '/builds/slave/test', 17:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:29 INFO - 'RUST_BACKTRACE': 'full', 17:23:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:29 INFO - 'SHELL': '/bin/bash', 17:23:29 INFO - 'SHLVL': '1', 17:23:29 INFO - 'TERM': 'linux', 17:23:29 INFO - 'TMOUT': '86400', 17:23:29 INFO - 'USER': 'cltbld', 17:23:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:29 INFO - '_': '/tools/buildbot/bin/python'} 17:23:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:23:29 INFO - mozversion application_buildid: 20170925232538 17:23:29 INFO - mozversion application_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:23:29 INFO - mozversion application_display_name: Nightly 17:23:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:29 INFO - mozversion application_name: Firefox 17:23:29 INFO - mozversion application_remotingname: firefox 17:23:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:23:29 INFO - mozversion application_vendor: Mozilla 17:23:29 INFO - mozversion application_version: 58.0a1 17:23:29 INFO - mozversion platform_buildid: 20170925232538 17:23:29 INFO - mozversion platform_changeset: 641bfddb87113b45ee3df9849345dbcf821ef3da 17:23:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:23:29 INFO - mozversion platform_version: 58.0a1 17:23:29 INFO - using testdate: 1506385409 17:23:29 INFO - actual date: 1506385409 17:23:29 INFO - starting webserver on 'localhost:55303' 17:23:29 INFO - SUITE-START | Running 2 tests 17:23:29 INFO - TEST-START | dromaeo_css 17:23:29 INFO - Initialising browser for dromaeo_css test... 17:23:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55303/getInfo.html -profile /tmp/tmp56KcdH/profile 17:23:29 INFO - TEST-INFO | started process 18471 (/builds/slave/test/build/application/firefox/firefox http://localhost:55303/getInfo.html) 17:23:35 INFO - TEST-INFO | 18471: exit 0 17:23:35 INFO - Browser initialized. 17:23:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:35 INFO - Using env: {'DISPLAY': ':0', 17:23:35 INFO - 'HOME': '/home/cltbld', 17:23:35 INFO - 'JSGC_DISABLE_POISONING': '1', 17:23:35 INFO - 'LANG': 'en_US.UTF-8', 17:23:35 INFO - 'LANGUAGE': 'en_US:en', 17:23:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:23:35 INFO - 'LOGNAME': 'cltbld', 17:23:35 INFO - 'MAIL': '/var/mail/cltbld', 17:23:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:35 INFO - 'MOZ_CRASHREPORTER': '1', 17:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:23:35 INFO - 'MOZ_NO_REMOTE': '1', 17:23:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:35 INFO - 'NO_EM_RESTART': '1', 17:23:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:35 INFO - 'PWD': '/builds/slave/test', 17:23:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:35 INFO - 'RUST_BACKTRACE': 'full', 17:23:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:23:35 INFO - 'SHELL': '/bin/bash', 17:23:35 INFO - 'SHLVL': '1', 17:23:35 INFO - 'TERM': 'linux', 17:23:35 INFO - 'TMOUT': '86400', 17:23:35 INFO - 'USER': 'cltbld', 17:23:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:35 INFO - '_': '/tools/buildbot/bin/python'} 17:23:35 INFO - TEST-INFO | started process 18708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp56KcdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:36 INFO - PID 18708 | 17:23:36 INFO - PID 18708 | (/builds/slave/test/build/application/firefox/firefox:18757): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:23:36 INFO - PID 18708 | 17:23:46 INFO - PID 18708 | RSS: Main: 151355392 17:23:46 INFO - PID 18708 | 17:26:44 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55303/tests/dromaeo/cssquery-ext.html) 17:26:45 INFO - PID 18708 | RSS: Main: 152735744 17:26:45 INFO - PID 18708 | 17:29:47 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-ext.html (next: http://localhost:55303/tests/dromaeo/cssquery-jquery.html) 17:29:47 INFO - PID 18708 | RSS: Main: 151515136 17:29:47 INFO - PID 18708 | 17:32:49 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55303/tests/dromaeo/cssquery-mootools.html) 17:32:50 INFO - PID 18708 | RSS: Main: 155090944 17:32:50 INFO - PID 18708 | 17:35:51 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55303/tests/dromaeo/cssquery-prototype.html) 17:35:52 INFO - PID 18708 | RSS: Main: 153464832 17:35:52 INFO - PID 18708 | 17:38:55 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55303/tests/dromaeo/cssquery-yui.html) 17:38:56 INFO - PID 18708 | RSS: Main: 154357760 17:38:56 INFO - PID 18708 | 17:41:57 INFO - PID 18708 | Cycle 1(1): loaded http://localhost:55303/tests/dromaeo/cssquery-yui.html (next: http://localhost:55303/tests/dromaeo/cssquery-dojo.html) 17:41:58 INFO - PID 18708 | RSS: Main: 156991488 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | __start_tp_report 17:41:58 INFO - PID 18708 | _x_x_mozilla_page_load 17:41:58 INFO - PID 18708 | _x_x_mozilla_page_load_details 17:41:58 INFO - PID 18708 | |i|pagename|runs| 17:41:58 INFO - PID 18708 | |0;dojo.html;3143.245621050947;3171.6035495563056;3173.7302329302006;3175.3490534440443;3179.936401271975;6150.354212807658;6327.177466929298;6395.6802159891995;6411.294757576663;6477.449416799566;6241.687915604224;6273.498120150389;6292.402221788922;6418.903716444257;6421.967890160543;5813.244278243833;5855.912161317584;5866.560007999396;5891.086881533369;5907.852303692421;1214.5249446705297;5736.024875771108;5859.853503662422;5888.322842873082;5899.410058994109;5740.7703691852275;5771.22088518051;5793.449622285876;5824.592278540504;5852.297724273072;5781.797637082724;5802.274715660543;5816.302043754734;5860.09168578871;5879.794207202727;5771.422857714237;5783.942160578383;5821.09772985188;5851.888141253148;5872.29532456108;6228.252609686821;6276.932921403372;6280.106513478728;6326.873462530723;6339.778107766206;6524.314946930552;6639.236487803868;6686.899696504556;6732.663366831639;6772.18733751948;6725.93274067258;6792.422644075259;6800.795976120724;6843.144606924135;6860.485463590251;6293.276273228637;6297.244330680348;6368.331325210879;6370.458511026568;6376.744930202786;6969.721211151497;6995.825104372431;7069.151701795715;7071.257517960643;7081.291870812981;6516.869662606816;6618.834529136714;6618.900716489256;6705.731770729214;6727.629980351127;6829.248782633907;6829.282925292872;6847.246802851682;6848.041274221613;6849.212340580797;6712.194536655633;6718.49611279156;6738.7304507819135;6827.419669328163;6828.283030281848;6586.341365863375;6662.367075127952;6670.866582668319;6697.598144111369;6780.1524809398825;5287.339082614673;5293.867653308621;5303.231031500411;5303.496167864047;5305.708186049727;4622.95377046232;4663.183942809995;4698.107359601665;4703.905921881543;4705.341252224691;5674.460926212003;5759.625624334405;5842.415758424208;5858.53131749459;5866.560007999417;6824.18109826824;6842.144731908512;6909.205441374306;6920.134983127109;6924.099867017256;5767.22142510764;5793.855153621109;5835.387284335168;5840.737166827503;5847.093700476433;5747.568932330092;5775.826725198251;5859.267591551056;5894.498967587803;5894.970525147347;6599;6611.900821487681;6645.767398141042;6648.235452922879;6656.73373065072;6840.726370945106;6848.1097457330225;6930.3762661360715;6933.479989000845;6958.582485050913;6365.077063825626;6485.189351331083;6499.2200935887995;6530.183727034121;6660.2673705893285;6686.06395104676;6727.058211850247;6734.966325168343;6735;6765.221999470124;6780.186377634715;6829.556078854858;6882.208546017272;6883.724651014104;6893.379595836399;6524.804255872332;6577.2107347116735;6578.7368505261165;6647.634380108947;6654.700538475683;6392.744290228339;6513.381228783258;6559.147310849559;6642.169728783902;6647.135872336758;6479.1901012373455;6546.770863019771;6555.2133743951035;6565.704543295467;6566.146400967844;6596.142501474969;6703.66481675924;6753.1896172457655;6756.560823546453;6778.152730908637;6255.24937007562;6360.650164241011;6405.807825765234;6411.903821442589;6506.479481641552 17:41:58 INFO - PID 18708 | |1;ext.html;781.3827076609479;801.9558924259167;802.3460879383302;803.9517628942264;804.4248362420868;39682.2063558729;43389.56610433895;43523.347149792775;43589.34615980755;43599.12801743963;39396.80301598488;39426.605733942655;39550.20899582014;39643.40534891979;39714.60285397145;7027.191872934614;7150.39221666159;7155.391791697686;7195.568265904037;7210.711571537132;7144.0712707347975;7180.964095179516;7187.568745875238;7209.0988626421695;7227.6386180691015;7149.49953503255;7172.282771722838;7177.282271772833;7192.5324853884595;7323.048003759503;7950.24472675095;7950.920490795076;8015.158408367125;8037.035555733291;8066.4353495255355;7869.055713314439;7873.133955264916;7942.245486678814;7967;7968.641411136513;37227.81386093079;39134;39412.60587394118;39488.81533553998;39501.209975800324;3506.0358401439553;3547.52108465359;3548.520949671787;3549.165946002687;3550.0059983204487;32510.349793004007;32913.34173316544;32960.505592416135;33140.668593313996;33155.50266746001;5220.321358223407;5253.080710875582;5287.550558202557;5290.153575427913;5301.867453313659;187982;188754;189906;190468;190470.04764976224;42948;43786.34320485195;49375;49428.50571494311;49536.27550484758;52311.21533177005;53350.06574638432;53523;53552.73223633857;53825;16226.918865405598;16335.59161020984;16335.754963675317;16349.182540873147;16394.672106557802;13344.666383340495;13376.933115334361;13397.12918660284;13402.396892139683;13409.865901341056;14287.142771433748;14366.35351409189;14489.637759056108;14641.707165856624;14739.926300368645;5749.597528173072;5884.588078834526;5915.615484993462;5931.347551769302;5961.2846458425265;1007.7077647482148;1021.6271061062807;1022.754538910656;1024.293237666008;1024.4928760263717;23041.308760737204;23166.7683323168;23232.186873459348;23315.417114571934;23496.412589685053;1079.4386918802336;1128.368113856243;1134.7787181499527;1139.6239241050434;1141.931484110956;12250.754984900252;12258.509659613694;12282.201656892274;12444.626661200178;12479.001679865589;227265;228250;228671;228730;229337;54272.3718288452;54436;54452.45547544553;54468.45531544713;54577.45422545803;1443.0908527627528;1499.4302165177162;1506.8342482326934;1508.7435136026681;1512.9319180636678;22556.66165007559;22924.4268893279;22999.195028173934;23137.652935206323;23289;38055.42916856194;38163.61836381712;38178;38180.236395271386;38185;187277;187312;187464;188148;188653.05673471544;31884.5217321745;32221;34597.65402345944;35237.29525409529;36099.819500902326;44550.3317450232;44683.55316446924;45053;45203.77398112988;45616;32563;32922.83538582292;33120.66879331176;33246.00261992144;33528.832355838065;32006.839965800023;32079.35841283208;32179.839100804347;32386.190345241557;32870.67129328676;36614.63385366112;36930.26139477142;37035.62964370322;37101.6289837109;37299.81350093232;31915.084377677053;32052.35895282128;32119.197020074684;32198;32932.1766955828;22903.427414314774;23490.882545587847;23538.29385118449;23703.407414814767;23857.880710596335 17:41:58 INFO - PID 18708 | |2;jquery.html;592.6029560194669;599.8380437281932;602.6354055796243;606.8452544601126;607.3744043635056;21517.56964860702;22108.668369974464;22178.223762168327;22259.888700556494;22299.331020069385;21910.89044554779;23686.289411317688;23914.76085239147;23933.282001539937;23965.880170599165;6383.5531512794005;6535.673216339188;6564.901526477107;6578.309277525863;6587.374199451068;6217.658028808413;6355.173827402431;6461.93538064618;6531.052997315386;6545.738170473175;6440.645764482952;6441.162648855642;6503.674816259192;6513.837154071139;6517.478601711875;6302.275238347603;6400.51996100292;6417.903731444032;6429.485641148697;6436.549441539094;6062.211912451397;6134.601250918676;6135.049067394561;6139.662318572477;6140.95603747364;27980.720192798017;28398.716012839814;28457.857710711312;28510.57234141469;28545.857270713514;2051.189780036892;2051.548659294953;2061.1034200122995;2072.3782865140547;2073.067119796083;18540.258389664396;19038.61922761537;19431.611367772566;19502.219911203534;19686.11412486427;2370.146747171017;2399.640053991915;2424.2242482405636;2427.417419819231;2447.8286519943613;114406;119924;120230;129623;134433;14564.927175364055;14590.489332873298;14673.584651262598;14674.143725312922;14917.927904512519;22654;22724.772752272595;22731.318060458212;22755.520891142023;22880.88559557225;10146.797064058677;10186.490675466197;10190.490475476197;10257.94871025655;10338.276320657482;9356.204722598655;9463.810723785486;9495.05049495045;9604.183644390305;9677.9032209677;8836.779080523038;8902.287816974627;8907.153820387053;8989.505577193317;9261.49061801594;2582.625519299691;2618.3454136465884;2697.878595463209;2739.876705548255;2749.4363655450984;916.812053529025;945.4516380499294;958.2341398304729;961.8701475300885;992.8212921674168;18396.356127535473;18406.907965460086;18710.158042888103;18923.43229703111;18992.620147596972;1011.4487604255698;1027.814993301213;1028.4857571214393;1041.4272150317295;1042.6507120114848;10359.741006474747;10367.727524847358;10396.220283478619;10537.209709271836;10598.9930956559;475204;480622;480703;482397;496526;105123;110128;111750.44124779323;111907.44046279717;111940;1141.2752901907184;1143.9485223164977;1182.1252273317682;1184.0049516564616;1188.3879801902028;16899.239534221237;16950.237239324015;16994.660106797546;17249.827501725325;17312.134393280034;55791;56083;56580;57410.712946435;57540.71229643825;70242.29757702358;71106.28893710997;71315.28684713086;71548;71620.64189679018;13922.303884805922;14207.431702731776;14311.35598898073;14323.212223327817;14381.209033503257;21345.573088538455;21815.890920545295;21903.780962190813;21960.682359058508;21976.560468790856;17279.222434990203;17285.827141728925;17287.308507659553;17692.82307176963;17710.468685939442;15536.61158471002;16024.839751602334;16361.263743131349;16420.507384778477;16580.253888574804;17628.471145865133;17745.55636109056;17906.91046544759;17985.640287194445;17998.460046198634;14169;14250.786238206229;14277.500287489887;14288.42846286137;14351.210683412513;16912;17002.31990720407;17404.82595174032;17685.204165812826;17703.73444398361 17:41:58 INFO - PID 18708 | |3;mootools.html;1341.1483707845516;1400.0829456705856;1405.6345350208946;1414.2645824171432;1416.9726947962722;15000.324985375657;15750;15856.28646710898;15884.602884927883;15902.920485397557;15241.618959526017;15540.456084037061;15570.14364209968;15577.065376077444;15577.92211038946;2655.0972669292437;2701.2166471723176;2710.241132482908;2727.4272402795436;2730.344717267851;2701.8513981731;2720.945581088377;2723.360010397555;2726.945461090777;2728.8499132547704;2490.3276115448907;2735.9726402736014;2801.929951751202;2802.453521563296;2805.368792021789;2532.480841427503;2564.1538292363475;2581.9483610327875;2583.147561304774;2588.2105957682897;2386.8925898334614;2431.2827715823873;2459.7417271186446;2470.505898820225;2475.616279476666;15176.848231517653;15178.468753593681;15279.694406111927;15324.387024519006;15327.770083448757;7968.282854543119;8238.134995825412;8243.670253189865;8263.917360826435;8289.917100828974;5341.599380046512;5577.8605534861545;5723.17014032967;5726.742296596663;5745.683987380692;1965.5872266823985;2007.5884443689008;2015.3248661698349;2054.815066644009;2055.897205139752;27425.725742742517;27662;27662.170134895783;27667.169984900484;27671.723282767114;6720.22717387497;6875.656217189121;6885.518013739091;6996.580205187705;7018.75434359795;18032.188551515213;18034.819651803577;18068.096595170187;18086;18106.094695265183;7905.802354941173;7998.240167184108;8034.67861285542;8044.718434854752;8070.1526339734655;7199.1001124859395;7236.4803391288415;7371.115466144097;7406.407487400995;7420.406367490696;5135.563477104488;5274.97362513185;5294.708791016531;5315.069862773999;5356.330458692663;1469.169918995764;1469.9559013229407;1482.762757958743;1498.5579254120062;1499.2054211268046;894.3069121430813;914.7850255190025;923.1691477670016;924.9630014799467;926.8285367207088;7829.686812527549;8829.735107946772;8994.820103597891;9079.50062746542;9099.68151114721;701.740356068258;736.1129838544648;740.315208432198;751.9962400187964;759.1383779410298;4839.274108883696;5195.038917800219;5410.242566040757;5514.862128446741;5690.658560486384;20608.896955515127;22313.776862231494;22824.771752282595;22849.771502284766;22956.081756729876;21579.892100539397;21764.129434822746;22080.668789968164;22228.444288892908;22294.55410891773;11217.270877392943;11601.82597261025;11787.410629468492;11806.52773889052;11843.111766617538;8685.305175585812;8736.432131911406;8752.256058234867;8786.209241168326;8832.425892316978;18783.530411739815;18787.34244301443;19354.903225483784;19413;19815.108320125917;19303.8069619302;19358.612827743647;19935.401937941886;20020;20177.697334539702;11476.713082172679;11679.357635330138;11718.824217636571;11732.12009099304;11746.647600571996;13962.232077235849;13970.231637260049;14156.646083847987;14174.291285435893;14273.072250303698;11202.775944480902;11227.66317010491;11248.550057997589;11371.20401571882;11517.712057198638;10894;11177.776444470903;11308.264962777394;11502.424878756196;11687.590934317259;10115.645952391631;10162.085412312927;10170.79658406813;10273.383596984206;10275.229357798045;7625.199354067965;7704.152543220353;7715.498492597963;7744.535327880345;7830.33442157423;7576.166621671722;7762.844743105219;7780.183080776437;7782.26068523512;7835.725749598737 17:41:58 INFO - PID 18708 | |4;prototype.html;521.3691433365627;523.272651015089;541;542.6038991536178;545.6453305351521;6247.375262473756;6264.310925798164;6291.678747463038;6358.205224346957;6418.5507014509;6240.563160578761;6272.59228150171;6274.3098259191565;6323.873522529547;6324.968375158118;5217.634765566412;5234.476552344773;5246.606504512168;5257.395399529046;5261.316028916235;4863.440704318996;5019.222020586815;5122.462141475147;5248.790048398059;5276.577873770108;5023.467842308095;5026.924596131061;5037.874053148664;5096.923546146811;5098.949010509903;5006.498050584846;5035.974820125876;5041.1682072458;5055.39335279767;5066.898662026757;4445.266531022377;4499.797509112098;4539.455265368177;4545.477270113913;4568.794404251817;6195.499542758327;6199.566030377875;6206.25524937006;6231.6572588507615;6253.968730156365;5675.5743319250805;5715.199872017921;5782.335031471351;5797.507211886995;5801.593888427812;6582.80251592453;6585.703643336062;6658.234303055162;6729.629870357128;6741.561798483083;4945.975270123662;4990.525900039491;4994.225894986283;5011.674241174312;5022.347094877679;6621.271660117383;6777.525573209878;6852.143482064742;6998.75504357345;7029.718811247595;5029.723365214875;5057.241413787888;5062.620303477254;5073.391193056783;5085.796568137307;5130.692158470503;5141.640085194001;5143.871403214949;5144.768485418165;5180.922286165711;5774.913376299359;5775.191473193756;5777.035807825276;5819.592628515963;5827.3007239131575;6729.6971636276485;6754.864902701918;6767.221769496472;6796;6802.829929251809;1778.728209330335;1780.5904641932168;1784.580623553464;1785.749995000701;1793.7219730941724;1152.1877076660935;1212.2605210821391;1231.8644949055597;1238.2694210415898;1239.7148655809215;5744.712764361849;5776.393478684761;5784.65292082468;5834.212381328552;5866.442687944638;6767.1879374475375;6785.896372124558;6879.2432832388395;6881.931180688229;6895.310468953065;5745.798897038583;5759.971200144057;5781.624194427349;5795.449432303924;5812.88374232513;3561.9643803562153;3595.9280814383565;3626.419772836386;3633.5458067741533;3639.090227443139;6529.400296927188;6531.934680653133;6534.477241820643;6554.770583029571;6568.704408301638;6542;6781.220159681699;6983.1620205575655;7048.647567621599;7087.0432491614;6375.649339286384;6404.199475065617;6466.870662586722;6542.8364290893105;6586.670666466657;6656.900146497903;6732.853247570494;6743.460523158037;6803.9319606805275;6829.487788415988;6669.7332106715185;6802.6258555779905;6803.387695107464;6831.795046148623;6867.862642747217;6494.967525162344;6570.375814297634;6586.473082153512;6593.538452308484;6623.350659736144;5096.502713670201;5097.464766199644;5098.2214692991665;5103.668261562986;5125.463430233127;6474.870502590016;6669.399754022162;6721.353268449261;6754.155730533684;6846.246912839683;6393.360663933569;6460.935390646221;6469.967650161719;6556.934430655632;6593.538452308292;6549.508786840911;6559.835254365952;6574.80275591733;6579.638119903259;6646.169228846395;6359.77740779089;6389.7763578274535;6440.2915679276175;6445.711772320758;6463.870722585616;6571.835704107436;6578.881590129785;6589.703463344257;6590.276493780998;6684.364985326386;6369.044643303541;6417.807465776034;6425.261094974137;6447.323031081669;6519.315471875574 17:41:58 INFO - PID 18708 | |5;yui.html;887.3566664168483;907.3739120007194;929.0338048429634;933.0249888866134;940.2290122099879;19386.51533711656;20324;20400.081996310164;20405;20428.182872685076;17914.37299694511;18018.909905450488;18101.7284740729;18961.715574266396;19283.22867085315;947.8957314695378;948.5257371314343;949.9762505937338;950.538988590533;971.349196038654;942.9057094290584;944.3153713557684;970.9271804614647;990.4799980010516;1007.6876168387823;1060.4962642744674;1064.3560645809291;1064.5050051725946;1064.7604289034982;1065.0840277361463;983.1790454970109;1050.1074087026043;1057.7937302226069;1058.0530425269378;1058.1059005140644;743.650484272391;748.7903387051634;749.1160430691782;749.4528993834476;749.61394881636;18528.44414667562;18609.627807443776;18616.162272697762;18619.348322808637;18628.348007819797;21645.67531487029;21927.561448771095;22097.447563810874;22410.32769016932;22423.663645045337;17637.64724705499;17863.73204401922;18019.27922883083;18030.549236269067;18238.0880955953;3692.316921369555;3737.906552336186;3749.8687545935763;3775.301569209705;3777.7166712496396;142752;142986.28506857503;143955;144347;146198.2690086543;16995.830041699424;17297.308107675803;17341.65316693659;17392.130393480275;17396.82603173952;30887.536686949712;32364.190895227806;32598.674013259562;32686.509702354484;32726.345473090405;8929.955350223338;8985.326100542356;9036;9093.454392736458;9127.178553930178;4514.932276015862;4637.46669133054;4638.489766125724;4649.04694537619;4649.116667833101;5586.301712285965;5665.915011274834;5678.914816277676;5702.486776190163;5703.914441283384;931.3480563605503;966.9564869580886;987.027777639025;988.8170688422665;998.4508520313798;686.2588404523103;709.4466316273315;717.720089165226;718.1633397092329;721.5778769419948;11583.884161158448;11825.822612660817;12056.63830085099;12740.362981851056;13162.276074815785;676.2561182698992;702.2240424331143;713.3472872321768;714.6926821466819;720.459655258556;5669.716514174274;5768.884622307531;5821.126830975388;5864.120381942743;5905.291365036223;122060;125008;125364.37317813352;126387.3680631591;126819.36590316989;83387.5830620843;85848;107553.46223268834;109495;110155.44922275338;85835;86939.13060869437;89545;90277;92346;12249.326287054297;12607.369631518204;12678.366081696062;12736.299503527394;12762;41619.167616648105;42164.367534486395;42342.153156936074;43734.781326093165;44245.336319954586;74828.75513734597;76147.23852761401;76492;76850.23149768655;77087;18670.346537871108;18720.251189952793;19101.808981910002;19114.52213694669;19182.232710691973;21047.684284735435;21519.892400537898;21740.89129554342;22086.77913220847;22154.778452215272;18604.906975465037;19014.904925475283;19093.236270549023;19672.311469098513;19878.801211987695;16396.344146234016;17857.28570857151;18187.09064546794;18369.72445413293;18502.814971850108;18504.629907401508;18624.44126676202;18635.72046419278;19024.71462928085;19165;13397.598072057464;13437;13467.653234676454;13576.710212529793;14000.579982600539;14647.853521464649;15194.240287985778;15259;15287.541373758804;15552.144632045347 17:41:58 INFO - PID 18708 | __end_tp_report 17:41:58 INFO - PID 18708 | __start_cc_report 17:41:58 INFO - PID 18708 | _x_x_mozilla_cycle_collect,290 17:41:58 INFO - PID 18708 | __end_cc_report 17:41:58 INFO - PID 18708 | __startTimestamp1506386518215__endTimestamp 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | ------- Summary: start ------- 17:41:58 INFO - PID 18708 | Number of tests: 6 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#0] dojo.html Cycles:165 Average:6208.61 Median:6485.19 stddev:849.04 (13.1%) stddev-sans-first:816.88 17:41:58 INFO - PID 18708 | Values: 3143.2 3171.6 3173.7 3175.3 3179.9 6150.4 6327.2 6395.7 6411.3 6477.4 6241.7 6273.5 6292.4 6418.9 6422.0 5813.2 5855.9 5866.6 5891.1 5907.9 1214.5 5736.0 5859.9 5888.3 5899.4 5740.8 5771.2 5793.4 5824.6 5852.3 5781.8 5802.3 5816.3 5860.1 5879.8 5771.4 5783.9 5821.1 5851.9 5872.3 6228.3 6276.9 6280.1 6326.9 6339.8 6524.3 6639.2 6686.9 6732.7 6772.2 6725.9 6792.4 6800.8 6843.1 6860.5 6293.3 6297.2 6368.3 6370.5 6376.7 6969.7 6995.8 7069.2 7071.3 7081.3 6516.9 6618.8 6618.9 6705.7 6727.6 6829.2 6829.3 6847.2 6848.0 6849.2 6712.2 6718.5 6738.7 6827.4 6828.3 6586.3 6662.4 6670.9 6697.6 6780.2 5287.3 5293.9 5303.2 5303.5 5305.7 4623.0 4663.2 4698.1 4703.9 4705.3 5674.5 5759.6 5842.4 5858.5 5866.6 6824.2 6842.1 6909.2 6920.1 6924.1 5767.2 5793.9 5835.4 5840.7 5847.1 5747.6 5775.8 5859.3 5894.5 5895.0 6599.0 6611.9 6645.8 6648.2 6656.7 6840.7 6848.1 6930.4 6933.5 6958.6 6365.1 6485.2 6499.2 6530.2 6660.3 6686.1 6727.1 6735.0 6735.0 6765.2 6780.2 6829.6 6882.2 6883.7 6893.4 6524.8 6577.2 6578.7 6647.6 6654.7 6392.7 6513.4 6559.1 6642.2 6647.1 6479.2 6546.8 6555.2 6565.7 6566.1 6596.1 6703.7 6753.2 6756.6 6778.2 6255.2 6360.7 6405.8 6411.9 6506.5 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#1] ext.html Cycles:180 Average:37483.32 Median:3548.02 stddev:52530.51 (1480.6%) stddev-sans-first:52605.58 17:41:58 INFO - PID 18708 | Values: 781.4 802.0 802.3 804.0 804.4 39682.2 43389.6 43523.3 43589.3 43599.1 39396.8 39426.6 39550.2 39643.4 39714.6 7027.2 7150.4 7155.4 7195.6 7210.7 7144.1 7181.0 7187.6 7209.1 7227.6 7149.5 7172.3 7177.3 7192.5 7323.0 7950.2 7950.9 8015.2 8037.0 8066.4 7869.1 7873.1 7942.2 7967.0 7968.6 37227.8 39134.0 39412.6 39488.8 39501.2 3506.0 3547.5 3548.5 3549.2 3550.0 32510.3 32913.3 32960.5 33140.7 33155.5 5220.3 5253.1 5287.6 5290.2 5301.9 187982.0 188754.0 189906.0 190468.0 190470.0 42948.0 43786.3 49375.0 49428.5 49536.3 52311.2 53350.1 53523.0 53552.7 53825.0 16226.9 16335.6 16335.8 16349.2 16394.7 13344.7 13376.9 13397.1 13402.4 13409.9 14287.1 14366.4 14489.6 14641.7 14739.9 5749.6 5884.6 5915.6 5931.3 5961.3 1007.7 1021.6 1022.8 1024.3 1024.5 23041.3 23166.8 23232.2 23315.4 23496.4 1079.4 1128.4 1134.8 1139.6 1141.9 12250.8 12258.5 12282.2 12444.6 12479.0 227265.0 228250.0 228671.0 228730.0 229337.0 54272.4 54436.0 54452.5 54468.5 54577.5 1443.1 1499.4 1506.8 1508.7 1512.9 22556.7 22924.4 22999.2 23137.7 23289.0 38055.4 38163.6 38178.0 38180.2 38185.0 187277.0 187312.0 187464.0 188148.0 188653.1 31884.5 32221.0 34597.7 35237.3 36099.8 44550.3 44683.6 45053.0 45203.8 45616.0 32563.0 32922.8 33120.7 33246.0 33528.8 32006.8 32079.4 32179.8 32386.2 32870.7 36614.6 36930.3 37035.6 37101.6 37299.8 31915.1 32052.4 32119.2 32198.0 32932.2 22903.4 23490.9 23538.3 23703.4 23857.9 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#2] jquery.html Cycles:180 Average:33676.98 Median:21968.62 stddev:80959.33 (368.5%) stddev-sans-first:81148.33 17:41:58 INFO - PID 18708 | Values: 592.6 599.8 602.6 606.8 607.4 21517.6 22108.7 22178.2 22259.9 22299.3 21910.9 23686.3 23914.8 23933.3 23965.9 6383.6 6535.7 6564.9 6578.3 6587.4 6217.7 6355.2 6461.9 6531.1 6545.7 6440.6 6441.2 6503.7 6513.8 6517.5 6302.3 6400.5 6417.9 6429.5 6436.5 6062.2 6134.6 6135.0 6139.7 6141.0 27980.7 28398.7 28457.9 28510.6 28545.9 2051.2 2051.5 2061.1 2072.4 2073.1 18540.3 19038.6 19431.6 19502.2 19686.1 2370.1 2399.6 2424.2 2427.4 2447.8 114406.0 119924.0 120230.0 129623.0 134433.0 14564.9 14590.5 14673.6 14674.1 14917.9 22654.0 22724.8 22731.3 22755.5 22880.9 10146.8 10186.5 10190.5 10257.9 10338.3 9356.2 9463.8 9495.1 9604.2 9677.9 8836.8 8902.3 8907.2 8989.5 9261.5 2582.6 2618.3 2697.9 2739.9 2749.4 916.8 945.5 958.2 961.9 992.8 18396.4 18406.9 18710.2 18923.4 18992.6 1011.4 1027.8 1028.5 1041.4 1042.7 10359.7 10367.7 10396.2 10537.2 10599.0 475204.0 480622.0 480703.0 482397.0 496526.0 105123.0 110128.0 111750.4 111907.4 111940.0 1141.3 1143.9 1182.1 1184.0 1188.4 16899.2 16950.2 16994.7 17249.8 17312.1 55791.0 56083.0 56580.0 57410.7 57540.7 70242.3 71106.3 71315.3 71548.0 71620.6 13922.3 14207.4 14311.4 14323.2 14381.2 21345.6 21815.9 21903.8 21960.7 21976.6 17279.2 17285.8 17287.3 17692.8 17710.5 15536.6 16024.8 16361.3 16420.5 16580.3 17628.5 17745.6 17906.9 17985.6 17998.5 14169.0 14250.8 14277.5 14288.4 14351.2 16912.0 17002.3 17404.8 17685.2 17703.7 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#3] mootools.html Cycles:180 Average:9584.75 Median:2511.40 stddev:6918.05 (275.5%) stddev-sans-first:6909.73 17:41:58 INFO - PID 18708 | Values: 1341.1 1400.1 1405.6 1414.3 1417.0 15000.3 15750.0 15856.3 15884.6 15902.9 15241.6 15540.5 15570.1 15577.1 15577.9 2655.1 2701.2 2710.2 2727.4 2730.3 2701.9 2720.9 2723.4 2726.9 2728.8 2490.3 2736.0 2801.9 2802.5 2805.4 2532.5 2564.2 2581.9 2583.1 2588.2 2386.9 2431.3 2459.7 2470.5 2475.6 15176.8 15178.5 15279.7 15324.4 15327.8 7968.3 8238.1 8243.7 8263.9 8289.9 5341.6 5577.9 5723.2 5726.7 5745.7 1965.6 2007.6 2015.3 2054.8 2055.9 27425.7 27662.0 27662.2 27667.2 27671.7 6720.2 6875.7 6885.5 6996.6 7018.8 18032.2 18034.8 18068.1 18086.0 18106.1 7905.8 7998.2 8034.7 8044.7 8070.2 7199.1 7236.5 7371.1 7406.4 7420.4 5135.6 5275.0 5294.7 5315.1 5356.3 1469.2 1470.0 1482.8 1498.6 1499.2 894.3 914.8 923.2 925.0 926.8 7829.7 8829.7 8994.8 9079.5 9099.7 701.7 736.1 740.3 752.0 759.1 4839.3 5195.0 5410.2 5514.9 5690.7 20608.9 22313.8 22824.8 22849.8 22956.1 21579.9 21764.1 22080.7 22228.4 22294.6 11217.3 11601.8 11787.4 11806.5 11843.1 8685.3 8736.4 8752.3 8786.2 8832.4 18783.5 18787.3 19354.9 19413.0 19815.1 19303.8 19358.6 19935.4 20020.0 20177.7 11476.7 11679.4 11718.8 11732.1 11746.6 13962.2 13970.2 14156.6 14174.3 14273.1 11202.8 11227.7 11248.6 11371.2 11517.7 10894.0 11177.8 11308.3 11502.4 11687.6 10115.6 10162.1 10170.8 10273.4 10275.2 7625.2 7704.2 7715.5 7744.5 7830.3 7576.2 7762.8 7780.2 7782.3 7835.7 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#4] prototype.html Cycles:180 Average:5576.58 Median:6250.67 stddev:1552.26 (24.8%) stddev-sans-first:1509.53 17:41:58 INFO - PID 18708 | Values: 521.4 523.3 541.0 542.6 545.6 6247.4 6264.3 6291.7 6358.2 6418.6 6240.6 6272.6 6274.3 6323.9 6325.0 5217.6 5234.5 5246.6 5257.4 5261.3 4863.4 5019.2 5122.5 5248.8 5276.6 5023.5 5026.9 5037.9 5096.9 5098.9 5006.5 5036.0 5041.2 5055.4 5066.9 4445.3 4499.8 4539.5 4545.5 4568.8 6195.5 6199.6 6206.3 6231.7 6254.0 5675.6 5715.2 5782.3 5797.5 5801.6 6582.8 6585.7 6658.2 6729.6 6741.6 4946.0 4990.5 4994.2 5011.7 5022.3 6621.3 6777.5 6852.1 6998.8 7029.7 5029.7 5057.2 5062.6 5073.4 5085.8 5130.7 5141.6 5143.9 5144.8 5180.9 5774.9 5775.2 5777.0 5819.6 5827.3 6729.7 6754.9 6767.2 6796.0 6802.8 1778.7 1780.6 1784.6 1785.7 1793.7 1152.2 1212.3 1231.9 1238.3 1239.7 5744.7 5776.4 5784.7 5834.2 5866.4 6767.2 6785.9 6879.2 6881.9 6895.3 5745.8 5760.0 5781.6 5795.4 5812.9 3562.0 3595.9 3626.4 3633.5 3639.1 6529.4 6531.9 6534.5 6554.8 6568.7 6542.0 6781.2 6983.2 7048.6 7087.0 6375.6 6404.2 6466.9 6542.8 6586.7 6656.9 6732.9 6743.5 6803.9 6829.5 6669.7 6802.6 6803.4 6831.8 6867.9 6495.0 6570.4 6586.5 6593.5 6623.4 5096.5 5097.5 5098.2 5103.7 5125.5 6474.9 6669.4 6721.4 6754.2 6846.2 6393.4 6460.9 6470.0 6556.9 6593.5 6549.5 6559.8 6574.8 6579.6 6646.2 6359.8 6389.8 6440.3 6445.7 6463.9 6571.8 6578.9 6589.7 6590.3 6684.4 6369.0 6417.8 6425.3 6447.3 6519.3 17:41:58 INFO - PID 18708 | 17:41:58 INFO - PID 18708 | [#5] yui.html Cycles:180 Average:25293.74 Median:21693.28 stddev:35452.29 (163.4%) stddev-sans-first:35504.37 17:41:58 INFO - PID 18708 | Values: 887.4 907.4 929.0 933.0 940.2 19386.5 20324.0 20400.1 20405.0 20428.2 17914.4 18018.9 18101.7 18961.7 19283.2 947.9 948.5 950.0 950.5 971.3 942.9 944.3 970.9 990.5 1007.7 1060.5 1064.4 1064.5 1064.8 1065.1 983.2 1050.1 1057.8 1058.1 1058.1 743.7 748.8 749.1 749.5 749.6 18528.4 18609.6 18616.2 18619.3 18628.3 21645.7 21927.6 22097.4 22410.3 22423.7 17637.6 17863.7 18019.3 18030.5 18238.1 3692.3 3737.9 3749.9 3775.3 3777.7 142752.0 142986.3 143955.0 144347.0 146198.3 16995.8 17297.3 17341.7 17392.1 17396.8 30887.5 32364.2 32598.7 32686.5 32726.3 8930.0 8985.3 9036.0 9093.5 9127.2 4514.9 4637.5 4638.5 4649.0 4649.1 5586.3 5665.9 5678.9 5702.5 5703.9 931.3 967.0 987.0 988.8 998.5 686.3 709.4 717.7 718.2 721.6 11583.9 11825.8 12056.6 12740.4 13162.3 676.3 702.2 713.3 714.7 720.5 5669.7 5768.9 5821.1 5864.1 5905.3 122060.0 125008.0 125364.4 126387.4 126819.4 83387.6 85848.0 107553.5 109495.0 110155.4 85835.0 86939.1 89545.0 90277.0 92346.0 12249.3 12607.4 12678.4 12736.3 12762.0 41619.2 42164.4 42342.2 43734.8 44245.3 74828.8 76147.2 76492.0 76850.2 77087.0 18670.3 18720.3 19101.8 19114.5 19182.2 21047.7 21519.9 21740.9 22086.8 22154.8 18604.9 19014.9 19093.2 19672.3 19878.8 16396.3 17857.3 18187.1 18369.7 18502.8 18504.6 18624.4 18635.7 19024.7 19165.0 13397.6 13437.0 13467.7 13576.7 14000.6 14647.9 15194.2 15259.0 15287.5 15552.1 17:41:58 INFO - PID 18708 | -------- Summary: end -------- 17:41:58 INFO - PID 18708 | 17:41:58 INFO - TEST-INFO | 18708: exit 0 17:41:58 INFO - TEST-OK | dromaeo_css | took 1109727ms 17:41:58 INFO - TEST-START | kraken 17:41:58 INFO - Initialising browser for kraken test... 17:41:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55303/getInfo.html -profile /tmp/tmpL3G_e2/profile 17:41:58 INFO - TEST-INFO | started process 19079 (/builds/slave/test/build/application/firefox/firefox http://localhost:55303/getInfo.html) 17:42:04 INFO - TEST-INFO | 19079: exit 0 17:42:04 INFO - Browser initialized. 17:42:04 INFO - Running cycle 1/1 for kraken test... 17:42:04 INFO - Using env: {'DISPLAY': ':0', 17:42:04 INFO - 'HOME': '/home/cltbld', 17:42:04 INFO - 'JSGC_DISABLE_POISONING': '1', 17:42:04 INFO - 'LANG': 'en_US.UTF-8', 17:42:04 INFO - 'LANGUAGE': 'en_US:en', 17:42:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:42:04 INFO - 'LOGNAME': 'cltbld', 17:42:04 INFO - 'MAIL': '/var/mail/cltbld', 17:42:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:42:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:42:04 INFO - 'MOZ_CRASHREPORTER': '1', 17:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:42:04 INFO - 'MOZ_NO_REMOTE': '1', 17:42:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:04 INFO - 'NO_EM_RESTART': '1', 17:42:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:04 INFO - 'PWD': '/builds/slave/test', 17:42:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:42:04 INFO - 'RUST_BACKTRACE': 'full', 17:42:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:42:04 INFO - 'SHELL': '/bin/bash', 17:42:04 INFO - 'SHLVL': '1', 17:42:04 INFO - 'TERM': 'linux', 17:42:04 INFO - 'TMOUT': '86400', 17:42:04 INFO - 'USER': 'cltbld', 17:42:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531', 17:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:04 INFO - '_': '/tools/buildbot/bin/python'} 17:42:04 INFO - TEST-INFO | started process 19314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL3G_e2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:42:05 INFO - PID 19314 | 17:42:05 INFO - PID 19314 | (/builds/slave/test/build/application/firefox/firefox:19363): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:42:05 INFO - PID 19314 | 17:42:15 INFO - PID 19314 | RSS: Main: 153108480 17:42:15 INFO - PID 19314 | 17:42:18 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55303/tests/kraken/driver.html?testName=audio-beat-detection) 17:42:19 INFO - PID 19314 | RSS: Main: 160555008 17:42:19 INFO - PID 19314 | 17:42:21 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55303/tests/kraken/driver.html?testName=audio-dft) 17:42:22 INFO - PID 19314 | RSS: Main: 160231424 17:42:22 INFO - PID 19314 | 17:42:25 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55303/tests/kraken/driver.html?testName=audio-fft) 17:42:25 INFO - PID 19314 | RSS: Main: 156004352 17:42:25 INFO - PID 19314 | 17:42:28 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55303/tests/kraken/driver.html?testName=audio-oscillator) 17:42:28 INFO - PID 19314 | RSS: Main: 156876800 17:42:28 INFO - PID 19314 | 17:42:30 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:31 INFO - PID 19314 | RSS: Main: 157069312 17:42:31 INFO - PID 19314 | 17:42:34 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55303/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:35 INFO - PID 19314 | RSS: Main: 159629312 17:42:35 INFO - PID 19314 | 17:42:38 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55303/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:39 INFO - PID 19314 | RSS: Main: 159965184 17:42:39 INFO - PID 19314 | 17:42:42 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55303/tests/kraken/driver.html?testName=json-parse-financial) 17:42:43 INFO - PID 19314 | RSS: Main: 159965184 17:42:43 INFO - PID 19314 | 17:42:44 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:45 INFO - PID 19314 | RSS: Main: 159928320 17:42:45 INFO - PID 19314 | 17:42:46 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:47 INFO - PID 19314 | RSS: Main: 159850496 17:42:47 INFO - PID 19314 | 17:42:49 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:50 INFO - PID 19314 | RSS: Main: 156815360 17:42:50 INFO - PID 19314 | 17:42:52 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:53 INFO - PID 19314 | RSS: Main: 156884992 17:42:53 INFO - PID 19314 | 17:42:56 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:57 INFO - PID 19314 | RSS: Main: 157057024 17:42:57 INFO - PID 19314 | 17:42:58 INFO - PID 19314 | Cycle 1(1): loaded http://localhost:55303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55303/tests/kraken/driver.html?testName=ai-astar) 17:42:59 INFO - PID 19314 | RSS: Main: 158470144 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | __start_tp_report 17:42:59 INFO - PID 19314 | _x_x_mozilla_page_load 17:42:59 INFO - PID 19314 | _x_x_mozilla_page_load_details 17:42:59 INFO - PID 19314 | |i|pagename|runs| 17:42:59 INFO - PID 19314 | |0;ai-astar;107;107;107;106;111;107;108;107;107;108 17:42:59 INFO - PID 19314 | |1;audio-beat-detection;117;119;118;117;118;117;117;116;121;116 17:42:59 INFO - PID 19314 | |2;audio-dft;164;162;163;161;162;164;162;165;172;165 17:42:59 INFO - PID 19314 | |3;audio-fft;78;78;76;74;73;74;76;79;72;75 17:42:59 INFO - PID 19314 | |4;audio-oscillator;80;79;79;79;80;79;80;81;81;79 17:42:59 INFO - PID 19314 | |5;imaging-gaussian-blur;117;113;113;115;115;114;114;114;114;114 17:42:59 INFO - PID 19314 | |6;imaging-darkroom;149;148;148;147;147;150;150;151;151;149 17:42:59 INFO - PID 19314 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;96;95 17:42:59 INFO - PID 19314 | |8;json-parse-financial;53;54;54;52;56;53;54;53;54;54 17:42:59 INFO - PID 19314 | |9;json-stringify-tinderbox;38;38;38;38;37;38;38;37;37;38 17:42:59 INFO - PID 19314 | |10;stanford-crypto-aes;82;77;76;74;80;73;77;77;76;83 17:42:59 INFO - PID 19314 | |11;stanford-crypto-ccm;112;112;115;115;116;112;112;117;114;115 17:42:59 INFO - PID 19314 | |12;stanford-crypto-pbkdf2;169;170;176;169;169;167;179;174;173;173 17:42:59 INFO - PID 19314 | |13;stanford-crypto-sha256-iterative;70;70;66;70;69;68;68;66;65;68 17:42:59 INFO - PID 19314 | __end_tp_report 17:42:59 INFO - PID 19314 | __start_cc_report 17:42:59 INFO - PID 19314 | _x_x_mozilla_cycle_collect,750 17:42:59 INFO - PID 19314 | __end_cc_report 17:42:59 INFO - PID 19314 | __startTimestamp1506386579163__endTimestamp 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | ------- Summary: start ------- 17:42:59 INFO - PID 19314 | Number of tests: 14 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#0] ai-astar Cycles:10 Average:107.50 Median:107.00 stddev:1.35 (1.3%) stddev-sans-first:1.42 17:42:59 INFO - PID 19314 | Values: 107.0 107.0 107.0 106.0 111.0 107.0 108.0 107.0 107.0 108.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:117.50 stddev:1.51 (1.3%) stddev-sans-first:1.58 17:42:59 INFO - PID 19314 | Values: 117.0 119.0 118.0 117.0 118.0 117.0 117.0 116.0 121.0 116.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:3.13 (1.9%) stddev-sans-first:3.32 17:42:59 INFO - PID 19314 | Values: 164.0 162.0 163.0 161.0 162.0 164.0 162.0 165.0 172.0 165.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#3] audio-fft Cycles:10 Average:75.50 Median:76.00 stddev:2.32 (3.1%) stddev-sans-first:2.28 17:42:59 INFO - PID 19314 | Values: 78.0 78.0 76.0 74.0 73.0 74.0 76.0 79.0 72.0 75.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 17:42:59 INFO - PID 19314 | Values: 80.0 79.0 79.0 79.0 80.0 79.0 80.0 81.0 81.0 79.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:0.71 17:42:59 INFO - PID 19314 | Values: 117.0 113.0 113.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.50 stddev:1.49 (1.0%) stddev-sans-first:1.58 17:42:59 INFO - PID 19314 | Values: 149.0 148.0 148.0 147.0 147.0 150.0 150.0 151.0 151.0 149.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 17:42:59 INFO - PID 19314 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 96.0 95.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 17:42:59 INFO - PID 19314 | Values: 53.0 54.0 54.0 52.0 56.0 53.0 54.0 53.0 54.0 54.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 17:42:59 INFO - PID 19314 | Values: 38.0 38.0 38.0 38.0 37.0 38.0 38.0 37.0 37.0 38.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:3.24 (4.2%) stddev-sans-first:3.00 17:42:59 INFO - PID 19314 | Values: 82.0 77.0 76.0 74.0 80.0 73.0 77.0 77.0 76.0 83.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:115.00 stddev:1.89 (1.6%) stddev-sans-first:1.86 17:42:59 INFO - PID 19314 | Values: 112.0 112.0 115.0 115.0 116.0 112.0 112.0 117.0 114.0 115.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.00 stddev:3.75 (2.2%) stddev-sans-first:3.83 17:42:59 INFO - PID 19314 | Values: 169.0 170.0 176.0 169.0 169.0 167.0 179.0 174.0 173.0 173.0 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.83 (2.7%) stddev-sans-first:1.79 17:42:59 INFO - PID 19314 | Values: 70.0 70.0 66.0 70.0 69.0 68.0 68.0 66.0 65.0 68.0 17:42:59 INFO - PID 19314 | -------- Summary: end -------- 17:42:59 INFO - PID 19314 | 17:42:59 INFO - PID 19314 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:42:59 INFO - TEST-INFO | 19314: exit 0 17:42:59 INFO - TEST-OK | kraken | took 60942ms 17:42:59 INFO - SUITE-END | took 1170s 17:43:00 INFO - Completed test suite (00:19:31) 17:43:00 INFO - javascript benchmark 17:43:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8597.635709197852, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.245621050947, 3171.6035495563056, 3173.7302329302006, 3175.3490534440443, 3179.936401271975, 6150.354212807658, 6327.177466929298, 6395.6802159891995, 6411.294757576663, 6477.449416799566, 6241.687915604224, 6273.498120150389, 6292.402221788922, 6418.903716444257, 6421.967890160543, 5813.244278243833, 5855.912161317584, 5866.560007999396, 5891.086881533369, 5907.852303692421, 1214.5249446705297, 5736.024875771108, 5859.853503662422, 5888.322842873082, 5899.410058994109, 5740.7703691852275, 5771.22088518051, 5793.449622285876, 5824.592278540504, 5852.297724273072, 5781.797637082724, 5802.274715660543, 5816.302043754734, 5860.09168578871, 5879.794207202727, 5771.422857714237, 5783.942160578383, 5821.09772985188, 5851.888141253148, 5872.29532456108, 6228.252609686821, 6276.932921403372, 6280.106513478728, 6326.873462530723, 6339.778107766206, 6524.314946930552, 6639.236487803868, 6686.899696504556, 6732.663366831639, 6772.18733751948, 6725.93274067258, 6792.422644075259, 6800.795976120724, 6843.144606924135, 6860.485463590251, 6293.276273228637, 6297.244330680348, 6368.331325210879, 6370.458511026568, 6376.744930202786, 6969.721211151497, 6995.825104372431, 7069.151701795715, 7071.257517960643, 7081.291870812981, 6516.869662606816, 6618.834529136714, 6618.900716489256, 6705.731770729214, 6727.629980351127, 6829.248782633907, 6829.282925292872, 6847.246802851682, 6848.041274221613, 6849.212340580797, 6712.194536655633, 6718.49611279156, 6738.7304507819135, 6827.419669328163, 6828.283030281848, 6586.341365863375, 6662.367075127952, 6670.866582668319, 6697.598144111369, 6780.1524809398825, 5287.339082614673, 5293.867653308621, 5303.231031500411, 5303.496167864047, 5305.708186049727, 4622.95377046232, 4663.183942809995, 4698.107359601665, 4703.905921881543, 4705.341252224691, 5674.460926212003, 5759.625624334405, 5842.415758424208, 5858.53131749459, 5866.560007999417, 6824.18109826824, 6842.144731908512, 6909.205441374306, 6920.134983127109, 6924.099867017256, 5767.22142510764, 5793.855153621109, 5835.387284335168, 5840.737166827503, 5847.093700476433, 5747.568932330092, 5775.826725198251, 5859.267591551056, 5894.498967587803, 5894.970525147347, 6599.0, 6611.900821487681, 6645.767398141042, 6648.235452922879, 6656.73373065072, 6840.726370945106, 6848.1097457330225, 6930.3762661360715, 6933.479989000845, 6958.582485050913, 6365.077063825626, 6485.189351331083, 6499.2200935887995, 6530.183727034121, 6660.2673705893285, 6686.06395104676, 6727.058211850247, 6734.966325168343, 6735.0, 6765.221999470124, 6780.186377634715, 6829.556078854858, 6882.208546017272, 6883.724651014104, 6893.379595836399, 6524.804255872332, 6577.2107347116735, 6578.7368505261165, 6647.634380108947, 6654.700538475683, 6392.744290228339, 6513.381228783258, 6559.147310849559, 6642.169728783902, 6647.135872336758, 6479.1901012373455, 6546.770863019771, 6555.2133743951035, 6565.704543295467, 6566.146400967844, 6596.142501474969, 6703.66481675924, 6753.1896172457655, 6756.560823546453, 6778.152730908637, 6255.24937007562, 6360.650164241011, 6405.807825765234, 6411.903821442589, 6506.479481641552], "value": 6146.548494407357, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.3827076609479, 801.9558924259167, 802.3460879383302, 803.9517628942264, 804.4248362420868, 39682.2063558729, 43389.56610433895, 43523.347149792775, 43589.34615980755, 43599.12801743963, 39396.80301598488, 39426.605733942655, 39550.20899582014, 39643.40534891979, 39714.60285397145, 7027.191872934614, 7150.39221666159, 7155.391791697686, 7195.568265904037, 7210.711571537132, 7144.0712707347975, 7180.964095179516, 7187.568745875238, 7209.0988626421695, 7227.6386180691015, 7149.49953503255, 7172.282771722838, 7177.282271772833, 7192.5324853884595, 7323.048003759503, 7950.24472675095, 7950.920490795076, 8015.158408367125, 8037.035555733291, 8066.4353495255355, 7869.055713314439, 7873.133955264916, 7942.245486678814, 7967.0, 7968.641411136513, 37227.81386093079, 39134.0, 39412.60587394118, 39488.81533553998, 39501.209975800324, 3506.0358401439553, 3547.52108465359, 3548.520949671787, 3549.165946002687, 3550.0059983204487, 32510.349793004007, 32913.34173316544, 32960.505592416135, 33140.668593313996, 33155.50266746001, 5220.321358223407, 5253.080710875582, 5287.550558202557, 5290.153575427913, 5301.867453313659, 187982.0, 188754.0, 189906.0, 190468.0, 190470.04764976224, 42948.0, 43786.34320485195, 49375.0, 49428.50571494311, 49536.27550484758, 52311.21533177005, 53350.06574638432, 53523.0, 53552.73223633857, 53825.0, 16226.918865405598, 16335.59161020984, 16335.754963675317, 16349.182540873147, 16394.672106557802, 13344.666383340495, 13376.933115334361, 13397.12918660284, 13402.396892139683, 13409.865901341056, 14287.142771433748, 14366.35351409189, 14489.637759056108, 14641.707165856624, 14739.926300368645, 5749.597528173072, 5884.588078834526, 5915.615484993462, 5931.347551769302, 5961.2846458425265, 1007.7077647482148, 1021.6271061062807, 1022.754538910656, 1024.293237666008, 1024.4928760263717, 23041.308760737204, 23166.7683323168, 23232.186873459348, 23315.417114571934, 23496.412589685053, 1079.4386918802336, 1128.368113856243, 1134.7787181499527, 1139.6239241050434, 1141.931484110956, 12250.754984900252, 12258.509659613694, 12282.201656892274, 12444.626661200178, 12479.001679865589, 227265.0, 228250.0, 228671.0, 228730.0, 229337.0, 54272.3718288452, 54436.0, 54452.45547544553, 54468.45531544713, 54577.45422545803, 1443.0908527627528, 1499.4302165177162, 1506.8342482326934, 1508.7435136026681, 1512.9319180636678, 22556.66165007559, 22924.4268893279, 22999.195028173934, 23137.652935206323, 23289.0, 38055.42916856194, 38163.61836381712, 38178.0, 38180.236395271386, 38185.0, 187277.0, 187312.0, 187464.0, 188148.0, 188653.05673471544, 31884.5217321745, 32221.0, 34597.65402345944, 35237.29525409529, 36099.819500902326, 44550.3317450232, 44683.55316446924, 45053.0, 45203.77398112988, 45616.0, 32563.0, 32922.83538582292, 33120.66879331176, 33246.00261992144, 33528.832355838065, 32006.839965800023, 32079.35841283208, 32179.839100804347, 32386.190345241557, 32870.67129328676, 36614.63385366112, 36930.26139477142, 37035.62964370322, 37101.6289837109, 37299.81350093232, 31915.084377677053, 32052.35895282128, 32119.197020074684, 32198.0, 32932.1766955828, 22903.427414314774, 23490.882545587847, 23538.29385118449, 23703.407414814767, 23857.880710596335], "value": 17217.026825746558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6029560194669, 599.8380437281932, 602.6354055796243, 606.8452544601126, 607.3744043635056, 21517.56964860702, 22108.668369974464, 22178.223762168327, 22259.888700556494, 22299.331020069385, 21910.89044554779, 23686.289411317688, 23914.76085239147, 23933.282001539937, 23965.880170599165, 6383.5531512794005, 6535.673216339188, 6564.901526477107, 6578.309277525863, 6587.374199451068, 6217.658028808413, 6355.173827402431, 6461.93538064618, 6531.052997315386, 6545.738170473175, 6440.645764482952, 6441.162648855642, 6503.674816259192, 6513.837154071139, 6517.478601711875, 6302.275238347603, 6400.51996100292, 6417.903731444032, 6429.485641148697, 6436.549441539094, 6062.211912451397, 6134.601250918676, 6135.049067394561, 6139.662318572477, 6140.95603747364, 27980.720192798017, 28398.716012839814, 28457.857710711312, 28510.57234141469, 28545.857270713514, 2051.189780036892, 2051.548659294953, 2061.1034200122995, 2072.3782865140547, 2073.067119796083, 18540.258389664396, 19038.61922761537, 19431.611367772566, 19502.219911203534, 19686.11412486427, 2370.146747171017, 2399.640053991915, 2424.2242482405636, 2427.417419819231, 2447.8286519943613, 114406.0, 119924.0, 120230.0, 129623.0, 134433.0, 14564.927175364055, 14590.489332873298, 14673.584651262598, 14674.143725312922, 14917.927904512519, 22654.0, 22724.772752272595, 22731.318060458212, 22755.520891142023, 22880.88559557225, 10146.797064058677, 10186.490675466197, 10190.490475476197, 10257.94871025655, 10338.276320657482, 9356.204722598655, 9463.810723785486, 9495.05049495045, 9604.183644390305, 9677.9032209677, 8836.779080523038, 8902.287816974627, 8907.153820387053, 8989.505577193317, 9261.49061801594, 2582.625519299691, 2618.3454136465884, 2697.878595463209, 2739.876705548255, 2749.4363655450984, 916.812053529025, 945.4516380499294, 958.2341398304729, 961.8701475300885, 992.8212921674168, 18396.356127535473, 18406.907965460086, 18710.158042888103, 18923.43229703111, 18992.620147596972, 1011.4487604255698, 1027.814993301213, 1028.4857571214393, 1041.4272150317295, 1042.6507120114848, 10359.741006474747, 10367.727524847358, 10396.220283478619, 10537.209709271836, 10598.9930956559, 475204.0, 480622.0, 480703.0, 482397.0, 496526.0, 105123.0, 110128.0, 111750.44124779323, 111907.44046279717, 111940.0, 1141.2752901907184, 1143.9485223164977, 1182.1252273317682, 1184.0049516564616, 1188.3879801902028, 16899.239534221237, 16950.237239324015, 16994.660106797546, 17249.827501725325, 17312.134393280034, 55791.0, 56083.0, 56580.0, 57410.712946435, 57540.71229643825, 70242.29757702358, 71106.28893710997, 71315.28684713086, 71548.0, 71620.64189679018, 13922.303884805922, 14207.431702731776, 14311.35598898073, 14323.212223327817, 14381.209033503257, 21345.573088538455, 21815.890920545295, 21903.780962190813, 21960.682359058508, 21976.560468790856, 17279.222434990203, 17285.827141728925, 17287.308507659553, 17692.82307176963, 17710.468685939442, 15536.61158471002, 16024.839751602334, 16361.263743131349, 16420.507384778477, 16580.253888574804, 17628.471145865133, 17745.55636109056, 17906.91046544759, 17985.640287194445, 17998.460046198634, 14169.0, 14250.786238206229, 14277.500287489887, 14288.42846286137, 14351.210683412513, 16912.0, 17002.31990720407, 17404.82595174032, 17685.204165812826, 17703.73444398361], "value": 11693.762309543152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.1483707845516, 1400.0829456705856, 1405.6345350208946, 1414.2645824171432, 1416.9726947962722, 15000.324985375657, 15750.0, 15856.28646710898, 15884.602884927883, 15902.920485397557, 15241.618959526017, 15540.456084037061, 15570.14364209968, 15577.065376077444, 15577.92211038946, 2655.0972669292437, 2701.2166471723176, 2710.241132482908, 2727.4272402795436, 2730.344717267851, 2701.8513981731, 2720.945581088377, 2723.360010397555, 2726.945461090777, 2728.8499132547704, 2490.3276115448907, 2735.9726402736014, 2801.929951751202, 2802.453521563296, 2805.368792021789, 2532.480841427503, 2564.1538292363475, 2581.9483610327875, 2583.147561304774, 2588.2105957682897, 2386.8925898334614, 2431.2827715823873, 2459.7417271186446, 2470.505898820225, 2475.616279476666, 15176.848231517653, 15178.468753593681, 15279.694406111927, 15324.387024519006, 15327.770083448757, 7968.282854543119, 8238.134995825412, 8243.670253189865, 8263.917360826435, 8289.917100828974, 5341.599380046512, 5577.8605534861545, 5723.17014032967, 5726.742296596663, 5745.683987380692, 1965.5872266823985, 2007.5884443689008, 2015.3248661698349, 2054.815066644009, 2055.897205139752, 27425.725742742517, 27662.0, 27662.170134895783, 27667.169984900484, 27671.723282767114, 6720.22717387497, 6875.656217189121, 6885.518013739091, 6996.580205187705, 7018.75434359795, 18032.188551515213, 18034.819651803577, 18068.096595170187, 18086.0, 18106.094695265183, 7905.802354941173, 7998.240167184108, 8034.67861285542, 8044.718434854752, 8070.1526339734655, 7199.1001124859395, 7236.4803391288415, 7371.115466144097, 7406.407487400995, 7420.406367490696, 5135.563477104488, 5274.97362513185, 5294.708791016531, 5315.069862773999, 5356.330458692663, 1469.169918995764, 1469.9559013229407, 1482.762757958743, 1498.5579254120062, 1499.2054211268046, 894.3069121430813, 914.7850255190025, 923.1691477670016, 924.9630014799467, 926.8285367207088, 7829.686812527549, 8829.735107946772, 8994.820103597891, 9079.50062746542, 9099.68151114721, 701.740356068258, 736.1129838544648, 740.315208432198, 751.9962400187964, 759.1383779410298, 4839.274108883696, 5195.038917800219, 5410.242566040757, 5514.862128446741, 5690.658560486384, 20608.896955515127, 22313.776862231494, 22824.771752282595, 22849.771502284766, 22956.081756729876, 21579.892100539397, 21764.129434822746, 22080.668789968164, 22228.444288892908, 22294.55410891773, 11217.270877392943, 11601.82597261025, 11787.410629468492, 11806.52773889052, 11843.111766617538, 8685.305175585812, 8736.432131911406, 8752.256058234867, 8786.209241168326, 8832.425892316978, 18783.530411739815, 18787.34244301443, 19354.903225483784, 19413.0, 19815.108320125917, 19303.8069619302, 19358.612827743647, 19935.401937941886, 20020.0, 20177.697334539702, 11476.713082172679, 11679.357635330138, 11718.824217636571, 11732.12009099304, 11746.647600571996, 13962.232077235849, 13970.231637260049, 14156.646083847987, 14174.291285435893, 14273.072250303698, 11202.775944480902, 11227.66317010491, 11248.550057997589, 11371.20401571882, 11517.712057198638, 10894.0, 11177.776444470903, 11308.264962777394, 11502.424878756196, 11687.590934317259, 10115.645952391631, 10162.085412312927, 10170.79658406813, 10273.383596984206, 10275.229357798045, 7625.199354067965, 7704.152543220353, 7715.498492597963, 7744.535327880345, 7830.33442157423, 7576.166621671722, 7762.844743105219, 7780.183080776437, 7782.26068523512, 7835.725749598737], "value": 6757.711528791452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.3691433365627, 523.272651015089, 541.0, 542.6038991536178, 545.6453305351521, 6247.375262473756, 6264.310925798164, 6291.678747463038, 6358.205224346957, 6418.5507014509, 6240.563160578761, 6272.59228150171, 6274.3098259191565, 6323.873522529547, 6324.968375158118, 5217.634765566412, 5234.476552344773, 5246.606504512168, 5257.395399529046, 5261.316028916235, 4863.440704318996, 5019.222020586815, 5122.462141475147, 5248.790048398059, 5276.577873770108, 5023.467842308095, 5026.924596131061, 5037.874053148664, 5096.923546146811, 5098.949010509903, 5006.498050584846, 5035.974820125876, 5041.1682072458, 5055.39335279767, 5066.898662026757, 4445.266531022377, 4499.797509112098, 4539.455265368177, 4545.477270113913, 4568.794404251817, 6195.499542758327, 6199.566030377875, 6206.25524937006, 6231.6572588507615, 6253.968730156365, 5675.5743319250805, 5715.199872017921, 5782.335031471351, 5797.507211886995, 5801.593888427812, 6582.80251592453, 6585.703643336062, 6658.234303055162, 6729.629870357128, 6741.561798483083, 4945.975270123662, 4990.525900039491, 4994.225894986283, 5011.674241174312, 5022.347094877679, 6621.271660117383, 6777.525573209878, 6852.143482064742, 6998.75504357345, 7029.718811247595, 5029.723365214875, 5057.241413787888, 5062.620303477254, 5073.391193056783, 5085.796568137307, 5130.692158470503, 5141.640085194001, 5143.871403214949, 5144.768485418165, 5180.922286165711, 5774.913376299359, 5775.191473193756, 5777.035807825276, 5819.592628515963, 5827.3007239131575, 6729.6971636276485, 6754.864902701918, 6767.221769496472, 6796.0, 6802.829929251809, 1778.728209330335, 1780.5904641932168, 1784.580623553464, 1785.749995000701, 1793.7219730941724, 1152.1877076660935, 1212.2605210821391, 1231.8644949055597, 1238.2694210415898, 1239.7148655809215, 5744.712764361849, 5776.393478684761, 5784.65292082468, 5834.212381328552, 5866.442687944638, 6767.1879374475375, 6785.896372124558, 6879.2432832388395, 6881.931180688229, 6895.310468953065, 5745.798897038583, 5759.971200144057, 5781.624194427349, 5795.449432303924, 5812.88374232513, 3561.9643803562153, 3595.9280814383565, 3626.419772836386, 3633.5458067741533, 3639.090227443139, 6529.400296927188, 6531.934680653133, 6534.477241820643, 6554.770583029571, 6568.704408301638, 6542.0, 6781.220159681699, 6983.1620205575655, 7048.647567621599, 7087.0432491614, 6375.649339286384, 6404.199475065617, 6466.870662586722, 6542.8364290893105, 6586.670666466657, 6656.900146497903, 6732.853247570494, 6743.460523158037, 6803.9319606805275, 6829.487788415988, 6669.7332106715185, 6802.6258555779905, 6803.387695107464, 6831.795046148623, 6867.862642747217, 6494.967525162344, 6570.375814297634, 6586.473082153512, 6593.538452308484, 6623.350659736144, 5096.502713670201, 5097.464766199644, 5098.2214692991665, 5103.668261562986, 5125.463430233127, 6474.870502590016, 6669.399754022162, 6721.353268449261, 6754.155730533684, 6846.246912839683, 6393.360663933569, 6460.935390646221, 6469.967650161719, 6556.934430655632, 6593.538452308292, 6549.508786840911, 6559.835254365952, 6574.80275591733, 6579.638119903259, 6646.169228846395, 6359.77740779089, 6389.7763578274535, 6440.2915679276175, 6445.711772320758, 6463.870722585616, 6571.835704107436, 6578.881590129785, 6589.703463344257, 6590.276493780998, 6684.364985326386, 6369.044643303541, 6417.807465776034, 6425.261094974137, 6447.323031081669, 6519.315471875574], "value": 5121.284243328168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.3566664168483, 907.3739120007194, 929.0338048429634, 933.0249888866134, 940.2290122099879, 19386.51533711656, 20324.0, 20400.081996310164, 20405.0, 20428.182872685076, 17914.37299694511, 18018.909905450488, 18101.7284740729, 18961.715574266396, 19283.22867085315, 947.8957314695378, 948.5257371314343, 949.9762505937338, 950.538988590533, 971.349196038654, 942.9057094290584, 944.3153713557684, 970.9271804614647, 990.4799980010516, 1007.6876168387823, 1060.4962642744674, 1064.3560645809291, 1064.5050051725946, 1064.7604289034982, 1065.0840277361463, 983.1790454970109, 1050.1074087026043, 1057.7937302226069, 1058.0530425269378, 1058.1059005140644, 743.650484272391, 748.7903387051634, 749.1160430691782, 749.4528993834476, 749.61394881636, 18528.44414667562, 18609.627807443776, 18616.162272697762, 18619.348322808637, 18628.348007819797, 21645.67531487029, 21927.561448771095, 22097.447563810874, 22410.32769016932, 22423.663645045337, 17637.64724705499, 17863.73204401922, 18019.27922883083, 18030.549236269067, 18238.0880955953, 3692.316921369555, 3737.906552336186, 3749.8687545935763, 3775.301569209705, 3777.7166712496396, 142752.0, 142986.28506857503, 143955.0, 144347.0, 146198.2690086543, 16995.830041699424, 17297.308107675803, 17341.65316693659, 17392.130393480275, 17396.82603173952, 30887.536686949712, 32364.190895227806, 32598.674013259562, 32686.509702354484, 32726.345473090405, 8929.955350223338, 8985.326100542356, 9036.0, 9093.454392736458, 9127.178553930178, 4514.932276015862, 4637.46669133054, 4638.489766125724, 4649.04694537619, 4649.116667833101, 5586.301712285965, 5665.915011274834, 5678.914816277676, 5702.486776190163, 5703.914441283384, 931.3480563605503, 966.9564869580886, 987.027777639025, 988.8170688422665, 998.4508520313798, 686.2588404523103, 709.4466316273315, 717.720089165226, 718.1633397092329, 721.5778769419948, 11583.884161158448, 11825.822612660817, 12056.63830085099, 12740.362981851056, 13162.276074815785, 676.2561182698992, 702.2240424331143, 713.3472872321768, 714.6926821466819, 720.459655258556, 5669.716514174274, 5768.884622307531, 5821.126830975388, 5864.120381942743, 5905.291365036223, 122060.0, 125008.0, 125364.37317813352, 126387.3680631591, 126819.36590316989, 83387.5830620843, 85848.0, 107553.46223268834, 109495.0, 110155.44922275338, 85835.0, 86939.13060869437, 89545.0, 90277.0, 92346.0, 12249.326287054297, 12607.369631518204, 12678.366081696062, 12736.299503527394, 12762.0, 41619.167616648105, 42164.367534486395, 42342.153156936074, 43734.781326093165, 44245.336319954586, 74828.75513734597, 76147.23852761401, 76492.0, 76850.23149768655, 77087.0, 18670.346537871108, 18720.251189952793, 19101.808981910002, 19114.52213694669, 19182.232710691973, 21047.684284735435, 21519.892400537898, 21740.89129554342, 22086.77913220847, 22154.778452215272, 18604.906975465037, 19014.904925475283, 19093.236270549023, 19672.311469098513, 19878.801211987695, 16396.344146234016, 17857.28570857151, 18187.09064546794, 18369.72445413293, 18502.814971850108, 18504.629907401508, 18624.44126676202, 18635.72046419278, 19024.71462928085, 19165.0, 13397.598072057464, 13437.0, 13467.653234676454, 13576.710212529793, 14000.579982600539, 14647.853521464649, 15194.240287985778, 15259.0, 15287.541373758804, 15552.144632045347], "value": 9430.330672774067, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 106.0, 111.0, 107.0, 108.0, 107.0, 107.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 121.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 161.0, 162.0, 164.0, 162.0, 165.0, 172.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 74.0, 73.0, 74.0, 76.0, 79.0, 72.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 80.0, 79.0, 80.0, 81.0, 81.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 113.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 147.0, 150.0, 150.0, 151.0, 151.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 52.0, 56.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 37.0, 37.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 76.0, 74.0, 80.0, 73.0, 77.0, 77.0, 76.0, 83.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 115.0, 115.0, 116.0, 112.0, 112.0, 117.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 176.0, 169.0, 169.0, 167.0, 179.0, 174.0, 173.0, 173.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 66.0, 70.0, 69.0, 68.0, 68.0, 66.0, 65.0, 68.0], "value": 68.0, "unit": "score"}]}]} 17:43:00 INFO - Return code: 0 17:43:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:43:00 INFO - # TBPL SUCCESS # 17:43:00 INFO - Running post-action listener: _package_coverage_data 17:43:00 INFO - Running post-action listener: _resource_record_post_action 17:43:00 INFO - [mozharness: 2017-09-26 00:43:00.454831Z] Finished run-tests step (success) 17:43:00 INFO - Running post-run listener: _resource_record_post_run 17:43:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 346624000; Read time: 312; Write time: 307276 17:43:00 INFO - TinderboxPrint: CPU usage
13.1% 17:43:00 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 312 17:43:00 INFO - TinderboxPrint: I/O write bytes / time
346,624,000 / 307,276 17:43:00 INFO - TinderboxPrint: CPU idle
8,234.7 (86.9%) 17:43:00 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 17:43:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:43:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13111296; Read time: 0; Write time: 2820 17:43:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:43:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 333119488; Read time: 264; Write time: 304432 17:43:01 INFO - Running post-run listener: _upload_blobber_files 17:43:01 INFO - Blob upload gear active. 17:43:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:43:01 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 17:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:43:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:02 INFO - (blobuploader) - INFO - Done attempting. 17:43:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:43:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:09 INFO - (blobuploader) - INFO - Done attempting. 17:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:10 INFO - (blobuploader) - INFO - Done attempting. 17:43:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:43:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:43:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:43:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:43:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:43:11 INFO - (blobuploader) - INFO - Done attempting. 17:43:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:43:11 INFO - Return code: 0 17:43:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:43:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:43:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77a37a120b6ddc8cd08d53ad6340cea9f1cf1a9dd402de93498df9080b3d0fa846b27735ba706a7e8393685bd0f477c86bea8aea21c366816e9ab453626ad6df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e77ce9d2f1d27822f6095f16727fc5e9d13a97420b2ec27614d80992918b57d7c0a53d77f7046482074ecf741a76dfb89bdefad371f00c9c90480b2e1ed67140", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93d0e54dec9964157d9031ee61b04f051cf21e2337665ff95bf3c0f3a4f0ed9573ddc63d15309c5698415f740a4d37f0e9efb3f5d6a7d8b8236e6ffe9899de39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8c9c30b66dd618d69274110ca4ec5b944c35cc097006c4b70f9f4a0f6cae9c5d6edd95259e77ebbfc23a246e19cff1d6cf89bfb4f84cd429dfeea6c48dea04b"} 17:43:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:43:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:43:11 INFO - Contents: 17:43:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77a37a120b6ddc8cd08d53ad6340cea9f1cf1a9dd402de93498df9080b3d0fa846b27735ba706a7e8393685bd0f477c86bea8aea21c366816e9ab453626ad6df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e77ce9d2f1d27822f6095f16727fc5e9d13a97420b2ec27614d80992918b57d7c0a53d77f7046482074ecf741a76dfb89bdefad371f00c9c90480b2e1ed67140", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93d0e54dec9964157d9031ee61b04f051cf21e2337665ff95bf3c0f3a4f0ed9573ddc63d15309c5698415f740a4d37f0e9efb3f5d6a7d8b8236e6ffe9899de39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8c9c30b66dd618d69274110ca4ec5b944c35cc097006c4b70f9f4a0f6cae9c5d6edd95259e77ebbfc23a246e19cff1d6cf89bfb4f84cd429dfeea6c48dea04b"} 17:43:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:43:11 INFO - Copying logs to upload dir... 17:43:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:43:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.225371 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-25 17:43:11.476065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:11.484314) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77a37a120b6ddc8cd08d53ad6340cea9f1cf1a9dd402de93498df9080b3d0fa846b27735ba706a7e8393685bd0f477c86bea8aea21c366816e9ab453626ad6df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e77ce9d2f1d27822f6095f16727fc5e9d13a97420b2ec27614d80992918b57d7c0a53d77f7046482074ecf741a76dfb89bdefad371f00c9c90480b2e1ed67140", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93d0e54dec9964157d9031ee61b04f051cf21e2337665ff95bf3c0f3a4f0ed9573ddc63d15309c5698415f740a4d37f0e9efb3f5d6a7d8b8236e6ffe9899de39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8c9c30b66dd618d69274110ca4ec5b944c35cc097006c4b70f9f4a0f6cae9c5d6edd95259e77ebbfc23a246e19cff1d6cf89bfb4f84cd429dfeea6c48dea04b"} build_url:https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/T6YG80ZaRluUV1sg95wmlQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/77a37a120b6ddc8cd08d53ad6340cea9f1cf1a9dd402de93498df9080b3d0fa846b27735ba706a7e8393685bd0f477c86bea8aea21c366816e9ab453626ad6df", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e77ce9d2f1d27822f6095f16727fc5e9d13a97420b2ec27614d80992918b57d7c0a53d77f7046482074ecf741a76dfb89bdefad371f00c9c90480b2e1ed67140", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/93d0e54dec9964157d9031ee61b04f051cf21e2337665ff95bf3c0f3a4f0ed9573ddc63d15309c5698415f740a4d37f0e9efb3f5d6a7d8b8236e6ffe9899de39", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8c9c30b66dd618d69274110ca4ec5b944c35cc097006c4b70f9f4a0f6cae9c5d6edd95259e77ebbfc23a246e19cff1d6cf89bfb4f84cd429dfeea6c48dea04b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:11.514728) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:11.515036) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1506385247.161506-1790006531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 17:43:11.603377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:43:11.603640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 17:43:11.603917) ========= ========= Total master_lag: 0.46 =========