builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1505348835.68 results: success (0) revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.683413) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.683901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.684188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.715687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.716070) ========= 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=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 17:27:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 106M=0s 2017-09-13 17:27:15 (106 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.887392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.887700) ========= 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=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:15.937332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-13 17:27:15.937670) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c15e2f280729b6503f9455cd4448ab2852eb5806 --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 c15e2f280729b6503f9455cd4448ab2852eb5806 --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=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 17:27:15,987 truncating revision to first 12 chars 2017-09-13 17:27:15,987 Setting DEBUG logging. 2017-09-13 17:27:15,987 attempt 1/10 2017-09-13 17:27:15,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c15e2f280729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 17:27:18,307 unpacking tar archive at: mozilla-central-c15e2f280729/testing/mozharness/ program finished with exit code 0 elapsedTime=2.683316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-09-13 17:27:18.641923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:18.642767) ========= script_repo_revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:18.643663) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:18.644227) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:27:18.659572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-13 17:27:18.659961) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:18 INFO - MultiFileLogger online at 20170913 17:27:18 in /builds/slave/test 17:27:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:27:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:18 INFO - {'append_to_log': False, 17:27:18 INFO - 'base_work_dir': '/builds/slave/test', 17:27:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:27:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:18 INFO - 'branch': 'Firefox-Non-PGO', 17:27:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:18 INFO - 'code_coverage': False, 17:27:18 INFO - 'config_files': ('talos/linux_config.py',), 17:27:18 INFO - 'default_actions': ('clobber', 17:27:18 INFO - 'read-buildbot-config', 17:27:18 INFO - 'download-and-extract', 17:27:18 INFO - 'populate-webroot', 17:27:18 INFO - 'create-virtualenv', 17:27:18 INFO - 'install', 17:27:18 INFO - 'setup-mitmproxy', 17:27:18 INFO - 'run-tests'), 17:27:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:18 INFO - 'disable_ccov_upload': False, 17:27:18 INFO - 'disable_stylo': False, 17:27:18 INFO - 'download_minidump_stackwalk': True, 17:27:18 INFO - 'download_symbols': 'ondemand', 17:27:18 INFO - 'enable_stylo': False, 17:27:18 INFO - 'enable_webrender': False, 17:27:18 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:27:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:18 INFO - 'gecko_profile': False, 17:27:18 INFO - 'gecko_profile_interval': 0, 17:27:18 INFO - 'installer_path': 'installer.exe', 17:27:18 INFO - 'log_level': 'info', 17:27:18 INFO - 'log_name': 'talos', 17:27:18 INFO - 'log_to_console': True, 17:27:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:18 INFO - 'opt_config_files': (), 17:27:18 INFO - 'pip_index': False, 17:27:18 INFO - 'suite': 'dromaeojs-e10s', 17:27:18 INFO - 'system_bits': '32', 17:27:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:18 INFO - 'title': 'talos-linux64-ix-055', 17:27:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:18 INFO - 'use_talos_json': True, 17:27:18 INFO - 'verify': 'False', 17:27:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:18 INFO - 'work_dir': 'build'} 17:27:18 INFO - [mozharness: 2017-09-14 00:27:18.952829Z] Running clobber step. 17:27:18 INFO - Running pre-action listener: _resource_record_pre_action 17:27:18 INFO - Running main action method: clobber 17:27:18 INFO - rmtree: /builds/slave/test/build 17:27:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:19 INFO - Running post-action listener: _resource_record_post_action 17:27:19 INFO - [mozharness: 2017-09-14 00:27:19.947206Z] Finished clobber step (success) 17:27:19 INFO - [mozharness: 2017-09-14 00:27:19.947368Z] Running read-buildbot-config step. 17:27:19 INFO - Running pre-action listener: _resource_record_pre_action 17:27:19 INFO - Running main action method: read_buildbot_config 17:27:19 INFO - Using buildbot properties: 17:27:19 INFO - { 17:27:19 INFO - "project": "", 17:27:19 INFO - "product": "firefox", 17:27:19 INFO - "who": "ryanvm@gmail.com", 17:27:19 INFO - "installer_path": "public/build/target.tar.bz2", 17:27:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:27:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:27:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:27:19 INFO - "stage_platform": "linux64", 17:27:19 INFO - "basedir": "/builds/slave/test", 17:27:19 INFO - "buildnumber": 1145, 17:27:19 INFO - "platform": "ubuntu64_hw", 17:27:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:27:19 INFO - "slavebuilddir": "test", 17:27:19 INFO - "taskId": "LqUuLz5WTA--nHgYkszQWA", 17:27:19 INFO - "branch": "mozilla-central", 17:27:19 INFO - "script_repo_revision": "production", 17:27:19 INFO - "revision": "c15e2f280729b6503f9455cd4448ab2852eb5806", 17:27:19 INFO - "slavename": "talos-linux64-ix-055", 17:27:19 INFO - "repo_path": "mozilla-central" 17:27:19 INFO - } 17:27:19 INFO - Finding installer, test and symbols from parent task. 17:27:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqUuLz5WTA--nHgYkszQWA'}, attempt #1 17:27:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqUuLz5WTA--nHgYkszQWA'}, attempt #1 17:27:20 INFO - Task dependencies: GhKihdsTQkWhAO3N2_oAlA 17:27:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA'}, attempt #1 17:27:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:27:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json 17:27:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip 17:27:21 INFO - Running post-action listener: _resource_record_post_action 17:27:21 INFO - [mozharness: 2017-09-14 00:27:21.448927Z] Finished read-buildbot-config step (success) 17:27:21 INFO - [mozharness: 2017-09-14 00:27:21.449146Z] Running download-and-extract step. 17:27:21 INFO - Running pre-action listener: _resource_record_pre_action 17:27:21 INFO - Running main action method: download_and_extract 17:27:21 INFO - mkdir: /builds/slave/test/build/tests 17:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:21 INFO - trying https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json 17:27:21 INFO - Downloading https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:27:23 INFO - Downloaded 989 bytes. 17:27:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:27:23 INFO - Using the following test package requirements: 17:27:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:27:23 INFO - u'common': [u'target.common.tests.zip'], 17:27:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:27:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:27:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:27:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:27:23 INFO - u'mozbase': [u'target.common.tests.zip'], 17:27:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:27:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:27:23 INFO - u'web-platform': [u'target.common.tests.zip', 17:27:23 INFO - u'target.web-platform.tests.tar.gz'], 17:27:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:27:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:27:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip 17:27:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:27:23 INFO - Fetch https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.common.tests.zip into memory 17:27:24 INFO - Content-Length response header: 54572603 17:27:24 INFO - Bytes received: 54572603 17:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip 17:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.talos.tests.zip into memory 17:27:36 INFO - Content-Length response header: 14500356 17:27:36 INFO - Bytes received: 14500356 17:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:36 INFO - trying https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:27:37 INFO - Downloaded 61426292 bytes. 17:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:27:37 INFO - mkdir: /builds/slave/test/properties 17:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:27:37 INFO - Contents: 17:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - Running post-action listener: find_tests_for_verification 17:27:37 INFO - Running post-action listener: set_extra_try_arguments 17:27:37 INFO - [mozharness: 2017-09-14 00:27:37.939952Z] Finished download-and-extract step (success) 17:27:37 INFO - [mozharness: 2017-09-14 00:27:37.940050Z] Running populate-webroot step. 17:27:37 INFO - Running pre-action listener: _resource_record_pre_action 17:27:37 INFO - Running main action method: populate_webroot 17:27:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:27:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['tresize', 17:27:37 INFO - 'tcanvasmark']}, 17:27:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:27:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['dromaeo_css', 17:27:37 INFO - 'kraken']}, 17:27:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'tests': ['damp', 'tps']}, 17:27:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['damp', 'tps']}, 17:27:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:27:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['dromaeo_dom']}, 17:27:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:27:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['basic_compositor_video', 17:27:37 INFO - 'glvideo']}, 17:27:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:27:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['ts_paint_webext', 17:27:37 INFO - 'tp5o_webext']}, 17:27:37 INFO - 'other-e10s': {'tests': ['a11yr', 17:27:37 INFO - 'ts_paint', 17:27:37 INFO - 'tpaint', 17:27:37 INFO - 'sessionrestore', 17:27:37 INFO - 'sessionrestore_many_windows', 17:27:37 INFO - 'sessionrestore_no_auto_restore', 17:27:37 INFO - 'tabpaint']}, 17:27:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['a11yr', 17:27:37 INFO - 'ts_paint', 17:27:37 INFO - 'tpaint', 17:27:37 INFO - 'sessionrestore', 17:27:37 INFO - 'sessionrestore_many_windows', 17:27:37 INFO - 'sessionrestore_no_auto_restore', 17:27:37 INFO - 'tabpaint']}, 17:27:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:27:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:27:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['bloom_basic_singleton']}, 17:27:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['bloom_basic']}, 17:27:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:27:37 INFO - 'tsvgr_opacity', 17:27:37 INFO - 'tart', 17:27:37 INFO - 'tscrollx', 17:27:37 INFO - 'tsvg_static']}, 17:27:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['tsvgx', 17:27:37 INFO - 'tsvgr_opacity', 17:27:37 INFO - 'tart', 17:27:37 INFO - 'tscrollx', 17:27:37 INFO - 'tsvg_static']}, 17:27:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:27:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo'], 17:27:37 INFO - 'tests': ['tp5o']}, 17:27:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:27:37 INFO - 'talos_options': ['--mitmproxy', 17:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:27:37 INFO - '--firstNonBlankPaint'], 17:27:37 INFO - 'tests': ['tp6_google', 17:27:37 INFO - 'tp6_youtube', 17:27:37 INFO - 'tp6_amazon', 17:27:37 INFO - 'tp6_facebook']}, 17:27:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo', 17:27:37 INFO - '--mitmproxy', 17:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:27:37 INFO - '--firstNonBlankPaint'], 17:27:37 INFO - 'tests': ['tp6_google', 17:27:37 INFO - 'tp6_youtube', 17:27:37 INFO - 'tp6_amazon', 17:27:37 INFO - 'tp6_facebook']}, 17:27:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:27:37 INFO - 'talos_options': ['--stylo-threads=1', 17:27:37 INFO - '--mitmproxy', 17:27:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:27:37 INFO - '--firstNonBlankPaint'], 17:27:37 INFO - 'tests': ['tp6_google', 17:27:37 INFO - 'tp6_youtube', 17:27:37 INFO - 'tp6_amazon', 17:27:37 INFO - 'tp6_facebook']}, 17:27:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--xperf_path', 17:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:37 INFO - 'tests': ['tp5n']}, 17:27:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:27:37 INFO - 'talos_options': ['--disable-stylo', 17:27:37 INFO - '--xperf_path', 17:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:37 INFO - 'tests': ['tp5n']}}} 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - [mozharness: 2017-09-14 00:27:37.954900Z] Finished populate-webroot step (success) 17:27:37 INFO - [mozharness: 2017-09-14 00:27:37.954989Z] Running create-virtualenv step. 17:27:37 INFO - Running pre-action listener: _resource_record_pre_action 17:27:37 INFO - Running main action method: create_virtualenv 17:27:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:27:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:27:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:27:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:27:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:27:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:27:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:27:39 INFO - Installing pip...............done. 17:27:39 INFO - Return code: 0 17:27:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:27:39 INFO - Reading from file tmpfile_stdout 17:27:39 INFO - Output received: 17:27:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:27:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:39 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:27:39 INFO - Using env: {'DISPLAY': ':0', 17:27:39 INFO - 'HOME': '/home/cltbld', 17:27:39 INFO - 'LANG': 'en_US.UTF-8', 17:27:39 INFO - 'LANGUAGE': 'en_US:en', 17:27:39 INFO - 'LOGNAME': 'cltbld', 17:27:39 INFO - 'MAIL': '/var/mail/cltbld', 17:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:39 INFO - 'MOZ_NO_REMOTE': '1', 17:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:39 INFO - 'NO_EM_RESTART': '1', 17:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:39 INFO - 'PWD': '/builds/slave/test', 17:27:39 INFO - 'SHELL': '/bin/bash', 17:27:39 INFO - 'SHLVL': '1', 17:27:39 INFO - 'TERM': 'linux', 17:27:39 INFO - 'TMOUT': '86400', 17:27:39 INFO - 'USER': 'cltbld', 17:27:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:39 INFO - '_': '/tools/buildbot/bin/python'} 17:27:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:27:40 INFO - Downloading/unpacking pip>=1.5 17:27:40 INFO - Running setup.py egg_info for package pip 17:27:40 INFO - warning: no files found matching 'pip/cacert.pem' 17:27:40 INFO - warning: no files found matching '*.html' under directory 'docs' 17:27:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:27:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:27:40 INFO - Installing collected packages: pip 17:27:40 INFO - Found existing installation: pip 1.1 17:27:40 INFO - Uninstalling pip: 17:27:40 INFO - Successfully uninstalled pip 17:27:40 INFO - Running setup.py install for pip 17:27:40 INFO - warning: no files found matching 'pip/cacert.pem' 17:27:40 INFO - warning: no files found matching '*.html' under directory 'docs' 17:27:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:27:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:27:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:27:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:27:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:27:40 INFO - Successfully installed pip 17:27:40 INFO - Cleaning up... 17:27:40 INFO - Return code: 0 17:27:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:40 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:27:40 INFO - Using env: {'DISPLAY': ':0', 17:27:40 INFO - 'HOME': '/home/cltbld', 17:27:40 INFO - 'LANG': 'en_US.UTF-8', 17:27:40 INFO - 'LANGUAGE': 'en_US:en', 17:27:40 INFO - 'LOGNAME': 'cltbld', 17:27:40 INFO - 'MAIL': '/var/mail/cltbld', 17:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:40 INFO - 'MOZ_NO_REMOTE': '1', 17:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:40 INFO - 'NO_EM_RESTART': '1', 17:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:40 INFO - 'PWD': '/builds/slave/test', 17:27:40 INFO - 'SHELL': '/bin/bash', 17:27:40 INFO - 'SHLVL': '1', 17:27:40 INFO - 'TERM': 'linux', 17:27:40 INFO - 'TMOUT': '86400', 17:27:40 INFO - 'USER': 'cltbld', 17:27:40 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:40 INFO - '_': '/tools/buildbot/bin/python'} 17:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:40 INFO - Downloading/unpacking psutil>=3.1.1 17:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:27:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:42 INFO - Installing collected packages: psutil 17:27:42 INFO - Running setup.py install for psutil 17:27:42 INFO - building 'psutil._psutil_linux' extension 17:27:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:27:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:27:43 INFO - building 'psutil._psutil_posix' extension 17:27:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:27:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:43 INFO - Successfully installed psutil 17:27:43 INFO - Cleaning up... 17:27:43 INFO - Return code: 0 17:27:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:27: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')]} 17:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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')]} 17:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:43 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:27:43 INFO - Using env: {'DISPLAY': ':0', 17:27:43 INFO - 'HOME': '/home/cltbld', 17:27:43 INFO - 'LANG': 'en_US.UTF-8', 17:27:43 INFO - 'LANGUAGE': 'en_US:en', 17:27:43 INFO - 'LOGNAME': 'cltbld', 17:27:43 INFO - 'MAIL': '/var/mail/cltbld', 17:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:43 INFO - 'MOZ_NO_REMOTE': '1', 17:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:43 INFO - 'NO_EM_RESTART': '1', 17:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:43 INFO - 'PWD': '/builds/slave/test', 17:27:43 INFO - 'SHELL': '/bin/bash', 17:27:43 INFO - 'SHLVL': '1', 17:27:43 INFO - 'TERM': 'linux', 17:27:43 INFO - 'TMOUT': '86400', 17:27:43 INFO - 'USER': 'cltbld', 17:27:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:43 INFO - '_': '/tools/buildbot/bin/python'} 17:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:27:45 INFO - Installing collected packages: mozsystemmonitor 17:27:45 INFO - Running setup.py install for mozsystemmonitor 17:27:45 INFO - Successfully installed mozsystemmonitor 17:27:45 INFO - Cleaning up... 17:27:45 INFO - Return code: 0 17:27:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:27:45 INFO - Using env: {'DISPLAY': ':0', 17:27:45 INFO - 'HOME': '/home/cltbld', 17:27:45 INFO - 'LANG': 'en_US.UTF-8', 17:27:45 INFO - 'LANGUAGE': 'en_US:en', 17:27:45 INFO - 'LOGNAME': 'cltbld', 17:27:45 INFO - 'MAIL': '/var/mail/cltbld', 17:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:45 INFO - 'MOZ_NO_REMOTE': '1', 17:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:45 INFO - 'NO_EM_RESTART': '1', 17:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:45 INFO - 'PWD': '/builds/slave/test', 17:27:45 INFO - 'SHELL': '/bin/bash', 17:27:45 INFO - 'SHLVL': '1', 17:27:45 INFO - 'TERM': 'linux', 17:27:45 INFO - 'TMOUT': '86400', 17:27:45 INFO - 'USER': 'cltbld', 17:27:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:45 INFO - '_': '/tools/buildbot/bin/python'} 17:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:45 INFO - Downloading/unpacking jsonschema==2.5.1 17:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:46 INFO - warning: no files found matching '*.txt' 17:27:46 INFO - no previously-included directories found matching 'build' 17:27:46 INFO - no previously-included directories found matching 'dist' 17:27:46 INFO - no previously-included directories found matching '.git*' 17:27:46 INFO - Installing collected packages: jsonschema, functools32 17:27:46 INFO - Running setup.py install for functools32 17:27:47 INFO - warning: no files found matching '*.txt' 17:27:47 INFO - no previously-included directories found matching 'build' 17:27:47 INFO - no previously-included directories found matching 'dist' 17:27:47 INFO - no previously-included directories found matching '.git*' 17:27:47 INFO - Successfully installed jsonschema functools32 17:27:47 INFO - Cleaning up... 17:27:47 INFO - Return code: 0 17:27:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:27: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')]} 17:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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')]} 17:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27: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', '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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:27: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 functools32==3.2.3-2 17:27:47 INFO - Using env: {'DISPLAY': ':0', 17:27:47 INFO - 'HOME': '/home/cltbld', 17:27:47 INFO - 'LANG': 'en_US.UTF-8', 17:27:47 INFO - 'LANGUAGE': 'en_US:en', 17:27:47 INFO - 'LOGNAME': 'cltbld', 17:27:47 INFO - 'MAIL': '/var/mail/cltbld', 17:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:47 INFO - 'MOZ_NO_REMOTE': '1', 17:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:47 INFO - 'NO_EM_RESTART': '1', 17:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:47 INFO - 'PWD': '/builds/slave/test', 17:27:47 INFO - 'SHELL': '/bin/bash', 17:27:47 INFO - 'SHLVL': '1', 17:27:47 INFO - 'TERM': 'linux', 17:27:47 INFO - 'TMOUT': '86400', 17:27:47 INFO - 'USER': 'cltbld', 17:27:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:47 INFO - '_': '/tools/buildbot/bin/python'} 17:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:27:47 INFO - Cleaning up... 17:27:47 INFO - Return code: 0 17:27:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:27: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')]} 17:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27: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')]} 17:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27: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', '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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:27: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 blobuploader==1.2.4 17:27:47 INFO - Using env: {'DISPLAY': ':0', 17:27:47 INFO - 'HOME': '/home/cltbld', 17:27:47 INFO - 'LANG': 'en_US.UTF-8', 17:27:47 INFO - 'LANGUAGE': 'en_US:en', 17:27:47 INFO - 'LOGNAME': 'cltbld', 17:27:47 INFO - 'MAIL': '/var/mail/cltbld', 17:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:47 INFO - 'MOZ_NO_REMOTE': '1', 17:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:47 INFO - 'NO_EM_RESTART': '1', 17:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:47 INFO - 'PWD': '/builds/slave/test', 17:27:47 INFO - 'SHELL': '/bin/bash', 17:27:47 INFO - 'SHLVL': '1', 17:27:47 INFO - 'TERM': 'linux', 17:27:47 INFO - 'TMOUT': '86400', 17:27:47 INFO - 'USER': 'cltbld', 17:27:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:47 INFO - '_': '/tools/buildbot/bin/python'} 17:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:48 INFO - Downloading blobuploader-1.2.4.tar.gz 17:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:27:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:27: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 17:27: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 17:27: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 17:27: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 17:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:27:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:49 INFO - Downloading docopt-0.6.1.tar.gz 17:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:27:49 INFO - Installing collected packages: blobuploader, requests, docopt 17:27:49 INFO - Running setup.py install for blobuploader 17:27:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:27:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:27:49 INFO - Running setup.py install for requests 17:27:49 INFO - Running setup.py install for docopt 17:27:49 INFO - Successfully installed blobuploader requests docopt 17:27:49 INFO - Cleaning up... 17:27:50 INFO - Return code: 0 17:27:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:50 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:50 INFO - Using env: {'DISPLAY': ':0', 17:27:50 INFO - 'HOME': '/home/cltbld', 17:27:50 INFO - 'LANG': 'en_US.UTF-8', 17:27:50 INFO - 'LANGUAGE': 'en_US:en', 17:27:50 INFO - 'LOGNAME': 'cltbld', 17:27:50 INFO - 'MAIL': '/var/mail/cltbld', 17:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:50 INFO - 'MOZ_NO_REMOTE': '1', 17:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:50 INFO - 'NO_EM_RESTART': '1', 17:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:50 INFO - 'PWD': '/builds/slave/test', 17:27:50 INFO - 'SHELL': '/bin/bash', 17:27:50 INFO - 'SHLVL': '1', 17:27:50 INFO - 'TERM': 'linux', 17:27:50 INFO - 'TMOUT': '86400', 17:27:50 INFO - 'USER': 'cltbld', 17:27:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:50 INFO - '_': '/tools/buildbot/bin/python'} 17:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:50 INFO - Running setup.py (path:/tmp/pip-8MSBJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:50 INFO - Running setup.py (path:/tmp/pip-gqqrHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:50 INFO - Running setup.py (path:/tmp/pip-BGk8AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:50 INFO - Running setup.py (path:/tmp/pip-v6P3OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:50 INFO - Running setup.py (path:/tmp/pip-3WBLTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:50 INFO - Running setup.py (path:/tmp/pip-mTnzIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:50 INFO - Running setup.py (path:/tmp/pip-em4G6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:50 INFO - Running setup.py (path:/tmp/pip-pdRrJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:50 INFO - Running setup.py (path:/tmp/pip-mTlwPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:50 INFO - Running setup.py (path:/tmp/pip-7Rbh_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:50 INFO - Running setup.py (path:/tmp/pip-nGR6Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:50 INFO - Running setup.py (path:/tmp/pip-MjEiQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:51 INFO - Running setup.py (path:/tmp/pip-nOIkrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:51 INFO - Running setup.py (path:/tmp/pip-lHUttm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:51 INFO - Running setup.py (path:/tmp/pip-IaEuEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:51 INFO - Running setup.py (path:/tmp/pip-k4AwpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:51 INFO - Running setup.py (path:/tmp/pip-UP9Wpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:51 INFO - Running setup.py install for manifestparser 17:27:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:51 INFO - Running setup.py install for mozcrash 17:27:51 INFO - Running setup.py install for mozdebug 17:27:51 INFO - Running setup.py install for mozdevice 17:27:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:51 INFO - Running setup.py install for mozfile 17:27:51 INFO - Running setup.py install for mozhttpd 17:27:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozinfo 17:27:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozInstall 17:27:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozleak 17:27:52 INFO - Running setup.py install for mozlog 17:27:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for moznetwork 17:27:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozprocess 17:27:52 INFO - Running setup.py install for mozprofile 17:27:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozrunner 17:27:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:52 INFO - Running setup.py install for mozscreenshot 17:27:52 INFO - Running setup.py install for moztest 17:27:53 INFO - Running setup.py install for mozversion 17:27:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:53 INFO - Cleaning up... 17:27:53 INFO - Return code: 0 17:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:53 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:53 INFO - Using env: {'DISPLAY': ':0', 17:27:53 INFO - 'HOME': '/home/cltbld', 17:27:53 INFO - 'LANG': 'en_US.UTF-8', 17:27:53 INFO - 'LANGUAGE': 'en_US:en', 17:27:53 INFO - 'LOGNAME': 'cltbld', 17:27:53 INFO - 'MAIL': '/var/mail/cltbld', 17:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:53 INFO - 'MOZ_NO_REMOTE': '1', 17:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:53 INFO - 'NO_EM_RESTART': '1', 17:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:53 INFO - 'PWD': '/builds/slave/test', 17:27:53 INFO - 'SHELL': '/bin/bash', 17:27:53 INFO - 'SHLVL': '1', 17:27:53 INFO - 'TERM': 'linux', 17:27:53 INFO - 'TMOUT': '86400', 17:27:53 INFO - 'USER': 'cltbld', 17:27:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:53 INFO - '_': '/tools/buildbot/bin/python'} 17:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:53 INFO - Running setup.py (path:/tmp/pip-QXhCLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:53 INFO - Running setup.py (path:/tmp/pip-vCxM3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:53 INFO - Running setup.py (path:/tmp/pip-G0DFYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:53 INFO - Running setup.py (path:/tmp/pip-n5Rslw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:53 INFO - Running setup.py (path:/tmp/pip-jgNM7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:53 INFO - Running setup.py (path:/tmp/pip-ospgD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:53 INFO - Running setup.py (path:/tmp/pip-feNpEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:53 INFO - Running setup.py (path:/tmp/pip-bNtKJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:53 INFO - Running setup.py (path:/tmp/pip-Vy9OmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:53 INFO - Running setup.py (path:/tmp/pip-16Mbnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:53 INFO - Running setup.py (path:/tmp/pip-kkduhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:54 INFO - Running setup.py (path:/tmp/pip-lIE2in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:54 INFO - Running setup.py (path:/tmp/pip-M730WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:54 INFO - Running setup.py (path:/tmp/pip-O7k1CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:54 INFO - Running setup.py (path:/tmp/pip-Jy13W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:54 INFO - Running setup.py (path:/tmp/pip-tohzpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:54 INFO - Running setup.py (path:/tmp/pip-GO1eR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:27:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:55 INFO - Downloading blessings-1.6.tar.gz 17:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:55 INFO - Installing collected packages: blessings 17:27:55 INFO - Running setup.py install for blessings 17:27:55 INFO - Successfully installed blessings 17:27:55 INFO - Cleaning up... 17:27:55 INFO - Return code: 0 17:27:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:56 INFO - Reading from file tmpfile_stdout 17:27:56 INFO - Current package versions: 17:27:56 INFO - argparse == 1.2.1 17:27:56 INFO - blessings == 1.6 17:27:56 INFO - blobuploader == 1.2.4 17:27:56 INFO - docopt == 0.6.1 17:27:56 INFO - functools32 == 3.2.3-2 17:27:56 INFO - jsonschema == 2.5.1 17:27:56 INFO - manifestparser == 1.1 17:27:56 INFO - mozInstall == 1.13 17:27:56 INFO - mozcrash == 1.0 17:27:56 INFO - mozdebug == 0.1 17:27:56 INFO - mozdevice == 0.51 17:27:56 INFO - mozfile == 1.2 17:27:56 INFO - mozhttpd == 0.7 17:27:56 INFO - mozinfo == 0.10 17:27:56 INFO - mozleak == 0.1 17:27:56 INFO - mozlog == 3.5 17:27:56 INFO - moznetwork == 0.27 17:27:56 INFO - mozprocess == 0.25 17:27:56 INFO - mozprofile == 0.28 17:27:56 INFO - mozrunner == 6.13 17:27:56 INFO - mozscreenshot == 0.1 17:27:56 INFO - mozsystemmonitor == 0.3 17:27:56 INFO - moztest == 0.8 17:27:56 INFO - mozversion == 1.4 17:27:56 INFO - psutil == 3.1.1 17:27:56 INFO - requests == 1.2.3 17:27:56 INFO - wsgiref == 0.1.2 17:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:56 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 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:27:56 INFO - Using env: {'DISPLAY': ':0', 17:27:56 INFO - 'HOME': '/home/cltbld', 17:27:56 INFO - 'LANG': 'en_US.UTF-8', 17:27:56 INFO - 'LANGUAGE': 'en_US:en', 17:27:56 INFO - 'LOGNAME': 'cltbld', 17:27:56 INFO - 'MAIL': '/var/mail/cltbld', 17:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:56 INFO - 'MOZ_NO_REMOTE': '1', 17:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:56 INFO - 'NO_EM_RESTART': '1', 17:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:56 INFO - 'PWD': '/builds/slave/test', 17:27:56 INFO - 'SHELL': '/bin/bash', 17:27:56 INFO - 'SHLVL': '1', 17:27:56 INFO - 'TERM': 'linux', 17:27:56 INFO - 'TMOUT': '86400', 17:27:56 INFO - 'USER': 'cltbld', 17:27:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:56 INFO - '_': '/tools/buildbot/bin/python'} 17:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:27:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:27: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 17:27: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 17:27: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 17:27: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 17:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:27:57 INFO - Installing collected packages: simplejson 17:27:57 INFO - Running setup.py install for simplejson 17:27:57 INFO - building 'simplejson._speedups' extension 17:27:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:27:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:27:58 INFO - Successfully installed simplejson 17:27:58 INFO - Cleaning up... 17:27:58 INFO - Return code: 0 17:27:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c15a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:27:58 INFO - Using env: {'DISPLAY': ':0', 17:27:58 INFO - 'HOME': '/home/cltbld', 17:27:58 INFO - 'LANG': 'en_US.UTF-8', 17:27:58 INFO - 'LANGUAGE': 'en_US:en', 17:27:58 INFO - 'LOGNAME': 'cltbld', 17:27:58 INFO - 'MAIL': '/var/mail/cltbld', 17:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:58 INFO - 'MOZ_NO_REMOTE': '1', 17:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:58 INFO - 'NO_EM_RESTART': '1', 17:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:58 INFO - 'PWD': '/builds/slave/test', 17:27:58 INFO - 'SHELL': '/bin/bash', 17:27:58 INFO - 'SHLVL': '1', 17:27:58 INFO - 'TERM': 'linux', 17:27:58 INFO - 'TMOUT': '86400', 17:27:58 INFO - 'USER': 'cltbld', 17:27:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:58 INFO - '_': '/tools/buildbot/bin/python'} 17:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:58 INFO - Cleaning up... 17:27:58 INFO - Return code: 0 17:27:58 INFO - Running post-action listener: _resource_record_post_action 17:27:58 INFO - Running post-action listener: _start_resource_monitoring 17:27:58 INFO - Starting resource monitoring. 17:27:58 INFO - [mozharness: 2017-09-14 00:27:58.767307Z] Finished create-virtualenv step (success) 17:27:58 INFO - [mozharness: 2017-09-14 00:27:58.768314Z] Running install step. 17:27:58 INFO - Running pre-action listener: _resource_record_pre_action 17:27:58 INFO - Running main action method: install 17:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:58 INFO - Reading from file tmpfile_stdout 17:27:58 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:59 INFO - Reading from file tmpfile_stdout 17:27:59 INFO - Output received: 17:27:59 INFO - Usage: mozinstall [options] installer 17:27:59 INFO - Options: 17:27:59 INFO - -h, --help show this help message and exit 17:27:59 INFO - -d DEST, --destination=DEST 17:27:59 INFO - Directory to install application into. [default: 17:27:59 INFO - "/builds/slave/test"] 17:27:59 INFO - --app=APP Application being installed. [default: firefox] 17:27:59 INFO - mkdir: /builds/slave/test/build/application 17:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:28:16 INFO - Reading from file tmpfile_stdout 17:28:16 INFO - Output received: 17:28:16 INFO - /builds/slave/test/build/application/firefox/firefox 17:28:16 INFO - Running post-action listener: _resource_record_post_action 17:28:16 INFO - [mozharness: 2017-09-14 00:28:16.850013Z] Finished install step (success) 17:28:16 INFO - [mozharness: 2017-09-14 00:28:16.850262Z] Running setup-mitmproxy step. 17:28:16 INFO - Running pre-action listener: _resource_record_pre_action 17:28:16 INFO - Running main action method: setup_mitmproxy 17:28:16 INFO - Skipping: mitmproxy is not required 17:28:16 INFO - Running post-action listener: _resource_record_post_action 17:28:16 INFO - [mozharness: 2017-09-14 00:28:16.851444Z] Finished setup-mitmproxy step (success) 17:28:16 INFO - [mozharness: 2017-09-14 00:28:16.851662Z] Running run-tests step. 17:28:16 INFO - Running pre-action listener: _resource_record_pre_action 17:28:16 INFO - Running pre-action listener: _set_gcov_prefix 17:28:16 INFO - Running main action method: run_tests 17:28:16 WARNING - Try message not found. 17:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:28:16 INFO - Python 2.7.3 17:28:16 INFO - Return code: 0 17:28:16 INFO - grabbing minidump binary from tooltool 17:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:16 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 0x1c19090>, '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 0x1c19d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c13f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:28:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:28:16 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:28:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:28:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:28:17 INFO - Return code: 0 17:28:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:28:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:28:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:28:17 INFO - ENV: RUST_BACKTRACE is now full 17:28:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:28:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:28:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:28:17 INFO - Using env: {'DISPLAY': ':0', 17:28:17 INFO - 'HOME': '/home/cltbld', 17:28:17 INFO - 'LANG': 'en_US.UTF-8', 17:28:17 INFO - 'LANGUAGE': 'en_US:en', 17:28:17 INFO - 'LOGNAME': 'cltbld', 17:28:17 INFO - 'MAIL': '/var/mail/cltbld', 17:28:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:17 INFO - 'MOZ_NO_REMOTE': '1', 17:28:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:17 INFO - 'NO_EM_RESTART': '1', 17:28:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:17 INFO - 'PWD': '/builds/slave/test', 17:28:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:17 INFO - 'RUST_BACKTRACE': 'full', 17:28:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:28:17 INFO - 'SHELL': '/bin/bash', 17:28:17 INFO - 'SHLVL': '1', 17:28:17 INFO - 'TERM': 'linux', 17:28:17 INFO - 'TMOUT': '86400', 17:28:17 INFO - 'USER': 'cltbld', 17:28:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:17 INFO - '_': '/tools/buildbot/bin/python'} 17:28:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:28:17 INFO - mozversion application_buildid: 20170913233914 17:28:17 INFO - mozversion application_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 17:28:17 INFO - mozversion application_display_name: Nightly 17:28:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:28:17 INFO - mozversion application_name: Firefox 17:28:17 INFO - mozversion application_remotingname: firefox 17:28:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:28:17 INFO - mozversion application_vendor: Mozilla 17:28:17 INFO - mozversion application_version: 57.0a1 17:28:17 INFO - mozversion platform_buildid: 20170913233914 17:28:17 INFO - mozversion platform_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 17:28:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:28:17 INFO - mozversion platform_version: 57.0a1 17:28:17 INFO - using testdate: 1505348897 17:28:17 INFO - actual date: 1505348897 17:28:17 INFO - starting webserver on 'localhost:54638' 17:28:17 INFO - SUITE-START | Running 2 tests 17:28:17 INFO - TEST-START | dromaeo_css 17:28:17 INFO - Initialising browser for dromaeo_css test... 17:28:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54638/getInfo.html -profile /tmp/tmpCTBmtE/profile 17:28:17 INFO - TEST-INFO | started process 3541 (/builds/slave/test/build/application/firefox/firefox http://localhost:54638/getInfo.html) 17:28:26 INFO - TEST-INFO | 3541: exit 0 17:28:26 INFO - Browser initialized. 17:28:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:28:26 INFO - Using env: {'DISPLAY': ':0', 17:28:26 INFO - 'HOME': '/home/cltbld', 17:28:26 INFO - 'JSGC_DISABLE_POISONING': '1', 17:28:26 INFO - 'LANG': 'en_US.UTF-8', 17:28:26 INFO - 'LANGUAGE': 'en_US:en', 17:28:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:28:26 INFO - 'LOGNAME': 'cltbld', 17:28:26 INFO - 'MAIL': '/var/mail/cltbld', 17:28:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:26 INFO - 'MOZ_CRASHREPORTER': '1', 17:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:28:26 INFO - 'MOZ_NO_REMOTE': '1', 17:28:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:26 INFO - 'NO_EM_RESTART': '1', 17:28:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:26 INFO - 'PWD': '/builds/slave/test', 17:28:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:26 INFO - 'RUST_BACKTRACE': 'full', 17:28:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:28:26 INFO - 'SHELL': '/bin/bash', 17:28:26 INFO - 'SHLVL': '1', 17:28:26 INFO - 'TERM': 'linux', 17:28:26 INFO - 'TMOUT': '86400', 17:28:26 INFO - 'USER': 'cltbld', 17:28:26 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:26 INFO - '_': '/tools/buildbot/bin/python'} 17:28:26 INFO - TEST-INFO | started process 3781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCTBmtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:27 INFO - PID 3781 | 17:28:27 INFO - PID 3781 | (/builds/slave/test/build/application/firefox/firefox:3831): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:28:27 INFO - PID 3781 | 17:28:37 INFO - PID 3781 | RSS: Main: 170733568 17:28:37 INFO - PID 3781 | 17:31:35 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54638/tests/dromaeo/cssquery-ext.html) 17:31:36 INFO - PID 3781 | RSS: Main: 177893376 17:31:36 INFO - PID 3781 | 17:34:38 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-ext.html (next: http://localhost:54638/tests/dromaeo/cssquery-jquery.html) 17:34:38 INFO - PID 3781 | RSS: Main: 173432832 17:34:38 INFO - PID 3781 | 17:37:40 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54638/tests/dromaeo/cssquery-mootools.html) 17:37:41 INFO - PID 3781 | RSS: Main: 175955968 17:37:41 INFO - PID 3781 | 17:40:42 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54638/tests/dromaeo/cssquery-prototype.html) 17:40:43 INFO - PID 3781 | RSS: Main: 174718976 17:40:43 INFO - PID 3781 | 17:43:46 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54638/tests/dromaeo/cssquery-yui.html) 17:43:47 INFO - PID 3781 | RSS: Main: 175771648 17:43:47 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:54638/tests/dromaeo/cssquery-yui.html (next: http://localhost:54638/tests/dromaeo/cssquery-dojo.html) 17:46:49 INFO - PID 3781 | RSS: Main: 178720768 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | __start_tp_report 17:46:49 INFO - PID 3781 | _x_x_mozilla_page_load 17:46:49 INFO - PID 3781 | _x_x_mozilla_page_load_details 17:46:49 INFO - PID 3781 | |i|pagename|runs| 17:46:49 INFO - PID 3781 | |0;dojo.html;3152.8581213845373;3154.211447138215;3165.8575364108615;3206.198450387403;3207.069949714583;6160.260768707762;6280.214973128359;6317.147185130006;6351.618902865831;6385.074164246187;6223.595466294688;6260.655663938482;6341.207349081365;6397.3602639736;6434.903476447857;1224.98538669931;5523.392426833066;5808.332041815182;5840.707964601774;5891.440313170242;5617.354004289518;5699.059655156894;5726.942730572682;5728.856778580527;5817.0983497557945;5708.914366284509;5761.251037365158;5768.3654797972185;5770.105633626795;5774.769009239625;5756;5784.1034639630925;5793.710314484259;5801.129830525413;5810.157527158581;5763.4812866842185;5844.853878653068;5845.210896528956;5846.795362162304;5883.911741323884;6221.2845522764555;6271.8745625087695;6335.334789847046;6370;6376.808695739135;6569.178852643419;6692.665366731644;6716.194056713226;6733.158355205599;6781.423578995791;6692.63190524521;6708.228553716288;6715.1941766988275;6718.49611279156;6733.3939945405145;6248.9999999999545;6260.467860231885;6275.8744825103695;6353;6377.394147555975;7031.8242043948285;7083.256258092826;7085.929140708527;7087.503874728823;7095.787126386217;6666.166729158856;6666.566673166229;6673.632950187786;6777.085093512412;6779.389854913082;6630.204375474974;6750.797476075725;6769.153855768029;6809.795706128824;6888.724451022003;6736.5958042517605;6757.290484499155;6766.864662706718;6802.387785099365;6843.931560684429;6776.864462710718;6848.075509806113;6863.245043045261;6864.347886950732;6869.862602747917;5346.8663283417445;5354.732263386815;5401.675899446046;5406.297181366397;5417.160340147283;4575.359449677047;4658.394408726844;4666.393368862094;4676.041411510632;4748.95251047492;5803;5810.796622118206;5818.301803783488;5820.563457740686;5831.125331200354;6782.525223234425;6794.184697836291;6805.251422343538;6875.449964002868;6895.862082758316;5759.971200143972;5793.420657934257;5850.502707269845;5878.441548053013;5887.11693246008;5737.569682273846;5822.301323841081;5826.359100498942;5828.883422331614;5904.380040095814;6436.292007879129;6489.707963141575;6509.316521765241;6512.869742605216;6533.509986751013;6798.592084474947;6841.315868413219;6872.965635171792;6890.8621827564175;6901.585904845725;6571.868562628816;6573.408393244631;6604.867902642017;6681.164854393201;6683.164604424447;6494.772682956074;6573.211214654272;6593.406593406617;6702.731890724316;6814.659267036727;6765.357291057342;6778.356056174655;6783.219929708147;6785.084013658093;6786.253512113565;6462.773802916875;6566.671666416755;6594.901076483952;6625;6646.102776125162;6626.0392243123515;6683.7660681875905;6712.865742685021;6718.328167183243;6728.899066514105;6547.934520654732;6556;6562.934370656232;6652.534322597566;6653.5009874260595;6512;6565.982272747732;6617.834554136185;6709.966450167718;6765.391114799691;6076.392360764065;6283.026130949527;6436.324185960407;6511;6526.543141980016 17:46:49 INFO - PID 3781 | |1;ext.html;835.6239692138539;840.5713086325972;867.9566021698914;881.8544940084882;889.8487257166281;39961.60038399615;40642.59357406429;40689.18621627573;40708.18583628326;40945;40452.79773601128;40878.38682419759;40959.79520102395;40984.59015409845;41047;7716.421268404864;7813.687452501893;7822;7840;7841.3726901848;7725.304722574967;7777.883331750028;7779.572123533232;7819.804504887366;7829.373650108007;7840.843183136334;7861.8034549136155;7868.2918537331625;7878.566678832662;7879.921200788005;7816.335611473031;7850.528968261922;7875.724349647735;7877.881831772528;7880.330171935364;7724.6523906424345;7774.105977812567;7774.961125194394;7778.64996075178;7785.065792104983;36293.637063629554;36465.63534364649;36477;36497;36539.63460365416;3449.6032956209856;3467.3065386922462;3467.826608669556;3468.722502199818;3471.409860323751;30229.69770302291;30266.54600180999;30268.09195724132;30319.24201894948;30370.696293037006;5115.897682046376;5123.410807757118;5139.948600513984;5142.100132476839;5162.741862906877;191779;192838;192889;193155;193391;46248.76875615668;46301.76849115733;46336;46378.76810615993;46427;47524.28713569299;54933.72533137309;55668;56419.153712694344;56583.71708141433;15919.681606367807;16041.197940103182;16048.75926861098;16068.75896861548;16072.598185045468;13190.406431710597;13362.265075420944;13383;13386.330683465983;13395.196288222738;14357.282135893163;14642;14700.705985880222;14739.55781326562;14849.109053456827;5822.854428639318;5893.675847828325;5895.322037965603;5968.671723055187;6077.878442431127;994.9005099489993;1004.7789486313;1016.2581315639625;1017.8269694152012;1029.1663752360612;22613.88693056524;22695.773042269695;22746.09015639389;22783.430414239778;22880;1119.1829964126234;1120.2382379981527;1127.5320741892024;1134.9773004540027;1143.2454579977175;12047.759044819055;12088.516459341703;12150.635480935585;12274.509019639294;12329.50681972729;229861;231438;231483;231612;232629;51332;54449.455505444435;57577.71211143918;57701.13448298279;57837.8432431349;1414.7736362182002;1440.63984003999;1445.9349329280208;1452.0996981871308;1477.0989696285258;26609;26846.194614161606;26982.865085674446;27080.593791093543;27397.863010684818;38519.2296154081;38521.6147838518;38612.227755445296;38621;38886.41670375003;207567;207605;207622;208590;208836;35244.64755352413;35756.4636530447;35784.642153578134;35876.64123358733;35878.103047424025;42386;42857.35713964355;42949.570504294556;43229.783851080545;43410.34884476672;31306.530402043532;31741.5238771414;31776.205594860312;31890.043298701075;32445;30960.0711978641;31083.689163108986;31125.59934802894;31281.687183127877;32157.356852862344;34834.82582587071;35121.64878351184;35304.29391412106;35415;35488.64511354853;30595.2351191222;30731;30819.229519261302;30900.0729978101;30972;21934;22307.53081606316;22618.66072008954;22665.2067177648;22712.886435567718 17:46:49 INFO - PID 3781 | |2;jquery.html;558.6201383059517;571.968541730205;575.9712014399279;585.1281590430259;600.0908623435496;22322.77677223227;22913.4271643209;22990.540189196206;22998.310050698507;23040.65439018414;22613.86930653469;23554.411139721517;23932;23983.760162398372;24337.878310608467;6465.709043093048;6678.198616166067;6693.83265418366;6707.128073350482;6708.36270554299;6274.247090349165;6534.509911756613;6540.4440622547145;6678.532502724811;6679.43224825888;6480.15757951468;6484.027395890607;6502.154719886408;6509.739610415578;6514.93485065148;6439.098526206335;6512.088307636935;6515.478761699076;6516.771912983023;6646.86706265872;6185.845353866144;6195.163652906845;6201.255849298068;6204.441600255954;6209.875802483925;27814.3046423839;28421.289467763265;28474;28482.430351393064;28545.857270713514;2053.5892821435773;2077.200277893007;2084.5830833833293;2084.8436367272366;2087.019101022517;18082.728759068625;18325.816741832678;18493;18594.814051859445;18629.161687724085;2068.1210485543734;2078.2414418737203;2093.98953005234;2097.6748603966257;2145.3992881993067;114876;121674.39162804218;123690.38154809168;131425.6857431423;135293;14040.929795350958;14126.717465650629;14433.711325773425;14475.203863787592;14610.561683149523;22218.88890555537;22260.443488912584;22282.777172228394;22289.21987730422;22310.107595696314;9147.725568232963;9232.492212928353;9351.485668288173;9378.765530861783;9442;8502.532360720095;8521.57392130391;8547.529885856213;8573.22840944318;8705.825883482421;8506.404551681446;8805.119488051143;8931.598078086501;8938;9047.683331083512;2621.595719191776;2660.2418310781336;2739.4794988952035;2795.972040279571;2808.9297767555568;953.7901661634429;958.152035448633;961.1397798969883;966.7873067925045;968.0464742228899;18833.434996950113;19084.522886927938;19187.136578853984;19260.614787704166;19455;1009.9899001009895;1017.6590842067842;1023.1916785739331;1024.36489376587;1034.912032477248;10372.222083343779;10455.738606534745;10559.788804223872;10608.787824243473;10684.198685098649;462928;465176;468833;478358;491438;110692;111262.44368778104;111353.44323278494;113226;114116;1025.7999690060367;1045.5086109528509;1056.816365670454;1149.2242736153064;1151.1884121694018;19773.406797796088;19821.900890495453;19933.800661993195;20049.498762531053;20315.59368812645;53497.73251133719;53909.730451347496;54433.72783136059;54789.726051369486;55775;66923.66538167278;67191.66404167948;67245;67327;67332.3266767326;13726.588202353945;13816.378262977989;14044.438222471395;14183.290835458392;14190.929045354707;22394.88802555977;22470.438239044153;22706.545869082856;22805.771942280364;23206.883965580066;18080.547986300448;18093.547661308574;18354.265829366675;18439.53901152482;18488.16803243884;16446.34214631449;16650.3339866404;16735;17062.402815901383;17274.136293185038;17562.82437175612;18508.537286567942;18728.250869965595;18908.621827563096;18915.337963171223;14058;14098.859011409755;14180.929095354457;14202.431902723776;14256.215908125152;18030.639387212446;18049.819501805337;18213.45359639213;18270.725939110656;18272.817271827113 17:46:49 INFO - PID 3781 | |3;mootools.html;1302.5050480817288;1387.5490465598677;1396.518201220579;1402.4740722229164;1405.5291477355086;15375.154366509838;15907.920460397696;15930.999999999985;15966.680666386665;15990.520284391458;15327;15387.615309617266;15408.30662620182;15410.768838467404;15461.149636769973;2665.5335316319665;2718.768904643103;2734.4941185880575;2737.8767955442054;2738.438620082878;2689.0857108583077;2693.488237234919;2721.2244510314563;2723.9319017024536;2728.0997270900557;2651.3504191473116;2730.945381092377;2730.9726902730918;2741.2735625059377;2741.451709658066;2759.1722483254944;2760.6135141080263;2778.7360200780895;2779.527480328349;2780.8748606312765;2655.7875369970357;2680.1021657744677;2684.516786978343;2688.8655567221563;2719.1162872066657;14564.635884102876;14800.185989770558;14827.92586037063;14847.48033818822;14857.554273371816;7799.96100019502;8056.798580035487;8068.556229407381;8095.878561821577;8100.270975612164;4993.433504577245;5177.844664660066;5238.659487133325;5280.392754833167;5311.2298716686255;1925.2780207422218;1925.9325923592746;1931.198552600669;1942.3493129801534;1956.9706454403195;24434.26697199087;26135;26259.343516412053;26475.94096236148;27517.174484765288;6716.597004179667;6751.426128779109;6907.75822846208;6972.477064220204;7020.473464490184;17053.062081585384;17079.231434585472;17124;17130;17142.314307427812;7818.569978651229;7991.72028978983;7991.800204994922;7994.80012999668;7994.800129996796;7298.124225093023;7332.30343117403;7337.19290878003;7454.36637885775;7461.552306861606;5145.842185508305;5288.92066619001;5309.522143007148;5380.300560927054;5392.946070539323;1467.449706360115;1472.2785834940803;1480.6076389756722;1481.7036592681507;1483.710676418088;887.6227603268585;892.455602082729;900.6667533012827;906.4108329585822;909.1590278991906;7365.889511657329;7447.180810110884;7458.291462311072;7494.737684181027;7528.811779705551;700.915890093192;708.6385943169021;708.8936659501013;717.4296434334613;720.2653293640458;4907.460179380265;5067.5185857343495;5286.947130528645;5449.155380915964;5470.097433923438;21268.25561105354;21687.891560542095;21862.453438663844;21965.560688786136;22135.889320553295;20657.793422065588;21749.456263593536;21881.452963675718;21896;21907.12371505122;10025;10991.890081099247;11159.665210043711;11303.530541029613;11457.88542114585;6866.862662746817;8634.395592308478;8808.955955220183;8810.603522841358;8832.735017949472;18738.344157954405;18891.811081889005;18908.905455472635;19072.61854762925;19429.417117486497;18978;19143.90428047851;19494.220231190593;19503.414897553095;19542;10879;11004.064654504456;11008.779824403307;11012;11014.1739369546;13755.862441375459;13839.169649821042;13870.930645346709;14004.369803359077;14009.159450433006;11156.386398748147;11174.106071514421;11290;11476.426178690865;11584.362860042778;11171.216004379243;11291.266067705574;11355.602553910574;11477.655670329903;11538;8880.333974951775;8997.055309192441;9073.092690730875;9095.181433671001;9097.590608422504;6729.495287853529;6779.322067793181;6799.626020568916;6845.383915447434;6939.757108501179;6850.520463567503;7020.894686579603;7040.8943865843075;7058.647067646494;7082.964585177041 17:46:49 INFO - PID 3781 | |4;prototype.html;491.85246393491803;496.32882761854967;522.4984015345268;523.8742701751581;530.8062557166634;6354.841128971778;6369.6496692681885;6384.457321127704;6392.552521323498;6401.775937842182;6270.717817698203;6294.527910406727;6346.270178929424;6348.269948955872;6411.743530258784;5208.895822083556;5223.041359490191;5252.448492908247;5265.605079619035;5280.257515020054;4883.682560633565;4963.751812409383;5108.2887232776875;5196.506331898464;5233.21501774733;4921.138800709879;4969.826056088038;5001.324821149135;5017.397912250535;5023.095842748304;4962.3548938638105;4962.975185124052;4980.178270585349;4988.5260900214425;5022;4324.632406245473;4445.444319460067;4450.5104438511735;4466;4482.843100491467;6119.663418512025;6137.478314343286;6147.170132032208;6153.784617538409;6174.59865108771;5661.131826497287;5707.3721890592005;5722.570807189478;5725.541956643458;5730.7421166047625;6567.441767449773;6578.440832529241;6620.404163625249;6625.768098116543;6638.236602790693;4622.745748983804;4854.538818812207;4883.584895283905;4892.315075889378;4933.777979990873;6626.503012274051;6659.267480577133;6709.027191057318;6822.658867056627;6938.91832450273;4945.381827271591;4985.351904252424;4985.476524964826;5002.59979201663;5007.424146223231;5002.374703162105;5028.723420211923;5082.593392528663;5089.312942752755;5098.490150984871;5676.545876329884;5726.627769194989;5743.167240750068;5763.049096899049;5763.769449221984;6645.435138013323;6649.434798042221;6676.499262555328;6696;6740;1730.9048002359739;1738.4523874979593;1752.1502071495315;1760.8063113057553;1781.4299424184137;1148;1213.4539457244275;1224.6877046353302;1225.6874497003384;1235.2650173146963;5673.574481913873;5708.20085188074;5721.456461636138;5754.942450575524;5799.449052340021;6623.9006414903815;6668.365995431777;6679.365460281266;6691.1636045494315;6704.731810727614;5624.859378515488;5658.85852853682;5668.914966275509;5688.8862222755315;5693.772249109989;3521.2182375922735;3522.9647703522637;3582.140286331262;3589.892303230907;3599.4240921452442;6327.430531252209;6389.712462939179;6412.461009357814;6446.161998940108;6465.838354041187;6739.258681545026;6801.489888258301;6841.281665425158;6873.347032031949;6916.688749006306;5975.611585247032;6318.178636777281;6448.290688024314;6537.901931471127;6556.213254409501;6760.695768690519;6768.153980752406;6777.457803375817;6806.251312355538;6840.8289792753585;6674.466042716668;6719.353758329241;6731.394174524316;6773.627450490073;6799.354061364163;6398.360163983564;6417.518686098655;6445.452136568444;6474.838129046811;6496.765614533224;4911.7298548580175;4946.060248552763;4976.328195693535;4984.277279794337;4986.80052797884;6378.521610879296;6629.635370054693;6644.578042308119;6717.790797656468;6833.009213663891;6260.77570051433;6400.743970241138;6471.967640161957;6477.190351206099;6513.837154071186;6457.126578672445;6459.870802583828;6507.707153178024;6536.738530458729;6549.4760419167305;6361.459275961595;6439.227292724716;6442.1976440248645;6465.773697920738;6505.739770409131;6645.239011661817;6659.234188068241;6663.83340416474;6672.933270667231;6688.7324507019175;6386.457151142205;6432.485401167989;6432.807015789534;6460.546377065123;6463.547551671338 17:46:49 INFO - PID 3781 | |5;yui.html;877.0922095631023;909.5406819556124;918.0910898210774;923.1322556796611;944.8110377924414;18728.625427491443;19692.70460943087;19701.901490492528;19709.211631534738;19718.408447746555;17330.82669173308;17889;17990.640187196248;18015.27938882443;18140.45578632643;925.9722208333761;935.3732998890725;938.0478814003792;939.7556635274809;939.7603611079165;959.9520023998807;981.4160574458186;981.7987312600935;982.5185659027097;989.7822479054596;1040.1522758951469;1043.6712435582806;1046.5918291866178;1047.0158051431667;1049.559185142242;1001.2890847498285;1018.5925629748086;1041.6874937518753;1042.3016578892161;1043.6503771236644;734.7061175529777;735.1655870586869;735.5807189901758;737.9409647228209;742.8588568172084;19362.515937101543;19612.215511379527;19647;19673.114709838093;19725.506862328555;21666.458338541506;22092.779072209232;22485.437864053365;22525.887370563207;22547.323580292617;17398;17443.5639109022;17502.29990800379;17632.911835440867;17684.557886052822;3681.5398075240596;3715.498407714978;3716.4053751399647;3717.014991027353;3717.070732316921;143105;143584;144121.55878441187;148241;149279;16454.67090658204;16843.91578042102;16976;16983.49049528516;16996.745048824276;30567;31621.683783161872;31659;31665.20836979094;31807.84096079505;7265.963670181721;7430.256974302634;7488.475806693588;7495.400367970549;7505.474616776883;4080.6327430531396;4181.184668989578;4188.183304255702;4191.517975432804;4202.453681021448;5447.809326673548;5563.916541251884;5600.159976003632;5982.790602328898;6095.420935011167;1114.4260705736551;1152.8501294831617;1153.7404084081184;1156.3524426321287;1162.7965106106567;694.8401867570487;708.479267738212;713.457772093213;719.2914978745931;727.1855521815601;12559.560415385418;12693.555725549562;12791.232526048467;13189.340532973312;13373.598792036255;654.5123882707318;657.3098246840893;661.2197606823994;665.670493105906;680.8365992161846;5396.757145928443;5405.324334458192;5413.512783849473;5559.027170245191;5579.0515612346;124053.37973310075;125283;126032;126889;132727;106877.46561267144;108397;108868.4556577212;109118.45440772903;109509.45245273723;88947;89003;90348;93698.53150734202;94092;10478.266521343432;10481.737956551147;10559.894401055892;10560.947195263974;10580.41807700553;43459.78270108629;44480.11039779251;45421;45459.31811022903;45737.31394029026;56387.154192687965;56697;58277;58399;59530.70234648799;16722;17053.744193836854;17056.658866822345;17203.13984300755;17205.311787528357;17260.136993150543;17461.650766984843;17510.124493775515;17525.211365488838;17621.911890440464;16060.839391605934;16199.595010124369;16237.512874613309;16366.509004729876;16407.917960410123;16774.66450671004;17048.659026819147;17054.062026588657;17193.484195474157;17201.913990429966;16255.918720406322;16295.18524073768;16347.591310216863;16461.83538164651;16481.67036659284;11191.608293709682;11245.662630121109;11465.082793376676;11631.88368116308;11660.883391166319;12316.876831231932;12356.62930112098;12455.750884982432;12500.937495312466;12712.36438178069 17:46:49 INFO - PID 3781 | __end_tp_report 17:46:49 INFO - PID 3781 | __start_cc_report 17:46:49 INFO - PID 3781 | _x_x_mozilla_cycle_collect,358 17:46:49 INFO - PID 3781 | __end_cc_report 17:46:49 INFO - PID 3781 | __startTimestamp1505350009366__endTimestamp 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | ------- Summary: start ------- 17:46:49 INFO - PID 3781 | Number of tests: 6 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#0] dojo.html Cycles:165 Average:6200.03 Median:6509.32 stddev:848.31 (13.0%) stddev-sans-first:816.54 17:46:49 INFO - PID 3781 | Values: 3152.9 3154.2 3165.9 3206.2 3207.1 6160.3 6280.2 6317.1 6351.6 6385.1 6223.6 6260.7 6341.2 6397.4 6434.9 1225.0 5523.4 5808.3 5840.7 5891.4 5617.4 5699.1 5726.9 5728.9 5817.1 5708.9 5761.3 5768.4 5770.1 5774.8 5756.0 5784.1 5793.7 5801.1 5810.2 5763.5 5844.9 5845.2 5846.8 5883.9 6221.3 6271.9 6335.3 6370.0 6376.8 6569.2 6692.7 6716.2 6733.2 6781.4 6692.6 6708.2 6715.2 6718.5 6733.4 6249.0 6260.5 6275.9 6353.0 6377.4 7031.8 7083.3 7085.9 7087.5 7095.8 6666.2 6666.6 6673.6 6777.1 6779.4 6630.2 6750.8 6769.2 6809.8 6888.7 6736.6 6757.3 6766.9 6802.4 6843.9 6776.9 6848.1 6863.2 6864.3 6869.9 5346.9 5354.7 5401.7 5406.3 5417.2 4575.4 4658.4 4666.4 4676.0 4749.0 5803.0 5810.8 5818.3 5820.6 5831.1 6782.5 6794.2 6805.3 6875.4 6895.9 5760.0 5793.4 5850.5 5878.4 5887.1 5737.6 5822.3 5826.4 5828.9 5904.4 6436.3 6489.7 6509.3 6512.9 6533.5 6798.6 6841.3 6873.0 6890.9 6901.6 6571.9 6573.4 6604.9 6681.2 6683.2 6494.8 6573.2 6593.4 6702.7 6814.7 6765.4 6778.4 6783.2 6785.1 6786.3 6462.8 6566.7 6594.9 6625.0 6646.1 6626.0 6683.8 6712.9 6718.3 6728.9 6547.9 6556.0 6562.9 6652.5 6653.5 6512.0 6566.0 6617.8 6710.0 6765.4 6076.4 6283.0 6436.3 6511.0 6526.5 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#1] ext.html Cycles:180 Average:38048.73 Median:35183.15 stddev:54772.80 (155.7%) stddev-sans-first:54855.18 17:46:49 INFO - PID 3781 | Values: 835.6 840.6 868.0 881.9 889.8 39961.6 40642.6 40689.2 40708.2 40945.0 40452.8 40878.4 40959.8 40984.6 41047.0 7716.4 7813.7 7822.0 7840.0 7841.4 7725.3 7777.9 7779.6 7819.8 7829.4 7840.8 7861.8 7868.3 7878.6 7879.9 7816.3 7850.5 7875.7 7877.9 7880.3 7724.7 7774.1 7775.0 7778.6 7785.1 36293.6 36465.6 36477.0 36497.0 36539.6 3449.6 3467.3 3467.8 3468.7 3471.4 30229.7 30266.5 30268.1 30319.2 30370.7 5115.9 5123.4 5139.9 5142.1 5162.7 191779.0 192838.0 192889.0 193155.0 193391.0 46248.8 46301.8 46336.0 46378.8 46427.0 47524.3 54933.7 55668.0 56419.2 56583.7 15919.7 16041.2 16048.8 16068.8 16072.6 13190.4 13362.3 13383.0 13386.3 13395.2 14357.3 14642.0 14700.7 14739.6 14849.1 5822.9 5893.7 5895.3 5968.7 6077.9 994.9 1004.8 1016.3 1017.8 1029.2 22613.9 22695.8 22746.1 22783.4 22880.0 1119.2 1120.2 1127.5 1135.0 1143.2 12047.8 12088.5 12150.6 12274.5 12329.5 229861.0 231438.0 231483.0 231612.0 232629.0 51332.0 54449.5 57577.7 57701.1 57837.8 1414.8 1440.6 1445.9 1452.1 1477.1 26609.0 26846.2 26982.9 27080.6 27397.9 38519.2 38521.6 38612.2 38621.0 38886.4 207567.0 207605.0 207622.0 208590.0 208836.0 35244.6 35756.5 35784.6 35876.6 35878.1 42386.0 42857.4 42949.6 43229.8 43410.3 31306.5 31741.5 31776.2 31890.0 32445.0 30960.1 31083.7 31125.6 31281.7 32157.4 34834.8 35121.6 35304.3 35415.0 35488.6 30595.2 30731.0 30819.2 30900.1 30972.0 21934.0 22307.5 22618.7 22665.2 22712.9 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#2] jquery.html Cycles:180 Average:33459.09 Median:22358.83 stddev:79484.74 (355.5%) stddev-sans-first:79669.33 17:46:49 INFO - PID 3781 | Values: 558.6 572.0 576.0 585.1 600.1 22322.8 22913.4 22990.5 22998.3 23040.7 22613.9 23554.4 23932.0 23983.8 24337.9 6465.7 6678.2 6693.8 6707.1 6708.4 6274.2 6534.5 6540.4 6678.5 6679.4 6480.2 6484.0 6502.2 6509.7 6514.9 6439.1 6512.1 6515.5 6516.8 6646.9 6185.8 6195.2 6201.3 6204.4 6209.9 27814.3 28421.3 28474.0 28482.4 28545.9 2053.6 2077.2 2084.6 2084.8 2087.0 18082.7 18325.8 18493.0 18594.8 18629.2 2068.1 2078.2 2094.0 2097.7 2145.4 114876.0 121674.4 123690.4 131425.7 135293.0 14040.9 14126.7 14433.7 14475.2 14610.6 22218.9 22260.4 22282.8 22289.2 22310.1 9147.7 9232.5 9351.5 9378.8 9442.0 8502.5 8521.6 8547.5 8573.2 8705.8 8506.4 8805.1 8931.6 8938.0 9047.7 2621.6 2660.2 2739.5 2796.0 2808.9 953.8 958.2 961.1 966.8 968.0 18833.4 19084.5 19187.1 19260.6 19455.0 1010.0 1017.7 1023.2 1024.4 1034.9 10372.2 10455.7 10559.8 10608.8 10684.2 462928.0 465176.0 468833.0 478358.0 491438.0 110692.0 111262.4 111353.4 113226.0 114116.0 1025.8 1045.5 1056.8 1149.2 1151.2 19773.4 19821.9 19933.8 20049.5 20315.6 53497.7 53909.7 54433.7 54789.7 55775.0 66923.7 67191.7 67245.0 67327.0 67332.3 13726.6 13816.4 14044.4 14183.3 14190.9 22394.9 22470.4 22706.5 22805.8 23206.9 18080.5 18093.5 18354.3 18439.5 18488.2 16446.3 16650.3 16735.0 17062.4 17274.1 17562.8 18508.5 18728.3 18908.6 18915.3 14058.0 14098.9 14180.9 14202.4 14256.2 18030.6 18049.8 18213.5 18270.7 18272.8 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#3] mootools.html Cycles:180 Average:9285.74 Median:2691.29 stddev:6711.05 (249.4%) stddev-sans-first:6703.07 17:46:49 INFO - PID 3781 | Values: 1302.5 1387.5 1396.5 1402.5 1405.5 15375.2 15907.9 15931.0 15966.7 15990.5 15327.0 15387.6 15408.3 15410.8 15461.1 2665.5 2718.8 2734.5 2737.9 2738.4 2689.1 2693.5 2721.2 2723.9 2728.1 2651.4 2730.9 2731.0 2741.3 2741.5 2759.2 2760.6 2778.7 2779.5 2780.9 2655.8 2680.1 2684.5 2688.9 2719.1 14564.6 14800.2 14827.9 14847.5 14857.6 7800.0 8056.8 8068.6 8095.9 8100.3 4993.4 5177.8 5238.7 5280.4 5311.2 1925.3 1925.9 1931.2 1942.3 1957.0 24434.3 26135.0 26259.3 26475.9 27517.2 6716.6 6751.4 6907.8 6972.5 7020.5 17053.1 17079.2 17124.0 17130.0 17142.3 7818.6 7991.7 7991.8 7994.8 7994.8 7298.1 7332.3 7337.2 7454.4 7461.6 5145.8 5288.9 5309.5 5380.3 5392.9 1467.4 1472.3 1480.6 1481.7 1483.7 887.6 892.5 900.7 906.4 909.2 7365.9 7447.2 7458.3 7494.7 7528.8 700.9 708.6 708.9 717.4 720.3 4907.5 5067.5 5286.9 5449.2 5470.1 21268.3 21687.9 21862.5 21965.6 22135.9 20657.8 21749.5 21881.5 21896.0 21907.1 10025.0 10991.9 11159.7 11303.5 11457.9 6866.9 8634.4 8809.0 8810.6 8832.7 18738.3 18891.8 18908.9 19072.6 19429.4 18978.0 19143.9 19494.2 19503.4 19542.0 10879.0 11004.1 11008.8 11012.0 11014.2 13755.9 13839.2 13870.9 14004.4 14009.2 11156.4 11174.1 11290.0 11476.4 11584.4 11171.2 11291.3 11355.6 11477.7 11538.0 8880.3 8997.1 9073.1 9095.2 9097.6 6729.5 6779.3 6799.6 6845.4 6939.8 6850.5 7020.9 7040.9 7058.6 7083.0 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#4] prototype.html Cycles:180 Average:5520.12 Median:6217.69 stddev:1547.06 (24.9%) stddev-sans-first:1504.66 17:46:49 INFO - PID 3781 | Values: 491.9 496.3 522.5 523.9 530.8 6354.8 6369.6 6384.5 6392.6 6401.8 6270.7 6294.5 6346.3 6348.3 6411.7 5208.9 5223.0 5252.4 5265.6 5280.3 4883.7 4963.8 5108.3 5196.5 5233.2 4921.1 4969.8 5001.3 5017.4 5023.1 4962.4 4963.0 4980.2 4988.5 5022.0 4324.6 4445.4 4450.5 4466.0 4482.8 6119.7 6137.5 6147.2 6153.8 6174.6 5661.1 5707.4 5722.6 5725.5 5730.7 6567.4 6578.4 6620.4 6625.8 6638.2 4622.7 4854.5 4883.6 4892.3 4933.8 6626.5 6659.3 6709.0 6822.7 6938.9 4945.4 4985.4 4985.5 5002.6 5007.4 5002.4 5028.7 5082.6 5089.3 5098.5 5676.5 5726.6 5743.2 5763.0 5763.8 6645.4 6649.4 6676.5 6696.0 6740.0 1730.9 1738.5 1752.2 1760.8 1781.4 1148.0 1213.5 1224.7 1225.7 1235.3 5673.6 5708.2 5721.5 5754.9 5799.4 6623.9 6668.4 6679.4 6691.2 6704.7 5624.9 5658.9 5668.9 5688.9 5693.8 3521.2 3523.0 3582.1 3589.9 3599.4 6327.4 6389.7 6412.5 6446.2 6465.8 6739.3 6801.5 6841.3 6873.3 6916.7 5975.6 6318.2 6448.3 6537.9 6556.2 6760.7 6768.2 6777.5 6806.3 6840.8 6674.5 6719.4 6731.4 6773.6 6799.4 6398.4 6417.5 6445.5 6474.8 6496.8 4911.7 4946.1 4976.3 4984.3 4986.8 6378.5 6629.6 6644.6 6717.8 6833.0 6260.8 6400.7 6472.0 6477.2 6513.8 6457.1 6459.9 6507.7 6536.7 6549.5 6361.5 6439.2 6442.2 6465.8 6505.7 6645.2 6659.2 6663.8 6672.9 6688.7 6386.5 6432.5 6432.8 6460.5 6463.5 17:46:49 INFO - PID 3781 | 17:46:49 INFO - PID 3781 | [#5] yui.html Cycles:180 Average:24626.56 Median:19045.57 stddev:35966.10 (188.8%) stddev-sans-first:36022.78 17:46:49 INFO - PID 3781 | Values: 877.1 909.5 918.1 923.1 944.8 18728.6 19692.7 19701.9 19709.2 19718.4 17330.8 17889.0 17990.6 18015.3 18140.5 926.0 935.4 938.0 939.8 939.8 960.0 981.4 981.8 982.5 989.8 1040.2 1043.7 1046.6 1047.0 1049.6 1001.3 1018.6 1041.7 1042.3 1043.7 734.7 735.2 735.6 737.9 742.9 19362.5 19612.2 19647.0 19673.1 19725.5 21666.5 22092.8 22485.4 22525.9 22547.3 17398.0 17443.6 17502.3 17632.9 17684.6 3681.5 3715.5 3716.4 3717.0 3717.1 143105.0 143584.0 144121.6 148241.0 149279.0 16454.7 16843.9 16976.0 16983.5 16996.7 30567.0 31621.7 31659.0 31665.2 31807.8 7266.0 7430.3 7488.5 7495.4 7505.5 4080.6 4181.2 4188.2 4191.5 4202.5 5447.8 5563.9 5600.2 5982.8 6095.4 1114.4 1152.9 1153.7 1156.4 1162.8 694.8 708.5 713.5 719.3 727.2 12559.6 12693.6 12791.2 13189.3 13373.6 654.5 657.3 661.2 665.7 680.8 5396.8 5405.3 5413.5 5559.0 5579.1 124053.4 125283.0 126032.0 126889.0 132727.0 106877.5 108397.0 108868.5 109118.5 109509.5 88947.0 89003.0 90348.0 93698.5 94092.0 10478.3 10481.7 10559.9 10560.9 10580.4 43459.8 44480.1 45421.0 45459.3 45737.3 56387.2 56697.0 58277.0 58399.0 59530.7 16722.0 17053.7 17056.7 17203.1 17205.3 17260.1 17461.7 17510.1 17525.2 17621.9 16060.8 16199.6 16237.5 16366.5 16407.9 16774.7 17048.7 17054.1 17193.5 17201.9 16255.9 16295.2 16347.6 16461.8 16481.7 11191.6 11245.7 11465.1 11631.9 11660.9 12316.9 12356.6 12455.8 12500.9 12712.4 17:46:49 INFO - PID 3781 | -------- Summary: end -------- 17:46:49 INFO - PID 3781 | 17:46:50 INFO - TEST-INFO | 3781: exit 0 17:46:50 INFO - TEST-OK | dromaeo_css | took 1112395ms 17:46:50 INFO - TEST-START | kraken 17:46:50 INFO - Initialising browser for kraken test... 17:46:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54638/getInfo.html -profile /tmp/tmpyBp6yv/profile 17:46:50 INFO - TEST-INFO | started process 4145 (/builds/slave/test/build/application/firefox/firefox http://localhost:54638/getInfo.html) 17:46:55 INFO - TEST-INFO | 4145: exit 0 17:46:55 INFO - Browser initialized. 17:46:55 INFO - Running cycle 1/1 for kraken test... 17:46:55 INFO - Using env: {'DISPLAY': ':0', 17:46:55 INFO - 'HOME': '/home/cltbld', 17:46:55 INFO - 'JSGC_DISABLE_POISONING': '1', 17:46:55 INFO - 'LANG': 'en_US.UTF-8', 17:46:55 INFO - 'LANGUAGE': 'en_US:en', 17:46:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:46:55 INFO - 'LOGNAME': 'cltbld', 17:46:55 INFO - 'MAIL': '/var/mail/cltbld', 17:46:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:46:55 INFO - 'MOZ_CRASHREPORTER': '1', 17:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:46:55 INFO - 'MOZ_NO_REMOTE': '1', 17:46:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:55 INFO - 'NO_EM_RESTART': '1', 17:46:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:55 INFO - 'PWD': '/builds/slave/test', 17:46:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:55 INFO - 'RUST_BACKTRACE': 'full', 17:46:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:46:55 INFO - 'SHELL': '/bin/bash', 17:46:55 INFO - 'SHLVL': '1', 17:46:55 INFO - 'TERM': 'linux', 17:46:55 INFO - 'TMOUT': '86400', 17:46:55 INFO - 'USER': 'cltbld', 17:46:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103', 17:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:55 INFO - '_': '/tools/buildbot/bin/python'} 17:46:55 INFO - TEST-INFO | started process 4373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyBp6yv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:56 INFO - PID 4373 | 17:46:56 INFO - PID 4373 | (/builds/slave/test/build/application/firefox/firefox:4422): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:46:56 INFO - PID 4373 | 17:47:06 INFO - PID 4373 | RSS: Main: 175976448 17:47:06 INFO - PID 4373 | 17:47:09 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54638/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:10 INFO - PID 4373 | RSS: Main: 180334592 17:47:10 INFO - PID 4373 | 17:47:13 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54638/tests/kraken/driver.html?testName=audio-dft) 17:47:13 INFO - PID 4373 | RSS: Main: 180883456 17:47:13 INFO - PID 4373 | 17:47:16 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54638/tests/kraken/driver.html?testName=audio-fft) 17:47:17 INFO - PID 4373 | RSS: Main: 176799744 17:47:17 INFO - PID 4373 | 17:47:19 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54638/tests/kraken/driver.html?testName=audio-oscillator) 17:47:20 INFO - PID 4373 | RSS: Main: 177639424 17:47:20 INFO - PID 4373 | 17:47:22 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:47:22 INFO - PID 4373 | RSS: Main: 177491968 17:47:22 INFO - PID 4373 | 17:47:25 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54638/tests/kraken/driver.html?testName=imaging-darkroom) 17:47:26 INFO - PID 4373 | RSS: Main: 180375552 17:47:26 INFO - PID 4373 | 17:47:30 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54638/tests/kraken/driver.html?testName=imaging-desaturate) 17:47:30 INFO - PID 4373 | RSS: Main: 180731904 17:47:30 INFO - PID 4373 | 17:47:33 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54638/tests/kraken/driver.html?testName=json-parse-financial) 17:47:34 INFO - PID 4373 | RSS: Main: 180305920 17:47:34 INFO - PID 4373 | 17:47:36 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:47:36 INFO - PID 4373 | RSS: Main: 179933184 17:47:36 INFO - PID 4373 | 17:47:38 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:47:38 INFO - PID 4373 | RSS: Main: 180219904 17:47:38 INFO - PID 4373 | 17:47:41 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:41 INFO - PID 4373 | RSS: Main: 177704960 17:47:41 INFO - PID 4373 | 17:47:44 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:45 INFO - PID 4373 | RSS: Main: 177852416 17:47:45 INFO - PID 4373 | 17:47:47 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:48 INFO - PID 4373 | RSS: Main: 177836032 17:47:48 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | Cycle 1(1): loaded http://localhost:54638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54638/tests/kraken/driver.html?testName=ai-astar) 17:47:50 INFO - PID 4373 | RSS: Main: 179539968 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | __start_tp_report 17:47:50 INFO - PID 4373 | _x_x_mozilla_page_load 17:47:50 INFO - PID 4373 | _x_x_mozilla_page_load_details 17:47:50 INFO - PID 4373 | |i|pagename|runs| 17:47:50 INFO - PID 4373 | |0;ai-astar;111;108;108;109;110;96;109;108;109;107 17:47:50 INFO - PID 4373 | |1;audio-beat-detection;117;121;116;119;116;120;119;121;117;117 17:47:50 INFO - PID 4373 | |2;audio-dft;162;162;161;159;161;162;161;165;166;165 17:47:50 INFO - PID 4373 | |3;audio-fft;73;74;75;73;73;73;74;73;74;75 17:47:50 INFO - PID 4373 | |4;audio-oscillator;78;78;78;77;78;78;78;78;87;78 17:47:50 INFO - PID 4373 | |5;imaging-gaussian-blur;113;114;113;114;114;114;114;114;115;117 17:47:50 INFO - PID 4373 | |6;imaging-darkroom;150;148;148;148;149;147;148;150;156;149 17:47:50 INFO - PID 4373 | |7;imaging-desaturate;98;95;94;94;93;93;94;96;94;95 17:47:50 INFO - PID 4373 | |8;json-parse-financial;55;54;52;50;51;52;52;53;51;51 17:47:50 INFO - PID 4373 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;37 17:47:50 INFO - PID 4373 | |10;stanford-crypto-aes;75;76;75;76;76;74;74;78;77;73 17:47:50 INFO - PID 4373 | |11;stanford-crypto-ccm;116;113;111;113;115;115;116;113;113;109 17:47:50 INFO - PID 4373 | |12;stanford-crypto-pbkdf2;174;166;172;167;179;167;165;165;170;168 17:47:50 INFO - PID 4373 | |13;stanford-crypto-sha256-iterative;67;65;64;64;66;71;63;69;65;63 17:47:50 INFO - PID 4373 | __end_tp_report 17:47:50 INFO - PID 4373 | __start_cc_report 17:47:50 INFO - PID 4373 | _x_x_mozilla_cycle_collect,885 17:47:50 INFO - PID 4373 | __end_cc_report 17:47:50 INFO - PID 4373 | __startTimestamp1505350070609__endTimestamp 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | ------- Summary: start ------- 17:47:50 INFO - PID 4373 | Number of tests: 14 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:4.20 (3.9%) stddev-sans-first:4.26 17:47:50 INFO - PID 4373 | Values: 111.0 108.0 108.0 109.0 110.0 96.0 109.0 108.0 109.0 107.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:119.00 stddev:1.95 (1.6%) stddev-sans-first:2.01 17:47:50 INFO - PID 4373 | Values: 117.0 121.0 116.0 119.0 116.0 120.0 119.0 121.0 117.0 117.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 17:47:50 INFO - PID 4373 | Values: 162.0 162.0 161.0 159.0 161.0 162.0 161.0 165.0 166.0 165.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 17:47:50 INFO - PID 4373 | Values: 73.0 74.0 75.0 73.0 73.0 73.0 74.0 73.0 74.0 75.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:78.00 stddev:2.90 (3.7%) stddev-sans-first:3.06 17:47:50 INFO - PID 4373 | Values: 78.0 78.0 78.0 77.0 78.0 78.0 78.0 78.0 87.0 78.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.14 (1.0%) stddev-sans-first:1.12 17:47:50 INFO - PID 4373 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 115.0 117.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:2.54 (1.7%) stddev-sans-first:2.68 17:47:50 INFO - PID 4373 | Values: 150.0 148.0 148.0 148.0 149.0 147.0 148.0 150.0 156.0 149.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:1.51 (1.6%) stddev-sans-first:0.97 17:47:50 INFO - PID 4373 | Values: 98.0 95.0 94.0 94.0 93.0 93.0 94.0 96.0 94.0 95.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.52 (2.9%) stddev-sans-first:1.20 17:47:50 INFO - PID 4373 | Values: 55.0 54.0 52.0 50.0 51.0 52.0 52.0 53.0 51.0 51.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 17:47:50 INFO - PID 4373 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 37.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:1.51 (2.0%) stddev-sans-first:1.59 17:47:50 INFO - PID 4373 | Values: 75.0 76.0 75.0 76.0 76.0 74.0 74.0 78.0 77.0 73.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:114.00 stddev:2.22 (1.9%) stddev-sans-first:2.15 17:47:50 INFO - PID 4373 | Values: 116.0 113.0 111.0 113.0 115.0 115.0 116.0 113.0 113.0 109.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:4.52 (2.7%) stddev-sans-first:4.47 17:47:50 INFO - PID 4373 | Values: 174.0 166.0 172.0 167.0 179.0 167.0 165.0 165.0 170.0 168.0 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:2.63 (4.0%) stddev-sans-first:2.74 17:47:50 INFO - PID 4373 | Values: 67.0 65.0 64.0 64.0 66.0 71.0 63.0 69.0 65.0 63.0 17:47:50 INFO - PID 4373 | -------- Summary: end -------- 17:47:50 INFO - PID 4373 | 17:47:50 INFO - PID 4373 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:47:51 INFO - TEST-INFO | 4373: exit 0 17:47:51 INFO - TEST-OK | kraken | took 61176ms 17:47:51 INFO - SUITE-END | took 1173s 17:47:51 INFO - Completed test suite (00:19:34) 17:47:51 INFO - javascript benchmark 17:47:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8476.50622123484, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.8581213845373, 3154.211447138215, 3165.8575364108615, 3206.198450387403, 3207.069949714583, 6160.260768707762, 6280.214973128359, 6317.147185130006, 6351.618902865831, 6385.074164246187, 6223.595466294688, 6260.655663938482, 6341.207349081365, 6397.3602639736, 6434.903476447857, 1224.98538669931, 5523.392426833066, 5808.332041815182, 5840.707964601774, 5891.440313170242, 5617.354004289518, 5699.059655156894, 5726.942730572682, 5728.856778580527, 5817.0983497557945, 5708.914366284509, 5761.251037365158, 5768.3654797972185, 5770.105633626795, 5774.769009239625, 5756.0, 5784.1034639630925, 5793.710314484259, 5801.129830525413, 5810.157527158581, 5763.4812866842185, 5844.853878653068, 5845.210896528956, 5846.795362162304, 5883.911741323884, 6221.2845522764555, 6271.8745625087695, 6335.334789847046, 6370.0, 6376.808695739135, 6569.178852643419, 6692.665366731644, 6716.194056713226, 6733.158355205599, 6781.423578995791, 6692.63190524521, 6708.228553716288, 6715.1941766988275, 6718.49611279156, 6733.3939945405145, 6248.9999999999545, 6260.467860231885, 6275.8744825103695, 6353.0, 6377.394147555975, 7031.8242043948285, 7083.256258092826, 7085.929140708527, 7087.503874728823, 7095.787126386217, 6666.166729158856, 6666.566673166229, 6673.632950187786, 6777.085093512412, 6779.389854913082, 6630.204375474974, 6750.797476075725, 6769.153855768029, 6809.795706128824, 6888.724451022003, 6736.5958042517605, 6757.290484499155, 6766.864662706718, 6802.387785099365, 6843.931560684429, 6776.864462710718, 6848.075509806113, 6863.245043045261, 6864.347886950732, 6869.862602747917, 5346.8663283417445, 5354.732263386815, 5401.675899446046, 5406.297181366397, 5417.160340147283, 4575.359449677047, 4658.394408726844, 4666.393368862094, 4676.041411510632, 4748.95251047492, 5803.0, 5810.796622118206, 5818.301803783488, 5820.563457740686, 5831.125331200354, 6782.525223234425, 6794.184697836291, 6805.251422343538, 6875.449964002868, 6895.862082758316, 5759.971200143972, 5793.420657934257, 5850.502707269845, 5878.441548053013, 5887.11693246008, 5737.569682273846, 5822.301323841081, 5826.359100498942, 5828.883422331614, 5904.380040095814, 6436.292007879129, 6489.707963141575, 6509.316521765241, 6512.869742605216, 6533.509986751013, 6798.592084474947, 6841.315868413219, 6872.965635171792, 6890.8621827564175, 6901.585904845725, 6571.868562628816, 6573.408393244631, 6604.867902642017, 6681.164854393201, 6683.164604424447, 6494.772682956074, 6573.211214654272, 6593.406593406617, 6702.731890724316, 6814.659267036727, 6765.357291057342, 6778.356056174655, 6783.219929708147, 6785.084013658093, 6786.253512113565, 6462.773802916875, 6566.671666416755, 6594.901076483952, 6625.0, 6646.102776125162, 6626.0392243123515, 6683.7660681875905, 6712.865742685021, 6718.328167183243, 6728.899066514105, 6547.934520654732, 6556.0, 6562.934370656232, 6652.534322597566, 6653.5009874260595, 6512.0, 6565.982272747732, 6617.834554136185, 6709.966450167718, 6765.391114799691, 6076.392360764065, 6283.026130949527, 6436.324185960407, 6511.0, 6526.543141980016], "value": 6137.893679553675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.6239692138539, 840.5713086325972, 867.9566021698914, 881.8544940084882, 889.8487257166281, 39961.60038399615, 40642.59357406429, 40689.18621627573, 40708.18583628326, 40945.0, 40452.79773601128, 40878.38682419759, 40959.79520102395, 40984.59015409845, 41047.0, 7716.421268404864, 7813.687452501893, 7822.0, 7840.0, 7841.3726901848, 7725.304722574967, 7777.883331750028, 7779.572123533232, 7819.804504887366, 7829.373650108007, 7840.843183136334, 7861.8034549136155, 7868.2918537331625, 7878.566678832662, 7879.921200788005, 7816.335611473031, 7850.528968261922, 7875.724349647735, 7877.881831772528, 7880.330171935364, 7724.6523906424345, 7774.105977812567, 7774.961125194394, 7778.64996075178, 7785.065792104983, 36293.637063629554, 36465.63534364649, 36477.0, 36497.0, 36539.63460365416, 3449.6032956209856, 3467.3065386922462, 3467.826608669556, 3468.722502199818, 3471.409860323751, 30229.69770302291, 30266.54600180999, 30268.09195724132, 30319.24201894948, 30370.696293037006, 5115.897682046376, 5123.410807757118, 5139.948600513984, 5142.100132476839, 5162.741862906877, 191779.0, 192838.0, 192889.0, 193155.0, 193391.0, 46248.76875615668, 46301.76849115733, 46336.0, 46378.76810615993, 46427.0, 47524.28713569299, 54933.72533137309, 55668.0, 56419.153712694344, 56583.71708141433, 15919.681606367807, 16041.197940103182, 16048.75926861098, 16068.75896861548, 16072.598185045468, 13190.406431710597, 13362.265075420944, 13383.0, 13386.330683465983, 13395.196288222738, 14357.282135893163, 14642.0, 14700.705985880222, 14739.55781326562, 14849.109053456827, 5822.854428639318, 5893.675847828325, 5895.322037965603, 5968.671723055187, 6077.878442431127, 994.9005099489993, 1004.7789486313, 1016.2581315639625, 1017.8269694152012, 1029.1663752360612, 22613.88693056524, 22695.773042269695, 22746.09015639389, 22783.430414239778, 22880.0, 1119.1829964126234, 1120.2382379981527, 1127.5320741892024, 1134.9773004540027, 1143.2454579977175, 12047.759044819055, 12088.516459341703, 12150.635480935585, 12274.509019639294, 12329.50681972729, 229861.0, 231438.0, 231483.0, 231612.0, 232629.0, 51332.0, 54449.455505444435, 57577.71211143918, 57701.13448298279, 57837.8432431349, 1414.7736362182002, 1440.63984003999, 1445.9349329280208, 1452.0996981871308, 1477.0989696285258, 26609.0, 26846.194614161606, 26982.865085674446, 27080.593791093543, 27397.863010684818, 38519.2296154081, 38521.6147838518, 38612.227755445296, 38621.0, 38886.41670375003, 207567.0, 207605.0, 207622.0, 208590.0, 208836.0, 35244.64755352413, 35756.4636530447, 35784.642153578134, 35876.64123358733, 35878.103047424025, 42386.0, 42857.35713964355, 42949.570504294556, 43229.783851080545, 43410.34884476672, 31306.530402043532, 31741.5238771414, 31776.205594860312, 31890.043298701075, 32445.0, 30960.0711978641, 31083.689163108986, 31125.59934802894, 31281.687183127877, 32157.356852862344, 34834.82582587071, 35121.64878351184, 35304.29391412106, 35415.0, 35488.64511354853, 30595.2351191222, 30731.0, 30819.229519261302, 30900.0729978101, 30972.0, 21934.0, 22307.53081606316, 22618.66072008954, 22665.2067177648, 22712.886435567718], "value": 17278.348511640255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6201383059517, 571.968541730205, 575.9712014399279, 585.1281590430259, 600.0908623435496, 22322.77677223227, 22913.4271643209, 22990.540189196206, 22998.310050698507, 23040.65439018414, 22613.86930653469, 23554.411139721517, 23932.0, 23983.760162398372, 24337.878310608467, 6465.709043093048, 6678.198616166067, 6693.83265418366, 6707.128073350482, 6708.36270554299, 6274.247090349165, 6534.509911756613, 6540.4440622547145, 6678.532502724811, 6679.43224825888, 6480.15757951468, 6484.027395890607, 6502.154719886408, 6509.739610415578, 6514.93485065148, 6439.098526206335, 6512.088307636935, 6515.478761699076, 6516.771912983023, 6646.86706265872, 6185.845353866144, 6195.163652906845, 6201.255849298068, 6204.441600255954, 6209.875802483925, 27814.3046423839, 28421.289467763265, 28474.0, 28482.430351393064, 28545.857270713514, 2053.5892821435773, 2077.200277893007, 2084.5830833833293, 2084.8436367272366, 2087.019101022517, 18082.728759068625, 18325.816741832678, 18493.0, 18594.814051859445, 18629.161687724085, 2068.1210485543734, 2078.2414418737203, 2093.98953005234, 2097.6748603966257, 2145.3992881993067, 114876.0, 121674.39162804218, 123690.38154809168, 131425.6857431423, 135293.0, 14040.929795350958, 14126.717465650629, 14433.711325773425, 14475.203863787592, 14610.561683149523, 22218.88890555537, 22260.443488912584, 22282.777172228394, 22289.21987730422, 22310.107595696314, 9147.725568232963, 9232.492212928353, 9351.485668288173, 9378.765530861783, 9442.0, 8502.532360720095, 8521.57392130391, 8547.529885856213, 8573.22840944318, 8705.825883482421, 8506.404551681446, 8805.119488051143, 8931.598078086501, 8938.0, 9047.683331083512, 2621.595719191776, 2660.2418310781336, 2739.4794988952035, 2795.972040279571, 2808.9297767555568, 953.7901661634429, 958.152035448633, 961.1397798969883, 966.7873067925045, 968.0464742228899, 18833.434996950113, 19084.522886927938, 19187.136578853984, 19260.614787704166, 19455.0, 1009.9899001009895, 1017.6590842067842, 1023.1916785739331, 1024.36489376587, 1034.912032477248, 10372.222083343779, 10455.738606534745, 10559.788804223872, 10608.787824243473, 10684.198685098649, 462928.0, 465176.0, 468833.0, 478358.0, 491438.0, 110692.0, 111262.44368778104, 111353.44323278494, 113226.0, 114116.0, 1025.7999690060367, 1045.5086109528509, 1056.816365670454, 1149.2242736153064, 1151.1884121694018, 19773.406797796088, 19821.900890495453, 19933.800661993195, 20049.498762531053, 20315.59368812645, 53497.73251133719, 53909.730451347496, 54433.72783136059, 54789.726051369486, 55775.0, 66923.66538167278, 67191.66404167948, 67245.0, 67327.0, 67332.3266767326, 13726.588202353945, 13816.378262977989, 14044.438222471395, 14183.290835458392, 14190.929045354707, 22394.88802555977, 22470.438239044153, 22706.545869082856, 22805.771942280364, 23206.883965580066, 18080.547986300448, 18093.547661308574, 18354.265829366675, 18439.53901152482, 18488.16803243884, 16446.34214631449, 16650.3339866404, 16735.0, 17062.402815901383, 17274.136293185038, 17562.82437175612, 18508.537286567942, 18728.250869965595, 18908.621827563096, 18915.337963171223, 14058.0, 14098.859011409755, 14180.929095354457, 14202.431902723776, 14256.215908125152, 18030.639387212446, 18049.819501805337, 18213.45359639213, 18270.725939110656, 18272.817271827113], "value": 11652.336749411666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.5050480817288, 1387.5490465598677, 1396.518201220579, 1402.4740722229164, 1405.5291477355086, 15375.154366509838, 15907.920460397696, 15930.999999999985, 15966.680666386665, 15990.520284391458, 15327.0, 15387.615309617266, 15408.30662620182, 15410.768838467404, 15461.149636769973, 2665.5335316319665, 2718.768904643103, 2734.4941185880575, 2737.8767955442054, 2738.438620082878, 2689.0857108583077, 2693.488237234919, 2721.2244510314563, 2723.9319017024536, 2728.0997270900557, 2651.3504191473116, 2730.945381092377, 2730.9726902730918, 2741.2735625059377, 2741.451709658066, 2759.1722483254944, 2760.6135141080263, 2778.7360200780895, 2779.527480328349, 2780.8748606312765, 2655.7875369970357, 2680.1021657744677, 2684.516786978343, 2688.8655567221563, 2719.1162872066657, 14564.635884102876, 14800.185989770558, 14827.92586037063, 14847.48033818822, 14857.554273371816, 7799.96100019502, 8056.798580035487, 8068.556229407381, 8095.878561821577, 8100.270975612164, 4993.433504577245, 5177.844664660066, 5238.659487133325, 5280.392754833167, 5311.2298716686255, 1925.2780207422218, 1925.9325923592746, 1931.198552600669, 1942.3493129801534, 1956.9706454403195, 24434.26697199087, 26135.0, 26259.343516412053, 26475.94096236148, 27517.174484765288, 6716.597004179667, 6751.426128779109, 6907.75822846208, 6972.477064220204, 7020.473464490184, 17053.062081585384, 17079.231434585472, 17124.0, 17130.0, 17142.314307427812, 7818.569978651229, 7991.72028978983, 7991.800204994922, 7994.80012999668, 7994.800129996796, 7298.124225093023, 7332.30343117403, 7337.19290878003, 7454.36637885775, 7461.552306861606, 5145.842185508305, 5288.92066619001, 5309.522143007148, 5380.300560927054, 5392.946070539323, 1467.449706360115, 1472.2785834940803, 1480.6076389756722, 1481.7036592681507, 1483.710676418088, 887.6227603268585, 892.455602082729, 900.6667533012827, 906.4108329585822, 909.1590278991906, 7365.889511657329, 7447.180810110884, 7458.291462311072, 7494.737684181027, 7528.811779705551, 700.915890093192, 708.6385943169021, 708.8936659501013, 717.4296434334613, 720.2653293640458, 4907.460179380265, 5067.5185857343495, 5286.947130528645, 5449.155380915964, 5470.097433923438, 21268.25561105354, 21687.891560542095, 21862.453438663844, 21965.560688786136, 22135.889320553295, 20657.793422065588, 21749.456263593536, 21881.452963675718, 21896.0, 21907.12371505122, 10025.0, 10991.890081099247, 11159.665210043711, 11303.530541029613, 11457.88542114585, 6866.862662746817, 8634.395592308478, 8808.955955220183, 8810.603522841358, 8832.735017949472, 18738.344157954405, 18891.811081889005, 18908.905455472635, 19072.61854762925, 19429.417117486497, 18978.0, 19143.90428047851, 19494.220231190593, 19503.414897553095, 19542.0, 10879.0, 11004.064654504456, 11008.779824403307, 11012.0, 11014.1739369546, 13755.862441375459, 13839.169649821042, 13870.930645346709, 14004.369803359077, 14009.159450433006, 11156.386398748147, 11174.106071514421, 11290.0, 11476.426178690865, 11584.362860042778, 11171.216004379243, 11291.266067705574, 11355.602553910574, 11477.655670329903, 11538.0, 8880.333974951775, 8997.055309192441, 9073.092690730875, 9095.181433671001, 9097.590608422504, 6729.495287853529, 6779.322067793181, 6799.626020568916, 6845.383915447434, 6939.757108501179, 6850.520463567503, 7020.894686579603, 7040.8943865843075, 7058.647067646494, 7082.964585177041], "value": 6581.236349753244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.85246393491803, 496.32882761854967, 522.4984015345268, 523.8742701751581, 530.8062557166634, 6354.841128971778, 6369.6496692681885, 6384.457321127704, 6392.552521323498, 6401.775937842182, 6270.717817698203, 6294.527910406727, 6346.270178929424, 6348.269948955872, 6411.743530258784, 5208.895822083556, 5223.041359490191, 5252.448492908247, 5265.605079619035, 5280.257515020054, 4883.682560633565, 4963.751812409383, 5108.2887232776875, 5196.506331898464, 5233.21501774733, 4921.138800709879, 4969.826056088038, 5001.324821149135, 5017.397912250535, 5023.095842748304, 4962.3548938638105, 4962.975185124052, 4980.178270585349, 4988.5260900214425, 5022.0, 4324.632406245473, 4445.444319460067, 4450.5104438511735, 4466.0, 4482.843100491467, 6119.663418512025, 6137.478314343286, 6147.170132032208, 6153.784617538409, 6174.59865108771, 5661.131826497287, 5707.3721890592005, 5722.570807189478, 5725.541956643458, 5730.7421166047625, 6567.441767449773, 6578.440832529241, 6620.404163625249, 6625.768098116543, 6638.236602790693, 4622.745748983804, 4854.538818812207, 4883.584895283905, 4892.315075889378, 4933.777979990873, 6626.503012274051, 6659.267480577133, 6709.027191057318, 6822.658867056627, 6938.91832450273, 4945.381827271591, 4985.351904252424, 4985.476524964826, 5002.59979201663, 5007.424146223231, 5002.374703162105, 5028.723420211923, 5082.593392528663, 5089.312942752755, 5098.490150984871, 5676.545876329884, 5726.627769194989, 5743.167240750068, 5763.049096899049, 5763.769449221984, 6645.435138013323, 6649.434798042221, 6676.499262555328, 6696.0, 6740.0, 1730.9048002359739, 1738.4523874979593, 1752.1502071495315, 1760.8063113057553, 1781.4299424184137, 1148.0, 1213.4539457244275, 1224.6877046353302, 1225.6874497003384, 1235.2650173146963, 5673.574481913873, 5708.20085188074, 5721.456461636138, 5754.942450575524, 5799.449052340021, 6623.9006414903815, 6668.365995431777, 6679.365460281266, 6691.1636045494315, 6704.731810727614, 5624.859378515488, 5658.85852853682, 5668.914966275509, 5688.8862222755315, 5693.772249109989, 3521.2182375922735, 3522.9647703522637, 3582.140286331262, 3589.892303230907, 3599.4240921452442, 6327.430531252209, 6389.712462939179, 6412.461009357814, 6446.161998940108, 6465.838354041187, 6739.258681545026, 6801.489888258301, 6841.281665425158, 6873.347032031949, 6916.688749006306, 5975.611585247032, 6318.178636777281, 6448.290688024314, 6537.901931471127, 6556.213254409501, 6760.695768690519, 6768.153980752406, 6777.457803375817, 6806.251312355538, 6840.8289792753585, 6674.466042716668, 6719.353758329241, 6731.394174524316, 6773.627450490073, 6799.354061364163, 6398.360163983564, 6417.518686098655, 6445.452136568444, 6474.838129046811, 6496.765614533224, 4911.7298548580175, 4946.060248552763, 4976.328195693535, 4984.277279794337, 4986.80052797884, 6378.521610879296, 6629.635370054693, 6644.578042308119, 6717.790797656468, 6833.009213663891, 6260.77570051433, 6400.743970241138, 6471.967640161957, 6477.190351206099, 6513.837154071186, 6457.126578672445, 6459.870802583828, 6507.707153178024, 6536.738530458729, 6549.4760419167305, 6361.459275961595, 6439.227292724716, 6442.1976440248645, 6465.773697920738, 6505.739770409131, 6645.239011661817, 6659.234188068241, 6663.83340416474, 6672.933270667231, 6688.7324507019175, 6386.457151142205, 6432.485401167989, 6432.807015789534, 6460.546377065123, 6463.547551671338], "value": 5063.146659352117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.0922095631023, 909.5406819556124, 918.0910898210774, 923.1322556796611, 944.8110377924414, 18728.625427491443, 19692.70460943087, 19701.901490492528, 19709.211631534738, 19718.408447746555, 17330.82669173308, 17889.0, 17990.640187196248, 18015.27938882443, 18140.45578632643, 925.9722208333761, 935.3732998890725, 938.0478814003792, 939.7556635274809, 939.7603611079165, 959.9520023998807, 981.4160574458186, 981.7987312600935, 982.5185659027097, 989.7822479054596, 1040.1522758951469, 1043.6712435582806, 1046.5918291866178, 1047.0158051431667, 1049.559185142242, 1001.2890847498285, 1018.5925629748086, 1041.6874937518753, 1042.3016578892161, 1043.6503771236644, 734.7061175529777, 735.1655870586869, 735.5807189901758, 737.9409647228209, 742.8588568172084, 19362.515937101543, 19612.215511379527, 19647.0, 19673.114709838093, 19725.506862328555, 21666.458338541506, 22092.779072209232, 22485.437864053365, 22525.887370563207, 22547.323580292617, 17398.0, 17443.5639109022, 17502.29990800379, 17632.911835440867, 17684.557886052822, 3681.5398075240596, 3715.498407714978, 3716.4053751399647, 3717.014991027353, 3717.070732316921, 143105.0, 143584.0, 144121.55878441187, 148241.0, 149279.0, 16454.67090658204, 16843.91578042102, 16976.0, 16983.49049528516, 16996.745048824276, 30567.0, 31621.683783161872, 31659.0, 31665.20836979094, 31807.84096079505, 7265.963670181721, 7430.256974302634, 7488.475806693588, 7495.400367970549, 7505.474616776883, 4080.6327430531396, 4181.184668989578, 4188.183304255702, 4191.517975432804, 4202.453681021448, 5447.809326673548, 5563.916541251884, 5600.159976003632, 5982.790602328898, 6095.420935011167, 1114.4260705736551, 1152.8501294831617, 1153.7404084081184, 1156.3524426321287, 1162.7965106106567, 694.8401867570487, 708.479267738212, 713.457772093213, 719.2914978745931, 727.1855521815601, 12559.560415385418, 12693.555725549562, 12791.232526048467, 13189.340532973312, 13373.598792036255, 654.5123882707318, 657.3098246840893, 661.2197606823994, 665.670493105906, 680.8365992161846, 5396.757145928443, 5405.324334458192, 5413.512783849473, 5559.027170245191, 5579.0515612346, 124053.37973310075, 125283.0, 126032.0, 126889.0, 132727.0, 106877.46561267144, 108397.0, 108868.4556577212, 109118.45440772903, 109509.45245273723, 88947.0, 89003.0, 90348.0, 93698.53150734202, 94092.0, 10478.266521343432, 10481.737956551147, 10559.894401055892, 10560.947195263974, 10580.41807700553, 43459.78270108629, 44480.11039779251, 45421.0, 45459.31811022903, 45737.31394029026, 56387.154192687965, 56697.0, 58277.0, 58399.0, 59530.70234648799, 16722.0, 17053.744193836854, 17056.658866822345, 17203.13984300755, 17205.311787528357, 17260.136993150543, 17461.650766984843, 17510.124493775515, 17525.211365488838, 17621.911890440464, 16060.839391605934, 16199.595010124369, 16237.512874613309, 16366.509004729876, 16407.917960410123, 16774.66450671004, 17048.659026819147, 17054.062026588657, 17193.484195474157, 17201.913990429966, 16255.918720406322, 16295.18524073768, 16347.591310216863, 16461.83538164651, 16481.67036659284, 11191.608293709682, 11245.662630121109, 11465.082793376676, 11631.88368116308, 11660.883391166319, 12316.876831231932, 12356.62930112098, 12455.750884982432, 12500.937495312466, 12712.36438178069], "value": 9007.680475249737, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1412.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 108.0, 109.0, 110.0, 96.0, 109.0, 108.0, 109.0, 107.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 116.0, 119.0, 116.0, 120.0, 119.0, 121.0, 117.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 159.0, 161.0, 162.0, 161.0, 165.0, 166.0, 165.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 78.0, 78.0, 78.0, 78.0, 87.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 150.0, 156.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 94.0, 93.0, 93.0, 94.0, 96.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 50.0, 51.0, 52.0, 52.0, 53.0, 51.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 76.0, 76.0, 74.0, 74.0, 78.0, 77.0, 73.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 111.0, 113.0, 115.0, 115.0, 116.0, 113.0, 113.0, 109.0], "value": 113.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 166.0, 172.0, 167.0, 179.0, 167.0, 165.0, 165.0, 170.0, 168.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 64.0, 66.0, 71.0, 63.0, 69.0, 65.0, 63.0], "value": 65.7, "unit": "score"}]}]} 17:47:51 INFO - Return code: 0 17:47:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:47:51 INFO - # TBPL SUCCESS # 17:47:51 INFO - Running post-action listener: _package_coverage_data 17:47:51 INFO - Running post-action listener: _resource_record_post_action 17:47:51 INFO - [mozharness: 2017-09-14 00:47:51.883076Z] Finished run-tests step (success) 17:47:51 INFO - Running post-run listener: _resource_record_post_run 17:47:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 11448320; Write bytes: 596787200; Read time: 4432; Write time: 518512 17:47:51 INFO - TinderboxPrint: CPU usage
13.1% 17:47:51 INFO - TinderboxPrint: I/O read bytes / time
11,448,320 / 4,432 17:47:51 INFO - TinderboxPrint: I/O write bytes / time
596,787,200 / 518,512 17:47:51 INFO - TinderboxPrint: CPU idle
8,261.5 (86.9%) 17:47:51 INFO - TinderboxPrint: CPU user
1,193.6 (12.5%) 17:47:51 INFO - TinderboxPrint: Swap in / out
0 / 0 17:47:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105201664; Read time: 20; Write time: 55864 17:47:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:47:51 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 9256960; Write bytes: 448327680; Read time: 4016; Write time: 420252 17:47:52 INFO - Running post-run listener: _upload_blobber_files 17:47:52 INFO - Blob upload gear active. 17:47:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:47:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:53 INFO - (blobuploader) - INFO - Done attempting. 17:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:00 INFO - (blobuploader) - INFO - Done attempting. 17:48:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:48:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:01 INFO - (blobuploader) - INFO - Done attempting. 17:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:02 INFO - (blobuploader) - INFO - Done attempting. 17:48:02 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:02 INFO - Return code: 0 17:48:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbef3d288d21ae996ff72dd0e76dd9231ae4d3d6caaa870934727dbc347cf0f641984c1517d59ecad3ba7b0c2f567fd139862339c83ef1dd457d02e4d081ee06", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eda60d5433ec8e8c9ceabcfa2f1da887f802e0a7e648c653c1aceb661a61cf092ddf684f9d5f4b3c5e901306ff490a3e898801c80ae3e67d454276969520d5df", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/326f26ca0f54509a0caf895581e6c865f337231edca2fb71c024739a6b67e20e9003a9559ddfabb7a657aef2aad2992a906bdc1a58a25afb16fd3ae2023be19d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32c1b2e39c00dd1caedf67e4b9e8f9ed303bbb02e4717e5a88c08dfe80d565e8a187bee021f76265f9a7d5fc6448c9439a34ab648964775c30202f51c0da5704"} 17:48:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:02 INFO - Contents: 17:48:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbef3d288d21ae996ff72dd0e76dd9231ae4d3d6caaa870934727dbc347cf0f641984c1517d59ecad3ba7b0c2f567fd139862339c83ef1dd457d02e4d081ee06", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eda60d5433ec8e8c9ceabcfa2f1da887f802e0a7e648c653c1aceb661a61cf092ddf684f9d5f4b3c5e901306ff490a3e898801c80ae3e67d454276969520d5df", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/326f26ca0f54509a0caf895581e6c865f337231edca2fb71c024739a6b67e20e9003a9559ddfabb7a657aef2aad2992a906bdc1a58a25afb16fd3ae2023be19d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32c1b2e39c00dd1caedf67e4b9e8f9ed303bbb02e4717e5a88c08dfe80d565e8a187bee021f76265f9a7d5fc6448c9439a34ab648964775c30202f51c0da5704"} 17:48:02 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:02 INFO - Copying logs to upload dir... 17:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.048843 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-13 17:48:02.828556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 17:48:02.835624) ========= 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=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 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/bbef3d288d21ae996ff72dd0e76dd9231ae4d3d6caaa870934727dbc347cf0f641984c1517d59ecad3ba7b0c2f567fd139862339c83ef1dd457d02e4d081ee06", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eda60d5433ec8e8c9ceabcfa2f1da887f802e0a7e648c653c1aceb661a61cf092ddf684f9d5f4b3c5e901306ff490a3e898801c80ae3e67d454276969520d5df", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/326f26ca0f54509a0caf895581e6c865f337231edca2fb71c024739a6b67e20e9003a9559ddfabb7a657aef2aad2992a906bdc1a58a25afb16fd3ae2023be19d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32c1b2e39c00dd1caedf67e4b9e8f9ed303bbb02e4717e5a88c08dfe80d565e8a187bee021f76265f9a7d5fc6448c9439a34ab648964775c30202f51c0da5704"} build_url:https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011143 build_url: 'https://queue.taskcluster.net/v1/task/GhKihdsTQkWhAO3N2_oAlA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbef3d288d21ae996ff72dd0e76dd9231ae4d3d6caaa870934727dbc347cf0f641984c1517d59ecad3ba7b0c2f567fd139862339c83ef1dd457d02e4d081ee06", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eda60d5433ec8e8c9ceabcfa2f1da887f802e0a7e648c653c1aceb661a61cf092ddf684f9d5f4b3c5e901306ff490a3e898801c80ae3e67d454276969520d5df", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/326f26ca0f54509a0caf895581e6c865f337231edca2fb71c024739a6b67e20e9003a9559ddfabb7a657aef2aad2992a906bdc1a58a25afb16fd3ae2023be19d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32c1b2e39c00dd1caedf67e4b9e8f9ed303bbb02e4717e5a88c08dfe80d565e8a187bee021f76265f9a7d5fc6448c9439a34ab648964775c30202f51c0da5704"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 17:48:02.863344) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:48:02.863695) ========= 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=bb9b54edd4a927dc735d112f000001d9-1505348834.403792-66448103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:48:03.002390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 17:48:03.002700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 17:48:03.003051) ========= ========= Total master_lag: 0.34 =========