builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-081 starttime: 1506278130.32 results: success (0) revision: 877c02446745576ac97f181dd9eeec78ef605451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.316341) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.316894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.317364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.335584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.336006) ========= 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=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 11:35:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.0M=0s 2017-09-24 11:35:30 (69.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.441447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.441794) ========= 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=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.492202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:30.492813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 877c02446745576ac97f181dd9eeec78ef605451 --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 877c02446745576ac97f181dd9eeec78ef605451 --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=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 11:35:30,542 truncating revision to first 12 chars 2017-09-24 11:35:30,542 Setting DEBUG logging. 2017-09-24 11:35:30,543 attempt 1/10 2017-09-24 11:35:30,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/877c02446745?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 11:35:30,831 unpacking tar archive at: mozilla-central-877c02446745/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:31.082082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:31.082489) ========= script_repo_revision: 877c02446745576ac97f181dd9eeec78ef605451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:31.083094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:31.083463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 11:35:31.097611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-24 11:35:31.098150) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:35:31 INFO - MultiFileLogger online at 20170924 11:35:31 in /builds/slave/test 11:35:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:35:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:31 INFO - {'append_to_log': False, 11:35:31 INFO - 'base_work_dir': '/builds/slave/test', 11:35:31 INFO - 'blob_upload_branch': 'Firefox', 11:35:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:31 INFO - 'branch': 'Firefox', 11:35:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:31 INFO - 'code_coverage': False, 11:35:31 INFO - 'config_files': ('talos/linux_config.py',), 11:35:31 INFO - 'default_actions': ('clobber', 11:35:31 INFO - 'read-buildbot-config', 11:35:31 INFO - 'download-and-extract', 11:35:31 INFO - 'populate-webroot', 11:35:31 INFO - 'create-virtualenv', 11:35:31 INFO - 'install', 11:35:31 INFO - 'setup-mitmproxy', 11:35:31 INFO - 'run-tests'), 11:35:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:31 INFO - 'disable_ccov_upload': False, 11:35:31 INFO - 'disable_stylo': False, 11:35:31 INFO - 'download_minidump_stackwalk': True, 11:35:31 INFO - 'download_symbols': 'ondemand', 11:35:31 INFO - 'enable_stylo': False, 11:35:31 INFO - 'enable_webrender': False, 11:35:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:35:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:31 INFO - 'gecko_profile': False, 11:35:31 INFO - 'gecko_profile_interval': 0, 11:35:31 INFO - 'installer_path': 'installer.exe', 11:35:31 INFO - 'log_level': 'info', 11:35:31 INFO - 'log_name': 'talos', 11:35:31 INFO - 'log_to_console': True, 11:35:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:35:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:35:31 INFO - 'opt_config_files': (), 11:35:31 INFO - 'pip_index': False, 11:35:31 INFO - 'suite': 'dromaeojs-e10s', 11:35:31 INFO - 'system_bits': '32', 11:35:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:31 INFO - 'title': 'talos-linux64-ix-081', 11:35:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:31 INFO - 'use_talos_json': True, 11:35:31 INFO - 'verify': 'False', 11:35:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:31 INFO - 'work_dir': 'build'} 11:35:31 INFO - [mozharness: 2017-09-24 18:35:31.300053Z] Running clobber step. 11:35:31 INFO - Running pre-action listener: _resource_record_pre_action 11:35:31 INFO - Running main action method: clobber 11:35:31 INFO - rmtree: /builds/slave/test/build 11:35:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:32 INFO - Running post-action listener: _resource_record_post_action 11:35:32 INFO - [mozharness: 2017-09-24 18:35:32.289801Z] Finished clobber step (success) 11:35:32 INFO - [mozharness: 2017-09-24 18:35:32.289898Z] Running read-buildbot-config step. 11:35:32 INFO - Running pre-action listener: _resource_record_pre_action 11:35:32 INFO - Running main action method: read_buildbot_config 11:35:32 INFO - Using buildbot properties: 11:35:32 INFO - { 11:35:32 INFO - "project": "", 11:35:32 INFO - "product": "firefox", 11:35:32 INFO - "who": "ffxbld@noreply.mozilla.org", 11:35:32 INFO - "installer_path": "public/build/target.tar.bz2", 11:35:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:35:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:35:32 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:35:32 INFO - "stage_platform": "linux64-qr", 11:35:32 INFO - "basedir": "/builds/slave/test", 11:35:32 INFO - "buildnumber": 79, 11:35:32 INFO - "platform": "ubuntu64_hw_qr", 11:35:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:35:32 INFO - "slavebuilddir": "test", 11:35:32 INFO - "taskId": "P8Deltm5R_WXkQgwhTER6g", 11:35:32 INFO - "branch": "mozilla-central", 11:35:32 INFO - "script_repo_revision": "production", 11:35:32 INFO - "revision": "877c02446745576ac97f181dd9eeec78ef605451", 11:35:32 INFO - "slavename": "talos-linux64-ix-081", 11:35:32 INFO - "repo_path": "mozilla-central" 11:35:32 INFO - } 11:35:32 INFO - Finding installer, test and symbols from parent task. 11:35:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8Deltm5R_WXkQgwhTER6g'}, attempt #1 11:35:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P8Deltm5R_WXkQgwhTER6g'}, attempt #1 11:35:33 INFO - Task dependencies: EBqoJLZ9SxOo9gWWXOxngg 11:35:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg'}, attempt #1 11:35:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 11:35:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.test_packages.json 11:35:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.crashreporter-symbols.zip 11:35:33 INFO - Running post-action listener: _resource_record_post_action 11:35:33 INFO - [mozharness: 2017-09-24 18:35:33.607352Z] Finished read-buildbot-config step (success) 11:35:33 INFO - [mozharness: 2017-09-24 18:35:33.607570Z] Running download-and-extract step. 11:35:33 INFO - Running pre-action listener: _resource_record_pre_action 11:35:33 INFO - Running main action method: download_and_extract 11:35:33 INFO - mkdir: /builds/slave/test/build/tests 11:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:33 INFO - trying https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.test_packages.json 11:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:35:34 INFO - Downloaded 989 bytes. 11:35:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:35:34 INFO - Using the following test package requirements: 11:35:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:35:34 INFO - u'common': [u'target.common.tests.zip'], 11:35:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:35:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:35:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:35:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:35:34 INFO - u'mozbase': [u'target.common.tests.zip'], 11:35:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:35:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:35:34 INFO - u'web-platform': [u'target.common.tests.zip', 11:35:34 INFO - u'target.web-platform.tests.tar.gz'], 11:35:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:35:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.common.tests.zip 11:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.common.tests.zip into memory 11:35:37 INFO - Content-Length response header: 54943889 11:35:37 INFO - Bytes received: 54943889 11:35:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.talos.tests.zip 11:35:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:35:47 INFO - Fetch https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.talos.tests.zip into memory 11:35:49 INFO - Content-Length response header: 14513823 11:35:49 INFO - Bytes received: 14513823 11:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:49 INFO - trying https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 11:35:49 INFO - Downloading https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:35:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:35:51 INFO - Downloaded 61787139 bytes. 11:35:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 11:35:51 INFO - mkdir: /builds/slave/test/properties 11:35:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:35:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:35:51 INFO - Contents: 11:35:51 INFO - build_url:https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 11:35:51 INFO - Running post-action listener: _resource_record_post_action 11:35:51 INFO - Running post-action listener: find_tests_for_verification 11:35:51 INFO - Running post-action listener: set_extra_try_arguments 11:35:51 INFO - [mozharness: 2017-09-24 18:35:51.512452Z] Finished download-and-extract step (success) 11:35:51 INFO - [mozharness: 2017-09-24 18:35:51.512552Z] Running populate-webroot step. 11:35:51 INFO - Running pre-action listener: _resource_record_pre_action 11:35:51 INFO - Running main action method: populate_webroot 11:35:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:35:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['tresize', 11:35:51 INFO - 'tcanvasmark']}, 11:35:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:35:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['dromaeo_css', 11:35:51 INFO - 'kraken']}, 11:35:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:35:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'tests': ['damp', 'tps']}, 11:35:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['damp', 'tps']}, 11:35:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:35:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['dromaeo_dom']}, 11:35:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:35:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['basic_compositor_video', 11:35:51 INFO - 'glvideo']}, 11:35:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:35:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['ts_paint_webext', 11:35:51 INFO - 'tp5o_webext']}, 11:35:51 INFO - 'other-e10s': {'tests': ['a11yr', 11:35:51 INFO - 'ts_paint', 11:35:51 INFO - 'tpaint', 11:35:51 INFO - 'sessionrestore', 11:35:51 INFO - 'sessionrestore_many_windows', 11:35:51 INFO - 'sessionrestore_no_auto_restore', 11:35:51 INFO - 'tabpaint']}, 11:35:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['a11yr', 11:35:51 INFO - 'ts_paint', 11:35:51 INFO - 'tpaint', 11:35:51 INFO - 'sessionrestore', 11:35:51 INFO - 'sessionrestore_many_windows', 11:35:51 INFO - 'sessionrestore_no_auto_restore', 11:35:51 INFO - 'tabpaint']}, 11:35:51 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:35:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:35:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['perf_reftest_singletons']}, 11:35:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['perf_reftest']}, 11:35:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:35:51 INFO - 'tsvgr_opacity', 11:35:51 INFO - 'tart', 11:35:51 INFO - 'tscrollx', 11:35:51 INFO - 'tsvg_static']}, 11:35:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['tsvgx', 11:35:51 INFO - 'tsvgr_opacity', 11:35:51 INFO - 'tart', 11:35:51 INFO - 'tscrollx', 11:35:51 INFO - 'tsvg_static']}, 11:35:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:35:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--disable-stylo'], 11:35:51 INFO - 'tests': ['tp5o']}, 11:35:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:35:51 INFO - 'talos_options': ['--mitmproxy', 11:35:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:51 INFO - '--firstNonBlankPaint'], 11:35:51 INFO - 'tests': ['tp6_google', 11:35:51 INFO - 'tp6_youtube', 11:35:51 INFO - 'tp6_amazon', 11:35:51 INFO - 'tp6_facebook']}, 11:35:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:35:51 INFO - 'talos_options': ['--disable-stylo', 11:35:51 INFO - '--mitmproxy', 11:35:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:51 INFO - '--firstNonBlankPaint'], 11:35:51 INFO - 'tests': ['tp6_google', 11:35:51 INFO - 'tp6_youtube', 11:35:51 INFO - 'tp6_amazon', 11:35:51 INFO - 'tp6_facebook']}, 11:35:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:35:51 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:35:51 INFO - 'talos_options': ['--stylo-threads=1', 11:35:51 INFO - '--mitmproxy', 11:35:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:35:51 INFO - '--firstNonBlankPaint'], 11:35:51 INFO - 'tests': ['tp6_google', 11:35:51 INFO - 'tp6_youtube', 11:35:51 INFO - 'tp6_amazon', 11:35:51 INFO - 'tp6_facebook']}, 11:35:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--xperf_path', 11:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:51 INFO - 'tests': ['tp5n']}, 11:35:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:35:51 INFO - 'talos_options': ['--disable-stylo', 11:35:51 INFO - '--xperf_path', 11:35:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:35:51 INFO - 'tests': ['tp5n']}}} 11:35:51 INFO - Running post-action listener: _resource_record_post_action 11:35:51 INFO - [mozharness: 2017-09-24 18:35:51.527979Z] Finished populate-webroot step (success) 11:35:51 INFO - [mozharness: 2017-09-24 18:35:51.528069Z] Running create-virtualenv step. 11:35:51 INFO - Running pre-action listener: _resource_record_pre_action 11:35:51 INFO - Running main action method: create_virtualenv 11:35:51 INFO - Creating virtualenv /builds/slave/test/build/venv 11:35:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:35:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:35:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:35:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:35:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:35:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:35:52 INFO - Installing pip...............done. 11:35:52 INFO - Return code: 0 11:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:35:52 INFO - Reading from file tmpfile_stdout 11:35:52 INFO - Output received: 11:35:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:35:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:35:52 INFO - Using env: {'DISPLAY': ':0', 11:35:52 INFO - 'HOME': '/home/cltbld', 11:35:52 INFO - 'LANG': 'en_US.UTF-8', 11:35:52 INFO - 'LANGUAGE': 'en_US:en', 11:35:52 INFO - 'LOGNAME': 'cltbld', 11:35:52 INFO - 'MAIL': '/var/mail/cltbld', 11:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:52 INFO - 'MOZ_NO_REMOTE': '1', 11:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:52 INFO - 'NO_EM_RESTART': '1', 11:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:52 INFO - 'PWD': '/builds/slave/test', 11:35:52 INFO - 'SHELL': '/bin/bash', 11:35:52 INFO - 'SHLVL': '1', 11:35:52 INFO - 'TERM': 'linux', 11:35:52 INFO - 'TMOUT': '86400', 11:35:52 INFO - 'USER': 'cltbld', 11:35:52 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:52 INFO - '_': '/tools/buildbot/bin/python'} 11:35:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:35:53 INFO - Downloading/unpacking pip>=1.5 11:35:53 INFO - Running setup.py egg_info for package pip 11:35:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:35:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:35:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:35:53 INFO - Installing collected packages: pip 11:35:53 INFO - Found existing installation: pip 1.1 11:35:53 INFO - Uninstalling pip: 11:35:53 INFO - Successfully uninstalled pip 11:35:53 INFO - Running setup.py install for pip 11:35:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:35:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:35:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:35:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:35:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:35:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:35:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:35:53 INFO - Successfully installed pip 11:35:53 INFO - Cleaning up... 11:35:53 INFO - Return code: 0 11:35:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:35: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')]} 11:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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')]} 11:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:35:53 INFO - Using env: {'DISPLAY': ':0', 11:35:53 INFO - 'HOME': '/home/cltbld', 11:35:53 INFO - 'LANG': 'en_US.UTF-8', 11:35:53 INFO - 'LANGUAGE': 'en_US:en', 11:35:53 INFO - 'LOGNAME': 'cltbld', 11:35:53 INFO - 'MAIL': '/var/mail/cltbld', 11:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:53 INFO - 'MOZ_NO_REMOTE': '1', 11:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:53 INFO - 'NO_EM_RESTART': '1', 11:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:53 INFO - 'PWD': '/builds/slave/test', 11:35:53 INFO - 'SHELL': '/bin/bash', 11:35:53 INFO - 'SHLVL': '1', 11:35:53 INFO - 'TERM': 'linux', 11:35:53 INFO - 'TMOUT': '86400', 11:35:53 INFO - 'USER': 'cltbld', 11:35:53 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:53 INFO - '_': '/tools/buildbot/bin/python'} 11:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:54 INFO - Downloading/unpacking psutil>=3.1.1 11:35: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 11:35: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 11:35: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 11:35: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 11:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:55 INFO - Installing collected packages: psutil 11:35:55 INFO - Running setup.py install for psutil 11:35:55 INFO - building 'psutil._psutil_linux' extension 11:35:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:35:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:35:55 INFO - building 'psutil._psutil_posix' extension 11:35:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:35:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:35:55 INFO - Successfully installed psutil 11:35:55 INFO - Cleaning up... 11:35:56 INFO - Return code: 0 11:35:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:35: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')]} 11:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35: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')]} 11:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:56 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 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:35:56 INFO - Using env: {'DISPLAY': ':0', 11:35:56 INFO - 'HOME': '/home/cltbld', 11:35:56 INFO - 'LANG': 'en_US.UTF-8', 11:35:56 INFO - 'LANGUAGE': 'en_US:en', 11:35:56 INFO - 'LOGNAME': 'cltbld', 11:35:56 INFO - 'MAIL': '/var/mail/cltbld', 11:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:56 INFO - 'MOZ_NO_REMOTE': '1', 11:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:56 INFO - 'NO_EM_RESTART': '1', 11:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:56 INFO - 'PWD': '/builds/slave/test', 11:35:56 INFO - 'SHELL': '/bin/bash', 11:35:56 INFO - 'SHLVL': '1', 11:35:56 INFO - 'TERM': 'linux', 11:35:56 INFO - 'TMOUT': '86400', 11:35:56 INFO - 'USER': 'cltbld', 11:35:56 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:56 INFO - '_': '/tools/buildbot/bin/python'} 11:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:35: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 11:35: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 11:35: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 11:35: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 11:35:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:35:57 INFO - Installing collected packages: mozsystemmonitor 11:35:57 INFO - Running setup.py install for mozsystemmonitor 11:35:57 INFO - Successfully installed mozsystemmonitor 11:35:57 INFO - Cleaning up... 11:35:58 INFO - Return code: 0 11:35:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:35: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==2.5.1'] in /builds/slave/test/build 11:35: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==2.5.1 11:35:58 INFO - Using env: {'DISPLAY': ':0', 11:35:58 INFO - 'HOME': '/home/cltbld', 11:35:58 INFO - 'LANG': 'en_US.UTF-8', 11:35:58 INFO - 'LANGUAGE': 'en_US:en', 11:35:58 INFO - 'LOGNAME': 'cltbld', 11:35:58 INFO - 'MAIL': '/var/mail/cltbld', 11:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:58 INFO - 'MOZ_NO_REMOTE': '1', 11:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:58 INFO - 'NO_EM_RESTART': '1', 11:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:58 INFO - 'PWD': '/builds/slave/test', 11:35:58 INFO - 'SHELL': '/bin/bash', 11:35:58 INFO - 'SHLVL': '1', 11:35:58 INFO - 'TERM': 'linux', 11:35:58 INFO - 'TMOUT': '86400', 11:35:58 INFO - 'USER': 'cltbld', 11:35:58 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:58 INFO - '_': '/tools/buildbot/bin/python'} 11:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:35:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:35:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:35:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:35:59 INFO - warning: no files found matching '*.txt' 11:35:59 INFO - no previously-included directories found matching 'build' 11:35:59 INFO - no previously-included directories found matching 'dist' 11:35:59 INFO - no previously-included directories found matching '.git*' 11:35:59 INFO - Installing collected packages: jsonschema, functools32 11:35:59 INFO - Running setup.py install for functools32 11:35:59 INFO - warning: no files found matching '*.txt' 11:35:59 INFO - no previously-included directories found matching 'build' 11:35:59 INFO - no previously-included directories found matching 'dist' 11:35:59 INFO - no previously-included directories found matching '.git*' 11:35:59 INFO - Successfully installed jsonschema functools32 11:35:59 INFO - Cleaning up... 11:35:59 INFO - Return code: 0 11:35:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:35:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:35:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:35:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:35:59 INFO - Using env: {'DISPLAY': ':0', 11:35:59 INFO - 'HOME': '/home/cltbld', 11:35:59 INFO - 'LANG': 'en_US.UTF-8', 11:35:59 INFO - 'LANGUAGE': 'en_US:en', 11:35:59 INFO - 'LOGNAME': 'cltbld', 11:35:59 INFO - 'MAIL': '/var/mail/cltbld', 11:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:59 INFO - 'MOZ_NO_REMOTE': '1', 11:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:59 INFO - 'NO_EM_RESTART': '1', 11:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:59 INFO - 'PWD': '/builds/slave/test', 11:35:59 INFO - 'SHELL': '/bin/bash', 11:35:59 INFO - 'SHLVL': '1', 11:35:59 INFO - 'TERM': 'linux', 11:35:59 INFO - 'TMOUT': '86400', 11:35:59 INFO - 'USER': 'cltbld', 11:35:59 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:59 INFO - '_': '/tools/buildbot/bin/python'} 11:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:36:00 INFO - Cleaning up... 11:36:00 INFO - Return code: 0 11:36:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:36:00 INFO - Using env: {'DISPLAY': ':0', 11:36:00 INFO - 'HOME': '/home/cltbld', 11:36:00 INFO - 'LANG': 'en_US.UTF-8', 11:36:00 INFO - 'LANGUAGE': 'en_US:en', 11:36:00 INFO - 'LOGNAME': 'cltbld', 11:36:00 INFO - 'MAIL': '/var/mail/cltbld', 11:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:00 INFO - 'MOZ_NO_REMOTE': '1', 11:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:00 INFO - 'NO_EM_RESTART': '1', 11:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:00 INFO - 'PWD': '/builds/slave/test', 11:36:00 INFO - 'SHELL': '/bin/bash', 11:36:00 INFO - 'SHLVL': '1', 11:36:00 INFO - 'TERM': 'linux', 11:36:00 INFO - 'TMOUT': '86400', 11:36:00 INFO - 'USER': 'cltbld', 11:36:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:00 INFO - '_': '/tools/buildbot/bin/python'} 11:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:01 INFO - Downloading docopt-0.6.1.tar.gz 11:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:02 INFO - Running setup.py install for blobuploader 11:36:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:02 INFO - Running setup.py install for requests 11:36:02 INFO - Running setup.py install for docopt 11:36:02 INFO - Successfully installed blobuploader requests docopt 11:36:02 INFO - Cleaning up... 11:36:02 INFO - Return code: 0 11:36:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:02 INFO - Using env: {'DISPLAY': ':0', 11:36:02 INFO - 'HOME': '/home/cltbld', 11:36:02 INFO - 'LANG': 'en_US.UTF-8', 11:36:02 INFO - 'LANGUAGE': 'en_US:en', 11:36:02 INFO - 'LOGNAME': 'cltbld', 11:36:02 INFO - 'MAIL': '/var/mail/cltbld', 11:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:02 INFO - 'MOZ_NO_REMOTE': '1', 11:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:02 INFO - 'NO_EM_RESTART': '1', 11:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:02 INFO - 'PWD': '/builds/slave/test', 11:36:02 INFO - 'SHELL': '/bin/bash', 11:36:02 INFO - 'SHLVL': '1', 11:36:02 INFO - 'TERM': 'linux', 11:36:02 INFO - 'TMOUT': '86400', 11:36:02 INFO - 'USER': 'cltbld', 11:36:02 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:02 INFO - '_': '/tools/buildbot/bin/python'} 11:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:02 INFO - Running setup.py (path:/tmp/pip-a04Fxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:02 INFO - Running setup.py (path:/tmp/pip-9NuvSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:02 INFO - Running setup.py (path:/tmp/pip-c2jJAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:03 INFO - Running setup.py (path:/tmp/pip-DC8ai_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:03 INFO - Running setup.py (path:/tmp/pip-QD2Ene-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:03 INFO - Running setup.py (path:/tmp/pip-w4mFes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:03 INFO - Running setup.py (path:/tmp/pip-zQStoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:03 INFO - Running setup.py (path:/tmp/pip-kf8RkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:03 INFO - Running setup.py (path:/tmp/pip-kpJHYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:03 INFO - Running setup.py (path:/tmp/pip-UxUBOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:03 INFO - Running setup.py (path:/tmp/pip-rQ9aGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:03 INFO - Running setup.py (path:/tmp/pip-Zhw8u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:03 INFO - Running setup.py (path:/tmp/pip-KDJizr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:03 INFO - Running setup.py (path:/tmp/pip-CnlCuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:03 INFO - Running setup.py (path:/tmp/pip-lIpdsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:03 INFO - Running setup.py (path:/tmp/pip-VZMRrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:03 INFO - Running setup.py (path:/tmp/pip-rBj0Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:04 INFO - Running setup.py install for manifestparser 11:36:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozcrash 11:36:04 INFO - Running setup.py install for mozdebug 11:36:04 INFO - Running setup.py install for mozdevice 11:36:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozfile 11:36:04 INFO - Running setup.py install for mozhttpd 11:36:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozinfo 11:36:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozInstall 11:36:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:04 INFO - Running setup.py install for mozleak 11:36:04 INFO - Running setup.py install for mozlog 11:36:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for moznetwork 11:36:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozprocess 11:36:05 INFO - Running setup.py install for mozprofile 11:36:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozrunner 11:36:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Running setup.py install for mozscreenshot 11:36:05 INFO - Running setup.py install for moztest 11:36:05 INFO - Running setup.py install for mozversion 11:36:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:05 INFO - Cleaning up... 11:36:05 INFO - Return code: 0 11:36:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:36:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:05 INFO - Using env: {'DISPLAY': ':0', 11:36:05 INFO - 'HOME': '/home/cltbld', 11:36:05 INFO - 'LANG': 'en_US.UTF-8', 11:36:05 INFO - 'LANGUAGE': 'en_US:en', 11:36:05 INFO - 'LOGNAME': 'cltbld', 11:36:05 INFO - 'MAIL': '/var/mail/cltbld', 11:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:05 INFO - 'MOZ_NO_REMOTE': '1', 11:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:05 INFO - 'NO_EM_RESTART': '1', 11:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:05 INFO - 'PWD': '/builds/slave/test', 11:36:05 INFO - 'SHELL': '/bin/bash', 11:36:05 INFO - 'SHLVL': '1', 11:36:05 INFO - 'TERM': 'linux', 11:36:05 INFO - 'TMOUT': '86400', 11:36:05 INFO - 'USER': 'cltbld', 11:36:05 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:05 INFO - '_': '/tools/buildbot/bin/python'} 11:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:06 INFO - Running setup.py (path:/tmp/pip-Bw3ZzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:06 INFO - Running setup.py (path:/tmp/pip-p2Tvj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:06 INFO - Running setup.py (path:/tmp/pip-G5zHgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:06 INFO - Running setup.py (path:/tmp/pip-HyKPwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:06 INFO - Running setup.py (path:/tmp/pip-dgTfGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:06 INFO - Running setup.py (path:/tmp/pip-41QQ2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:06 INFO - Running setup.py (path:/tmp/pip-fYiqHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:06 INFO - Running setup.py (path:/tmp/pip-6sKPoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:06 INFO - Running setup.py (path:/tmp/pip-puwNva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:06 INFO - Running setup.py (path:/tmp/pip-R3tsoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:06 INFO - Running setup.py (path:/tmp/pip-1C38kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:06 INFO - Running setup.py (path:/tmp/pip-YrzqpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:06 INFO - Running setup.py (path:/tmp/pip-35RqN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:06 INFO - Running setup.py (path:/tmp/pip-zZxe_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:07 INFO - Running setup.py (path:/tmp/pip-CwKI2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:07 INFO - Running setup.py (path:/tmp/pip-ltAPMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:07 INFO - Running setup.py (path:/tmp/pip-3G9YUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:36:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:08 INFO - Downloading blessings-1.6.tar.gz 11:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:08 INFO - Installing collected packages: blessings 11:36:08 INFO - Running setup.py install for blessings 11:36:08 INFO - Successfully installed blessings 11:36:08 INFO - Cleaning up... 11:36:08 INFO - Return code: 0 11:36:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:08 INFO - Reading from file tmpfile_stdout 11:36:08 INFO - Current package versions: 11:36:08 INFO - argparse == 1.2.1 11:36:08 INFO - blessings == 1.6 11:36:08 INFO - blobuploader == 1.2.4 11:36:08 INFO - docopt == 0.6.1 11:36:08 INFO - functools32 == 3.2.3-2 11:36:08 INFO - jsonschema == 2.5.1 11:36:08 INFO - manifestparser == 1.1 11:36:08 INFO - mozInstall == 1.13 11:36:08 INFO - mozcrash == 1.0 11:36:08 INFO - mozdebug == 0.1 11:36:08 INFO - mozdevice == 0.51 11:36:08 INFO - mozfile == 1.2 11:36:08 INFO - mozhttpd == 0.7 11:36:08 INFO - mozinfo == 0.10 11:36:08 INFO - mozleak == 0.1 11:36:08 INFO - mozlog == 3.5 11:36:08 INFO - moznetwork == 0.27 11:36:08 INFO - mozprocess == 0.25 11:36:08 INFO - mozprofile == 0.28 11:36:08 INFO - mozrunner == 6.13 11:36:08 INFO - mozscreenshot == 0.1 11:36:08 INFO - mozsystemmonitor == 0.3 11:36:08 INFO - moztest == 0.8 11:36:08 INFO - mozversion == 1.4 11:36:08 INFO - psutil == 3.1.1 11:36:08 INFO - requests == 1.2.3 11:36:08 INFO - wsgiref == 0.1.2 11:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:36:08 INFO - Using env: {'DISPLAY': ':0', 11:36:08 INFO - 'HOME': '/home/cltbld', 11:36:08 INFO - 'LANG': 'en_US.UTF-8', 11:36:08 INFO - 'LANGUAGE': 'en_US:en', 11:36:08 INFO - 'LOGNAME': 'cltbld', 11:36:08 INFO - 'MAIL': '/var/mail/cltbld', 11:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:08 INFO - 'MOZ_NO_REMOTE': '1', 11:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:08 INFO - 'NO_EM_RESTART': '1', 11:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:08 INFO - 'PWD': '/builds/slave/test', 11:36:08 INFO - 'SHELL': '/bin/bash', 11:36:08 INFO - 'SHLVL': '1', 11:36:08 INFO - 'TERM': 'linux', 11:36:08 INFO - 'TMOUT': '86400', 11:36:08 INFO - 'USER': 'cltbld', 11:36:08 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:08 INFO - '_': '/tools/buildbot/bin/python'} 11:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:36:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:36:10 INFO - Installing collected packages: simplejson 11:36:10 INFO - Running setup.py install for simplejson 11:36:10 INFO - building 'simplejson._speedups' extension 11:36:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:36:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:36:11 INFO - Successfully installed simplejson 11:36:11 INFO - Cleaning up... 11:36:11 INFO - Return code: 0 11:36:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b37b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, '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': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:36:11 INFO - Using env: {'DISPLAY': ':0', 11:36:11 INFO - 'HOME': '/home/cltbld', 11:36:11 INFO - 'LANG': 'en_US.UTF-8', 11:36:11 INFO - 'LANGUAGE': 'en_US:en', 11:36:11 INFO - 'LOGNAME': 'cltbld', 11:36:11 INFO - 'MAIL': '/var/mail/cltbld', 11:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:11 INFO - 'MOZ_NO_REMOTE': '1', 11:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:11 INFO - 'NO_EM_RESTART': '1', 11:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:11 INFO - 'PWD': '/builds/slave/test', 11:36:11 INFO - 'SHELL': '/bin/bash', 11:36:11 INFO - 'SHLVL': '1', 11:36:11 INFO - 'TERM': 'linux', 11:36:11 INFO - 'TMOUT': '86400', 11:36:11 INFO - 'USER': 'cltbld', 11:36:11 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:11 INFO - '_': '/tools/buildbot/bin/python'} 11:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:36:11 INFO - Cleaning up... 11:36:11 INFO - Return code: 0 11:36:11 INFO - Running post-action listener: _resource_record_post_action 11:36:11 INFO - Running post-action listener: _start_resource_monitoring 11:36:11 INFO - Starting resource monitoring. 11:36:11 INFO - [mozharness: 2017-09-24 18:36:11.538386Z] Finished create-virtualenv step (success) 11:36:11 INFO - [mozharness: 2017-09-24 18:36:11.538853Z] Running install step. 11:36:11 INFO - Running pre-action listener: _resource_record_pre_action 11:36:11 INFO - Running main action method: install 11:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:11 INFO - Reading from file tmpfile_stdout 11:36:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:11 INFO - Reading from file tmpfile_stdout 11:36:11 INFO - Output received: 11:36:11 INFO - Usage: mozinstall [options] installer 11:36:11 INFO - Options: 11:36:11 INFO - -h, --help show this help message and exit 11:36:11 INFO - -d DEST, --destination=DEST 11:36:11 INFO - Directory to install application into. [default: 11:36:11 INFO - "/builds/slave/test"] 11:36:11 INFO - --app=APP Application being installed. [default: firefox] 11:36:11 INFO - mkdir: /builds/slave/test/build/application 11:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:36:29 INFO - Reading from file tmpfile_stdout 11:36:29 INFO - Output received: 11:36:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:36:29 INFO - Running post-action listener: _resource_record_post_action 11:36:29 INFO - [mozharness: 2017-09-24 18:36:29.679073Z] Finished install step (success) 11:36:29 INFO - [mozharness: 2017-09-24 18:36:29.679327Z] Running setup-mitmproxy step. 11:36:29 INFO - Running pre-action listener: _resource_record_pre_action 11:36:29 INFO - Running main action method: setup_mitmproxy 11:36:29 INFO - Skipping: mitmproxy is not required 11:36:29 INFO - Running post-action listener: _resource_record_post_action 11:36:29 INFO - [mozharness: 2017-09-24 18:36:29.680455Z] Finished setup-mitmproxy step (success) 11:36:29 INFO - [mozharness: 2017-09-24 18:36:29.680675Z] Running run-tests step. 11:36:29 INFO - Running pre-action listener: _resource_record_pre_action 11:36:29 INFO - Running pre-action listener: _set_gcov_prefix 11:36:29 INFO - Running main action method: run_tests 11:36:29 WARNING - Try message not found. 11:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:36:29 INFO - Python 2.7.3 11:36:29 INFO - Return code: 0 11:36:29 INFO - grabbing minidump binary from tooltool 11:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd9d60>, '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 0x1cdaa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cdaef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:36:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:36:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:36:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:36:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:36:29 INFO - Return code: 0 11:36:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:36:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:36:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:36:29 INFO - ENV: RUST_BACKTRACE is now full 11:36:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:36:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 11:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 11:36:29 INFO - Using env: {'DISPLAY': ':0', 11:36:29 INFO - 'HOME': '/home/cltbld', 11:36:29 INFO - 'LANG': 'en_US.UTF-8', 11:36:29 INFO - 'LANGUAGE': 'en_US:en', 11:36:29 INFO - 'LOGNAME': 'cltbld', 11:36:29 INFO - 'MAIL': '/var/mail/cltbld', 11:36:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:29 INFO - 'MOZ_ACCELERATED': '1', 11:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:29 INFO - 'MOZ_NO_REMOTE': '1', 11:36:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:29 INFO - 'MOZ_WEBRENDER': '1', 11:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:29 INFO - 'NO_EM_RESTART': '1', 11:36:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:29 INFO - 'PWD': '/builds/slave/test', 11:36:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:29 INFO - 'RUST_BACKTRACE': 'full', 11:36:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:29 INFO - 'SHELL': '/bin/bash', 11:36:29 INFO - 'SHLVL': '1', 11:36:29 INFO - 'TERM': 'linux', 11:36:29 INFO - 'TMOUT': '86400', 11:36:29 INFO - 'USER': 'cltbld', 11:36:29 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:29 INFO - '_': '/tools/buildbot/bin/python'} 11:36:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 11:36:30 INFO - mozversion application_buildid: 20170924174343 11:36:30 INFO - mozversion application_changeset: 877c02446745576ac97f181dd9eeec78ef605451 11:36:30 INFO - mozversion application_display_name: Nightly 11:36:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:36:30 INFO - mozversion application_name: Firefox 11:36:30 INFO - mozversion application_remotingname: firefox 11:36:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:36:30 INFO - mozversion application_vendor: Mozilla 11:36:30 INFO - mozversion application_version: 58.0a1 11:36:30 INFO - mozversion platform_buildid: 20170924174343 11:36:30 INFO - mozversion platform_changeset: 877c02446745576ac97f181dd9eeec78ef605451 11:36:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:36:30 INFO - mozversion platform_version: 58.0a1 11:36:30 INFO - using testdate: 1506278190 11:36:30 INFO - actual date: 1506278190 11:36:30 INFO - starting webserver on 'localhost:34363' 11:36:30 INFO - SUITE-START | Running 2 tests 11:36:30 INFO - TEST-START | dromaeo_css 11:36:30 INFO - Initialising browser for dromaeo_css test... 11:36:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34363/getInfo.html -profile /tmp/tmpAcoboa/profile 11:36:30 INFO - TEST-INFO | started process 19743 (/builds/slave/test/build/application/firefox/firefox http://localhost:34363/getInfo.html) 11:36:37 INFO - TEST-INFO | 19743: exit 0 11:36:37 INFO - Browser initialized. 11:36:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:36:37 INFO - Using env: {'DISPLAY': ':0', 11:36:37 INFO - 'HOME': '/home/cltbld', 11:36:37 INFO - 'JSGC_DISABLE_POISONING': '1', 11:36:37 INFO - 'LANG': 'en_US.UTF-8', 11:36:37 INFO - 'LANGUAGE': 'en_US:en', 11:36:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:36:37 INFO - 'LOGNAME': 'cltbld', 11:36:37 INFO - 'MAIL': '/var/mail/cltbld', 11:36:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:37 INFO - 'MOZ_ACCELERATED': '1', 11:36:37 INFO - 'MOZ_CRASHREPORTER': '1', 11:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:36:37 INFO - 'MOZ_NO_REMOTE': '1', 11:36:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:37 INFO - 'MOZ_WEBRENDER': '1', 11:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:37 INFO - 'NO_EM_RESTART': '1', 11:36:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:37 INFO - 'PWD': '/builds/slave/test', 11:36:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:37 INFO - 'RUST_BACKTRACE': 'full', 11:36:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:37 INFO - 'SHELL': '/bin/bash', 11:36:37 INFO - 'SHLVL': '1', 11:36:37 INFO - 'TERM': 'linux', 11:36:37 INFO - 'TMOUT': '86400', 11:36:37 INFO - 'USER': 'cltbld', 11:36:37 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:37 INFO - '_': '/tools/buildbot/bin/python'} 11:36:37 INFO - TEST-INFO | started process 19987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAcoboa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:38 INFO - PID 19987 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:36:39 INFO - PID 19987 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:36:39 INFO - PID 19987 | 11:36:39 INFO - PID 19987 | (/builds/slave/test/build/application/firefox/firefox:20049): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:39 INFO - PID 19987 | 11:36:49 INFO - PID 19987 | RSS: Main: 203960320 11:36:49 INFO - PID 19987 | 11:39:47 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34363/tests/dromaeo/cssquery-ext.html) 11:39:48 INFO - PID 19987 | RSS: Main: 209580032 11:39:48 INFO - PID 19987 | 11:42:51 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-ext.html (next: http://localhost:34363/tests/dromaeo/cssquery-jquery.html) 11:42:51 INFO - PID 19987 | RSS: Main: 210440192 11:42:51 INFO - PID 19987 | 11:45:53 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34363/tests/dromaeo/cssquery-mootools.html) 11:45:54 INFO - PID 19987 | RSS: Main: 209317888 11:45:54 INFO - PID 19987 | 11:48:56 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34363/tests/dromaeo/cssquery-prototype.html) 11:48:56 INFO - PID 19987 | RSS: Main: 210575360 11:48:56 INFO - PID 19987 | 11:52:00 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34363/tests/dromaeo/cssquery-yui.html) 11:52:01 INFO - PID 19987 | RSS: Main: 211869696 11:52:01 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | Cycle 1(1): loaded http://localhost:34363/tests/dromaeo/cssquery-yui.html (next: http://localhost:34363/tests/dromaeo/cssquery-dojo.html) 11:55:03 INFO - PID 19987 | RSS: Main: 211955712 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | __start_tp_report 11:55:03 INFO - PID 19987 | _x_x_mozilla_page_load 11:55:03 INFO - PID 19987 | _x_x_mozilla_page_load_details 11:55:03 INFO - PID 19987 | |i|pagename|runs| 11:55:03 INFO - PID 19987 | |0;dojo.html;3122.8750849966;3156.3845050215205;3159.5892533970596;3175.7776955613103;3193.042087373787;6125.234345706786;6277.811665650032;6286.8113956581265;6351.650659213741;6388.297287298399;6192.442680158785;6208.472279856206;6213.627182369061;6219.067139929013;6286.654234017139;5806.303243610762;5824.359320474766;5827.533797296227;5870.647761134324;5883.29400471944;5848.590598658096;5892.234009578749;5895.616784908967;5907.88184236315;5984.431479009487;5762.1068734346245;5812.564057695668;5825.766969321222;5907.084401917688;5922.4077592240865;5385.246065550826;5837.708114594253;5841.620294680833;5900.557458190653;5935.406459354073;5515.448455154453;5610;5642.548596112301;5721.313442386899;5820.88358232833;6199.287081985584;6240.31356550779;6250.4374606285655;6268.4671802896355;6324.683765811737;6782.084418603524;6793.4225590824835;6802.14973128359;6803.285655006202;6822.897656535156;6813.11429514165;6890.276520965327;6897.379235868746;6902.792916212522;6928.341807528327;6154.26148862135;6180.690965451709;6192.907106393408;6221;6395.77614783485;7117;7119.038929744522;7120.608366539786;7125.53684010548;7125.714971401189;6492.577982431127;6679.398854103057;6727.865442691119;6772.661366931732;6803.149606299213;6657.733690652417;6784.389404953479;6845.657717114124;6863.588184708933;6870.106886104774;6736.6631668416385;6791.45668346541;6846.281140480278;6854.554453960476;6863.691133898987;6771.221309549366;6773.153355830521;6786.728530858711;6805.421539169127;6897.655117244118;5197.974010129925;5322.2282768998275;5382.703951282717;5392.649477783932;5405.729713514309;4583.472900616405;4599.770011499411;4601.5168407317415;4621.006483605974;4621.353010578522;5771.913421298684;5827.88344233113;5847.327557330961;5873.20711703923;5894.67579283135;6781.25406205317;6846.623435711083;6849.828754281183;6947.340002699735;6956.40870526011;5825.621334613236;5832.766689332379;5844.736986835603;5897.941020589825;5904.114382842608;5717.028105222039;5772.942270577324;5777.826665200051;5781.248437703071;5888.116782482662;6497.512686548528;6497.902531462032;6518.739250430024;6528.967355163194;6532.640704761188;6775.3224677532835;6780.525363224527;6878.965605171942;6897.793066208022;6907.930920690729;6585.703643336157;6587.308332625005;6607.834804129935;6691.063251144941;6694.29709880475;6491.675416229265;6583.473322134122;6709.194896612437;6757.45940324763;6812.318768123347;6683.7660681875905;6708.463322934251;6719.496037797283;6765.797026089225;6773.864522709617;6408.263049749152;6526.771562995273;6543.901841472477;6642.4021838034805;6642.6014439133805;6628.304028076983;6635.071090047494;6664.4668426524795;6678.7328506859185;6694.029365742038;6472.190976127984;6497.155369801895;6534.771283005262;6602.10871532337;6602.702878370581;6361.2048493938255;6517.641529715911;6575.506836987341;6636.834079147867;6702.36327548882;6442.710078046593;6464.385883341075;6472.061551074974;6485.027245913151;6496.935030649633 11:55:03 INFO - PID 19987 | |1;ext.html;873.384264093814;900.7072701372056;901.0133903375802;903.7424334064793;907.5054095517944;39073.80463097684;42855;43277.78361108198;43469.78265108674;43548.34677479837;39841.80079099601;40110.598894011055;40149.19701605966;40560.18879622406;40679.38980915289;7282.126144862611;7348.889766653505;7381.778546643609;7407.185209626937;7411.518251313674;7229.855402891965;7349.265073492661;7390.852182956338;7394.5563266203935;7401.555906645618;7374.963125184393;7388.150362708277;7391.408687305029;7408.962955185217;7409.48133630646;7282.453815963824;7810.80472988177;7931.325837303836;7956.761297161094;8012.8798068028445;7857.410694197901;7887.408444366695;7894.368450523944;7901.841963160762;7903.762887113396;38697.226055478735;39041.80479097586;39091.60908390937;39118;39796.403053954215;3580.1765593913547;3601.981990090033;3625.456181572785;3625.927481450356;3626.4741612466046;32470.837645811618;32765.344693106243;32819;32841.50737738936;32889;5243.816466423695;5244.423113457517;5255.369355677305;5266.078436273637;5373.113436283009;188515;188685;188686;189673;189921;41378.37932431016;42188;48838.5116148834;49063.26405103926;49953;52028;52212.73893630583;52241.73879130656;52432.21351679728;52595.94808103893;16325.102119383548;16392;16440.588985275226;16491.83508164927;16526.504204873872;13324.267165306;13416.262105584286;13425.86574134246;13438.664033399244;13576.389062492211;13793.793093103612;13903.09629874055;13919.234442105579;13956.72086558263;13975.09161904473;5439.673619582838;5509.834704958857;5539.556835453154;5603.523700485504;5669.801556945487;803.188779332878;816.3754727633366;828.5857071464268;831.4512421801703;846.1073567386467;19599.706004409945;19674.50813729668;19820.70268945967;20013.39959801208;20191.596168076558;917.4449458077767;919.4115765909823;920.0339643374564;924.117467818232;933.6732143749633;10094.747631309128;10379.896201038044;10417.895821041844;10572.259941803999;10575.788484230272;220812;222257;222318;222440;223129;55388.16917746237;55680;55810.44189558134;56334.15498767522;56351.154732679046;1433.3263366217861;1480.407836865241;1490.93290801912;1492.3284521964943;1494.656229067299;19246.23015079437;19519.70720439223;19521.70717439268;19828.603427931073;19982;38322.42516362313;38503.229935401694;38602;38823.805880970416;38976.805115975374;194523;195364;196358;196978;197581;33319;34365.65634343625;34828.82585587056;35165.64834351624;35279.470807938415;45128.32307515324;45494;45583.54416455793;45796.54203457923;45997.54002459932;32433.29653256932;33253.50119748157;33304.66695333113;33313;33419.498707519895;32763;32772.34455310928;32990.34019319648;32997;33102.33795324032;35908;37535.62464375321;37536.43695344627;37537.2492550153;38008;31749.36501270008;31848.5222721664;32109.678903211603;32121.196970075;32302.19244518906;23728.52542949097;23903.641445378682;24470.38824029342;24520.264392068268;24528.87735561311 11:55:03 INFO - PID 19987 | |2;jquery.html;578.9855253618656;588.314613475301;596.4989408896527;600.0788789208565;611.7522403426613;22240.88879555602;22854.885725571392;22961.885190574023;23010.424739381524;23092.538149237003;21426.357209283746;21506;21725.13099476019;22591.435214119654;24451.75548244517;6581;6605.867882642344;6669.732750777337;6749.966250168743;6778.118844550201;6557.213134423876;6643.103181070566;6655.168103987002;6676.632785196836;6701.3298670132845;6342.429181373675;6649.434798042173;6677.833054173636;6690.163729533809;6708.765193218238;6658.3674550917585;6680.465562755016;6698.83252918681;6699.229588597325;6705.228898676666;5851.970740146272;6050.757969681252;6069.969650151766;6085.269767627913;6190.195274614316;27541;28101.85949070262;28121.85939070312;28135;28233.870645174167;1991.6415045291842;1996.0418998880473;2014.1238561225914;2018.5155562665002;2029.5027718209133;18434.539136521693;19033.143508542147;19375.12811923467;19392.4182274532;19699.80300196994;2331.825113116523;2395.856248625088;2406.6991626046743;2416.818738594595;2420.0561780905286;115547;121957;138769;145029;145490.27254863764;14590.978840051506;14962.850371496146;15002.522565724128;15029.554459650439;15202.695946081016;22514.66228006581;22551.210707625156;22609;22661.320160395215;22694.319170424915;10047.497625118714;10082.546285417175;10127.898721012843;10208.693739187836;10210.234232432596;9094.136057074567;9173.541322933826;9317.534123293808;9473.100055494855;9475.952620236854;8850.867236991451;9019.323550733721;9044.638214471479;9103.408278462011;9190.954045229731;2632.907848225303;2649.1522712732126;2649.867506624661;2729.6178535005115;2745.1490038088255;946.7207173883721;955.7992821507561;964.4406244378243;965.4448692002127;979.5885727994117;18528.16623251957;18955.431337059912;19306.517337066685;19513.414597562096;19910.60178796416;1008.3395376028712;1020.4132623741378;1029.6653587584065;1030.6701855406197;1033.679559336608;10394.532246048946;10675.733106672395;10686.954442185843;10737.194710396752;10832.187585931088;451928;461786;472896;479133;481371;111733.44133279443;113353.43323283331;114878;114879.42560287144;115680.42159789147;1028;1097.632293181793;1132.0886686217673;1162.215504534436;1191.076915390562;19805.20779168817;19971.20115195376;19995.700064498753;20296;20320.898395507927;55637.1654425192;57332.71333643472;57855.421445785;58382.4161758394;59348;69849.65075174591;70357;70733.29266707473;71435;71736;14339.498117566252;14801.851981480047;14810.77783833265;14841;14973.176475293963;20398.796012040282;20472.59054818925;20680.276190333265;20701.171953121706;21949;17013;17777.911110444882;18054.36809711706;18171;18244.72632910534;15152.621184470476;15478.767818482956;15647.608809779847;15978.440754573534;16886;17037.233324500674;17097.74353384725;17815.73276400829;18643.90678046601;18751.437456876316;14418.855811441752;14515.927420363252;14524.27378631043;14591;14624.268786560842;16736.41422550205;16799.244034018255;17691.911540442215;18186.181621826785;18227.453176404728 11:55:03 INFO - PID 19987 | |3;mootools.html;1274.350081458456;1391.0193313713833;1391.0540832234083;1393.8118354022204;1396.755567775639;15263.465778697748;15742.921285393571;15808.920955395208;15914.283857226425;15921.76117358239;15610.921945390257;15617.21913904306;15677.29452174652;15684.372625095011;15709.371625134982;2680.7051224365305;2719.2250208690525;2767.529519981598;2772.639556857606;2780.249332680175;2667.66654168229;2762.903298384557;2768.1418760184306;2772.209920172751;2786.916392508228;2679.289988153141;2745.2450576091633;2767.529519981598;2793.553031514958;2795.7903157263186;2722.7957903157344;2739.8904043838224;2744.286485513771;2748.4503099380104;2752.5320695481814;2653.031643450146;2666.0668765931964;2675.946481070387;2679;2679.6382488364015;12261.080418968613;12844.871551284554;12879.162854414526;14908.701825963528;15521.146336951464;8084.474509156886;8391.83216335676;8409.243168114837;8410.537420441873;8410.621522031523;5343.652662576959;5433.972830135824;5474.452554744494;5480.3971563128025;5556.305461817273;1949.2008276606664;2009.708592254115;2020.2525065725777;2059.6395630764555;2063.0406860809794;28118;28136.577951330746;28349.57475637867;28392.43215135727;28514;6629.303923088103;6784.694688739019;6798.082258894986;7018.613976231356;7092.822679433056;17557.82442175562;17580.38468653591;17591.912040439714;17665.470035898943;17673.558161046076;8136.75589732309;8255.752327430067;8293.8341233175;8308.210719981593;8319.584020798935;7223.530470519399;7584.393248540104;7623.4663573549315;7636.809079772939;7688.807779805437;5341.172118321666;5369.812056578001;5514.834554963358;5578.581606379456;5705.828825135252;1582.9604259893365;1600.087949868587;1605.6868910562562;1606.9758953615706;1611.701835160499;853.3088198559187;866.4368160695599;873.3100850328296;876.6493402638868;882.8013696918142;8282.4202305838;8308.086110527836;8309.60445203769;8317.83364332722;8319.8336033279;965.2422848064236;977.413551868873;982.6511588386163;984.6849008317413;1000.4047591682937;5334.653247538898;5356.571474282048;5372.167314066326;5382.192671099367;5498.257735205776;21184.470388240108;22489.662655060187;22493.88753056257;22528.098876044776;22557.210497632503;20850.687239691415;21971.34085977423;22207.777922220896;22324.999999999676;22392.440188995406;11595.304281743123;11667.88332116685;11855.940720296343;11922.880771192351;11993.940030299967;7355;8388.286995605442;8488.74533763988;8510.872336914827;8526.403151779565;17976.550586235448;18448.907755461136;19139.23443062262;19501.219951201794;19523.609527809647;19413;19745.506362341057;19806.20775168977;19932.90033549823;20070.698939515627;10797.13622910181;10847.240693151403;10852.728681783019;10961.50673219723;11015.614453494089;14087.929560352133;14200.92899535537;14332.355044023252;14358.282085895873;14377.281135942952;11204.495797689287;11317.886821132013;11387.259828111146;11468.369239691563;11604.419779010846;10912.61805836792;11030.44847757625;11177.329360238411;11273.661790146309;11446.713832154262;9978.950105249427;10232.334898231591;10238.744031399274;10242.231832612435;10259.076683098558;6958.165020197609;7007.509474336747;7015.754448594274;7035.6833942471685;7172.426205903619;6944.687489063105;6967.930320696728;7047.964760176166;7053.118360204974;7134.750283740044 11:55:03 INFO - PID 19987 | |4;prototype.html;489.27587170986936;510.246391445812;514.3698968763265;528.4583302115334;530.6975024236187;6260.405261500162;6288.968555157224;6324.367563243679;6344.2386913570435;6350.587211831239;6165.722542485588;6180.536459765513;6257.311695713479;6291.716872740726;6301.527385446087;5205.37535495741;5251.789928402859;5262.079750585819;5281.207818827187;5286.947130528684;5221.947780522203;5222.529972302492;5251.947480525203;5254.474552544753;5326.946730532683;4807.89890520614;5049.570786483135;5107.361579802525;5184.377874655047;5240.318758561381;4986.301917731521;5007.724575148365;5080.364954380702;5085.720285384303;5085.90653009601;4525.162844873709;4548.977255113737;4564.744695208811;4572.748498832596;4584.839530616446;6025.186599809013;6052.4552790248645;6126.486162453827;6151.031669865645;6229.6573688447115;5719.857003574903;5734.369219385864;5744.913826292609;5772.682502462363;5804.854878628026;6555.704993275266;6585.275619681831;6593.175853018372;6637.634930078843;6673.799786006428;4686.179918514246;4924;4971.552560269593;5031.32077169581;5033.144365457881;6675.46596272297;6787.219469760991;6809.795706128774;6898.448124150106;6965.930340696528;5075.644704870698;5080.002798348992;5084.49155084496;5088.1350170471105;5125.9743701282005;5120.743962801919;5139.203423469368;5155.819546315861;5195.376554813371;5214.556762675215;5678.744456499468;5762.94237057624;5795.739191736382;5824.126381042877;5829.4170582942215;6601.53789234749;6648.833779155463;6686.431653309523;6703.698333575001;6710.698018589175;1781.9821801782075;1783.61652244768;1793.7757780277466;1808.9185986630632;1809.9909500452677;1202.0149719578237;1256.1646505074023;1260.3635164241998;1276.527684756646;1280.5326055989497;5644.0528017833785;5768;5774.642958904654;5794.362620111784;5828.825135245949;6694.464442844561;6735.528513004141;6806.115205023315;6817.193443737414;6833.350831670983;5529.281193444826;5735.713214339266;5745.91381129275;5776.451237132465;5779.624324418899;3426.417509023472;3534.929301413957;3539.6460353964912;3540.8760693375607;3541.1501239702284;6453.225612926385;6458.903116453257;6518.217813862367;6537.378948999837;6552.515974440857;6723.344279009763;6731.663416829139;6747.493937954673;6807.319268073252;6848.315168483112;6539.542232043711;6547.508936829757;6552.901706474407;6578.506612004023;6598.3401659833635;6723.5293529452465;6733.158355205599;6774.220964589135;6807.115075040213;6832.316768323128;6765.154355705537;6777.8983315249325;6793.184817821893;6819.931800681929;6837.247902730795;6478.740850365933;6482.805515834532;6486.513511486563;6530.444912182517;6545.03648905336;4981.825636102719;5049.747512624427;5051.217061355495;5093.847184584469;5097.28637990689;6458.709358078804;6519.196745399524;6590.9670451647435;6851.383375496229;6882.552634078969;6291.307956124731;6544.280129185881;6553.180852393451;6555.639439830665;6646.302138275605;6493.090967264681;6493.545451818516;6523.445507131757;6527.967360163168;6538.248101468202;6329.7468101275435;6330.620162790063;6356.968215158895;6388.9041664376;6428.228612566522;6493.584362633265;6530.183727034121;6569.770058047945;6579.934200657932;6668.633225172662;6329.082283069021;6341.8097457076365;6362.091372588297;6410.358964103552;6423.29343772194 11:55:03 INFO - PID 19987 | |5;yui.html;902.5893218585542;908.8046070094928;919.397794444639;923.146089866873;929.2705226397279;19366.70949935752;20399.898000509977;20400.489987750312;20470.385888423334;20490.897545512253;18569.628607427876;18582.628347433045;18693.626127477477;18939.810601894013;19018.049097545103;931.9720408387742;952.3761935931975;956.7273327101777;962.6390103711109;963.2534785541192;967.3228739882076;971.4414211828192;978.5547575853005;978.6330126202674;980.4999450280372;996.9152622027136;1004.7839714461389;1047.3401756893147;1057.4501259345136;1060.6446840308467;1044.2116202267316;1046.6179844356832;1053.6206965492418;1053.9104176145038;1054.7626783973622;716.8064622551934;748.7416841189781;752.4281546025005;753.9132999705049;758.4577027425362;18146.90926545372;18298.63402731938;18305.542361440937;18321;18368.908155459136;21807.127714891387;21992.230271940407;22115.557688846133;22158.88920555403;22185.778142218533;17527.12364381776;17814.46556603304;17948.910255448638;18260.269589216547;18483.353082642177;3772.622737726233;3818.5417749870194;3832.9808350958065;3833.4824798652103;3835.712321575893;108158;144107;146428;146864.265678672;147797.26101369533;17907.194176261837;18065.187066582035;18097.547561311072;18175.272989080553;18383.54041148982;32502.187445313582;32594.185145371557;32929;32948.50577241343;32982;8876.556172191365;9184.816303674022;9276;9318.534073296309;9376.203022743006;4287.614114729689;4387.648988080946;4401.053773438662;4418.072204836956;4426.136903303889;5499.477549632858;5602.187682785973;5626.915596266059;5628.746706398222;5684.346300175533;1055.3509591601264;1065.2117433099606;1081.1837063017529;1085.2077983072402;1085.4084523934475;659.7427003468651;678.4538446550574;679.2528218959204;684.8253695307665;689.183317768446;11562;11918.821217681741;12041.939790300992;12803;13027.08810383283;652.4128284543948;664.0802488553388;667.6861874918877;668.6456178225549;676.9458443324522;5508.421615730291;5524.8342549723575;5536.474034966672;5638.464345887134;5692.23154874095;124908;126788;128652;128906.35546822206;129492;106861.46569267259;107468.4626576862;108226.45886770515;109649;110250;96241;96333;96393;100181.49909250408;100583.99416005747;10371.844422333521;10448.477576121315;10502.632407865687;10635.20235982289;10687.305325154151;42788.57211427846;43421.348679769195;44655.77672111749;44814.55185448104;45506.31740523829;57985.71007144937;58300.708496458945;58872.41127588841;59061;59598;15994.280257388213;16052.438164664181;16364;16433.753493697845;16523.00861948287;17923.37268195607;18045.909770451064;18144;18165.636687266444;18558.907205463885;15943.282552285407;16007.599810004844;16072;16076;16392.098434586213;15503.767443488583;15884.205789710699;15909.68180636404;15990.03363647689;16131.596710082342;16131.435399760952;16279.755803662718;16378.508644740677;16470.917645411697;16512.75230871514;11486.885131148581;11536.711582210512;11720.88279117198;11894.762104757683;11968.222065565711;12543.93728031354;12545.372731363213;12643.93678031604;12794.976401888012;12863.935680321538 11:55:03 INFO - PID 19987 | __end_tp_report 11:55:03 INFO - PID 19987 | __start_cc_report 11:55:03 INFO - PID 19987 | _x_x_mozilla_cycle_collect,289 11:55:03 INFO - PID 19987 | __end_cc_report 11:55:03 INFO - PID 19987 | __startTimestamp1506279303613__endTimestamp 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | ------- Summary: start ------- 11:55:03 INFO - PID 19987 | Number of tests: 6 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#0] dojo.html Cycles:165 Average:6231.02 Median:6491.68 stddev:765.91 (11.8%) stddev-sans-first:728.42 11:55:03 INFO - PID 19987 | Values: 3122.9 3156.4 3159.6 3175.8 3193.0 6125.2 6277.8 6286.8 6351.7 6388.3 6192.4 6208.5 6213.6 6219.1 6286.7 5806.3 5824.4 5827.5 5870.6 5883.3 5848.6 5892.2 5895.6 5907.9 5984.4 5762.1 5812.6 5825.8 5907.1 5922.4 5385.2 5837.7 5841.6 5900.6 5935.4 5515.4 5610.0 5642.5 5721.3 5820.9 6199.3 6240.3 6250.4 6268.5 6324.7 6782.1 6793.4 6802.1 6803.3 6822.9 6813.1 6890.3 6897.4 6902.8 6928.3 6154.3 6180.7 6192.9 6221.0 6395.8 7117.0 7119.0 7120.6 7125.5 7125.7 6492.6 6679.4 6727.9 6772.7 6803.1 6657.7 6784.4 6845.7 6863.6 6870.1 6736.7 6791.5 6846.3 6854.6 6863.7 6771.2 6773.2 6786.7 6805.4 6897.7 5198.0 5322.2 5382.7 5392.6 5405.7 4583.5 4599.8 4601.5 4621.0 4621.4 5771.9 5827.9 5847.3 5873.2 5894.7 6781.3 6846.6 6849.8 6947.3 6956.4 5825.6 5832.8 5844.7 5897.9 5904.1 5717.0 5772.9 5777.8 5781.2 5888.1 6497.5 6497.9 6518.7 6529.0 6532.6 6775.3 6780.5 6879.0 6897.8 6907.9 6585.7 6587.3 6607.8 6691.1 6694.3 6491.7 6583.5 6709.2 6757.5 6812.3 6683.8 6708.5 6719.5 6765.8 6773.9 6408.3 6526.8 6543.9 6642.4 6642.6 6628.3 6635.1 6664.5 6678.7 6694.0 6472.2 6497.2 6534.8 6602.1 6602.7 6361.2 6517.6 6575.5 6636.8 6702.4 6442.7 6464.4 6472.1 6485.0 6496.9 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#1] ext.html Cycles:180 Average:37363.07 Median:38412.83 stddev:52654.03 (137.1%) stddev-sans-first:52730.44 11:55:03 INFO - PID 19987 | Values: 873.4 900.7 901.0 903.7 907.5 39073.8 42855.0 43277.8 43469.8 43548.3 39841.8 40110.6 40149.2 40560.2 40679.4 7282.1 7348.9 7381.8 7407.2 7411.5 7229.9 7349.3 7390.9 7394.6 7401.6 7375.0 7388.2 7391.4 7409.0 7409.5 7282.5 7810.8 7931.3 7956.8 8012.9 7857.4 7887.4 7894.4 7901.8 7903.8 38697.2 39041.8 39091.6 39118.0 39796.4 3580.2 3602.0 3625.5 3625.9 3626.5 32470.8 32765.3 32819.0 32841.5 32889.0 5243.8 5244.4 5255.4 5266.1 5373.1 188515.0 188685.0 188686.0 189673.0 189921.0 41378.4 42188.0 48838.5 49063.3 49953.0 52028.0 52212.7 52241.7 52432.2 52595.9 16325.1 16392.0 16440.6 16491.8 16526.5 13324.3 13416.3 13425.9 13438.7 13576.4 13793.8 13903.1 13919.2 13956.7 13975.1 5439.7 5509.8 5539.6 5603.5 5669.8 803.2 816.4 828.6 831.5 846.1 19599.7 19674.5 19820.7 20013.4 20191.6 917.4 919.4 920.0 924.1 933.7 10094.7 10379.9 10417.9 10572.3 10575.8 220812.0 222257.0 222318.0 222440.0 223129.0 55388.2 55680.0 55810.4 56334.2 56351.2 1433.3 1480.4 1490.9 1492.3 1494.7 19246.2 19519.7 19521.7 19828.6 19982.0 38322.4 38503.2 38602.0 38823.8 38976.8 194523.0 195364.0 196358.0 196978.0 197581.0 33319.0 34365.7 34828.8 35165.6 35279.5 45128.3 45494.0 45583.5 45796.5 45997.5 32433.3 33253.5 33304.7 33313.0 33419.5 32763.0 32772.3 32990.3 32997.0 33102.3 35908.0 37535.6 37536.4 37537.2 38008.0 31749.4 31848.5 32109.7 32121.2 32302.2 23728.5 23903.6 24470.4 24520.3 24528.9 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#2] jquery.html Cycles:180 Average:33791.98 Median:21615.57 stddev:79285.08 (366.8%) stddev-sans-first:79468.28 11:55:03 INFO - PID 19987 | Values: 579.0 588.3 596.5 600.1 611.8 22240.9 22854.9 22961.9 23010.4 23092.5 21426.4 21506.0 21725.1 22591.4 24451.8 6581.0 6605.9 6669.7 6750.0 6778.1 6557.2 6643.1 6655.2 6676.6 6701.3 6342.4 6649.4 6677.8 6690.2 6708.8 6658.4 6680.5 6698.8 6699.2 6705.2 5852.0 6050.8 6070.0 6085.3 6190.2 27541.0 28101.9 28121.9 28135.0 28233.9 1991.6 1996.0 2014.1 2018.5 2029.5 18434.5 19033.1 19375.1 19392.4 19699.8 2331.8 2395.9 2406.7 2416.8 2420.1 115547.0 121957.0 138769.0 145029.0 145490.3 14591.0 14962.9 15002.5 15029.6 15202.7 22514.7 22551.2 22609.0 22661.3 22694.3 10047.5 10082.5 10127.9 10208.7 10210.2 9094.1 9173.5 9317.5 9473.1 9476.0 8850.9 9019.3 9044.6 9103.4 9191.0 2632.9 2649.2 2649.9 2729.6 2745.1 946.7 955.8 964.4 965.4 979.6 18528.2 18955.4 19306.5 19513.4 19910.6 1008.3 1020.4 1029.7 1030.7 1033.7 10394.5 10675.7 10687.0 10737.2 10832.2 451928.0 461786.0 472896.0 479133.0 481371.0 111733.4 113353.4 114878.0 114879.4 115680.4 1028.0 1097.6 1132.1 1162.2 1191.1 19805.2 19971.2 19995.7 20296.0 20320.9 55637.2 57332.7 57855.4 58382.4 59348.0 69849.7 70357.0 70733.3 71435.0 71736.0 14339.5 14801.9 14810.8 14841.0 14973.2 20398.8 20472.6 20680.3 20701.2 21949.0 17013.0 17777.9 18054.4 18171.0 18244.7 15152.6 15478.8 15647.6 15978.4 16886.0 17037.2 17097.7 17815.7 18643.9 18751.4 14418.9 14515.9 14524.3 14591.0 14624.3 16736.4 16799.2 17691.9 18186.2 18227.5 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#3] mootools.html Cycles:180 Average:9503.75 Median:2679.46 stddev:6899.80 (257.5%) stddev-sans-first:6891.46 11:55:03 INFO - PID 19987 | Values: 1274.4 1391.0 1391.1 1393.8 1396.8 15263.5 15742.9 15808.9 15914.3 15921.8 15610.9 15617.2 15677.3 15684.4 15709.4 2680.7 2719.2 2767.5 2772.6 2780.2 2667.7 2762.9 2768.1 2772.2 2786.9 2679.3 2745.2 2767.5 2793.6 2795.8 2722.8 2739.9 2744.3 2748.5 2752.5 2653.0 2666.1 2675.9 2679.0 2679.6 12261.1 12844.9 12879.2 14908.7 15521.1 8084.5 8391.8 8409.2 8410.5 8410.6 5343.7 5434.0 5474.5 5480.4 5556.3 1949.2 2009.7 2020.3 2059.6 2063.0 28118.0 28136.6 28349.6 28392.4 28514.0 6629.3 6784.7 6798.1 7018.6 7092.8 17557.8 17580.4 17591.9 17665.5 17673.6 8136.8 8255.8 8293.8 8308.2 8319.6 7223.5 7584.4 7623.5 7636.8 7688.8 5341.2 5369.8 5514.8 5578.6 5705.8 1583.0 1600.1 1605.7 1607.0 1611.7 853.3 866.4 873.3 876.6 882.8 8282.4 8308.1 8309.6 8317.8 8319.8 965.2 977.4 982.7 984.7 1000.4 5334.7 5356.6 5372.2 5382.2 5498.3 21184.5 22489.7 22493.9 22528.1 22557.2 20850.7 21971.3 22207.8 22325.0 22392.4 11595.3 11667.9 11855.9 11922.9 11993.9 7355.0 8388.3 8488.7 8510.9 8526.4 17976.6 18448.9 19139.2 19501.2 19523.6 19413.0 19745.5 19806.2 19932.9 20070.7 10797.1 10847.2 10852.7 10961.5 11015.6 14087.9 14200.9 14332.4 14358.3 14377.3 11204.5 11317.9 11387.3 11468.4 11604.4 10912.6 11030.4 11177.3 11273.7 11446.7 9979.0 10232.3 10238.7 10242.2 10259.1 6958.2 7007.5 7015.8 7035.7 7172.4 6944.7 6967.9 7048.0 7053.1 7134.8 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#4] prototype.html Cycles:180 Average:5555.65 Median:6205.10 stddev:1538.53 (24.8%) stddev-sans-first:1495.12 11:55:03 INFO - PID 19987 | Values: 489.3 510.2 514.4 528.5 530.7 6260.4 6289.0 6324.4 6344.2 6350.6 6165.7 6180.5 6257.3 6291.7 6301.5 5205.4 5251.8 5262.1 5281.2 5286.9 5221.9 5222.5 5251.9 5254.5 5326.9 4807.9 5049.6 5107.4 5184.4 5240.3 4986.3 5007.7 5080.4 5085.7 5085.9 4525.2 4549.0 4564.7 4572.7 4584.8 6025.2 6052.5 6126.5 6151.0 6229.7 5719.9 5734.4 5744.9 5772.7 5804.9 6555.7 6585.3 6593.2 6637.6 6673.8 4686.2 4924.0 4971.6 5031.3 5033.1 6675.5 6787.2 6809.8 6898.4 6965.9 5075.6 5080.0 5084.5 5088.1 5126.0 5120.7 5139.2 5155.8 5195.4 5214.6 5678.7 5762.9 5795.7 5824.1 5829.4 6601.5 6648.8 6686.4 6703.7 6710.7 1782.0 1783.6 1793.8 1808.9 1810.0 1202.0 1256.2 1260.4 1276.5 1280.5 5644.1 5768.0 5774.6 5794.4 5828.8 6694.5 6735.5 6806.1 6817.2 6833.4 5529.3 5735.7 5745.9 5776.5 5779.6 3426.4 3534.9 3539.6 3540.9 3541.2 6453.2 6458.9 6518.2 6537.4 6552.5 6723.3 6731.7 6747.5 6807.3 6848.3 6539.5 6547.5 6552.9 6578.5 6598.3 6723.5 6733.2 6774.2 6807.1 6832.3 6765.2 6777.9 6793.2 6819.9 6837.2 6478.7 6482.8 6486.5 6530.4 6545.0 4981.8 5049.7 5051.2 5093.8 5097.3 6458.7 6519.2 6591.0 6851.4 6882.6 6291.3 6544.3 6553.2 6555.6 6646.3 6493.1 6493.5 6523.4 6528.0 6538.2 6329.7 6330.6 6357.0 6388.9 6428.2 6493.6 6530.2 6569.8 6579.9 6668.6 6329.1 6341.8 6362.1 6410.4 6423.3 11:55:03 INFO - PID 19987 | 11:55:03 INFO - PID 19987 | [#5] yui.html Cycles:180 Average:24743.84 Median:18564.27 stddev:35829.76 (193.0%) stddev-sans-first:35885.55 11:55:03 INFO - PID 19987 | Values: 902.6 908.8 919.4 923.1 929.3 19366.7 20399.9 20400.5 20470.4 20490.9 18569.6 18582.6 18693.6 18939.8 19018.0 932.0 952.4 956.7 962.6 963.3 967.3 971.4 978.6 978.6 980.5 996.9 1004.8 1047.3 1057.5 1060.6 1044.2 1046.6 1053.6 1053.9 1054.8 716.8 748.7 752.4 753.9 758.5 18146.9 18298.6 18305.5 18321.0 18368.9 21807.1 21992.2 22115.6 22158.9 22185.8 17527.1 17814.5 17948.9 18260.3 18483.4 3772.6 3818.5 3833.0 3833.5 3835.7 108158.0 144107.0 146428.0 146864.3 147797.3 17907.2 18065.2 18097.5 18175.3 18383.5 32502.2 32594.2 32929.0 32948.5 32982.0 8876.6 9184.8 9276.0 9318.5 9376.2 4287.6 4387.6 4401.1 4418.1 4426.1 5499.5 5602.2 5626.9 5628.7 5684.3 1055.4 1065.2 1081.2 1085.2 1085.4 659.7 678.5 679.3 684.8 689.2 11562.0 11918.8 12041.9 12803.0 13027.1 652.4 664.1 667.7 668.6 676.9 5508.4 5524.8 5536.5 5638.5 5692.2 124908.0 126788.0 128652.0 128906.4 129492.0 106861.5 107468.5 108226.5 109649.0 110250.0 96241.0 96333.0 96393.0 100181.5 100584.0 10371.8 10448.5 10502.6 10635.2 10687.3 42788.6 43421.3 44655.8 44814.6 45506.3 57985.7 58300.7 58872.4 59061.0 59598.0 15994.3 16052.4 16364.0 16433.8 16523.0 17923.4 18045.9 18144.0 18165.6 18558.9 15943.3 16007.6 16072.0 16076.0 16392.1 15503.8 15884.2 15909.7 15990.0 16131.6 16131.4 16279.8 16378.5 16470.9 16512.8 11486.9 11536.7 11720.9 11894.8 11968.2 12543.9 12545.4 12643.9 12795.0 12863.9 11:55:03 INFO - PID 19987 | -------- Summary: end -------- 11:55:03 INFO - PID 19987 | 11:55:04 INFO - TEST-INFO | 19987: exit 0 11:55:04 INFO - TEST-OK | dromaeo_css | took 1114528ms 11:55:04 INFO - TEST-START | kraken 11:55:04 INFO - Initialising browser for kraken test... 11:55:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34363/getInfo.html -profile /tmp/tmpfIvPip/profile 11:55:04 INFO - TEST-INFO | started process 20376 (/builds/slave/test/build/application/firefox/firefox http://localhost:34363/getInfo.html) 11:55:10 INFO - TEST-INFO | 20376: exit 0 11:55:10 INFO - Browser initialized. 11:55:10 INFO - Running cycle 1/1 for kraken test... 11:55:10 INFO - Using env: {'DISPLAY': ':0', 11:55:10 INFO - 'HOME': '/home/cltbld', 11:55:10 INFO - 'JSGC_DISABLE_POISONING': '1', 11:55:10 INFO - 'LANG': 'en_US.UTF-8', 11:55:10 INFO - 'LANGUAGE': 'en_US:en', 11:55:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:55:10 INFO - 'LOGNAME': 'cltbld', 11:55:10 INFO - 'MAIL': '/var/mail/cltbld', 11:55:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:55:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:55:10 INFO - 'MOZ_ACCELERATED': '1', 11:55:10 INFO - 'MOZ_CRASHREPORTER': '1', 11:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:55:10 INFO - 'MOZ_NO_REMOTE': '1', 11:55:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:55:10 INFO - 'MOZ_WEBRENDER': '1', 11:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:10 INFO - 'NO_EM_RESTART': '1', 11:55:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:10 INFO - 'PWD': '/builds/slave/test', 11:55:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:55:10 INFO - 'RUST_BACKTRACE': 'full', 11:55:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:55:10 INFO - 'SHELL': '/bin/bash', 11:55:10 INFO - 'SHLVL': '1', 11:55:10 INFO - 'TERM': 'linux', 11:55:10 INFO - 'TMOUT': '86400', 11:55:10 INFO - 'USER': 'cltbld', 11:55:10 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1506267047.327623-1751645334', 11:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:10 INFO - '_': '/tools/buildbot/bin/python'} 11:55:10 INFO - TEST-INFO | started process 20620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfIvPip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:55:11 INFO - PID 20620 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:55:11 INFO - PID 20620 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:55:12 INFO - PID 20620 | 11:55:12 INFO - PID 20620 | (/builds/slave/test/build/application/firefox/firefox:20682): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:55:12 INFO - PID 20620 | 11:55:22 INFO - PID 20620 | RSS: Main: 215654400 11:55:22 INFO - PID 20620 | 11:55:25 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34363/tests/kraken/driver.html?testName=audio-beat-detection) 11:55:26 INFO - PID 20620 | RSS: Main: 215429120 11:55:26 INFO - PID 20620 | 11:55:28 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34363/tests/kraken/driver.html?testName=audio-dft) 11:55:29 INFO - PID 20620 | RSS: Main: 215236608 11:55:29 INFO - PID 20620 | 11:55:32 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34363/tests/kraken/driver.html?testName=audio-fft) 11:55:33 INFO - PID 20620 | RSS: Main: 211152896 11:55:33 INFO - PID 20620 | 11:55:35 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34363/tests/kraken/driver.html?testName=audio-oscillator) 11:55:35 INFO - PID 20620 | RSS: Main: 210587648 11:55:35 INFO - PID 20620 | 11:55:38 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:55:38 INFO - PID 20620 | RSS: Main: 210460672 11:55:38 INFO - PID 20620 | 11:55:42 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34363/tests/kraken/driver.html?testName=imaging-darkroom) 11:55:42 INFO - PID 20620 | RSS: Main: 214470656 11:55:42 INFO - PID 20620 | 11:55:46 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34363/tests/kraken/driver.html?testName=imaging-desaturate) 11:55:46 INFO - PID 20620 | RSS: Main: 213692416 11:55:46 INFO - PID 20620 | 11:55:50 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34363/tests/kraken/driver.html?testName=json-parse-financial) 11:55:50 INFO - PID 20620 | RSS: Main: 214724608 11:55:50 INFO - PID 20620 | 11:55:52 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:55:52 INFO - PID 20620 | RSS: Main: 214921216 11:55:52 INFO - PID 20620 | 11:55:54 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:55:55 INFO - PID 20620 | RSS: Main: 210268160 11:55:55 INFO - PID 20620 | 11:55:57 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:55:58 INFO - PID 20620 | RSS: Main: 212201472 11:55:58 INFO - PID 20620 | 11:56:00 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:01 INFO - PID 20620 | RSS: Main: 211902464 11:56:01 INFO - PID 20620 | 11:56:04 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:04 INFO - PID 20620 | RSS: Main: 210841600 11:56:04 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | Cycle 1(1): loaded http://localhost:34363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34363/tests/kraken/driver.html?testName=ai-astar) 11:56:06 INFO - PID 20620 | RSS: Main: 213508096 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | __start_tp_report 11:56:06 INFO - PID 20620 | _x_x_mozilla_page_load 11:56:06 INFO - PID 20620 | _x_x_mozilla_page_load_details 11:56:06 INFO - PID 20620 | |i|pagename|runs| 11:56:06 INFO - PID 20620 | |0;ai-astar;113;112;121;116;109;108;113;108;108;110 11:56:06 INFO - PID 20620 | |1;audio-beat-detection;128;120;134;119;115;148;121;132;127;133 11:56:06 INFO - PID 20620 | |2;audio-dft;165;169;165;165;164;172;169;163;169;163 11:56:06 INFO - PID 20620 | |3;audio-fft;77;75;74;92;82;77;77;79;74;75 11:56:06 INFO - PID 20620 | |4;audio-oscillator;81;89;84;88;79;83;81;83;79;87 11:56:06 INFO - PID 20620 | |5;imaging-gaussian-blur;114;114;122;115;116;114;112;115;112;121 11:56:06 INFO - PID 20620 | |6;imaging-darkroom;161;160;148;150;150;156;149;151;148;150 11:56:06 INFO - PID 20620 | |7;imaging-desaturate;95;95;94;94;96;94;98;102;101;94 11:56:06 INFO - PID 20620 | |8;json-parse-financial;54;54;53;54;54;54;54;53;59;55 11:56:06 INFO - PID 20620 | |9;json-stringify-tinderbox;43;45;44;42;37;46;44;41;38;38 11:56:06 INFO - PID 20620 | |10;stanford-crypto-aes;80;78;77;74;73;79;75;75;86;78 11:56:06 INFO - PID 20620 | |11;stanford-crypto-ccm;120;110;119;118;112;117;108;119;117;116 11:56:06 INFO - PID 20620 | |12;stanford-crypto-pbkdf2;194;169;179;167;177;169;166;172;173;168 11:56:06 INFO - PID 20620 | |13;stanford-crypto-sha256-iterative;73;66;65;64;67;65;66;64;66;70 11:56:06 INFO - PID 20620 | __end_tp_report 11:56:06 INFO - PID 20620 | __start_cc_report 11:56:06 INFO - PID 20620 | _x_x_mozilla_cycle_collect,754 11:56:06 INFO - PID 20620 | __end_cc_report 11:56:06 INFO - PID 20620 | __startTimestamp1506279366905__endTimestamp 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | ------- Summary: start ------- 11:56:06 INFO - PID 20620 | Number of tests: 14 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:4.21 (3.7%) stddev-sans-first:4.44 11:56:06 INFO - PID 20620 | Values: 113.0 112.0 121.0 116.0 109.0 108.0 113.0 108.0 108.0 110.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:130.00 stddev:9.66 (7.4%) stddev-sans-first:10.25 11:56:06 INFO - PID 20620 | Values: 128.0 120.0 134.0 119.0 115.0 148.0 121.0 132.0 127.0 133.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:3.10 (1.9%) stddev-sans-first:3.24 11:56:06 INFO - PID 20620 | Values: 165.0 169.0 165.0 165.0 164.0 172.0 169.0 163.0 169.0 163.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#3] audio-fft Cycles:10 Average:78.20 Median:77.00 stddev:5.43 (7.1%) stddev-sans-first:5.74 11:56:06 INFO - PID 20620 | Values: 77.0 75.0 74.0 92.0 82.0 77.0 77.0 79.0 74.0 75.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#4] audio-oscillator Cycles:10 Average:83.40 Median:83.50 stddev:3.60 (4.3%) stddev-sans-first:3.71 11:56:06 INFO - PID 20620 | Values: 81.0 89.0 84.0 88.0 79.0 83.0 81.0 83.0 79.0 87.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:3.41 (3.0%) stddev-sans-first:3.57 11:56:06 INFO - PID 20620 | Values: 114.0 114.0 122.0 115.0 116.0 114.0 112.0 115.0 112.0 121.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:150.50 stddev:4.88 (3.2%) stddev-sans-first:4.03 11:56:06 INFO - PID 20620 | Values: 161.0 160.0 148.0 150.0 150.0 156.0 149.0 151.0 148.0 150.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:94.50 stddev:3.02 (3.2%) stddev-sans-first:3.17 11:56:06 INFO - PID 20620 | Values: 95.0 95.0 94.0 94.0 96.0 94.0 98.0 102.0 101.0 94.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.71 (3.2%) stddev-sans-first:1.81 11:56:06 INFO - PID 20620 | Values: 54.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 59.0 55.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#9] json-stringify-tinderbox Cycles:10 Average:41.80 Median:43.50 stddev:3.19 (7.3%) stddev-sans-first:3.35 11:56:06 INFO - PID 20620 | Values: 43.0 45.0 44.0 42.0 37.0 46.0 44.0 41.0 38.0 38.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:3.75 (4.8%) stddev-sans-first:3.87 11:56:06 INFO - PID 20620 | Values: 80.0 78.0 77.0 74.0 73.0 79.0 75.0 75.0 86.0 78.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:117.50 stddev:4.14 (3.5%) stddev-sans-first:4.08 11:56:06 INFO - PID 20620 | Values: 120.0 110.0 119.0 118.0 112.0 117.0 108.0 119.0 117.0 116.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:172.50 stddev:8.40 (4.9%) stddev-sans-first:4.51 11:56:06 INFO - PID 20620 | Values: 194.0 169.0 179.0 167.0 177.0 169.0 166.0 172.0 173.0 168.0 11:56:06 INFO - PID 20620 | 11:56:06 INFO - PID 20620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.84 (4.3%) stddev-sans-first:1.83 11:56:06 INFO - PID 20620 | Values: 73.0 66.0 65.0 64.0 67.0 65.0 66.0 64.0 66.0 70.0 11:56:06 INFO - PID 20620 | -------- Summary: end -------- 11:56:06 INFO - PID 20620 | 11:56:07 INFO - PID 20620 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:56:07 INFO - TEST-INFO | 20620: exit 0 11:56:07 INFO - TEST-OK | kraken | took 63248ms 11:56:07 INFO - SUITE-END | took 1177s 11:56:08 INFO - Completed test suite (00:19:38) 11:56:08 INFO - javascript benchmark 11:56:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8533.322432391962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.8750849966, 3156.3845050215205, 3159.5892533970596, 3175.7776955613103, 3193.042087373787, 6125.234345706786, 6277.811665650032, 6286.8113956581265, 6351.650659213741, 6388.297287298399, 6192.442680158785, 6208.472279856206, 6213.627182369061, 6219.067139929013, 6286.654234017139, 5806.303243610762, 5824.359320474766, 5827.533797296227, 5870.647761134324, 5883.29400471944, 5848.590598658096, 5892.234009578749, 5895.616784908967, 5907.88184236315, 5984.431479009487, 5762.1068734346245, 5812.564057695668, 5825.766969321222, 5907.084401917688, 5922.4077592240865, 5385.246065550826, 5837.708114594253, 5841.620294680833, 5900.557458190653, 5935.406459354073, 5515.448455154453, 5610.0, 5642.548596112301, 5721.313442386899, 5820.88358232833, 6199.287081985584, 6240.31356550779, 6250.4374606285655, 6268.4671802896355, 6324.683765811737, 6782.084418603524, 6793.4225590824835, 6802.14973128359, 6803.285655006202, 6822.897656535156, 6813.11429514165, 6890.276520965327, 6897.379235868746, 6902.792916212522, 6928.341807528327, 6154.26148862135, 6180.690965451709, 6192.907106393408, 6221.0, 6395.77614783485, 7117.0, 7119.038929744522, 7120.608366539786, 7125.53684010548, 7125.714971401189, 6492.577982431127, 6679.398854103057, 6727.865442691119, 6772.661366931732, 6803.149606299213, 6657.733690652417, 6784.389404953479, 6845.657717114124, 6863.588184708933, 6870.106886104774, 6736.6631668416385, 6791.45668346541, 6846.281140480278, 6854.554453960476, 6863.691133898987, 6771.221309549366, 6773.153355830521, 6786.728530858711, 6805.421539169127, 6897.655117244118, 5197.974010129925, 5322.2282768998275, 5382.703951282717, 5392.649477783932, 5405.729713514309, 4583.472900616405, 4599.770011499411, 4601.5168407317415, 4621.006483605974, 4621.353010578522, 5771.913421298684, 5827.88344233113, 5847.327557330961, 5873.20711703923, 5894.67579283135, 6781.25406205317, 6846.623435711083, 6849.828754281183, 6947.340002699735, 6956.40870526011, 5825.621334613236, 5832.766689332379, 5844.736986835603, 5897.941020589825, 5904.114382842608, 5717.028105222039, 5772.942270577324, 5777.826665200051, 5781.248437703071, 5888.116782482662, 6497.512686548528, 6497.902531462032, 6518.739250430024, 6528.967355163194, 6532.640704761188, 6775.3224677532835, 6780.525363224527, 6878.965605171942, 6897.793066208022, 6907.930920690729, 6585.703643336157, 6587.308332625005, 6607.834804129935, 6691.063251144941, 6694.29709880475, 6491.675416229265, 6583.473322134122, 6709.194896612437, 6757.45940324763, 6812.318768123347, 6683.7660681875905, 6708.463322934251, 6719.496037797283, 6765.797026089225, 6773.864522709617, 6408.263049749152, 6526.771562995273, 6543.901841472477, 6642.4021838034805, 6642.6014439133805, 6628.304028076983, 6635.071090047494, 6664.4668426524795, 6678.7328506859185, 6694.029365742038, 6472.190976127984, 6497.155369801895, 6534.771283005262, 6602.10871532337, 6602.702878370581, 6361.2048493938255, 6517.641529715911, 6575.506836987341, 6636.834079147867, 6702.36327548882, 6442.710078046593, 6464.385883341075, 6472.061551074974, 6485.027245913151, 6496.935030649633], "value": 6171.656569028045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.384264093814, 900.7072701372056, 901.0133903375802, 903.7424334064793, 907.5054095517944, 39073.80463097684, 42855.0, 43277.78361108198, 43469.78265108674, 43548.34677479837, 39841.80079099601, 40110.598894011055, 40149.19701605966, 40560.18879622406, 40679.38980915289, 7282.126144862611, 7348.889766653505, 7381.778546643609, 7407.185209626937, 7411.518251313674, 7229.855402891965, 7349.265073492661, 7390.852182956338, 7394.5563266203935, 7401.555906645618, 7374.963125184393, 7388.150362708277, 7391.408687305029, 7408.962955185217, 7409.48133630646, 7282.453815963824, 7810.80472988177, 7931.325837303836, 7956.761297161094, 8012.8798068028445, 7857.410694197901, 7887.408444366695, 7894.368450523944, 7901.841963160762, 7903.762887113396, 38697.226055478735, 39041.80479097586, 39091.60908390937, 39118.0, 39796.403053954215, 3580.1765593913547, 3601.981990090033, 3625.456181572785, 3625.927481450356, 3626.4741612466046, 32470.837645811618, 32765.344693106243, 32819.0, 32841.50737738936, 32889.0, 5243.816466423695, 5244.423113457517, 5255.369355677305, 5266.078436273637, 5373.113436283009, 188515.0, 188685.0, 188686.0, 189673.0, 189921.0, 41378.37932431016, 42188.0, 48838.5116148834, 49063.26405103926, 49953.0, 52028.0, 52212.73893630583, 52241.73879130656, 52432.21351679728, 52595.94808103893, 16325.102119383548, 16392.0, 16440.588985275226, 16491.83508164927, 16526.504204873872, 13324.267165306, 13416.262105584286, 13425.86574134246, 13438.664033399244, 13576.389062492211, 13793.793093103612, 13903.09629874055, 13919.234442105579, 13956.72086558263, 13975.09161904473, 5439.673619582838, 5509.834704958857, 5539.556835453154, 5603.523700485504, 5669.801556945487, 803.188779332878, 816.3754727633366, 828.5857071464268, 831.4512421801703, 846.1073567386467, 19599.706004409945, 19674.50813729668, 19820.70268945967, 20013.39959801208, 20191.596168076558, 917.4449458077767, 919.4115765909823, 920.0339643374564, 924.117467818232, 933.6732143749633, 10094.747631309128, 10379.896201038044, 10417.895821041844, 10572.259941803999, 10575.788484230272, 220812.0, 222257.0, 222318.0, 222440.0, 223129.0, 55388.16917746237, 55680.0, 55810.44189558134, 56334.15498767522, 56351.154732679046, 1433.3263366217861, 1480.407836865241, 1490.93290801912, 1492.3284521964943, 1494.656229067299, 19246.23015079437, 19519.70720439223, 19521.70717439268, 19828.603427931073, 19982.0, 38322.42516362313, 38503.229935401694, 38602.0, 38823.805880970416, 38976.805115975374, 194523.0, 195364.0, 196358.0, 196978.0, 197581.0, 33319.0, 34365.65634343625, 34828.82585587056, 35165.64834351624, 35279.470807938415, 45128.32307515324, 45494.0, 45583.54416455793, 45796.54203457923, 45997.54002459932, 32433.29653256932, 33253.50119748157, 33304.66695333113, 33313.0, 33419.498707519895, 32763.0, 32772.34455310928, 32990.34019319648, 32997.0, 33102.33795324032, 35908.0, 37535.62464375321, 37536.43695344627, 37537.2492550153, 38008.0, 31749.36501270008, 31848.5222721664, 32109.678903211603, 32121.196970075, 32302.19244518906, 23728.52542949097, 23903.641445378682, 24470.38824029342, 24520.264392068268, 24528.87735561311], "value": 16885.786261022724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9855253618656, 588.314613475301, 596.4989408896527, 600.0788789208565, 611.7522403426613, 22240.88879555602, 22854.885725571392, 22961.885190574023, 23010.424739381524, 23092.538149237003, 21426.357209283746, 21506.0, 21725.13099476019, 22591.435214119654, 24451.75548244517, 6581.0, 6605.867882642344, 6669.732750777337, 6749.966250168743, 6778.118844550201, 6557.213134423876, 6643.103181070566, 6655.168103987002, 6676.632785196836, 6701.3298670132845, 6342.429181373675, 6649.434798042173, 6677.833054173636, 6690.163729533809, 6708.765193218238, 6658.3674550917585, 6680.465562755016, 6698.83252918681, 6699.229588597325, 6705.228898676666, 5851.970740146272, 6050.757969681252, 6069.969650151766, 6085.269767627913, 6190.195274614316, 27541.0, 28101.85949070262, 28121.85939070312, 28135.0, 28233.870645174167, 1991.6415045291842, 1996.0418998880473, 2014.1238561225914, 2018.5155562665002, 2029.5027718209133, 18434.539136521693, 19033.143508542147, 19375.12811923467, 19392.4182274532, 19699.80300196994, 2331.825113116523, 2395.856248625088, 2406.6991626046743, 2416.818738594595, 2420.0561780905286, 115547.0, 121957.0, 138769.0, 145029.0, 145490.27254863764, 14590.978840051506, 14962.850371496146, 15002.522565724128, 15029.554459650439, 15202.695946081016, 22514.66228006581, 22551.210707625156, 22609.0, 22661.320160395215, 22694.319170424915, 10047.497625118714, 10082.546285417175, 10127.898721012843, 10208.693739187836, 10210.234232432596, 9094.136057074567, 9173.541322933826, 9317.534123293808, 9473.100055494855, 9475.952620236854, 8850.867236991451, 9019.323550733721, 9044.638214471479, 9103.408278462011, 9190.954045229731, 2632.907848225303, 2649.1522712732126, 2649.867506624661, 2729.6178535005115, 2745.1490038088255, 946.7207173883721, 955.7992821507561, 964.4406244378243, 965.4448692002127, 979.5885727994117, 18528.16623251957, 18955.431337059912, 19306.517337066685, 19513.414597562096, 19910.60178796416, 1008.3395376028712, 1020.4132623741378, 1029.6653587584065, 1030.6701855406197, 1033.679559336608, 10394.532246048946, 10675.733106672395, 10686.954442185843, 10737.194710396752, 10832.187585931088, 451928.0, 461786.0, 472896.0, 479133.0, 481371.0, 111733.44133279443, 113353.43323283331, 114878.0, 114879.42560287144, 115680.42159789147, 1028.0, 1097.632293181793, 1132.0886686217673, 1162.215504534436, 1191.076915390562, 19805.20779168817, 19971.20115195376, 19995.700064498753, 20296.0, 20320.898395507927, 55637.1654425192, 57332.71333643472, 57855.421445785, 58382.4161758394, 59348.0, 69849.65075174591, 70357.0, 70733.29266707473, 71435.0, 71736.0, 14339.498117566252, 14801.851981480047, 14810.77783833265, 14841.0, 14973.176475293963, 20398.796012040282, 20472.59054818925, 20680.276190333265, 20701.171953121706, 21949.0, 17013.0, 17777.911110444882, 18054.36809711706, 18171.0, 18244.72632910534, 15152.621184470476, 15478.767818482956, 15647.608809779847, 15978.440754573534, 16886.0, 17037.233324500674, 17097.74353384725, 17815.73276400829, 18643.90678046601, 18751.437456876316, 14418.855811441752, 14515.927420363252, 14524.27378631043, 14591.0, 14624.268786560842, 16736.41422550205, 16799.244034018255, 17691.911540442215, 18186.181621826785, 18227.453176404728], "value": 11795.457788406093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1274.350081458456, 1391.0193313713833, 1391.0540832234083, 1393.8118354022204, 1396.755567775639, 15263.465778697748, 15742.921285393571, 15808.920955395208, 15914.283857226425, 15921.76117358239, 15610.921945390257, 15617.21913904306, 15677.29452174652, 15684.372625095011, 15709.371625134982, 2680.7051224365305, 2719.2250208690525, 2767.529519981598, 2772.639556857606, 2780.249332680175, 2667.66654168229, 2762.903298384557, 2768.1418760184306, 2772.209920172751, 2786.916392508228, 2679.289988153141, 2745.2450576091633, 2767.529519981598, 2793.553031514958, 2795.7903157263186, 2722.7957903157344, 2739.8904043838224, 2744.286485513771, 2748.4503099380104, 2752.5320695481814, 2653.031643450146, 2666.0668765931964, 2675.946481070387, 2679.0, 2679.6382488364015, 12261.080418968613, 12844.871551284554, 12879.162854414526, 14908.701825963528, 15521.146336951464, 8084.474509156886, 8391.83216335676, 8409.243168114837, 8410.537420441873, 8410.621522031523, 5343.652662576959, 5433.972830135824, 5474.452554744494, 5480.3971563128025, 5556.305461817273, 1949.2008276606664, 2009.708592254115, 2020.2525065725777, 2059.6395630764555, 2063.0406860809794, 28118.0, 28136.577951330746, 28349.57475637867, 28392.43215135727, 28514.0, 6629.303923088103, 6784.694688739019, 6798.082258894986, 7018.613976231356, 7092.822679433056, 17557.82442175562, 17580.38468653591, 17591.912040439714, 17665.470035898943, 17673.558161046076, 8136.75589732309, 8255.752327430067, 8293.8341233175, 8308.210719981593, 8319.584020798935, 7223.530470519399, 7584.393248540104, 7623.4663573549315, 7636.809079772939, 7688.807779805437, 5341.172118321666, 5369.812056578001, 5514.834554963358, 5578.581606379456, 5705.828825135252, 1582.9604259893365, 1600.087949868587, 1605.6868910562562, 1606.9758953615706, 1611.701835160499, 853.3088198559187, 866.4368160695599, 873.3100850328296, 876.6493402638868, 882.8013696918142, 8282.4202305838, 8308.086110527836, 8309.60445203769, 8317.83364332722, 8319.8336033279, 965.2422848064236, 977.413551868873, 982.6511588386163, 984.6849008317413, 1000.4047591682937, 5334.653247538898, 5356.571474282048, 5372.167314066326, 5382.192671099367, 5498.257735205776, 21184.470388240108, 22489.662655060187, 22493.88753056257, 22528.098876044776, 22557.210497632503, 20850.687239691415, 21971.34085977423, 22207.777922220896, 22324.999999999676, 22392.440188995406, 11595.304281743123, 11667.88332116685, 11855.940720296343, 11922.880771192351, 11993.940030299967, 7355.0, 8388.286995605442, 8488.74533763988, 8510.872336914827, 8526.403151779565, 17976.550586235448, 18448.907755461136, 19139.23443062262, 19501.219951201794, 19523.609527809647, 19413.0, 19745.506362341057, 19806.20775168977, 19932.90033549823, 20070.698939515627, 10797.13622910181, 10847.240693151403, 10852.728681783019, 10961.50673219723, 11015.614453494089, 14087.929560352133, 14200.92899535537, 14332.355044023252, 14358.282085895873, 14377.281135942952, 11204.495797689287, 11317.886821132013, 11387.259828111146, 11468.369239691563, 11604.419779010846, 10912.61805836792, 11030.44847757625, 11177.329360238411, 11273.661790146309, 11446.713832154262, 9978.950105249427, 10232.334898231591, 10238.744031399274, 10242.231832612435, 10259.076683098558, 6958.165020197609, 7007.509474336747, 7015.754448594274, 7035.6833942471685, 7172.426205903619, 6944.687489063105, 6967.930320696728, 7047.964760176166, 7053.118360204974, 7134.750283740044], "value": 6777.958013222294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.27587170986936, 510.246391445812, 514.3698968763265, 528.4583302115334, 530.6975024236187, 6260.405261500162, 6288.968555157224, 6324.367563243679, 6344.2386913570435, 6350.587211831239, 6165.722542485588, 6180.536459765513, 6257.311695713479, 6291.716872740726, 6301.527385446087, 5205.37535495741, 5251.789928402859, 5262.079750585819, 5281.207818827187, 5286.947130528684, 5221.947780522203, 5222.529972302492, 5251.947480525203, 5254.474552544753, 5326.946730532683, 4807.89890520614, 5049.570786483135, 5107.361579802525, 5184.377874655047, 5240.318758561381, 4986.301917731521, 5007.724575148365, 5080.364954380702, 5085.720285384303, 5085.90653009601, 4525.162844873709, 4548.977255113737, 4564.744695208811, 4572.748498832596, 4584.839530616446, 6025.186599809013, 6052.4552790248645, 6126.486162453827, 6151.031669865645, 6229.6573688447115, 5719.857003574903, 5734.369219385864, 5744.913826292609, 5772.682502462363, 5804.854878628026, 6555.704993275266, 6585.275619681831, 6593.175853018372, 6637.634930078843, 6673.799786006428, 4686.179918514246, 4924.0, 4971.552560269593, 5031.32077169581, 5033.144365457881, 6675.46596272297, 6787.219469760991, 6809.795706128774, 6898.448124150106, 6965.930340696528, 5075.644704870698, 5080.002798348992, 5084.49155084496, 5088.1350170471105, 5125.9743701282005, 5120.743962801919, 5139.203423469368, 5155.819546315861, 5195.376554813371, 5214.556762675215, 5678.744456499468, 5762.94237057624, 5795.739191736382, 5824.126381042877, 5829.4170582942215, 6601.53789234749, 6648.833779155463, 6686.431653309523, 6703.698333575001, 6710.698018589175, 1781.9821801782075, 1783.61652244768, 1793.7757780277466, 1808.9185986630632, 1809.9909500452677, 1202.0149719578237, 1256.1646505074023, 1260.3635164241998, 1276.527684756646, 1280.5326055989497, 5644.0528017833785, 5768.0, 5774.642958904654, 5794.362620111784, 5828.825135245949, 6694.464442844561, 6735.528513004141, 6806.115205023315, 6817.193443737414, 6833.350831670983, 5529.281193444826, 5735.713214339266, 5745.91381129275, 5776.451237132465, 5779.624324418899, 3426.417509023472, 3534.929301413957, 3539.6460353964912, 3540.8760693375607, 3541.1501239702284, 6453.225612926385, 6458.903116453257, 6518.217813862367, 6537.378948999837, 6552.515974440857, 6723.344279009763, 6731.663416829139, 6747.493937954673, 6807.319268073252, 6848.315168483112, 6539.542232043711, 6547.508936829757, 6552.901706474407, 6578.506612004023, 6598.3401659833635, 6723.5293529452465, 6733.158355205599, 6774.220964589135, 6807.115075040213, 6832.316768323128, 6765.154355705537, 6777.8983315249325, 6793.184817821893, 6819.931800681929, 6837.247902730795, 6478.740850365933, 6482.805515834532, 6486.513511486563, 6530.444912182517, 6545.03648905336, 4981.825636102719, 5049.747512624427, 5051.217061355495, 5093.847184584469, 5097.28637990689, 6458.709358078804, 6519.196745399524, 6590.9670451647435, 6851.383375496229, 6882.552634078969, 6291.307956124731, 6544.280129185881, 6553.180852393451, 6555.639439830665, 6646.302138275605, 6493.090967264681, 6493.545451818516, 6523.445507131757, 6527.967360163168, 6538.248101468202, 6329.7468101275435, 6330.620162790063, 6356.968215158895, 6388.9041664376, 6428.228612566522, 6493.584362633265, 6530.183727034121, 6569.770058047945, 6579.934200657932, 6668.633225172662, 6329.082283069021, 6341.8097457076365, 6362.091372588297, 6410.358964103552, 6423.29343772194], "value": 5103.290287026118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.5893218585542, 908.8046070094928, 919.397794444639, 923.146089866873, 929.2705226397279, 19366.70949935752, 20399.898000509977, 20400.489987750312, 20470.385888423334, 20490.897545512253, 18569.628607427876, 18582.628347433045, 18693.626127477477, 18939.810601894013, 19018.049097545103, 931.9720408387742, 952.3761935931975, 956.7273327101777, 962.6390103711109, 963.2534785541192, 967.3228739882076, 971.4414211828192, 978.5547575853005, 978.6330126202674, 980.4999450280372, 996.9152622027136, 1004.7839714461389, 1047.3401756893147, 1057.4501259345136, 1060.6446840308467, 1044.2116202267316, 1046.6179844356832, 1053.6206965492418, 1053.9104176145038, 1054.7626783973622, 716.8064622551934, 748.7416841189781, 752.4281546025005, 753.9132999705049, 758.4577027425362, 18146.90926545372, 18298.63402731938, 18305.542361440937, 18321.0, 18368.908155459136, 21807.127714891387, 21992.230271940407, 22115.557688846133, 22158.88920555403, 22185.778142218533, 17527.12364381776, 17814.46556603304, 17948.910255448638, 18260.269589216547, 18483.353082642177, 3772.622737726233, 3818.5417749870194, 3832.9808350958065, 3833.4824798652103, 3835.712321575893, 108158.0, 144107.0, 146428.0, 146864.265678672, 147797.26101369533, 17907.194176261837, 18065.187066582035, 18097.547561311072, 18175.272989080553, 18383.54041148982, 32502.187445313582, 32594.185145371557, 32929.0, 32948.50577241343, 32982.0, 8876.556172191365, 9184.816303674022, 9276.0, 9318.534073296309, 9376.203022743006, 4287.614114729689, 4387.648988080946, 4401.053773438662, 4418.072204836956, 4426.136903303889, 5499.477549632858, 5602.187682785973, 5626.915596266059, 5628.746706398222, 5684.346300175533, 1055.3509591601264, 1065.2117433099606, 1081.1837063017529, 1085.2077983072402, 1085.4084523934475, 659.7427003468651, 678.4538446550574, 679.2528218959204, 684.8253695307665, 689.183317768446, 11562.0, 11918.821217681741, 12041.939790300992, 12803.0, 13027.08810383283, 652.4128284543948, 664.0802488553388, 667.6861874918877, 668.6456178225549, 676.9458443324522, 5508.421615730291, 5524.8342549723575, 5536.474034966672, 5638.464345887134, 5692.23154874095, 124908.0, 126788.0, 128652.0, 128906.35546822206, 129492.0, 106861.46569267259, 107468.4626576862, 108226.45886770515, 109649.0, 110250.0, 96241.0, 96333.0, 96393.0, 100181.49909250408, 100583.99416005747, 10371.844422333521, 10448.477576121315, 10502.632407865687, 10635.20235982289, 10687.305325154151, 42788.57211427846, 43421.348679769195, 44655.77672111749, 44814.55185448104, 45506.31740523829, 57985.71007144937, 58300.708496458945, 58872.41127588841, 59061.0, 59598.0, 15994.280257388213, 16052.438164664181, 16364.0, 16433.753493697845, 16523.00861948287, 17923.37268195607, 18045.909770451064, 18144.0, 18165.636687266444, 18558.907205463885, 15943.282552285407, 16007.599810004844, 16072.0, 16076.0, 16392.098434586213, 15503.767443488583, 15884.205789710699, 15909.68180636404, 15990.03363647689, 16131.596710082342, 16131.435399760952, 16279.755803662718, 16378.508644740677, 16470.917645411697, 16512.75230871514, 11486.885131148581, 11536.711582210512, 11720.88279117198, 11894.762104757683, 11968.222065565711, 12543.93728031354, 12545.372731363213, 12643.93678031604, 12794.976401888012, 12863.935680321538], "value": 9080.241648790301, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 121.0, 116.0, 109.0, 108.0, 113.0, 108.0, 108.0, 110.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 120.0, 134.0, 119.0, 115.0, 148.0, 121.0, 132.0, 127.0, 133.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 165.0, 165.0, 164.0, 172.0, 169.0, 163.0, 169.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 92.0, 82.0, 77.0, 77.0, 79.0, 74.0, 75.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 84.0, 88.0, 79.0, 83.0, 81.0, 83.0, 79.0, 87.0], "value": 83.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 122.0, 115.0, 116.0, 114.0, 112.0, 115.0, 112.0, 121.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 148.0, 150.0, 150.0, 156.0, 149.0, 151.0, 148.0, 150.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 96.0, 94.0, 98.0, 102.0, 101.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 59.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 44.0, 42.0, 37.0, 46.0, 44.0, 41.0, 38.0, 38.0], "value": 41.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 74.0, 73.0, 79.0, 75.0, 75.0, 86.0, 78.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 119.0, 118.0, 112.0, 117.0, 108.0, 119.0, 117.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 169.0, 179.0, 167.0, 177.0, 169.0, 166.0, 172.0, 173.0, 168.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 66.0, 65.0, 64.0, 67.0, 65.0, 66.0, 64.0, 66.0, 70.0], "value": 66.6, "unit": "score"}]}]} 11:56:08 INFO - Return code: 0 11:56:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:56:08 INFO - # TBPL SUCCESS # 11:56:08 INFO - Running post-action listener: _package_coverage_data 11:56:08 INFO - Running post-action listener: _resource_record_post_action 11:56:08 INFO - [mozharness: 2017-09-24 18:56:08.166990Z] Finished run-tests step (success) 11:56:08 INFO - Running post-run listener: _resource_record_post_run 11:56:08 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 11145216; Write bytes: 407384064; Read time: 5432; Write time: 247920 11:56:08 INFO - TinderboxPrint: CPU usage
13.3% 11:56:08 INFO - TinderboxPrint: I/O read bytes / time
11,145,216 / 5,432 11:56:08 INFO - TinderboxPrint: I/O write bytes / time
407,384,064 / 247,920 11:56:08 INFO - TinderboxPrint: CPU idle
8,264.6 (86.7%) 11:56:08 INFO - TinderboxPrint: CPU user
1,203.0 (12.6%) 11:56:08 INFO - TinderboxPrint: Swap in / out
0 / 0 11:56:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74526720; Read time: 0; Write time: 36588 11:56:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:56:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 11141120; Write bytes: 332447744; Read time: 5416; Write time: 211316 11:56:08 INFO - Running post-run listener: _upload_blobber_files 11:56:08 INFO - Blob upload gear active. 11:56:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:08 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 11:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:56:09 INFO - Traceback (most recent call last): 11:56:09 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 11:56:09 INFO - main() 11:56:09 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 11:56:09 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 11:56:09 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 11:56:09 INFO - return set(response.json().get('whitelist', [])) 11:56:09 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 11:56:09 INFO - return json.loads(self.text or self.content, **kwargs) 11:56:09 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 11:56:09 INFO - return _default_decoder.decode(s) 11:56:09 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 11:56:09 INFO - obj, end = self.raw_decode(s) 11:56:09 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 11:56:09 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 11:56:09 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 11:56:09 ERROR - Return code: 1 11:56:09 INFO - Setting buildbot property blobber_files to {} 11:56:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:09 INFO - Contents: 11:56:09 INFO - blobber_files:{} 11:56:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:09 INFO - Copying logs to upload dir... 11:56:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.172690 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-24 11:56:09.306863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 11:56:09.310131) ========= 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=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/EBqoJLZ9SxOo9gWWXOxngg/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 11:56:09.364487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:56:09.364939) ========= 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=483e410453545d07cca6935c000001ab-1506267047.327623-1751645334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 11:56:09.414823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 11:56:09.415139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 11:56:09.415482) ========= ========= Total master_lag: 0.19 =========