builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-076 starttime: 1506814404.78 results: success (0) revision: a5f92049b409adbb465586f6217416aa9b7b3157 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.782135) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.782579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.782848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.816277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.816633) ========= 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=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 16:33:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 41.9M=0s 2017-09-30 16:33:24 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109152 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.946140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.946544) ========= 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=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015683 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.996888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:24.997215) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a5f92049b409adbb465586f6217416aa9b7b3157 --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 a5f92049b409adbb465586f6217416aa9b7b3157 --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=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 16:33:25,042 truncating revision to first 12 chars 2017-09-30 16:33:25,042 Setting DEBUG logging. 2017-09-30 16:33:25,042 attempt 1/10 2017-09-30 16:33:25,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a5f92049b409?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 16:33:25,501 unpacking tar archive at: mozilla-central-a5f92049b409/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:25.757450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:25.757739) ========= script_repo_revision: a5f92049b409adbb465586f6217416aa9b7b3157 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:25.758128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:25.758400) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 16:33:25.786220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-30 16:33:25.786521) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:33:25 INFO - MultiFileLogger online at 20170930 16:33:25 in /builds/slave/test 16:33:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:33:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:33:25 INFO - {'append_to_log': False, 16:33:25 INFO - 'base_work_dir': '/builds/slave/test', 16:33:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:33:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:33:25 INFO - 'branch': 'Firefox-Non-PGO', 16:33:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:33:25 INFO - 'code_coverage': False, 16:33:25 INFO - 'config_files': ('talos/linux_config.py',), 16:33:25 INFO - 'default_actions': ('clobber', 16:33:25 INFO - 'read-buildbot-config', 16:33:25 INFO - 'download-and-extract', 16:33:25 INFO - 'populate-webroot', 16:33:25 INFO - 'create-virtualenv', 16:33:25 INFO - 'install', 16:33:25 INFO - 'setup-mitmproxy', 16:33:25 INFO - 'run-tests'), 16:33:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:33:25 INFO - 'disable_ccov_upload': False, 16:33:25 INFO - 'disable_stylo': False, 16:33:25 INFO - 'download_minidump_stackwalk': True, 16:33:25 INFO - 'download_symbols': 'ondemand', 16:33:25 INFO - 'enable_stylo': False, 16:33:25 INFO - 'enable_webrender': False, 16:33:25 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:33:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:33:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:33:25 INFO - 'gecko_profile': False, 16:33:25 INFO - 'gecko_profile_interval': 0, 16:33:25 INFO - 'installer_path': 'installer.exe', 16:33:25 INFO - 'log_level': 'info', 16:33:25 INFO - 'log_name': 'talos', 16:33:25 INFO - 'log_to_console': True, 16:33:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:33:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:33:25 INFO - 'opt_config_files': (), 16:33:25 INFO - 'pip_index': False, 16:33:25 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:33:25 INFO - 'system_bits': '32', 16:33:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:33:25 INFO - 'title': 'talos-linux64-ix-076', 16:33:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:33:25 INFO - 'use_talos_json': True, 16:33:25 INFO - 'verify': 'False', 16:33:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:33:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:33:25 INFO - 'work_dir': 'build'} 16:33:25 INFO - [mozharness: 2017-09-30 23:33:25.974779Z] Running clobber step. 16:33:25 INFO - Running pre-action listener: _resource_record_pre_action 16:33:25 INFO - Running main action method: clobber 16:33:25 INFO - rmtree: /builds/slave/test/build 16:33:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:33:27 INFO - Running post-action listener: _resource_record_post_action 16:33:27 INFO - [mozharness: 2017-09-30 23:33:27.482279Z] Finished clobber step (success) 16:33:27 INFO - [mozharness: 2017-09-30 23:33:27.482376Z] Running read-buildbot-config step. 16:33:27 INFO - Running pre-action listener: _resource_record_pre_action 16:33:27 INFO - Running main action method: read_buildbot_config 16:33:27 INFO - Using buildbot properties: 16:33:27 INFO - { 16:33:27 INFO - "project": "", 16:33:27 INFO - "product": "firefox", 16:33:27 INFO - "who": "archaeopteryx@coole-files.de", 16:33:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:33:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:33:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:33:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 16:33:27 INFO - "stage_platform": "linux64", 16:33:27 INFO - "basedir": "/builds/slave/test", 16:33:27 INFO - "buildnumber": 84, 16:33:27 INFO - "platform": "ubuntu64_hw", 16:33:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:33:27 INFO - "slavebuilddir": "test", 16:33:27 INFO - "taskId": "fODPK-FTRrWiwV77K_Z6eA", 16:33:27 INFO - "branch": "mozilla-central", 16:33:27 INFO - "script_repo_revision": "production", 16:33:27 INFO - "revision": "a5f92049b409adbb465586f6217416aa9b7b3157", 16:33:27 INFO - "slavename": "talos-linux64-ix-076", 16:33:27 INFO - "repo_path": "mozilla-central" 16:33:27 INFO - } 16:33:27 INFO - Finding installer, test and symbols from parent task. 16:33:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fODPK-FTRrWiwV77K_Z6eA'}, attempt #1 16:33:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fODPK-FTRrWiwV77K_Z6eA'}, attempt #1 16:33:28 INFO - Task dependencies: T48oeLAPQg6zMtCYv_JcQg 16:33:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg'}, attempt #1 16:33:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 16:33:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.test_packages.json 16:33:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.crashreporter-symbols.zip 16:33:29 INFO - Running post-action listener: _resource_record_post_action 16:33:29 INFO - [mozharness: 2017-09-30 23:33:29.455512Z] Finished read-buildbot-config step (success) 16:33:29 INFO - [mozharness: 2017-09-30 23:33:29.455729Z] Running download-and-extract step. 16:33:29 INFO - Running pre-action listener: _resource_record_pre_action 16:33:29 INFO - Running main action method: download_and_extract 16:33:29 INFO - mkdir: /builds/slave/test/build/tests 16:33: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')]} 16:33:29 INFO - trying https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.test_packages.json 16:33:29 INFO - Downloading https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:33:30 INFO - Downloaded 989 bytes. 16:33:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:33:30 INFO - Using the following test package requirements: 16:33:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:33:30 INFO - u'common': [u'target.common.tests.zip'], 16:33:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:33:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:33:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:33:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:33:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:33:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:33:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:33:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:33:30 INFO - u'target.web-platform.tests.tar.gz'], 16:33:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:33:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.common.tests.zip 16:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:33:30 INFO - Fetch https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.common.tests.zip into memory 16:33:32 INFO - Content-Length response header: 55366758 16:33:32 INFO - Bytes received: 55366758 16:33:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.talos.tests.zip 16:33:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:33:42 INFO - Fetch https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.talos.tests.zip into memory 16:33:43 INFO - Content-Length response header: 14522385 16:33:43 INFO - Bytes received: 14522385 16:33:43 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')]} 16:33:43 INFO - trying https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 16:33:43 INFO - Downloading https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:33:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:33:46 INFO - Downloaded 61659398 bytes. 16:33:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 16:33:46 INFO - mkdir: /builds/slave/test/properties 16:33:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:33:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:33:46 INFO - Contents: 16:33:46 INFO - build_url:https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 16:33:46 INFO - Running post-action listener: _resource_record_post_action 16:33:46 INFO - Running post-action listener: find_tests_for_verification 16:33:46 INFO - Running post-action listener: set_extra_try_arguments 16:33:46 INFO - [mozharness: 2017-09-30 23:33:46.099749Z] Finished download-and-extract step (success) 16:33:46 INFO - [mozharness: 2017-09-30 23:33:46.100109Z] Running populate-webroot step. 16:33:46 INFO - Running pre-action listener: _resource_record_pre_action 16:33:46 INFO - Running main action method: populate_webroot 16:33:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:33:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['tresize', 16:33:46 INFO - 'tcanvasmark']}, 16:33:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:33:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['dromaeo_css', 16:33:46 INFO - 'kraken']}, 16:33:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'tests': ['damp', 'tps']}, 16:33:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['damp', 'tps']}, 16:33:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:33:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['dromaeo_dom']}, 16:33:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:33:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['basic_compositor_video', 16:33:46 INFO - 'glvideo']}, 16:33:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:33:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['ts_paint_webext', 16:33:46 INFO - 'tp5o_webext']}, 16:33:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:33:46 INFO - 'ts_paint', 16:33:46 INFO - 'tpaint', 16:33:46 INFO - 'sessionrestore', 16:33:46 INFO - 'sessionrestore_many_windows', 16:33:46 INFO - 'sessionrestore_no_auto_restore', 16:33:46 INFO - 'tabpaint', 16:33:46 INFO - 'cpstartup']}, 16:33:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['a11yr', 16:33:46 INFO - 'ts_paint', 16:33:46 INFO - 'tpaint', 16:33:46 INFO - 'sessionrestore', 16:33:46 INFO - 'sessionrestore_many_windows', 16:33:46 INFO - 'sessionrestore_no_auto_restore', 16:33:46 INFO - 'tabpaint', 16:33:46 INFO - 'cpstartup']}, 16:33:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:33:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:33:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['perf_reftest_singletons']}, 16:33:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['perf_reftest']}, 16:33:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:33:46 INFO - 'tsvgr_opacity', 16:33:46 INFO - 'tart', 16:33:46 INFO - 'tscrollx', 16:33:46 INFO - 'tsvg_static']}, 16:33:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['tsvgx', 16:33:46 INFO - 'tsvgr_opacity', 16:33:46 INFO - 'tart', 16:33:46 INFO - 'tscrollx', 16:33:46 INFO - 'tsvg_static']}, 16:33:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:33:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--disable-stylo'], 16:33:46 INFO - 'tests': ['tp5o']}, 16:33:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:33:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:33:46 INFO - 'talos_options': ['--mitmproxy', 16:33:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:33:46 INFO - '--firstNonBlankPaint'], 16:33:46 INFO - 'tests': ['tp6_google', 16:33:46 INFO - 'tp6_youtube', 16:33:46 INFO - 'tp6_amazon', 16:33:46 INFO - 'tp6_facebook']}, 16:33:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:33:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:33:46 INFO - 'talos_options': ['--disable-stylo', 16:33:46 INFO - '--mitmproxy', 16:33:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:33:46 INFO - '--firstNonBlankPaint'], 16:33:46 INFO - 'tests': ['tp6_google', 16:33:46 INFO - 'tp6_youtube', 16:33:46 INFO - 'tp6_amazon', 16:33:46 INFO - 'tp6_facebook']}, 16:33:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:33:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:33:46 INFO - 'talos_options': ['--stylo-threads=1', 16:33:46 INFO - '--mitmproxy', 16:33:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:33:46 INFO - '--firstNonBlankPaint'], 16:33:46 INFO - 'tests': ['tp6_google', 16:33:46 INFO - 'tp6_youtube', 16:33:46 INFO - 'tp6_amazon', 16:33:46 INFO - 'tp6_facebook']}, 16:33:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--xperf_path', 16:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:46 INFO - 'tests': ['tp5n']}, 16:33:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:33:46 INFO - 'talos_options': ['--disable-stylo', 16:33:46 INFO - '--xperf_path', 16:33:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:46 INFO - 'tests': ['tp5n']}}} 16:33:46 INFO - Running post-action listener: _resource_record_post_action 16:33:46 INFO - [mozharness: 2017-09-30 23:33:46.189864Z] Finished populate-webroot step (success) 16:33:46 INFO - [mozharness: 2017-09-30 23:33:46.190000Z] Running create-virtualenv step. 16:33:46 INFO - Running pre-action listener: _resource_record_pre_action 16:33:46 INFO - Running main action method: create_virtualenv 16:33:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:33:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:33:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:33:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:33:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:33:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:33:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:33:47 INFO - Installing pip...............done. 16:33:47 INFO - Return code: 0 16:33:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:33:47 INFO - Reading from file tmpfile_stdout 16:33:47 INFO - Output received: 16:33:47 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:33:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:33:47 INFO - Using env: {'DISPLAY': ':0', 16:33:47 INFO - 'HOME': '/home/cltbld', 16:33:47 INFO - 'LANG': 'en_US.UTF-8', 16:33:47 INFO - 'LANGUAGE': 'en_US:en', 16:33:47 INFO - 'LOGNAME': 'cltbld', 16:33:47 INFO - 'MAIL': '/var/mail/cltbld', 16:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:47 INFO - 'MOZ_NO_REMOTE': '1', 16:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:47 INFO - 'NO_EM_RESTART': '1', 16:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:47 INFO - 'PWD': '/builds/slave/test', 16:33:47 INFO - 'SHELL': '/bin/bash', 16:33:47 INFO - 'SHLVL': '1', 16:33:47 INFO - 'TERM': 'linux', 16:33:47 INFO - 'TMOUT': '86400', 16:33:47 INFO - 'USER': 'cltbld', 16:33:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:47 INFO - '_': '/tools/buildbot/bin/python'} 16:33:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:33:48 INFO - Downloading/unpacking pip>=1.5 16:33:48 INFO - Running setup.py egg_info for package pip 16:33:48 INFO - warning: no files found matching 'pip/cacert.pem' 16:33:48 INFO - warning: no files found matching '*.html' under directory 'docs' 16:33:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:33:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:33:48 INFO - Installing collected packages: pip 16:33:48 INFO - Found existing installation: pip 1.1 16:33:48 INFO - Uninstalling pip: 16:33:48 INFO - Successfully uninstalled pip 16:33:48 INFO - Running setup.py install for pip 16:33:48 INFO - warning: no files found matching 'pip/cacert.pem' 16:33:48 INFO - warning: no files found matching '*.html' under directory 'docs' 16:33:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:33:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:33:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:33:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:33:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:33:48 INFO - Successfully installed pip 16:33:48 INFO - Cleaning up... 16:33:48 INFO - Return code: 0 16:33:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:48 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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33:48 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 16:33:48 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 16:33:48 INFO - Using env: {'DISPLAY': ':0', 16:33:48 INFO - 'HOME': '/home/cltbld', 16:33:48 INFO - 'LANG': 'en_US.UTF-8', 16:33:48 INFO - 'LANGUAGE': 'en_US:en', 16:33:48 INFO - 'LOGNAME': 'cltbld', 16:33:48 INFO - 'MAIL': '/var/mail/cltbld', 16:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:48 INFO - 'MOZ_NO_REMOTE': '1', 16:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:48 INFO - 'NO_EM_RESTART': '1', 16:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:48 INFO - 'PWD': '/builds/slave/test', 16:33:48 INFO - 'SHELL': '/bin/bash', 16:33:48 INFO - 'SHLVL': '1', 16:33:48 INFO - 'TERM': 'linux', 16:33:48 INFO - 'TMOUT': '86400', 16:33:48 INFO - 'USER': 'cltbld', 16:33:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:48 INFO - '_': '/tools/buildbot/bin/python'} 16:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:48 INFO - Downloading/unpacking psutil>=3.1.1 16:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:33:49 INFO - Installing collected packages: psutil 16:33:49 INFO - Running setup.py install for psutil 16:33:49 INFO - building 'psutil._psutil_linux' extension 16:33:49 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 16:33:50 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 16:33:50 INFO - building 'psutil._psutil_posix' extension 16:33:50 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 16:33:50 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 16:33:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:33:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:33:50 INFO - Successfully installed psutil 16:33:50 INFO - Cleaning up... 16:33:50 INFO - Return code: 0 16:33:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:33: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')]} 16:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33: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')]} 16:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:33: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 mozsystemmonitor==0.3 16:33:50 INFO - Using env: {'DISPLAY': ':0', 16:33:50 INFO - 'HOME': '/home/cltbld', 16:33:50 INFO - 'LANG': 'en_US.UTF-8', 16:33:50 INFO - 'LANGUAGE': 'en_US:en', 16:33:50 INFO - 'LOGNAME': 'cltbld', 16:33:50 INFO - 'MAIL': '/var/mail/cltbld', 16:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:50 INFO - 'MOZ_NO_REMOTE': '1', 16:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:50 INFO - 'NO_EM_RESTART': '1', 16:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:50 INFO - 'PWD': '/builds/slave/test', 16:33:50 INFO - 'SHELL': '/bin/bash', 16:33:50 INFO - 'SHLVL': '1', 16:33:50 INFO - 'TERM': 'linux', 16:33:50 INFO - 'TMOUT': '86400', 16:33:50 INFO - 'USER': 'cltbld', 16:33:50 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:50 INFO - '_': '/tools/buildbot/bin/python'} 16:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:33: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 16:33: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 16:33: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 16:33: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 16:33:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:33:51 INFO - Installing collected packages: mozsystemmonitor 16:33:51 INFO - Running setup.py install for mozsystemmonitor 16:33:51 INFO - Successfully installed mozsystemmonitor 16:33:51 INFO - Cleaning up... 16:33:52 INFO - Return code: 0 16:33:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:33: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')]} 16:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33: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')]} 16:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33: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', '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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:33: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 jsonschema==2.5.1 16:33:52 INFO - Using env: {'DISPLAY': ':0', 16:33:52 INFO - 'HOME': '/home/cltbld', 16:33:52 INFO - 'LANG': 'en_US.UTF-8', 16:33:52 INFO - 'LANGUAGE': 'en_US:en', 16:33:52 INFO - 'LOGNAME': 'cltbld', 16:33:52 INFO - 'MAIL': '/var/mail/cltbld', 16:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:52 INFO - 'MOZ_NO_REMOTE': '1', 16:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:52 INFO - 'NO_EM_RESTART': '1', 16:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:52 INFO - 'PWD': '/builds/slave/test', 16:33:52 INFO - 'SHELL': '/bin/bash', 16:33:52 INFO - 'SHLVL': '1', 16:33:52 INFO - 'TERM': 'linux', 16:33:52 INFO - 'TMOUT': '86400', 16:33:52 INFO - 'USER': 'cltbld', 16:33:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:52 INFO - '_': '/tools/buildbot/bin/python'} 16:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:33: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 16:33: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 16:33: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 16:33: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 16:33:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:33:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:53 INFO - Downloading functools32-3.2.3-2.tar.gz 16:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:33:53 INFO - warning: no files found matching '*.txt' 16:33:53 INFO - no previously-included directories found matching 'build' 16:33:53 INFO - no previously-included directories found matching 'dist' 16:33:53 INFO - no previously-included directories found matching '.git*' 16:33:53 INFO - Installing collected packages: jsonschema, functools32 16:33:54 INFO - Running setup.py install for functools32 16:33:54 INFO - warning: no files found matching '*.txt' 16:33:54 INFO - no previously-included directories found matching 'build' 16:33:54 INFO - no previously-included directories found matching 'dist' 16:33:54 INFO - no previously-included directories found matching '.git*' 16:33:54 INFO - Successfully installed jsonschema functools32 16:33:54 INFO - Cleaning up... 16:33:54 INFO - Return code: 0 16:33:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:33:54 INFO - Using env: {'DISPLAY': ':0', 16:33:54 INFO - 'HOME': '/home/cltbld', 16:33:54 INFO - 'LANG': 'en_US.UTF-8', 16:33:54 INFO - 'LANGUAGE': 'en_US:en', 16:33:54 INFO - 'LOGNAME': 'cltbld', 16:33:54 INFO - 'MAIL': '/var/mail/cltbld', 16:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:54 INFO - 'MOZ_NO_REMOTE': '1', 16:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:54 INFO - 'NO_EM_RESTART': '1', 16:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:54 INFO - 'PWD': '/builds/slave/test', 16:33:54 INFO - 'SHELL': '/bin/bash', 16:33:54 INFO - 'SHLVL': '1', 16:33:54 INFO - 'TERM': 'linux', 16:33:54 INFO - 'TMOUT': '86400', 16:33:54 INFO - 'USER': 'cltbld', 16:33:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:54 INFO - '_': '/tools/buildbot/bin/python'} 16:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:33:55 INFO - Cleaning up... 16:33:55 INFO - Return code: 0 16:33:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:33: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')]} 16:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33: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')]} 16:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33: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', '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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:33: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 blobuploader==1.2.4 16:33:55 INFO - Using env: {'DISPLAY': ':0', 16:33:55 INFO - 'HOME': '/home/cltbld', 16:33:55 INFO - 'LANG': 'en_US.UTF-8', 16:33:55 INFO - 'LANGUAGE': 'en_US:en', 16:33:55 INFO - 'LOGNAME': 'cltbld', 16:33:55 INFO - 'MAIL': '/var/mail/cltbld', 16:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:55 INFO - 'MOZ_NO_REMOTE': '1', 16:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:55 INFO - 'NO_EM_RESTART': '1', 16:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:55 INFO - 'PWD': '/builds/slave/test', 16:33:55 INFO - 'SHELL': '/bin/bash', 16:33:55 INFO - 'SHLVL': '1', 16:33:55 INFO - 'TERM': 'linux', 16:33:55 INFO - 'TMOUT': '86400', 16:33:55 INFO - 'USER': 'cltbld', 16:33:55 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:55 INFO - '_': '/tools/buildbot/bin/python'} 16:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:33: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 16:33: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 16:33: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 16:33: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 16:33:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:33:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:33:56 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 16:33:56 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 16:33:56 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 16:33:56 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 16:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:33:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:33:56 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 16:33:56 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 16:33:56 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 16:33:56 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 16:33:57 INFO - Downloading docopt-0.6.1.tar.gz 16:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:33:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:33:57 INFO - Running setup.py install for blobuploader 16:33:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:33:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:33:57 INFO - Running setup.py install for requests 16:33:57 INFO - Running setup.py install for docopt 16:33:57 INFO - Successfully installed blobuploader requests docopt 16:33:57 INFO - Cleaning up... 16:33:57 INFO - Return code: 0 16:33:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:57 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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:33:57 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 16:33:57 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 16:33:57 INFO - Using env: {'DISPLAY': ':0', 16:33:57 INFO - 'HOME': '/home/cltbld', 16:33:57 INFO - 'LANG': 'en_US.UTF-8', 16:33:57 INFO - 'LANGUAGE': 'en_US:en', 16:33:57 INFO - 'LOGNAME': 'cltbld', 16:33:57 INFO - 'MAIL': '/var/mail/cltbld', 16:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:57 INFO - 'MOZ_NO_REMOTE': '1', 16:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:57 INFO - 'NO_EM_RESTART': '1', 16:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:57 INFO - 'PWD': '/builds/slave/test', 16:33:57 INFO - 'SHELL': '/bin/bash', 16:33:57 INFO - 'SHLVL': '1', 16:33:57 INFO - 'TERM': 'linux', 16:33:57 INFO - 'TMOUT': '86400', 16:33:57 INFO - 'USER': 'cltbld', 16:33:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:57 INFO - '_': '/tools/buildbot/bin/python'} 16:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:57 INFO - Running setup.py (path:/tmp/pip-MX2WOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:58 INFO - Running setup.py (path:/tmp/pip-TibaBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:58 INFO - Running setup.py (path:/tmp/pip-PtnFde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:58 INFO - Running setup.py (path:/tmp/pip-yUvXx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:58 INFO - Running setup.py (path:/tmp/pip-d1ItT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:58 INFO - Running setup.py (path:/tmp/pip-LOvyl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:58 INFO - Running setup.py (path:/tmp/pip-yjawPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:58 INFO - Running setup.py (path:/tmp/pip-ThkQgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:58 INFO - Running setup.py (path:/tmp/pip-qrYwyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:58 INFO - Running setup.py (path:/tmp/pip-JUOE1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:58 INFO - Running setup.py (path:/tmp/pip-ZnIqLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:58 INFO - Running setup.py (path:/tmp/pip-h4yzcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:58 INFO - Running setup.py (path:/tmp/pip-Kn3Edn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:58 INFO - Running setup.py (path:/tmp/pip-UD3I67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:58 INFO - Running setup.py (path:/tmp/pip-EKdECA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:59 INFO - Running setup.py (path:/tmp/pip-j83ixR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:59 INFO - Running setup.py (path:/tmp/pip-0HPpcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:33:59 INFO - Running setup.py install for manifestparser 16:33:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Running setup.py install for mozcrash 16:33:59 INFO - Running setup.py install for mozdebug 16:33:59 INFO - Running setup.py install for mozdevice 16:33:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Running setup.py install for mozfile 16:33:59 INFO - Running setup.py install for mozhttpd 16:33:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Running setup.py install for mozinfo 16:33:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Running setup.py install for mozInstall 16:33:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:33:59 INFO - Running setup.py install for mozleak 16:34:00 INFO - Running setup.py install for mozlog 16:34:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Running setup.py install for moznetwork 16:34:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Running setup.py install for mozprocess 16:34:00 INFO - Running setup.py install for mozprofile 16:34:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Running setup.py install for mozrunner 16:34:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Running setup.py install for mozscreenshot 16:34:00 INFO - Running setup.py install for moztest 16:34:00 INFO - Running setup.py install for mozversion 16:34:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:34:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:00 INFO - Cleaning up... 16:34:00 INFO - Return code: 0 16:34:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:00 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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:34:00 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 16:34:00 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 16:34:00 INFO - Using env: {'DISPLAY': ':0', 16:34:00 INFO - 'HOME': '/home/cltbld', 16:34:00 INFO - 'LANG': 'en_US.UTF-8', 16:34:00 INFO - 'LANGUAGE': 'en_US:en', 16:34:00 INFO - 'LOGNAME': 'cltbld', 16:34:00 INFO - 'MAIL': '/var/mail/cltbld', 16:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:00 INFO - 'MOZ_NO_REMOTE': '1', 16:34:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:00 INFO - 'NO_EM_RESTART': '1', 16:34:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:00 INFO - 'PWD': '/builds/slave/test', 16:34:00 INFO - 'SHELL': '/bin/bash', 16:34:00 INFO - 'SHLVL': '1', 16:34:00 INFO - 'TERM': 'linux', 16:34:00 INFO - 'TMOUT': '86400', 16:34:00 INFO - 'USER': 'cltbld', 16:34:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:00 INFO - '_': '/tools/buildbot/bin/python'} 16:34:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:34:01 INFO - Running setup.py (path:/tmp/pip-Ehl7o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:34:01 INFO - Running setup.py (path:/tmp/pip-DWlrPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:34:01 INFO - Running setup.py (path:/tmp/pip-f7oL_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:34:01 INFO - Running setup.py (path:/tmp/pip-ldRyrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:34:01 INFO - Running setup.py (path:/tmp/pip-Gj96AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:34:01 INFO - Running setup.py (path:/tmp/pip-hKbr4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:34:01 INFO - Running setup.py (path:/tmp/pip-wNwGx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:34:01 INFO - Running setup.py (path:/tmp/pip-o7ulrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:34:01 INFO - Running setup.py (path:/tmp/pip-eErk3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:34:01 INFO - Running setup.py (path:/tmp/pip-r5gCLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:34:01 INFO - Running setup.py (path:/tmp/pip-ebO2x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:34:01 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)) 16:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:34:01 INFO - Running setup.py (path:/tmp/pip-8nSfjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:34:02 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)) 16:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:34:02 INFO - Running setup.py (path:/tmp/pip-1Am_uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:34:02 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)) 16:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:34:02 INFO - Running setup.py (path:/tmp/pip-nJWWAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:34:02 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)) 16:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:02 INFO - Running setup.py (path:/tmp/pip-SHT09L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:34:02 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)) 16:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:34:02 INFO - Running setup.py (path:/tmp/pip-DBniiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:34:02 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)) 16:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:34:02 INFO - Running setup.py (path:/tmp/pip-TEhUyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:34:02 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)) 16:34:02 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)) 16:34:02 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)) 16:34:02 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)) 16:34:02 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)) 16:34:02 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)) 16:34:02 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)) 16:34:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:03 INFO - Downloading blessings-1.6.tar.gz 16:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:03 INFO - Installing collected packages: blessings 16:34:03 INFO - Running setup.py install for blessings 16:34:03 INFO - Successfully installed blessings 16:34:03 INFO - Cleaning up... 16:34:03 INFO - Return code: 0 16:34:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:03 INFO - Reading from file tmpfile_stdout 16:34:03 INFO - Current package versions: 16:34:03 INFO - argparse == 1.2.1 16:34:03 INFO - blessings == 1.6 16:34:03 INFO - blobuploader == 1.2.4 16:34:03 INFO - docopt == 0.6.1 16:34:03 INFO - functools32 == 3.2.3-2 16:34:03 INFO - jsonschema == 2.5.1 16:34:03 INFO - manifestparser == 1.1 16:34:03 INFO - mozInstall == 1.13 16:34:03 INFO - mozcrash == 1.0 16:34:03 INFO - mozdebug == 0.1 16:34:03 INFO - mozdevice == 0.51 16:34:03 INFO - mozfile == 1.2 16:34:03 INFO - mozhttpd == 0.7 16:34:03 INFO - mozinfo == 0.10 16:34:03 INFO - mozleak == 0.1 16:34:03 INFO - mozlog == 3.5 16:34:03 INFO - moznetwork == 0.27 16:34:03 INFO - mozprocess == 0.25 16:34:03 INFO - mozprofile == 0.28 16:34:03 INFO - mozrunner == 6.13 16:34:03 INFO - mozscreenshot == 0.1 16:34:03 INFO - mozsystemmonitor == 0.3 16:34:03 INFO - moztest == 0.8 16:34:03 INFO - mozversion == 1.4 16:34:03 INFO - psutil == 3.1.1 16:34:03 INFO - requests == 1.2.3 16:34:03 INFO - wsgiref == 0.1.2 16:34:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:03 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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:34:03 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 16:34:03 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 16:34:03 INFO - Using env: {'DISPLAY': ':0', 16:34:03 INFO - 'HOME': '/home/cltbld', 16:34:03 INFO - 'LANG': 'en_US.UTF-8', 16:34:03 INFO - 'LANGUAGE': 'en_US:en', 16:34:03 INFO - 'LOGNAME': 'cltbld', 16:34:03 INFO - 'MAIL': '/var/mail/cltbld', 16:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:03 INFO - 'MOZ_NO_REMOTE': '1', 16:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:03 INFO - 'NO_EM_RESTART': '1', 16:34:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:03 INFO - 'PWD': '/builds/slave/test', 16:34:03 INFO - 'SHELL': '/bin/bash', 16:34:03 INFO - 'SHLVL': '1', 16:34:03 INFO - 'TERM': 'linux', 16:34:03 INFO - 'TMOUT': '86400', 16:34:03 INFO - 'USER': 'cltbld', 16:34:03 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:03 INFO - '_': '/tools/buildbot/bin/python'} 16:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 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)) 16:34:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:34:04 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 16:34:04 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 16:34:04 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 16:34:04 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 16:34:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:34:05 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)) 16:34:05 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)) 16:34:05 INFO - Installing collected packages: simplejson 16:34:05 INFO - Running setup.py install for simplejson 16:34:05 INFO - building 'simplejson._speedups' extension 16:34:05 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 16:34:06 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 16:34:06 INFO - Successfully installed simplejson 16:34:06 INFO - Cleaning up... 16:34:06 INFO - Return code: 0 16:34:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:06 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 0x25f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29649c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, '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': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', '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 16:34:06 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 16:34:06 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 16:34:06 INFO - Using env: {'DISPLAY': ':0', 16:34:06 INFO - 'HOME': '/home/cltbld', 16:34:06 INFO - 'LANG': 'en_US.UTF-8', 16:34:06 INFO - 'LANGUAGE': 'en_US:en', 16:34:06 INFO - 'LOGNAME': 'cltbld', 16:34:06 INFO - 'MAIL': '/var/mail/cltbld', 16:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:06 INFO - 'MOZ_NO_REMOTE': '1', 16:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:06 INFO - 'NO_EM_RESTART': '1', 16:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:06 INFO - 'PWD': '/builds/slave/test', 16:34:06 INFO - 'SHELL': '/bin/bash', 16:34:06 INFO - 'SHLVL': '1', 16:34:06 INFO - 'TERM': 'linux', 16:34:06 INFO - 'TMOUT': '86400', 16:34:06 INFO - 'USER': 'cltbld', 16:34:06 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:06 INFO - '_': '/tools/buildbot/bin/python'} 16:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:34:06 INFO - Cleaning up... 16:34:06 INFO - Return code: 0 16:34:06 INFO - Running post-action listener: _resource_record_post_action 16:34:06 INFO - Running post-action listener: _start_resource_monitoring 16:34:06 INFO - Starting resource monitoring. 16:34:06 INFO - [mozharness: 2017-09-30 23:34:06.637673Z] Finished create-virtualenv step (success) 16:34:06 INFO - [mozharness: 2017-09-30 23:34:06.638146Z] Running install step. 16:34:06 INFO - Running pre-action listener: _resource_record_pre_action 16:34:06 INFO - Running main action method: install 16:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:34:06 INFO - Reading from file tmpfile_stdout 16:34:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:34:06 INFO - Reading from file tmpfile_stdout 16:34:07 INFO - Output received: 16:34:07 INFO - Usage: mozinstall [options] installer 16:34:07 INFO - Options: 16:34:07 INFO - -h, --help show this help message and exit 16:34:07 INFO - -d DEST, --destination=DEST 16:34:07 INFO - Directory to install application into. [default: 16:34:07 INFO - "/builds/slave/test"] 16:34:07 INFO - --app=APP Application being installed. [default: firefox] 16:34:07 INFO - mkdir: /builds/slave/test/build/application 16:34:07 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'] 16:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:34:24 INFO - Reading from file tmpfile_stdout 16:34:24 INFO - Output received: 16:34:24 INFO - /builds/slave/test/build/application/firefox/firefox 16:34:24 INFO - Running post-action listener: _resource_record_post_action 16:34:24 INFO - [mozharness: 2017-09-30 23:34:24.877042Z] Finished install step (success) 16:34:24 INFO - [mozharness: 2017-09-30 23:34:24.877297Z] Running setup-mitmproxy step. 16:34:24 INFO - Running pre-action listener: _resource_record_pre_action 16:34:24 INFO - Running main action method: setup_mitmproxy 16:34:24 INFO - Skipping: mitmproxy is not required 16:34:24 INFO - Running post-action listener: _resource_record_post_action 16:34:24 INFO - [mozharness: 2017-09-30 23:34:24.878439Z] Finished setup-mitmproxy step (success) 16:34:24 INFO - [mozharness: 2017-09-30 23:34:24.878660Z] Running run-tests step. 16:34:24 INFO - Running pre-action listener: _resource_record_pre_action 16:34:24 INFO - Running pre-action listener: _set_gcov_prefix 16:34:24 INFO - Running main action method: run_tests 16:34:24 WARNING - Try message not found. 16:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:34:24 INFO - Python 2.7.3 16:34:24 INFO - Return code: 0 16:34:24 INFO - grabbing minidump binary from tooltool 16:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:34:24 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 0x2961d60>, '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 0x2962a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2962ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:34:24 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 16:34:24 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 16:34:24 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 16:34:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:34:25 INFO - Return code: 0 16:34:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:34:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:34:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:34:25 INFO - ENV: RUST_BACKTRACE is now full 16:34:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:34:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:34:25 INFO - Using env: {'DISPLAY': ':0', 16:34:25 INFO - 'HOME': '/home/cltbld', 16:34:25 INFO - 'LANG': 'en_US.UTF-8', 16:34:25 INFO - 'LANGUAGE': 'en_US:en', 16:34:25 INFO - 'LOGNAME': 'cltbld', 16:34:25 INFO - 'MAIL': '/var/mail/cltbld', 16:34:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:25 INFO - 'MOZ_NO_REMOTE': '1', 16:34:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:25 INFO - 'NO_EM_RESTART': '1', 16:34:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:25 INFO - 'PWD': '/builds/slave/test', 16:34:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:25 INFO - 'RUST_BACKTRACE': 'full', 16:34:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:34:25 INFO - 'SHELL': '/bin/bash', 16:34:25 INFO - 'SHLVL': '1', 16:34:25 INFO - 'TERM': 'linux', 16:34:25 INFO - 'TMOUT': '86400', 16:34:25 INFO - 'USER': 'cltbld', 16:34:25 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:25 INFO - '_': '/tools/buildbot/bin/python'} 16:34:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:34:25 INFO - mozversion application_buildid: 20170930223431 16:34:25 INFO - mozversion application_changeset: a5f92049b409adbb465586f6217416aa9b7b3157 16:34:25 INFO - mozversion application_display_name: Nightly 16:34:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:34:25 INFO - mozversion application_name: Firefox 16:34:25 INFO - mozversion application_remotingname: firefox 16:34:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:34:25 INFO - mozversion application_vendor: Mozilla 16:34:25 INFO - mozversion application_version: 58.0a1 16:34:25 INFO - mozversion platform_buildid: 20170930223431 16:34:25 INFO - mozversion platform_changeset: a5f92049b409adbb465586f6217416aa9b7b3157 16:34:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:34:25 INFO - mozversion platform_version: 58.0a1 16:34:25 INFO - using testdate: 1506814465 16:34:25 INFO - actual date: 1506814465 16:34:25 INFO - starting webserver on 'localhost:42805' 16:34:25 INFO - SUITE-START | Running 2 tests 16:34:25 INFO - TEST-START | dromaeo_css 16:34:25 INFO - Initialising browser for dromaeo_css test... 16:34:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42805/getInfo.html -profile /tmp/tmpaZXgWF/profile 16:34:25 INFO - TEST-INFO | started process 24618 (/builds/slave/test/build/application/firefox/firefox http://localhost:42805/getInfo.html) 16:34:31 INFO - TEST-INFO | 24618: exit 0 16:34:31 INFO - Browser initialized. 16:34:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:34:31 INFO - Using env: {'DISPLAY': ':0', 16:34:31 INFO - 'HOME': '/home/cltbld', 16:34:31 INFO - 'JSGC_DISABLE_POISONING': '1', 16:34:31 INFO - 'LANG': 'en_US.UTF-8', 16:34:31 INFO - 'LANGUAGE': 'en_US:en', 16:34:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:34:31 INFO - 'LOGNAME': 'cltbld', 16:34:31 INFO - 'MAIL': '/var/mail/cltbld', 16:34:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:34:31 INFO - 'MOZ_CRASHREPORTER': '1', 16:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:34:31 INFO - 'MOZ_NO_REMOTE': '1', 16:34:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:31 INFO - 'NO_EM_RESTART': '1', 16:34:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:31 INFO - 'PWD': '/builds/slave/test', 16:34:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:31 INFO - 'RUST_BACKTRACE': 'full', 16:34:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:34:31 INFO - 'SHELL': '/bin/bash', 16:34:31 INFO - 'SHLVL': '1', 16:34:31 INFO - 'STYLO_FORCE_DISABLED': '1', 16:34:31 INFO - 'TERM': 'linux', 16:34:31 INFO - 'TMOUT': '86400', 16:34:31 INFO - 'USER': 'cltbld', 16:34:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:31 INFO - '_': '/tools/buildbot/bin/python'} 16:34:31 INFO - TEST-INFO | started process 24857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaZXgWF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:32 INFO - PID 24857 | 16:34:32 INFO - PID 24857 | (/builds/slave/test/build/application/firefox/firefox:24906): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:34:32 INFO - PID 24857 | 16:34:42 INFO - PID 24857 | RSS: Main: 151601152 16:34:42 INFO - PID 24857 | 16:37:39 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42805/tests/dromaeo/cssquery-ext.html) 16:37:41 INFO - PID 24857 | RSS: Main: 148639744 16:37:41 INFO - PID 24857 | 16:40:42 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-ext.html (next: http://localhost:42805/tests/dromaeo/cssquery-jquery.html) 16:40:43 INFO - PID 24857 | RSS: Main: 149823488 16:40:43 INFO - PID 24857 | 16:43:45 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42805/tests/dromaeo/cssquery-mootools.html) 16:43:45 INFO - PID 24857 | RSS: Main: 149483520 16:43:45 INFO - PID 24857 | 16:46:47 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42805/tests/dromaeo/cssquery-prototype.html) 16:46:47 INFO - PID 24857 | RSS: Main: 151588864 16:46:47 INFO - PID 24857 | 16:49:51 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42805/tests/dromaeo/cssquery-yui.html) 16:49:51 INFO - PID 24857 | RSS: Main: 154030080 16:49:51 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:42805/tests/dromaeo/cssquery-yui.html (next: http://localhost:42805/tests/dromaeo/cssquery-dojo.html) 16:52:53 INFO - PID 24857 | RSS: Main: 155488256 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | __start_tp_report 16:52:53 INFO - PID 24857 | _x_x_mozilla_page_load 16:52:53 INFO - PID 24857 | _x_x_mozilla_page_load_details 16:52:53 INFO - PID 24857 | |i|pagename|runs| 16:52:53 INFO - PID 24857 | |0;dojo.html;3129.327194653149;3155.3846999835027;3185.1877771168347;3190.9680903190974;3192.489201727724;6182.505399568035;6264.154339164217;6285.560010799246;6306.180196574444;6411.551191416603;6248.156498872662;6292.339304373044;6328.746850126001;6332.905006424908;6349.301576826545;5777.017906955806;5789.9710501447435;5837.44544268296;5870.794522191724;5893.469587737103;5805.332386775512;5876.030454974945;5881.5294776417995;5888.293404791431;5892.263467066617;5338.306020217386;5567.693776842272;5719.828405147831;5873.236479257712;5896.734646940877;5781.595288329819;5816.040353341694;5886.05823068307;5888.470037696585;5891.3814049525035;5656.377798442168;5696.857578560528;5770.278715160605;5833.979053665592;5845.561582881301;6234.812955611339;6244.656543890084;6277.183966084425;6278.623282603058;6330.525210609177;6775.322467753234;6799.796006119825;6801.4898882584;6820.04519367289;6829.453643708541;6817.965910170417;6886.829239029377;6895.241523432469;6896.137982752156;6897;6225.906611400833;6306.810795676137;6314.368563143695;6349.396807303298;6410.455111315544;6770.5599136056;6827.726890924407;6828.180618325733;6833.077534532874;6881.346272104242;6515.250746164157;6548.116004339353;6563.737450502022;6575.80272591823;6580.605163690194;6763.154605674291;6790.422814060761;6802.93197068023;6849.863002739918;6859.519833611599;6701.865962680719;6706.329367063352;6707.0610114584;6780.694868730919;6801.42187914023;6587.143671322698;6648.33516648341;6650.268470468244;6690.364415380531;6696.63168525726;5130.948690513122;5199.844004679866;5208.270842082112;5268.947310526923;5336.226247194135;4590.862274131781;4629.398178236875;4639.8144074237325;4640.744759038218;4669.719816811003;5819.767209311664;5860.941390586125;5934.347221805598;5940.732667029907;5943.316518600416;6796.4562834973085;6796.898046529306;6797.218319893177;6873.965630171917;6892.104026476626;5827.941720582825;5890.587658863838;5910.645361278337;5915.792947246826;5917.082852157922;5776.653400795965;5790.884182316414;5809.157672137601;5855.473007429352;5883.235179426732;6422.775202867877;6531.967340163269;6537.182852143482;6617.834554136089;6621.503387245976;6727.394534491821;6835.350641689031;6838.589684618939;6839.487038472234;6840.41856442208;6570.638614876228;6588.209414870246;6664.76673316451;6682.131322927989;6684.565503242274;6662.034005069141;6679.9332006679315;6681.5656982296;6746.628935408599;6761.256261811099;6662.467002639874;6744.393004629607;6784.59292442455;6871.553349032297;6890.724371025103;6601.669916504059;6622.37087476689;6654.800355989328;6670.599764014175;6674.83312917181;6491.578047426902;6595.076689263411;6668.399844014062;6678.56589321712;6684.398404143456;6367.458766004941;6452.580582262138;6467.126937863328;6471.126397936218;6477.967610162107;6576.473882089325;6595.406413422815;6616.4045235929;6631.237407698177;6703.4302084321425;6444.323346048597;6498.252700939453;6521.836954076186;6523.902141467976;6528.086067950586 16:52:53 INFO - PID 24857 | |1;ext.html;722.122621015466;742.4172024960408;773.3156156801231;790.5217343507178;799.380480127901;38140.80929595351;38927.61072389275;38938.415923761095;38959;39031;36308.63691363086;36601.45097823535;36636;36652.63347366526;36672.08319792007;7024.262452442496;7164.928350716505;7168.175659799112;7173.10336207974;7173.569585824841;6889.276625954278;6959.269276725947;7000.5449645773115;7001;7001.439884809229;6953.304669533031;6994;6996.195437524699;6997;7018.227994920555;6892.689828957709;6953.026576279325;6957.06079679247;6960.303969603025;6994.755183568576;6278.183836101323;6356.555041147121;6358.841028974266;6361.713722882481;6366.87266254677;32235.677643223502;32428;32428.054316741072;32441.6755832441;32509.187270318194;3363.2768954674616;3386.3904497190497;3386.881459148918;3387.424137896539;3388.15296175956;26278.343041423926;26310.73689263102;26393.20820375392;26421.603675944683;26443.735562644513;4449.9777501112285;4479.126570318789;4508.61676757476;4548.454185497729;4588.082383523309;186337;188478;188966;189642.05178974156;189958;19763.703544446846;19775.802241977683;19777.4066777994;19818.504537386394;44959.77520112378;46965.76517117461;47140.7642961783;47322.290165647544;47409.525904741204;47519.5248047522;14843.406263749544;14950.327235274439;14968.251587420804;15023.09861408319;15032.774508382383;12347.506099756089;12443.688907777378;12445.502179912703;12447.93776031114;12471.127021108436;14056.508022219377;14120.152790832582;14131.78802317966;14264.144151350953;14285.428582856777;5641.153826925994;5732.541396688255;5798.681072540966;5850.853728656818;5943.791967281211;1001.1440218613127;1017.7506510904876;1020.6325722739808;1031.9690409287734;1046.1055797293357;22553.774462255496;22608.660870086962;22708.545829083327;22826.315210543376;23150.1897433589;1121.450489260273;1122.1920217443428;1127.610974213895;1137.6188976692736;1139.3448766958866;12037;12091;12264.693382665326;12272.202306850026;12367.814482782765;226852;226953;227482;227709;228712;49146;49918.25122623164;50105.498945010084;52616.736916315174;52625;1408.7041721238654;1449.326063380512;1451.013310948544;1452.3827373366278;1456.7377871982933;26257.868710656323;26287.211383657756;26348.341291467867;26366;26398.86800565985;33118;33431.66568334286;33439.16402089967;33448.66551334455;33465;205721;205943;206356;206614;207080;33352.1661958453;33451.66548334583;33501;33785.66214337825;33858.32283354369;39060.80469597634;40178.799106004284;40559.594404055584;40706.38940415837;40816.59183408128;29663.703362966957;30012.099637010924;30271.394572108875;30342.393152136392;30671;29375.265618359714;29717.554236686035;29832.552511712776;29919;29920.551191731705;33423.83288083544;33526.497102543966;33877.66122338745;33982.49026264559;33988.15029624279;28697.42605147927;28886.566701499072;29098.854505727337;29295.560566591943;29502.85248573829;22038.88980555087;22328.21851235199;22431.21490747816;22439.32682019477;22716 16:52:53 INFO - PID 24857 | |2;jquery.html;549.2639862584136;568.7582777319639;575.6114622629726;592.451981916727;595.5057302438976;21950.89024554877;22766.772332276672;22805.543889122207;22815.543689126207;22833.771662283372;22867.31398058061;23553.29340119795;24182;24548.263552093467;24635.260942171717;6511.316311787254;6706.497012724041;6716.764913228038;6719.462443004572;6723.8319042024095;6576.0793488911595;6682.766103186389;6685.598864068147;6688.163979502562;6691.498137639672;6374.394432528902;6660.200775906898;6660.433863121641;6667.69995350208;6668.566543174702;6622.966885165568;6662.533622646417;6676.799696009103;6689.264180940093;6689.364510371507;6212.87574248517;6214;6541.803745887631;6853.657317134173;6905.033295338657;29237.70762292371;29617;29617;29640.851795740884;29676.258093547618;2105.1684584589157;2114.545372744867;2124.4264048706764;2128.446603882986;2137.326742076241;19746.407607771645;19788.80211197884;20127.899360503252;20173.394798156078;20629.17483300681;2377.6076947303673;2465.90136394544;2469.407342237868;2613.0592986525025;2656.6413534172834;127184.36407817902;133502;145438;146223;151517.24241378834;20373;20541.281055163;21533;22094.558108837733;22111;41541.1691766169;41693.58306416958;41734.582654173675;41753.582464175575;41788.16423671509;11196.328220306645;11401.885981140249;11452.484638191301;11505.367204803817;11594.130440216848;9412.294077944181;9442.763930901783;9464.391053520918;9517.23862091031;9672.22622190223;11147.498362573542;11181.385023823768;11308.378039207922;11310.434478276053;11489.597864074718;4026.651216685972;4117.423560701504;4368.213721530092;4415.889602759957;4468.664850136252;935.733316004949;939.455116032713;952.7951490429591;961.1061712607342;964.4046120237076;18733.625327493646;18772.81227187738;18786.71819922675;18908.054597270082;19465.221391144194;976.682578162086;1011.8431643095332;1014.2950649298666;1019.6278358399131;1021.4790456867051;10240.231982601335;10385.376877387382;10541.314814537183;10587.57649694019;10678.359298442118;459748;473592;479939;480544;481829;113178.43410782893;114119;114787;115468.42265788617;116826;1128.683968488841;1132.3488993828582;1154.8498695169574;1159.6231224851788;1169.9473523691454;16845.831541684427;16964.98210107348;16988.725845561385;17362.39231626887;17465.738013929546;53269;54647.726761365935;55167.172492411846;55201;55295.72352138213;69151;69980;71151.28848711446;71322;71372;18213.180406881987;18493.260269589067;18655.90672046631;18667.81332186715;18797.624047519246;21387.7861221392;21777.564448711255;21854.235101771363;21877.343679689635;22119.77880221177;17421.39025134114;17537.473875783748;17556.473305800846;17715;17798.46604601864;15762.133082680104;16101.436449724204;16159.59601009937;16177.919110404373;16237.67524649524;16641.66716665684;17683.38108166208;17875.553111172325;18038;18086.638267234845;18605;18763.812361876207;18819.435416937515;18841.623167536847;18856.905715471334;17183.31266749316;17282.827171728626;17317.78775485704;17331.30674772995;17395.91302043482 16:52:53 INFO - PID 24857 | |3;mootools.html;1332.1407692038636;1383.3498255819768;1384.204082652475;1404.9719005619882;1405.4027038508632;14730.116193028412;15422.228888555555;15430.537083887473;15472.303746331414;15497.225138743073;15237.314320855561;15355.616109597266;15362.308696108674;15375.769363459556;15376.000559963622;2718.8912443502286;2825.4631619992238;2825.477286701967;2827.1235916865735;2827.5758636204528;2650.191691534081;2782.0123856031123;2782.1514438096374;2782.4156927045346;2786.9303267418272;2684.986575067122;2795.6784969728537;2799.5660672595677;2801.243664210662;2801.285672153598;2800.4399120176045;2804.733550312717;2840.4177143685597;2845.4166895786316;2848.230977636037;2711.91864244073;2749.092799376201;2770.1827960751625;2771.6673999120035;2774.3480282133683;14755.704885902329;14825.18461484618;14867.776983345258;14891.70216595662;14905.776413353808;7723.884141737878;7968.561729104897;8000.119986801447;8017.037955445326;8041.9947506561675;5329.653572517813;5477.7261136943;5551.361593416728;5659.4340565943485;5694.2312787773535;1968.7539057617798;2010.698395240711;2013.8489613279062;2041.061111888533;2041.9897900510402;26125.608115878276;26523.469530609473;26548;26705.732942670715;26753.197404077713;6833.3166683332265;7027.15674119109;7056.470764692566;7163.964180179066;7210.819729506804;17522.21150048251;17561.209745561482;17592.472225833244;17600;17601.647967040844;8011.359091272684;8096.595170241464;8168.224018718212;8173.305269052078;8175.14161013097;7276.599787011765;7413.666385012687;7493.625318734042;7496.100467943882;7502.549847009197;5136.691798492103;5307.230451584576;5308;5333.439988801198;5336.679799211982;1499.5856670760068;1503.4286970950968;1505.2624214134994;1509.3283488847358;1534.7237497250603;878.3895192841042;896.3411892259185;901.0178904993588;903.8553831386946;904.1907492794044;7389.741359052515;7494.6627401767055;7497.550146991198;7499.400047996147;7591.430642701819;725.8330583965612;725.9963700181465;734.6069852628818;738.9298016688406;749.7300971650202;4577.656675749332;4813.9037219255415;4821.132196204647;5019.974900125549;5253.080710875582;20514.487137821674;21181.894090529448;21906.23328183506;21916.780832191474;22009.22967696123;21242;21310;21538.246161384275;21634.78365216359;21809.67285490719;10698.251122421356;11110.222284440173;11144.498497567629;11178;11272.436378181223;7935.920640793518;8054.959725201336;8085.514869107872;8103.959480202797;8177.509349439053;18087.457376278733;18582.349617763855;19078.904605476884;19120;19238.134283957537;19087.713684294467;19133.043347832274;19251.614967700287;19262;19326;11047.558097676325;11172.720681983015;11290.774184516427;11296.6046188383;11311.490982905625;13663.38514766818;13732.107413018122;13881.305934703427;13896.930515347358;13917.72164556683;11285;11321.603743868925;11347.54609815598;11560.132990025613;11728.765424691288;11199.72000699989;11211.60759373418;11329.320240785579;11434.942825286153;11610.361430121424;10026.548805303633;10194.490275486047;10213.029762172582;10217.080462758388;10239.18086553059;6945.756898508528;6964.547304425196;6971.233164352018;7023.543469674455;7035;7200.423966082596;7219.061522002106;7273.527220730635;7282.235365286569;7296.160941491584 16:52:53 INFO - PID 24857 | |4;prototype.html;506.4555602727069;511.91041567725637;534.1213703457814;537.0735481294766;543.139124487687;6103.603265787726;6122;6135.263768347793;6158.322584515699;6259.655718935457;6043.395660433955;6099.7865074722395;6104.725287362068;6123.571350005502;6133.681258529416;5109.514596113363;5190.584753219733;5215.348081489814;5266.631335806495;5284.863754292826;5279.445658205891;5282.286891269687;5317.404778566434;5333.973330133344;5360.785568577272;5256.553192978601;5272;5296.066935568509;5304.310439642841;5309.973450132763;5256.185291279858;5264.684118952837;5292.761825717833;5356.491133342326;5372.167314066287;4982.177940639826;5000.524950129732;5002.324686167357;5010.198368261061;5023.246513023039;6193.1639228704;6228.252609686867;6332.746690132389;6348.269948955883;6349.904751428732;5952.523798096186;5964.582479226413;5997.700114994276;6032.638041717511;6059.151718759377;6479.449246814026;6554.803355899283;6609;6620.56966297194;6634.767783127568;5268.657537260104;5290.312259406291;5293.7353132343615;5326.414094449608;5357.7589008494715;6778.254392016875;6851.4518838493295;6931.792046238621;6954.860902781967;6963.825904352381;5550.694711790809;5556.194351818964;5564.940971840364;5569.248151499577;5589.74846131925;5564.777408903598;5599.412061733459;5661.065924122474;5663.122216056518;5672;5688.715564221772;5841.795537156179;5919.585629006015;5971.223740913653;5981.252343457068;6190.721417536221;6517.967410162919;6564.212294524687;6591.978243372285;6642.800715978528;1918.788933217345;1928.7974762650001;1938.340964072194;1939.2533874458436;1949.103412430298;1419.1556024165604;1428.2144820348767;1439.5465428390023;1448.3989144505124;1474.8451412601523;5667.1782591524;5674.687892165888;5676.829695109153;5741.425857414225;5820.650760954356;6588.934110658928;6711.6979735912;6735.911867321146;6772.255051944282;6805;5808.477237048686;5819.156222347736;5832.387599302097;5833.366657335952;5844.772597754434;3544.556930383702;3554.7867127972404;3569.196930690574;3598.7660802047785;3604.693601043888;6370.267419246753;6425.935740642533;6449.806505804833;6450.935490645127;6532.150820393318;6848.7260509580055;6853.246142924274;6869.210040845367;6876.96845473173;6908.447324214151;6383.425491705769;6443.548951573345;6523.478121750249;6532.346765323429;6558.114654521769;6452.35476452351;6486.740530378732;6546.476281897341;6612.338766123542;6629.966850165718;6545.14913061299;6569.24453687832;6586.407223349922;6658.63377514222;6669.7665581704405;6534.934650653433;6536.607803531803;6584.934150658623;6590.670466476753;6612.272650008399;5461.918071228855;5482.903419316073;5507.118860982224;5531.230006397914;5532.197831314517;6272.2159730033745;6522.380373864476;6688.665566721742;6708.966455167693;6717.56335838169;6351.872962540816;6527.640979746159;6527.804165875032;6537.738490460329;6538.117354157128;6391.2104610709075;6445.2265728112925;6480.967595161994;6507.869842603216;6584.341565843569;6181.381861813783;6344.809655710336;6361.650109244036;6411.679416029273;6484.935150648433;6410.326915673973;6413.294537600954;6442.452391546771;6579;6589.902745709509;6259.561830671809;6274.937250627618;6317.842053948504;6378.138951241523;6448.419642232034 16:52:53 INFO - PID 24857 | |5;yui.html;920.7191806499015;933.4446004627247;942.7360339105053;948.3314263444272;961.6778379242953;18295.451136465894;18942.242310307607;18946.24215031397;18952;18966;18529.536761580966;18630.813691863077;18722.71915921259;18787.90606046971;18832.90583547084;954.346272803132;972.2367941166186;975.8633791269228;976.3117002513211;976.8827740671129;974.9707508774748;987.6247026130061;988.4020167798486;990.1781521337273;990.3661656539784;944.4286206844863;992.00303694787;1035.7824856780048;1037.9948100259487;1043.7599352149011;1026.6560702164747;1041.8228901086757;1042.6298663974333;1043.2332235806675;1043.373975614629;723.1936390924081;760.1372442277999;761.9314261716472;762.0969151555424;763.3358977689446;19180.040997950186;19187.232510699694;19211.32760353381;19215.423537293904;19254.80745192544;21701.891490542603;21990.780092199035;22313.665295020586;22770.430739231488;22870.085196592117;16511.504654860255;16680;16863.07253101079;16937.40719074839;17115.828841711547;3815.3704638734575;3826.253880493305;3835.386338185877;3842.4044273137706;3845.8846234612724;102777;140285;140491;141299;142839;17954.5511362217;18210.08949552517;18226.544336391697;18477.445676629723;18549.81450185508;32173.356532869213;32848.83575582107;32972.17569560732;32990.83504582462;32991;8848.070952550019;9057.230135438429;9088.772780680536;9118.088191180961;9150.40522366044;4267.359896015622;4381.9342709859375;4409.404730361424;4419.889502762457;4450.6884518083425;5351.785928562814;5396.163594642837;5464.371597266365;5497.285352904177;5497.285352904177;1067.5783065689166;1091.6288461922984;1092.5192915117323;1096.2545469081101;1096.5010920031366;648.5524987758431;662.1524448705665;672.7779832655212;677.8983152527161;685.2222727204659;11946.163768536293;12056.758864822654;12092.57675981354;12222.877771222351;12338.753224935452;611.9388061193933;631.2330518420141;635.2694401438383;637.6461064109463;638.450932198309;5289.153735402318;5410.1343784994215;5471.23402723619;5578.748956296977;5592.664440133605;123537.38231308966;123673.38163309125;123724;124414;130074.34962825125;106032.93967060231;110450.44774776074;112329.43835280772;113283;115618;98654;101511;101757;102367;103680;9958.751031224278;10082.344647597884;10191.84712229332;10210.795784084425;10474.581016759244;43881;44726;44865.551344487445;45059.54940450554;45824;55498;56428.15357769555;56834;57031;57975.71012145081;15998.280077396312;16342.591435214215;16376.426825061066;16490.58773530671;16543.503694889172;17815.821841781417;17868.55328616795;17882.91058544699;17999.820001799813;18087.36694215696;14758.114513128818;14813.259337033322;14911.25443727831;15011.699766004836;15218.847811521742;16375.836241637431;16480.258388372313;16566.50300490987;16754.832451675327;16762.32950681959;16811.579710506845;16846.66306673835;16849.15754212309;16902.154892255585;16925;10590.8411373831;10778.946105269424;11002.33985960845;11172.162087843606;11270.154738394489;11133.220674553027;11147.72130696739;11293.661190164308;11351.205415620827;11422.771544568895 16:52:53 INFO - PID 24857 | __end_tp_report 16:52:53 INFO - PID 24857 | __start_cc_report 16:52:53 INFO - PID 24857 | _x_x_mozilla_cycle_collect,304 16:52:53 INFO - PID 24857 | __end_cc_report 16:52:53 INFO - PID 24857 | __startTimestamp1506815573706__endTimestamp 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | ------- Summary: start ------- 16:52:53 INFO - PID 24857 | Number of tests: 6 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#0] dojo.html Cycles:165 Average:6220.82 Median:6491.58 stddev:750.96 (11.6%) stddev-sans-first:713.03 16:52:53 INFO - PID 24857 | Values: 3129.3 3155.4 3185.2 3191.0 3192.5 6182.5 6264.2 6285.6 6306.2 6411.6 6248.2 6292.3 6328.7 6332.9 6349.3 5777.0 5790.0 5837.4 5870.8 5893.5 5805.3 5876.0 5881.5 5888.3 5892.3 5338.3 5567.7 5719.8 5873.2 5896.7 5781.6 5816.0 5886.1 5888.5 5891.4 5656.4 5696.9 5770.3 5834.0 5845.6 6234.8 6244.7 6277.2 6278.6 6330.5 6775.3 6799.8 6801.5 6820.0 6829.5 6818.0 6886.8 6895.2 6896.1 6897.0 6225.9 6306.8 6314.4 6349.4 6410.5 6770.6 6827.7 6828.2 6833.1 6881.3 6515.3 6548.1 6563.7 6575.8 6580.6 6763.2 6790.4 6802.9 6849.9 6859.5 6701.9 6706.3 6707.1 6780.7 6801.4 6587.1 6648.3 6650.3 6690.4 6696.6 5130.9 5199.8 5208.3 5268.9 5336.2 4590.9 4629.4 4639.8 4640.7 4669.7 5819.8 5860.9 5934.3 5940.7 5943.3 6796.5 6796.9 6797.2 6874.0 6892.1 5827.9 5890.6 5910.6 5915.8 5917.1 5776.7 5790.9 5809.2 5855.5 5883.2 6422.8 6532.0 6537.2 6617.8 6621.5 6727.4 6835.4 6838.6 6839.5 6840.4 6570.6 6588.2 6664.8 6682.1 6684.6 6662.0 6679.9 6681.6 6746.6 6761.3 6662.5 6744.4 6784.6 6871.6 6890.7 6601.7 6622.4 6654.8 6670.6 6674.8 6491.6 6595.1 6668.4 6678.6 6684.4 6367.5 6452.6 6467.1 6471.1 6478.0 6576.5 6595.4 6616.4 6631.2 6703.4 6444.3 6498.3 6521.8 6523.9 6528.1 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#1] ext.html Cycles:180 Average:35762.15 Median:32428.03 stddev:54012.38 (166.6%) stddev-sans-first:54099.82 16:52:53 INFO - PID 24857 | Values: 722.1 742.4 773.3 790.5 799.4 38140.8 38927.6 38938.4 38959.0 39031.0 36308.6 36601.5 36636.0 36652.6 36672.1 7024.3 7164.9 7168.2 7173.1 7173.6 6889.3 6959.3 7000.5 7001.0 7001.4 6953.3 6994.0 6996.2 6997.0 7018.2 6892.7 6953.0 6957.1 6960.3 6994.8 6278.2 6356.6 6358.8 6361.7 6366.9 32235.7 32428.0 32428.1 32441.7 32509.2 3363.3 3386.4 3386.9 3387.4 3388.2 26278.3 26310.7 26393.2 26421.6 26443.7 4450.0 4479.1 4508.6 4548.5 4588.1 186337.0 188478.0 188966.0 189642.1 189958.0 19763.7 19775.8 19777.4 19818.5 44959.8 46965.8 47140.8 47322.3 47409.5 47519.5 14843.4 14950.3 14968.3 15023.1 15032.8 12347.5 12443.7 12445.5 12447.9 12471.1 14056.5 14120.2 14131.8 14264.1 14285.4 5641.2 5732.5 5798.7 5850.9 5943.8 1001.1 1017.8 1020.6 1032.0 1046.1 22553.8 22608.7 22708.5 22826.3 23150.2 1121.5 1122.2 1127.6 1137.6 1139.3 12037.0 12091.0 12264.7 12272.2 12367.8 226852.0 226953.0 227482.0 227709.0 228712.0 49146.0 49918.3 50105.5 52616.7 52625.0 1408.7 1449.3 1451.0 1452.4 1456.7 26257.9 26287.2 26348.3 26366.0 26398.9 33118.0 33431.7 33439.2 33448.7 33465.0 205721.0 205943.0 206356.0 206614.0 207080.0 33352.2 33451.7 33501.0 33785.7 33858.3 39060.8 40178.8 40559.6 40706.4 40816.6 29663.7 30012.1 30271.4 30342.4 30671.0 29375.3 29717.6 29832.6 29919.0 29920.6 33423.8 33526.5 33877.7 33982.5 33988.2 28697.4 28886.6 29098.9 29295.6 29502.9 22038.9 22328.2 22431.2 22439.3 22716.0 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#2] jquery.html Cycles:180 Average:35213.91 Median:21914.12 stddev:80245.01 (366.2%) stddev-sans-first:80427.91 16:52:53 INFO - PID 24857 | Values: 549.3 568.8 575.6 592.5 595.5 21950.9 22766.8 22805.5 22815.5 22833.8 22867.3 23553.3 24182.0 24548.3 24635.3 6511.3 6706.5 6716.8 6719.5 6723.8 6576.1 6682.8 6685.6 6688.2 6691.5 6374.4 6660.2 6660.4 6667.7 6668.6 6623.0 6662.5 6676.8 6689.3 6689.4 6212.9 6214.0 6541.8 6853.7 6905.0 29237.7 29617.0 29617.0 29640.9 29676.3 2105.2 2114.5 2124.4 2128.4 2137.3 19746.4 19788.8 20127.9 20173.4 20629.2 2377.6 2465.9 2469.4 2613.1 2656.6 127184.4 133502.0 145438.0 146223.0 151517.2 20373.0 20541.3 21533.0 22094.6 22111.0 41541.2 41693.6 41734.6 41753.6 41788.2 11196.3 11401.9 11452.5 11505.4 11594.1 9412.3 9442.8 9464.4 9517.2 9672.2 11147.5 11181.4 11308.4 11310.4 11489.6 4026.7 4117.4 4368.2 4415.9 4468.7 935.7 939.5 952.8 961.1 964.4 18733.6 18772.8 18786.7 18908.1 19465.2 976.7 1011.8 1014.3 1019.6 1021.5 10240.2 10385.4 10541.3 10587.6 10678.4 459748.0 473592.0 479939.0 480544.0 481829.0 113178.4 114119.0 114787.0 115468.4 116826.0 1128.7 1132.3 1154.8 1159.6 1169.9 16845.8 16965.0 16988.7 17362.4 17465.7 53269.0 54647.7 55167.2 55201.0 55295.7 69151.0 69980.0 71151.3 71322.0 71372.0 18213.2 18493.3 18655.9 18667.8 18797.6 21387.8 21777.6 21854.2 21877.3 22119.8 17421.4 17537.5 17556.5 17715.0 17798.5 15762.1 16101.4 16159.6 16177.9 16237.7 16641.7 17683.4 17875.6 18038.0 18086.6 18605.0 18763.8 18819.4 18841.6 18856.9 17183.3 17282.8 17317.8 17331.3 17395.9 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#3] mootools.html Cycles:180 Average:9342.34 Median:14719.09 stddev:6689.10 (45.4%) stddev-sans-first:6680.79 16:52:53 INFO - PID 24857 | Values: 1332.1 1383.3 1384.2 1405.0 1405.4 14730.1 15422.2 15430.5 15472.3 15497.2 15237.3 15355.6 15362.3 15375.8 15376.0 2718.9 2825.5 2825.5 2827.1 2827.6 2650.2 2782.0 2782.2 2782.4 2786.9 2685.0 2795.7 2799.6 2801.2 2801.3 2800.4 2804.7 2840.4 2845.4 2848.2 2711.9 2749.1 2770.2 2771.7 2774.3 14755.7 14825.2 14867.8 14891.7 14905.8 7723.9 7968.6 8000.1 8017.0 8042.0 5329.7 5477.7 5551.4 5659.4 5694.2 1968.8 2010.7 2013.8 2041.1 2042.0 26125.6 26523.5 26548.0 26705.7 26753.2 6833.3 7027.2 7056.5 7164.0 7210.8 17522.2 17561.2 17592.5 17600.0 17601.6 8011.4 8096.6 8168.2 8173.3 8175.1 7276.6 7413.7 7493.6 7496.1 7502.5 5136.7 5307.2 5308.0 5333.4 5336.7 1499.6 1503.4 1505.3 1509.3 1534.7 878.4 896.3 901.0 903.9 904.2 7389.7 7494.7 7497.6 7499.4 7591.4 725.8 726.0 734.6 738.9 749.7 4577.7 4813.9 4821.1 5020.0 5253.1 20514.5 21181.9 21906.2 21916.8 22009.2 21242.0 21310.0 21538.2 21634.8 21809.7 10698.3 11110.2 11144.5 11178.0 11272.4 7935.9 8055.0 8085.5 8104.0 8177.5 18087.5 18582.3 19078.9 19120.0 19238.1 19087.7 19133.0 19251.6 19262.0 19326.0 11047.6 11172.7 11290.8 11296.6 11311.5 13663.4 13732.1 13881.3 13896.9 13917.7 11285.0 11321.6 11347.5 11560.1 11728.8 11199.7 11211.6 11329.3 11434.9 11610.4 10026.5 10194.5 10213.0 10217.1 10239.2 6945.8 6964.5 6971.2 7023.5 7035.0 7200.4 7219.1 7273.5 7282.2 7296.2 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#4] prototype.html Cycles:180 Average:5626.57 Median:6128.63 stddev:1476.36 (24.1%) stddev-sans-first:1429.61 16:52:53 INFO - PID 24857 | Values: 506.5 511.9 534.1 537.1 543.1 6103.6 6122.0 6135.3 6158.3 6259.7 6043.4 6099.8 6104.7 6123.6 6133.7 5109.5 5190.6 5215.3 5266.6 5284.9 5279.4 5282.3 5317.4 5334.0 5360.8 5256.6 5272.0 5296.1 5304.3 5310.0 5256.2 5264.7 5292.8 5356.5 5372.2 4982.2 5000.5 5002.3 5010.2 5023.2 6193.2 6228.3 6332.7 6348.3 6349.9 5952.5 5964.6 5997.7 6032.6 6059.2 6479.4 6554.8 6609.0 6620.6 6634.8 5268.7 5290.3 5293.7 5326.4 5357.8 6778.3 6851.5 6931.8 6954.9 6963.8 5550.7 5556.2 5564.9 5569.2 5589.7 5564.8 5599.4 5661.1 5663.1 5672.0 5688.7 5841.8 5919.6 5971.2 5981.3 6190.7 6518.0 6564.2 6592.0 6642.8 1918.8 1928.8 1938.3 1939.3 1949.1 1419.2 1428.2 1439.5 1448.4 1474.8 5667.2 5674.7 5676.8 5741.4 5820.7 6588.9 6711.7 6735.9 6772.3 6805.0 5808.5 5819.2 5832.4 5833.4 5844.8 3544.6 3554.8 3569.2 3598.8 3604.7 6370.3 6425.9 6449.8 6450.9 6532.2 6848.7 6853.2 6869.2 6877.0 6908.4 6383.4 6443.5 6523.5 6532.3 6558.1 6452.4 6486.7 6546.5 6612.3 6630.0 6545.1 6569.2 6586.4 6658.6 6669.8 6534.9 6536.6 6584.9 6590.7 6612.3 5461.9 5482.9 5507.1 5531.2 5532.2 6272.2 6522.4 6688.7 6709.0 6717.6 6351.9 6527.6 6527.8 6537.7 6538.1 6391.2 6445.2 6481.0 6507.9 6584.3 6181.4 6344.8 6361.7 6411.7 6484.9 6410.3 6413.3 6442.5 6579.0 6589.9 6259.6 6274.9 6317.8 6378.1 6448.4 16:52:53 INFO - PID 24857 | 16:52:53 INFO - PID 24857 | [#5] yui.html Cycles:180 Average:24551.24 Median:18810.41 stddev:35592.43 (189.2%) stddev-sans-first:35648.05 16:52:53 INFO - PID 24857 | Values: 920.7 933.4 942.7 948.3 961.7 18295.5 18942.2 18946.2 18952.0 18966.0 18529.5 18630.8 18722.7 18787.9 18832.9 954.3 972.2 975.9 976.3 976.9 975.0 987.6 988.4 990.2 990.4 944.4 992.0 1035.8 1038.0 1043.8 1026.7 1041.8 1042.6 1043.2 1043.4 723.2 760.1 761.9 762.1 763.3 19180.0 19187.2 19211.3 19215.4 19254.8 21701.9 21990.8 22313.7 22770.4 22870.1 16511.5 16680.0 16863.1 16937.4 17115.8 3815.4 3826.3 3835.4 3842.4 3845.9 102777.0 140285.0 140491.0 141299.0 142839.0 17954.6 18210.1 18226.5 18477.4 18549.8 32173.4 32848.8 32972.2 32990.8 32991.0 8848.1 9057.2 9088.8 9118.1 9150.4 4267.4 4381.9 4409.4 4419.9 4450.7 5351.8 5396.2 5464.4 5497.3 5497.3 1067.6 1091.6 1092.5 1096.3 1096.5 648.6 662.2 672.8 677.9 685.2 11946.2 12056.8 12092.6 12222.9 12338.8 611.9 631.2 635.3 637.6 638.5 5289.2 5410.1 5471.2 5578.7 5592.7 123537.4 123673.4 123724.0 124414.0 130074.3 106032.9 110450.4 112329.4 113283.0 115618.0 98654.0 101511.0 101757.0 102367.0 103680.0 9958.8 10082.3 10191.8 10210.8 10474.6 43881.0 44726.0 44865.6 45059.5 45824.0 55498.0 56428.2 56834.0 57031.0 57975.7 15998.3 16342.6 16376.4 16490.6 16543.5 17815.8 17868.6 17882.9 17999.8 18087.4 14758.1 14813.3 14911.3 15011.7 15218.8 16375.8 16480.3 16566.5 16754.8 16762.3 16811.6 16846.7 16849.2 16902.2 16925.0 10590.8 10778.9 11002.3 11172.2 11270.2 11133.2 11147.7 11293.7 11351.2 11422.8 16:52:53 INFO - PID 24857 | -------- Summary: end -------- 16:52:53 INFO - PID 24857 | 16:52:54 INFO - TEST-INFO | 24857: exit 0 16:52:54 INFO - TEST-OK | dromaeo_css | took 1109137ms 16:52:54 INFO - TEST-START | kraken 16:52:54 INFO - Initialising browser for kraken test... 16:52:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42805/getInfo.html -profile /tmp/tmpMGFvfF/profile 16:52:54 INFO - TEST-INFO | started process 25216 (/builds/slave/test/build/application/firefox/firefox http://localhost:42805/getInfo.html) 16:53:00 INFO - TEST-INFO | 25216: exit 0 16:53:00 INFO - Browser initialized. 16:53:00 INFO - Running cycle 1/1 for kraken test... 16:53:00 INFO - Using env: {'DISPLAY': ':0', 16:53:00 INFO - 'HOME': '/home/cltbld', 16:53:00 INFO - 'JSGC_DISABLE_POISONING': '1', 16:53:00 INFO - 'LANG': 'en_US.UTF-8', 16:53:00 INFO - 'LANGUAGE': 'en_US:en', 16:53:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:53:00 INFO - 'LOGNAME': 'cltbld', 16:53:00 INFO - 'MAIL': '/var/mail/cltbld', 16:53:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:00 INFO - 'MOZ_CRASHREPORTER': '1', 16:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:53:00 INFO - 'MOZ_NO_REMOTE': '1', 16:53:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:00 INFO - 'NO_EM_RESTART': '1', 16:53:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:00 INFO - 'PWD': '/builds/slave/test', 16:53:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:00 INFO - 'RUST_BACKTRACE': 'full', 16:53:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:00 INFO - 'SHELL': '/bin/bash', 16:53:00 INFO - 'SHLVL': '1', 16:53:00 INFO - 'STYLO_FORCE_DISABLED': '1', 16:53:00 INFO - 'TERM': 'linux', 16:53:00 INFO - 'TMOUT': '86400', 16:53:00 INFO - 'USER': 'cltbld', 16:53:00 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861', 16:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:00 INFO - '_': '/tools/buildbot/bin/python'} 16:53:00 INFO - TEST-INFO | started process 25452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMGFvfF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:53:01 INFO - PID 25452 | 16:53:01 INFO - PID 25452 | (/builds/slave/test/build/application/firefox/firefox:25501): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:53:01 INFO - PID 25452 | 16:53:11 INFO - PID 25452 | RSS: Main: 152055808 16:53:11 INFO - PID 25452 | 16:53:14 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42805/tests/kraken/driver.html?testName=audio-beat-detection) 16:53:15 INFO - PID 25452 | RSS: Main: 158744576 16:53:15 INFO - PID 25452 | 16:53:17 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42805/tests/kraken/driver.html?testName=audio-dft) 16:53:18 INFO - PID 25452 | RSS: Main: 159047680 16:53:18 INFO - PID 25452 | 16:53:21 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42805/tests/kraken/driver.html?testName=audio-fft) 16:53:21 INFO - PID 25452 | RSS: Main: 154632192 16:53:21 INFO - PID 25452 | 16:53:24 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42805/tests/kraken/driver.html?testName=audio-oscillator) 16:53:24 INFO - PID 25452 | RSS: Main: 155226112 16:53:24 INFO - PID 25452 | 16:53:26 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:53:27 INFO - PID 25452 | RSS: Main: 155578368 16:53:27 INFO - PID 25452 | 16:53:30 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42805/tests/kraken/driver.html?testName=imaging-darkroom) 16:53:31 INFO - PID 25452 | RSS: Main: 157851648 16:53:31 INFO - PID 25452 | 16:53:34 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42805/tests/kraken/driver.html?testName=imaging-desaturate) 16:53:35 INFO - PID 25452 | RSS: Main: 158105600 16:53:35 INFO - PID 25452 | 16:53:38 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42805/tests/kraken/driver.html?testName=json-parse-financial) 16:53:39 INFO - PID 25452 | RSS: Main: 158257152 16:53:39 INFO - PID 25452 | 16:53:40 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:53:41 INFO - PID 25452 | RSS: Main: 158162944 16:53:41 INFO - PID 25452 | 16:53:42 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:53:43 INFO - PID 25452 | RSS: Main: 158261248 16:53:43 INFO - PID 25452 | 16:53:45 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:53:46 INFO - PID 25452 | RSS: Main: 154841088 16:53:46 INFO - PID 25452 | 16:53:48 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:53:49 INFO - PID 25452 | RSS: Main: 155746304 16:53:49 INFO - PID 25452 | 16:53:52 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:53:53 INFO - PID 25452 | RSS: Main: 155688960 16:53:53 INFO - PID 25452 | 16:53:54 INFO - PID 25452 | Cycle 1(1): loaded http://localhost:42805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42805/tests/kraken/driver.html?testName=ai-astar) 16:53:55 INFO - PID 25452 | RSS: Main: 157118464 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | __start_tp_report 16:53:55 INFO - PID 25452 | _x_x_mozilla_page_load 16:53:55 INFO - PID 25452 | _x_x_mozilla_page_load_details 16:53:55 INFO - PID 25452 | |i|pagename|runs| 16:53:55 INFO - PID 25452 | |0;ai-astar;111;107;108;109;107;109;109;108;109;109 16:53:55 INFO - PID 25452 | |1;audio-beat-detection;122;115;117;141;122;116;117;117;152;115 16:53:55 INFO - PID 25452 | |2;audio-dft;164;161;161;163;162;162;163;165;170;172 16:53:55 INFO - PID 25452 | |3;audio-fft;80;79;73;73;74;74;75;77;77;76 16:53:55 INFO - PID 25452 | |4;audio-oscillator;79;80;79;81;79;78;79;79;80;78 16:53:55 INFO - PID 25452 | |5;imaging-gaussian-blur;117;113;111;111;118;112;112;117;112;112 16:53:55 INFO - PID 25452 | |6;imaging-darkroom;152;148;149;149;149;148;150;151;149;149 16:53:55 INFO - PID 25452 | |7;imaging-desaturate;94;94;94;93;94;94;95;94;95;94 16:53:55 INFO - PID 25452 | |8;json-parse-financial;53;52;53;52;54;54;54;53;53;54 16:53:55 INFO - PID 25452 | |9;json-stringify-tinderbox;38;38;37;37;37;38;37;37;37;37 16:53:55 INFO - PID 25452 | |10;stanford-crypto-aes;73;75;72;74;75;74;74;76;74;76 16:53:55 INFO - PID 25452 | |11;stanford-crypto-ccm;110;110;116;108;117;117;112;115;109;115 16:53:55 INFO - PID 25452 | |12;stanford-crypto-pbkdf2;162;162;160;171;165;171;165;164;169;168 16:53:55 INFO - PID 25452 | |13;stanford-crypto-sha256-iterative;65;67;65;67;67;66;65;65;64;64 16:53:55 INFO - PID 25452 | __end_tp_report 16:53:55 INFO - PID 25452 | __start_cc_report 16:53:55 INFO - PID 25452 | _x_x_mozilla_cycle_collect,746 16:53:55 INFO - PID 25452 | __end_cc_report 16:53:55 INFO - PID 25452 | __startTimestamp1506815635034__endTimestamp 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | ------- Summary: start ------- 16:53:55 INFO - PID 25452 | Number of tests: 14 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.17 (1.1%) stddev-sans-first:0.87 16:53:55 INFO - PID 25452 | Values: 111.0 107.0 108.0 109.0 107.0 109.0 109.0 108.0 109.0 109.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:119.50 stddev:12.69 (10.6%) stddev-sans-first:13.45 16:53:55 INFO - PID 25452 | Values: 122.0 115.0 117.0 141.0 122.0 116.0 117.0 117.0 152.0 115.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.77 (2.3%) stddev-sans-first:4.00 16:53:55 INFO - PID 25452 | Values: 164.0 161.0 161.0 163.0 162.0 162.0 163.0 165.0 170.0 172.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#3] audio-fft Cycles:10 Average:75.80 Median:76.50 stddev:2.44 (3.2%) stddev-sans-first:2.06 16:53:55 INFO - PID 25452 | Values: 80.0 79.0 73.0 73.0 74.0 74.0 75.0 77.0 77.0 76.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 16:53:55 INFO - PID 25452 | Values: 79.0 80.0 79.0 81.0 79.0 78.0 79.0 79.0 80.0 78.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:112.50 stddev:2.72 (2.4%) stddev-sans-first:2.57 16:53:55 INFO - PID 25452 | Values: 117.0 113.0 111.0 111.0 118.0 112.0 112.0 117.0 112.0 112.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:0.93 16:53:55 INFO - PID 25452 | Values: 152.0 148.0 149.0 149.0 149.0 148.0 150.0 151.0 149.0 149.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:53:55 INFO - PID 25452 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 95.0 94.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 16:53:55 INFO - PID 25452 | Values: 53.0 52.0 53.0 52.0 54.0 54.0 54.0 53.0 53.0 54.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#9] json-stringify-tinderbox Cycles:10 Average:37.30 Median:37.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 16:53:55 INFO - PID 25452 | Values: 38.0 38.0 37.0 37.0 37.0 38.0 37.0 37.0 37.0 37.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:1.25 (1.7%) stddev-sans-first:1.24 16:53:55 INFO - PID 25452 | Values: 73.0 75.0 72.0 74.0 75.0 74.0 74.0 76.0 74.0 76.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#11] stanford-crypto-ccm Cycles:10 Average:112.90 Median:115.00 stddev:3.48 (3.0%) stddev-sans-first:3.53 16:53:55 INFO - PID 25452 | Values: 110.0 110.0 116.0 108.0 117.0 117.0 112.0 115.0 109.0 115.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.50 stddev:3.89 (2.3%) stddev-sans-first:3.89 16:53:55 INFO - PID 25452 | Values: 162.0 162.0 160.0 171.0 165.0 171.0 165.0 164.0 169.0 168.0 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.18 (1.8%) stddev-sans-first:1.24 16:53:55 INFO - PID 25452 | Values: 65.0 67.0 65.0 67.0 67.0 66.0 65.0 65.0 64.0 64.0 16:53:55 INFO - PID 25452 | -------- Summary: end -------- 16:53:55 INFO - PID 25452 | 16:53:55 INFO - PID 25452 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:53:55 INFO - TEST-INFO | 25452: exit 0 16:53:55 INFO - TEST-OK | kraken | took 61362ms 16:53:55 INFO - SUITE-END | took 1170s 16:53:56 INFO - Completed test suite (00:19:30) 16:53:56 INFO - javascript benchmark 16:53:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8530.455681986596, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.327194653149, 3155.3846999835027, 3185.1877771168347, 3190.9680903190974, 3192.489201727724, 6182.505399568035, 6264.154339164217, 6285.560010799246, 6306.180196574444, 6411.551191416603, 6248.156498872662, 6292.339304373044, 6328.746850126001, 6332.905006424908, 6349.301576826545, 5777.017906955806, 5789.9710501447435, 5837.44544268296, 5870.794522191724, 5893.469587737103, 5805.332386775512, 5876.030454974945, 5881.5294776417995, 5888.293404791431, 5892.263467066617, 5338.306020217386, 5567.693776842272, 5719.828405147831, 5873.236479257712, 5896.734646940877, 5781.595288329819, 5816.040353341694, 5886.05823068307, 5888.470037696585, 5891.3814049525035, 5656.377798442168, 5696.857578560528, 5770.278715160605, 5833.979053665592, 5845.561582881301, 6234.812955611339, 6244.656543890084, 6277.183966084425, 6278.623282603058, 6330.525210609177, 6775.322467753234, 6799.796006119825, 6801.4898882584, 6820.04519367289, 6829.453643708541, 6817.965910170417, 6886.829239029377, 6895.241523432469, 6896.137982752156, 6897.0, 6225.906611400833, 6306.810795676137, 6314.368563143695, 6349.396807303298, 6410.455111315544, 6770.5599136056, 6827.726890924407, 6828.180618325733, 6833.077534532874, 6881.346272104242, 6515.250746164157, 6548.116004339353, 6563.737450502022, 6575.80272591823, 6580.605163690194, 6763.154605674291, 6790.422814060761, 6802.93197068023, 6849.863002739918, 6859.519833611599, 6701.865962680719, 6706.329367063352, 6707.0610114584, 6780.694868730919, 6801.42187914023, 6587.143671322698, 6648.33516648341, 6650.268470468244, 6690.364415380531, 6696.63168525726, 5130.948690513122, 5199.844004679866, 5208.270842082112, 5268.947310526923, 5336.226247194135, 4590.862274131781, 4629.398178236875, 4639.8144074237325, 4640.744759038218, 4669.719816811003, 5819.767209311664, 5860.941390586125, 5934.347221805598, 5940.732667029907, 5943.316518600416, 6796.4562834973085, 6796.898046529306, 6797.218319893177, 6873.965630171917, 6892.104026476626, 5827.941720582825, 5890.587658863838, 5910.645361278337, 5915.792947246826, 5917.082852157922, 5776.653400795965, 5790.884182316414, 5809.157672137601, 5855.473007429352, 5883.235179426732, 6422.775202867877, 6531.967340163269, 6537.182852143482, 6617.834554136089, 6621.503387245976, 6727.394534491821, 6835.350641689031, 6838.589684618939, 6839.487038472234, 6840.41856442208, 6570.638614876228, 6588.209414870246, 6664.76673316451, 6682.131322927989, 6684.565503242274, 6662.034005069141, 6679.9332006679315, 6681.5656982296, 6746.628935408599, 6761.256261811099, 6662.467002639874, 6744.393004629607, 6784.59292442455, 6871.553349032297, 6890.724371025103, 6601.669916504059, 6622.37087476689, 6654.800355989328, 6670.599764014175, 6674.83312917181, 6491.578047426902, 6595.076689263411, 6668.399844014062, 6678.56589321712, 6684.398404143456, 6367.458766004941, 6452.580582262138, 6467.126937863328, 6471.126397936218, 6477.967610162107, 6576.473882089325, 6595.406413422815, 6616.4045235929, 6631.237407698177, 6703.4302084321425, 6444.323346048597, 6498.252700939453, 6521.836954076186, 6523.902141467976, 6528.086067950586], "value": 6163.193862263296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.122621015466, 742.4172024960408, 773.3156156801231, 790.5217343507178, 799.380480127901, 38140.80929595351, 38927.61072389275, 38938.415923761095, 38959.0, 39031.0, 36308.63691363086, 36601.45097823535, 36636.0, 36652.63347366526, 36672.08319792007, 7024.262452442496, 7164.928350716505, 7168.175659799112, 7173.10336207974, 7173.569585824841, 6889.276625954278, 6959.269276725947, 7000.5449645773115, 7001.0, 7001.439884809229, 6953.304669533031, 6994.0, 6996.195437524699, 6997.0, 7018.227994920555, 6892.689828957709, 6953.026576279325, 6957.06079679247, 6960.303969603025, 6994.755183568576, 6278.183836101323, 6356.555041147121, 6358.841028974266, 6361.713722882481, 6366.87266254677, 32235.677643223502, 32428.0, 32428.054316741072, 32441.6755832441, 32509.187270318194, 3363.2768954674616, 3386.3904497190497, 3386.881459148918, 3387.424137896539, 3388.15296175956, 26278.343041423926, 26310.73689263102, 26393.20820375392, 26421.603675944683, 26443.735562644513, 4449.9777501112285, 4479.126570318789, 4508.61676757476, 4548.454185497729, 4588.082383523309, 186337.0, 188478.0, 188966.0, 189642.05178974156, 189958.0, 19763.703544446846, 19775.802241977683, 19777.4066777994, 19818.504537386394, 44959.77520112378, 46965.76517117461, 47140.7642961783, 47322.290165647544, 47409.525904741204, 47519.5248047522, 14843.406263749544, 14950.327235274439, 14968.251587420804, 15023.09861408319, 15032.774508382383, 12347.506099756089, 12443.688907777378, 12445.502179912703, 12447.93776031114, 12471.127021108436, 14056.508022219377, 14120.152790832582, 14131.78802317966, 14264.144151350953, 14285.428582856777, 5641.153826925994, 5732.541396688255, 5798.681072540966, 5850.853728656818, 5943.791967281211, 1001.1440218613127, 1017.7506510904876, 1020.6325722739808, 1031.9690409287734, 1046.1055797293357, 22553.774462255496, 22608.660870086962, 22708.545829083327, 22826.315210543376, 23150.1897433589, 1121.450489260273, 1122.1920217443428, 1127.610974213895, 1137.6188976692736, 1139.3448766958866, 12037.0, 12091.0, 12264.693382665326, 12272.202306850026, 12367.814482782765, 226852.0, 226953.0, 227482.0, 227709.0, 228712.0, 49146.0, 49918.25122623164, 50105.498945010084, 52616.736916315174, 52625.0, 1408.7041721238654, 1449.326063380512, 1451.013310948544, 1452.3827373366278, 1456.7377871982933, 26257.868710656323, 26287.211383657756, 26348.341291467867, 26366.0, 26398.86800565985, 33118.0, 33431.66568334286, 33439.16402089967, 33448.66551334455, 33465.0, 205721.0, 205943.0, 206356.0, 206614.0, 207080.0, 33352.1661958453, 33451.66548334583, 33501.0, 33785.66214337825, 33858.32283354369, 39060.80469597634, 40178.799106004284, 40559.594404055584, 40706.38940415837, 40816.59183408128, 29663.703362966957, 30012.099637010924, 30271.394572108875, 30342.393152136392, 30671.0, 29375.265618359714, 29717.554236686035, 29832.552511712776, 29919.0, 29920.551191731705, 33423.83288083544, 33526.497102543966, 33877.66122338745, 33982.49026264559, 33988.15029624279, 28697.42605147927, 28886.566701499072, 29098.854505727337, 29295.560566591943, 29502.85248573829, 22038.88980555087, 22328.21851235199, 22431.21490747816, 22439.32682019477, 22716.0], "value": 15934.147324889056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.2639862584136, 568.7582777319639, 575.6114622629726, 592.451981916727, 595.5057302438976, 21950.89024554877, 22766.772332276672, 22805.543889122207, 22815.543689126207, 22833.771662283372, 22867.31398058061, 23553.29340119795, 24182.0, 24548.263552093467, 24635.260942171717, 6511.316311787254, 6706.497012724041, 6716.764913228038, 6719.462443004572, 6723.8319042024095, 6576.0793488911595, 6682.766103186389, 6685.598864068147, 6688.163979502562, 6691.498137639672, 6374.394432528902, 6660.200775906898, 6660.433863121641, 6667.69995350208, 6668.566543174702, 6622.966885165568, 6662.533622646417, 6676.799696009103, 6689.264180940093, 6689.364510371507, 6212.87574248517, 6214.0, 6541.803745887631, 6853.657317134173, 6905.033295338657, 29237.70762292371, 29617.0, 29617.0, 29640.851795740884, 29676.258093547618, 2105.1684584589157, 2114.545372744867, 2124.4264048706764, 2128.446603882986, 2137.326742076241, 19746.407607771645, 19788.80211197884, 20127.899360503252, 20173.394798156078, 20629.17483300681, 2377.6076947303673, 2465.90136394544, 2469.407342237868, 2613.0592986525025, 2656.6413534172834, 127184.36407817902, 133502.0, 145438.0, 146223.0, 151517.24241378834, 20373.0, 20541.281055163, 21533.0, 22094.558108837733, 22111.0, 41541.1691766169, 41693.58306416958, 41734.582654173675, 41753.582464175575, 41788.16423671509, 11196.328220306645, 11401.885981140249, 11452.484638191301, 11505.367204803817, 11594.130440216848, 9412.294077944181, 9442.763930901783, 9464.391053520918, 9517.23862091031, 9672.22622190223, 11147.498362573542, 11181.385023823768, 11308.378039207922, 11310.434478276053, 11489.597864074718, 4026.651216685972, 4117.423560701504, 4368.213721530092, 4415.889602759957, 4468.664850136252, 935.733316004949, 939.455116032713, 952.7951490429591, 961.1061712607342, 964.4046120237076, 18733.625327493646, 18772.81227187738, 18786.71819922675, 18908.054597270082, 19465.221391144194, 976.682578162086, 1011.8431643095332, 1014.2950649298666, 1019.6278358399131, 1021.4790456867051, 10240.231982601335, 10385.376877387382, 10541.314814537183, 10587.57649694019, 10678.359298442118, 459748.0, 473592.0, 479939.0, 480544.0, 481829.0, 113178.43410782893, 114119.0, 114787.0, 115468.42265788617, 116826.0, 1128.683968488841, 1132.3488993828582, 1154.8498695169574, 1159.6231224851788, 1169.9473523691454, 16845.831541684427, 16964.98210107348, 16988.725845561385, 17362.39231626887, 17465.738013929546, 53269.0, 54647.726761365935, 55167.172492411846, 55201.0, 55295.72352138213, 69151.0, 69980.0, 71151.28848711446, 71322.0, 71372.0, 18213.180406881987, 18493.260269589067, 18655.90672046631, 18667.81332186715, 18797.624047519246, 21387.7861221392, 21777.564448711255, 21854.235101771363, 21877.343679689635, 22119.77880221177, 17421.39025134114, 17537.473875783748, 17556.473305800846, 17715.0, 17798.46604601864, 15762.133082680104, 16101.436449724204, 16159.59601009937, 16177.919110404373, 16237.67524649524, 16641.66716665684, 17683.38108166208, 17875.553111172325, 18038.0, 18086.638267234845, 18605.0, 18763.812361876207, 18819.435416937515, 18841.623167536847, 18856.905715471334, 17183.31266749316, 17282.827171728626, 17317.78775485704, 17331.30674772995, 17395.91302043482], "value": 12621.325009457913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.1407692038636, 1383.3498255819768, 1384.204082652475, 1404.9719005619882, 1405.4027038508632, 14730.116193028412, 15422.228888555555, 15430.537083887473, 15472.303746331414, 15497.225138743073, 15237.314320855561, 15355.616109597266, 15362.308696108674, 15375.769363459556, 15376.000559963622, 2718.8912443502286, 2825.4631619992238, 2825.477286701967, 2827.1235916865735, 2827.5758636204528, 2650.191691534081, 2782.0123856031123, 2782.1514438096374, 2782.4156927045346, 2786.9303267418272, 2684.986575067122, 2795.6784969728537, 2799.5660672595677, 2801.243664210662, 2801.285672153598, 2800.4399120176045, 2804.733550312717, 2840.4177143685597, 2845.4166895786316, 2848.230977636037, 2711.91864244073, 2749.092799376201, 2770.1827960751625, 2771.6673999120035, 2774.3480282133683, 14755.704885902329, 14825.18461484618, 14867.776983345258, 14891.70216595662, 14905.776413353808, 7723.884141737878, 7968.561729104897, 8000.119986801447, 8017.037955445326, 8041.9947506561675, 5329.653572517813, 5477.7261136943, 5551.361593416728, 5659.4340565943485, 5694.2312787773535, 1968.7539057617798, 2010.698395240711, 2013.8489613279062, 2041.061111888533, 2041.9897900510402, 26125.608115878276, 26523.469530609473, 26548.0, 26705.732942670715, 26753.197404077713, 6833.3166683332265, 7027.15674119109, 7056.470764692566, 7163.964180179066, 7210.819729506804, 17522.21150048251, 17561.209745561482, 17592.472225833244, 17600.0, 17601.647967040844, 8011.359091272684, 8096.595170241464, 8168.224018718212, 8173.305269052078, 8175.14161013097, 7276.599787011765, 7413.666385012687, 7493.625318734042, 7496.100467943882, 7502.549847009197, 5136.691798492103, 5307.230451584576, 5308.0, 5333.439988801198, 5336.679799211982, 1499.5856670760068, 1503.4286970950968, 1505.2624214134994, 1509.3283488847358, 1534.7237497250603, 878.3895192841042, 896.3411892259185, 901.0178904993588, 903.8553831386946, 904.1907492794044, 7389.741359052515, 7494.6627401767055, 7497.550146991198, 7499.400047996147, 7591.430642701819, 725.8330583965612, 725.9963700181465, 734.6069852628818, 738.9298016688406, 749.7300971650202, 4577.656675749332, 4813.9037219255415, 4821.132196204647, 5019.974900125549, 5253.080710875582, 20514.487137821674, 21181.894090529448, 21906.23328183506, 21916.780832191474, 22009.22967696123, 21242.0, 21310.0, 21538.246161384275, 21634.78365216359, 21809.67285490719, 10698.251122421356, 11110.222284440173, 11144.498497567629, 11178.0, 11272.436378181223, 7935.920640793518, 8054.959725201336, 8085.514869107872, 8103.959480202797, 8177.509349439053, 18087.457376278733, 18582.349617763855, 19078.904605476884, 19120.0, 19238.134283957537, 19087.713684294467, 19133.043347832274, 19251.614967700287, 19262.0, 19326.0, 11047.558097676325, 11172.720681983015, 11290.774184516427, 11296.6046188383, 11311.490982905625, 13663.38514766818, 13732.107413018122, 13881.305934703427, 13896.930515347358, 13917.72164556683, 11285.0, 11321.603743868925, 11347.54609815598, 11560.132990025613, 11728.765424691288, 11199.72000699989, 11211.60759373418, 11329.320240785579, 11434.942825286153, 11610.361430121424, 10026.548805303633, 10194.490275486047, 10213.029762172582, 10217.080462758388, 10239.18086553059, 6945.756898508528, 6964.547304425196, 6971.233164352018, 7023.543469674455, 7035.0, 7200.423966082596, 7219.061522002106, 7273.527220730635, 7282.235365286569, 7296.160941491584], "value": 6654.806975182498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.4555602727069, 511.91041567725637, 534.1213703457814, 537.0735481294766, 543.139124487687, 6103.603265787726, 6122.0, 6135.263768347793, 6158.322584515699, 6259.655718935457, 6043.395660433955, 6099.7865074722395, 6104.725287362068, 6123.571350005502, 6133.681258529416, 5109.514596113363, 5190.584753219733, 5215.348081489814, 5266.631335806495, 5284.863754292826, 5279.445658205891, 5282.286891269687, 5317.404778566434, 5333.973330133344, 5360.785568577272, 5256.553192978601, 5272.0, 5296.066935568509, 5304.310439642841, 5309.973450132763, 5256.185291279858, 5264.684118952837, 5292.761825717833, 5356.491133342326, 5372.167314066287, 4982.177940639826, 5000.524950129732, 5002.324686167357, 5010.198368261061, 5023.246513023039, 6193.1639228704, 6228.252609686867, 6332.746690132389, 6348.269948955883, 6349.904751428732, 5952.523798096186, 5964.582479226413, 5997.700114994276, 6032.638041717511, 6059.151718759377, 6479.449246814026, 6554.803355899283, 6609.0, 6620.56966297194, 6634.767783127568, 5268.657537260104, 5290.312259406291, 5293.7353132343615, 5326.414094449608, 5357.7589008494715, 6778.254392016875, 6851.4518838493295, 6931.792046238621, 6954.860902781967, 6963.825904352381, 5550.694711790809, 5556.194351818964, 5564.940971840364, 5569.248151499577, 5589.74846131925, 5564.777408903598, 5599.412061733459, 5661.065924122474, 5663.122216056518, 5672.0, 5688.715564221772, 5841.795537156179, 5919.585629006015, 5971.223740913653, 5981.252343457068, 6190.721417536221, 6517.967410162919, 6564.212294524687, 6591.978243372285, 6642.800715978528, 1918.788933217345, 1928.7974762650001, 1938.340964072194, 1939.2533874458436, 1949.103412430298, 1419.1556024165604, 1428.2144820348767, 1439.5465428390023, 1448.3989144505124, 1474.8451412601523, 5667.1782591524, 5674.687892165888, 5676.829695109153, 5741.425857414225, 5820.650760954356, 6588.934110658928, 6711.6979735912, 6735.911867321146, 6772.255051944282, 6805.0, 5808.477237048686, 5819.156222347736, 5832.387599302097, 5833.366657335952, 5844.772597754434, 3544.556930383702, 3554.7867127972404, 3569.196930690574, 3598.7660802047785, 3604.693601043888, 6370.267419246753, 6425.935740642533, 6449.806505804833, 6450.935490645127, 6532.150820393318, 6848.7260509580055, 6853.246142924274, 6869.210040845367, 6876.96845473173, 6908.447324214151, 6383.425491705769, 6443.548951573345, 6523.478121750249, 6532.346765323429, 6558.114654521769, 6452.35476452351, 6486.740530378732, 6546.476281897341, 6612.338766123542, 6629.966850165718, 6545.14913061299, 6569.24453687832, 6586.407223349922, 6658.63377514222, 6669.7665581704405, 6534.934650653433, 6536.607803531803, 6584.934150658623, 6590.670466476753, 6612.272650008399, 5461.918071228855, 5482.903419316073, 5507.118860982224, 5531.230006397914, 5532.197831314517, 6272.2159730033745, 6522.380373864476, 6688.665566721742, 6708.966455167693, 6717.56335838169, 6351.872962540816, 6527.640979746159, 6527.804165875032, 6537.738490460329, 6538.117354157128, 6391.2104610709075, 6445.2265728112925, 6480.967595161994, 6507.869842603216, 6584.341565843569, 6181.381861813783, 6344.809655710336, 6361.650109244036, 6411.679416029273, 6484.935150648433, 6410.326915673973, 6413.294537600954, 6442.452391546771, 6579.0, 6589.902745709509, 6259.561830671809, 6274.937250627618, 6317.842053948504, 6378.138951241523, 6448.419642232034], "value": 5203.190860309366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [920.7191806499015, 933.4446004627247, 942.7360339105053, 948.3314263444272, 961.6778379242953, 18295.451136465894, 18942.242310307607, 18946.24215031397, 18952.0, 18966.0, 18529.536761580966, 18630.813691863077, 18722.71915921259, 18787.90606046971, 18832.90583547084, 954.346272803132, 972.2367941166186, 975.8633791269228, 976.3117002513211, 976.8827740671129, 974.9707508774748, 987.6247026130061, 988.4020167798486, 990.1781521337273, 990.3661656539784, 944.4286206844863, 992.00303694787, 1035.7824856780048, 1037.9948100259487, 1043.7599352149011, 1026.6560702164747, 1041.8228901086757, 1042.6298663974333, 1043.2332235806675, 1043.373975614629, 723.1936390924081, 760.1372442277999, 761.9314261716472, 762.0969151555424, 763.3358977689446, 19180.040997950186, 19187.232510699694, 19211.32760353381, 19215.423537293904, 19254.80745192544, 21701.891490542603, 21990.780092199035, 22313.665295020586, 22770.430739231488, 22870.085196592117, 16511.504654860255, 16680.0, 16863.07253101079, 16937.40719074839, 17115.828841711547, 3815.3704638734575, 3826.253880493305, 3835.386338185877, 3842.4044273137706, 3845.8846234612724, 102777.0, 140285.0, 140491.0, 141299.0, 142839.0, 17954.5511362217, 18210.08949552517, 18226.544336391697, 18477.445676629723, 18549.81450185508, 32173.356532869213, 32848.83575582107, 32972.17569560732, 32990.83504582462, 32991.0, 8848.070952550019, 9057.230135438429, 9088.772780680536, 9118.088191180961, 9150.40522366044, 4267.359896015622, 4381.9342709859375, 4409.404730361424, 4419.889502762457, 4450.6884518083425, 5351.785928562814, 5396.163594642837, 5464.371597266365, 5497.285352904177, 5497.285352904177, 1067.5783065689166, 1091.6288461922984, 1092.5192915117323, 1096.2545469081101, 1096.5010920031366, 648.5524987758431, 662.1524448705665, 672.7779832655212, 677.8983152527161, 685.2222727204659, 11946.163768536293, 12056.758864822654, 12092.57675981354, 12222.877771222351, 12338.753224935452, 611.9388061193933, 631.2330518420141, 635.2694401438383, 637.6461064109463, 638.450932198309, 5289.153735402318, 5410.1343784994215, 5471.23402723619, 5578.748956296977, 5592.664440133605, 123537.38231308966, 123673.38163309125, 123724.0, 124414.0, 130074.34962825125, 106032.93967060231, 110450.44774776074, 112329.43835280772, 113283.0, 115618.0, 98654.0, 101511.0, 101757.0, 102367.0, 103680.0, 9958.751031224278, 10082.344647597884, 10191.84712229332, 10210.795784084425, 10474.581016759244, 43881.0, 44726.0, 44865.551344487445, 45059.54940450554, 45824.0, 55498.0, 56428.15357769555, 56834.0, 57031.0, 57975.71012145081, 15998.280077396312, 16342.591435214215, 16376.426825061066, 16490.58773530671, 16543.503694889172, 17815.821841781417, 17868.55328616795, 17882.91058544699, 17999.820001799813, 18087.36694215696, 14758.114513128818, 14813.259337033322, 14911.25443727831, 15011.699766004836, 15218.847811521742, 16375.836241637431, 16480.258388372313, 16566.50300490987, 16754.832451675327, 16762.32950681959, 16811.579710506845, 16846.66306673835, 16849.15754212309, 16902.154892255585, 16925.0, 10590.8411373831, 10778.946105269424, 11002.33985960845, 11172.162087843606, 11270.154738394489, 11133.220674553027, 11147.72130696739, 11293.661190164308, 11351.205415620827, 11422.771544568895], "value": 8977.693989166108, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 108.0, 109.0, 107.0, 109.0, 109.0, 108.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 117.0, 141.0, 122.0, 116.0, 117.0, 117.0, 152.0, 115.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 163.0, 162.0, 162.0, 163.0, 165.0, 170.0, 172.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 73.0, 73.0, 74.0, 74.0, 75.0, 77.0, 77.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 81.0, 79.0, 78.0, 79.0, 79.0, 80.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 111.0, 111.0, 118.0, 112.0, 112.0, 117.0, 112.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 149.0, 149.0, 149.0, 148.0, 150.0, 151.0, 149.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0], "value": 37.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 74.0, 75.0, 74.0, 74.0, 76.0, 74.0, 76.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 116.0, 108.0, 117.0, 117.0, 112.0, 115.0, 109.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 171.0, 165.0, 171.0, 165.0, 164.0, 169.0, 168.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 67.0, 67.0, 66.0, 65.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}]}]} 16:53:56 INFO - Return code: 0 16:53:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:53:56 INFO - # TBPL SUCCESS # 16:53:56 INFO - Running post-action listener: _package_coverage_data 16:53:56 INFO - Running post-action listener: _resource_record_post_action 16:53:56 INFO - [mozharness: 2017-09-30 23:53:56.349407Z] Finished run-tests step (success) 16:53:56 INFO - Running post-run listener: _resource_record_post_run 16:53:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346394624; Read time: 16; Write time: 296436 16:53:56 INFO - TinderboxPrint: CPU usage
13.1% 16:53:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:53:56 INFO - TinderboxPrint: I/O write bytes / time
346,394,624 / 296,436 16:53:56 INFO - TinderboxPrint: CPU idle
8,235.8 (86.9%) 16:53:56 INFO - TinderboxPrint: CPU user
1,193.1 (12.6%) 16:53:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:53:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13488128; Read time: 0; Write time: 1012 16:53:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:53:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 332906496; Read time: 0; Write time: 295424 16:53:56 INFO - Running post-run listener: _upload_blobber_files 16:53:56 INFO - Blob upload gear active. 16:53:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:53:56 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 16:53:56 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'] 16:53:56 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 16:53:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:53:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:53:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:53:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:58 INFO - (blobuploader) - INFO - Done attempting. 16:53:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:53:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:54:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:04 INFO - (blobuploader) - INFO - Done attempting. 16:54:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:54:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:54:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:05 INFO - (blobuploader) - INFO - Done attempting. 16:54:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:54:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:54:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:54:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:54:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:54:06 INFO - (blobuploader) - INFO - Done attempting. 16:54:06 INFO - (blobuploader) - INFO - Iteration through files over. 16:54:06 INFO - Return code: 0 16:54:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:54:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:54:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59fc515e08e7a54b0c74b93dbe2d85ab1012cad5afc40fc312dbaff3724c309e6c1c7359e6220a5369213c4c0c5945175db3d4f2cb85c6a5a65da68b29434979", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f44018c6fbcc8bea44410ec5ca5490608ace8fbea91bfdead58401886ed63916203efb9922dcc0347e95f126e91c1920124095bd11490aca88023e532d8eb78", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef6c3adf21384a56c8f6a921bdbdd134c5cf79cfe9664f56619e0e5df17ebce0096734d949f5555e78de6f722efded8fe4d5703743a84bdb5909a7fd935ad84b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013ceee75e551a1d513d341c3904e20c253acd64fc5eb80fdcf9a4d64eea7b6e22f8147b5e0cd8ae090d0b81814c08693782fa8d6c94439c14dcaa33735d4d19"} 16:54:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:54:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:54:06 INFO - Contents: 16:54:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59fc515e08e7a54b0c74b93dbe2d85ab1012cad5afc40fc312dbaff3724c309e6c1c7359e6220a5369213c4c0c5945175db3d4f2cb85c6a5a65da68b29434979", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f44018c6fbcc8bea44410ec5ca5490608ace8fbea91bfdead58401886ed63916203efb9922dcc0347e95f126e91c1920124095bd11490aca88023e532d8eb78", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef6c3adf21384a56c8f6a921bdbdd134c5cf79cfe9664f56619e0e5df17ebce0096734d949f5555e78de6f722efded8fe4d5703743a84bdb5909a7fd935ad84b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013ceee75e551a1d513d341c3904e20c253acd64fc5eb80fdcf9a4d64eea7b6e22f8147b5e0cd8ae090d0b81814c08693782fa8d6c94439c14dcaa33735d4d19"} 16:54:06 INFO - Running post-run listener: copy_logs_to_upload_dir 16:54:06 INFO - Copying logs to upload dir... 16:54:06 INFO - mkdir: /builds/slave/test/build/upload/logs 16:54:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.076974 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-30 16:54:06.916589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 16:54:06.922280) ========= 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=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59fc515e08e7a54b0c74b93dbe2d85ab1012cad5afc40fc312dbaff3724c309e6c1c7359e6220a5369213c4c0c5945175db3d4f2cb85c6a5a65da68b29434979", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f44018c6fbcc8bea44410ec5ca5490608ace8fbea91bfdead58401886ed63916203efb9922dcc0347e95f126e91c1920124095bd11490aca88023e532d8eb78", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef6c3adf21384a56c8f6a921bdbdd134c5cf79cfe9664f56619e0e5df17ebce0096734d949f5555e78de6f722efded8fe4d5703743a84bdb5909a7fd935ad84b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013ceee75e551a1d513d341c3904e20c253acd64fc5eb80fdcf9a4d64eea7b6e22f8147b5e0cd8ae090d0b81814c08693782fa8d6c94439c14dcaa33735d4d19"} build_url:https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/T48oeLAPQg6zMtCYv_JcQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59fc515e08e7a54b0c74b93dbe2d85ab1012cad5afc40fc312dbaff3724c309e6c1c7359e6220a5369213c4c0c5945175db3d4f2cb85c6a5a65da68b29434979", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f44018c6fbcc8bea44410ec5ca5490608ace8fbea91bfdead58401886ed63916203efb9922dcc0347e95f126e91c1920124095bd11490aca88023e532d8eb78", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef6c3adf21384a56c8f6a921bdbdd134c5cf79cfe9664f56619e0e5df17ebce0096734d949f5555e78de6f722efded8fe4d5703743a84bdb5909a7fd935ad84b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/013ceee75e551a1d513d341c3904e20c253acd64fc5eb80fdcf9a4d64eea7b6e22f8147b5e0cd8ae090d0b81814c08693782fa8d6c94439c14dcaa33735d4d19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 16:54:06.952323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:54:06.952650) ========= 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=9bfb7e13875ed353a705960e000001c0-1506812284.583272-1919778861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 16:54:07.033777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 16:54:07.035170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 16:54:07.035469) ========= ========= Total master_lag: 0.22 =========